builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1483441616.49 results: success (0) buildid: 20170103004005 builduid: e7a1886d3b184d44a10c22e9008b56f3 revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.488891) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.489304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.489649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.505447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.506061) ========= 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=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 03:06:57-- 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% 227M=0s 2017-01-03 03:06:57 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.618636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.618950) ========= 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=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018046 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.679474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:56.679827) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6f6cf4180980a74083cc03f611cc510eb15b5cc --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 a6f6cf4180980a74083cc03f611cc510eb15b5cc --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=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 03:06:57,440 truncating revision to first 12 chars 2017-01-03 03:06:57,440 Setting DEBUG logging. 2017-01-03 03:06:57,440 attempt 1/10 2017-01-03 03:06:57,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6f6cf418098?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 03:06:57,808 unpacking tar archive at: mozilla-aurora-a6f6cf418098/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:57.411146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:57.411461) ========= script_repo_revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:57.411904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:57.414954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 03:06:57.424735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-03 03:06:57.425036) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:58 INFO - MultiFileLogger online at 20170103 03:06:58 in /builds/slave/test 03:06:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:58 INFO - {'append_to_log': False, 03:06:58 INFO - 'base_work_dir': '/builds/slave/test', 03:06:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:58 INFO - 'branch': 'Mozilla-Aurora', 03:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:58 INFO - 'config_files': ('talos/linux_config.py',), 03:06:58 INFO - 'default_actions': ('clobber', 03:06:58 INFO - 'read-buildbot-config', 03:06:58 INFO - 'download-and-extract', 03:06:58 INFO - 'populate-webroot', 03:06:58 INFO - 'create-virtualenv', 03:06:58 INFO - 'install', 03:06:58 INFO - 'run-tests'), 03:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:58 INFO - 'download_minidump_stackwalk': True, 03:06:58 INFO - 'download_symbols': 'ondemand', 03:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:58 INFO - 'installer_path': 'installer.exe', 03:06:58 INFO - 'log_level': 'info', 03:06:58 INFO - 'log_name': 'talos', 03:06:58 INFO - 'log_to_console': True, 03:06:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:58 INFO - 'opt_config_files': (), 03:06:58 INFO - 'pip_index': False, 03:06:58 INFO - 'sps_profile': False, 03:06:58 INFO - 'sps_profile_interval': 0, 03:06:58 INFO - 'suite': 'dromaeojs', 03:06:58 INFO - 'system_bits': '32', 03:06:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:58 INFO - 'title': 'talos-linux64-ix-038', 03:06:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:58 INFO - 'use_talos_json': True, 03:06:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:58 INFO - 'work_dir': 'build'} 03:06:58 INFO - [mozharness: 2017-01-03 11:06:58.285327Z] Running clobber step. 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: clobber 03:06:58 INFO - rmtree: /builds/slave/test/build 03:06:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:58 INFO - Running post-action listener: _resource_record_post_action 03:06:58 INFO - [mozharness: 2017-01-03 11:06:58.731860Z] Finished clobber step (success) 03:06:58 INFO - [mozharness: 2017-01-03 11:06:58.731960Z] Running read-buildbot-config step. 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: read_buildbot_config 03:06:58 INFO - Using buildbot properties: 03:06:58 INFO - { 03:06:58 INFO - "project": "", 03:06:58 INFO - "product": "firefox", 03:06:58 INFO - "script_repo_revision": "production", 03:06:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:06:58 INFO - "repository": "", 03:06:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:06:58 INFO - "buildid": "20170103004005", 03:06:58 INFO - "stage_platform": "linux64-pgo", 03:06:58 INFO - "basedir": "/builds/slave/test", 03:06:58 INFO - "nightly_build": "True", 03:06:58 INFO - "buildnumber": 677, 03:06:58 INFO - "slavename": "talos-linux64-ix-038", 03:06:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:06:58 INFO - "platform": "ubuntu64_hw", 03:06:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:06:58 INFO - "branch": "mozilla-aurora", 03:06:58 INFO - "repo_path": "releases/mozilla-aurora", 03:06:58 INFO - "revision": "a6f6cf4180980a74083cc03f611cc510eb15b5cc", 03:06:58 INFO - "pgo_build": "True", 03:06:58 INFO - "builduid": "e7a1886d3b184d44a10c22e9008b56f3", 03:06:58 INFO - "slavebuilddir": "test" 03:06:58 INFO - } 03:06:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:06:58 INFO - Running post-action listener: _resource_record_post_action 03:06:58 INFO - [mozharness: 2017-01-03 11:06:58.734462Z] Finished read-buildbot-config step (success) 03:06:58 INFO - [mozharness: 2017-01-03 11:06:58.734550Z] Running download-and-extract step. 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: download_and_extract 03:06:58 INFO - mkdir: /builds/slave/test/build/tests 03:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:58 INFO - trying https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:06:58 INFO - Downloading https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:06:59 INFO - Downloaded 1361 bytes. 03:06:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:06:59 INFO - Using the following test package requirements: 03:06:59 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:06:59 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:06:59 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:06:59 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'jsshell-linux-x86_64.zip'], 03:06:59 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:06:59 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:06:59 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:06:59 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:06:59 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:06:59 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:06:59 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:06:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:06:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:59 INFO - Fetch https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:06:59 INFO - Http code: 200 03:06:59 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 03:06:59 INFO - x-amz-cf-id: VnvDRsDdx66hgwitU20IDfv9fffKk0ODKdVAwpGd95Ce8hTJPCBP9A== 03:06:59 INFO - x-amz-version-id: aI5GZ5YjLdBEJFUJ9v7.Z9FIzUom3UzP 03:07:00 INFO - Expected file size: 21940379 03:07:00 INFO - Obtained file size: 21940379 03:07:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:07:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:07:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:07:04 INFO - Fetch https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:07:04 INFO - Http code: 200 03:07:04 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 03:07:04 INFO - x-amz-cf-id: bYvxvpQk56d5ZMMlOIAusIEnRSEy6d82sADWTEV8vc0b2WpnWO98Rw== 03:07:04 INFO - x-amz-version-id: aI5GZ5YjLdBEJFUJ9v7.Z9FIzUom3UzP 03:07:05 INFO - Expected file size: 21940379 03:07:05 INFO - Obtained file size: 21940379 03:07:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:07:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:07:09 INFO - Fetch https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:07:09 INFO - Http code: 200 03:07:09 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 03:07:09 INFO - x-amz-cf-id: jSqY0LgOsWCpLbhgejkZibK3RKMAUP1Vv3zFr_AQF5y-b7jV0V9FeQ== 03:07:09 INFO - x-amz-version-id: ImkPJ5OHDRM74d6GYHRqcXYQmfA.a9NF 03:07:10 INFO - Expected file size: 14409038 03:07:10 INFO - Obtained file size: 14409038 03:07: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')]} 03:07:10 INFO - trying https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:07:10 INFO - Downloading https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:07:12 INFO - Downloaded 64007354 bytes. 03:07:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:07:12 INFO - mkdir: /builds/slave/test/properties 03:07:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:12 INFO - Contents: 03:07:12 INFO - build_url:https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:07:12 INFO - Running post-action listener: _resource_record_post_action 03:07:12 INFO - Running post-action listener: set_extra_try_arguments 03:07:12 INFO - [mozharness: 2017-01-03 11:07:12.858586Z] Finished download-and-extract step (success) 03:07:12 INFO - [mozharness: 2017-01-03 11:07:12.858852Z] Running populate-webroot step. 03:07:12 INFO - Running pre-action listener: _resource_record_pre_action 03:07:12 INFO - Running main action method: populate_webroot 03:07:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:12 INFO - '--tppagecycles', 03:07:12 INFO - '7'], 03:07:12 INFO - 'tests': ['tsvgm']}}, 03:07:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['damp', 'tps']}, 03:07:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'tests': ['damp', 'tps']}, 03:07:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['dromaeo_dom']}, 03:07:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['basic_compositor_video']}, 03:07:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:07:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['a11yr', 03:07:12 INFO - 'ts_paint', 03:07:12 INFO - 'tpaint', 03:07:12 INFO - 'sessionrestore', 03:07:12 INFO - 'sessionrestore_no_auto_restore', 03:07:12 INFO - 'tabpaint']}, 03:07:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['tsvgx', 03:07:12 INFO - 'tsvgr_opacity', 03:07:12 INFO - 'tart', 03:07:12 INFO - 'tscrollx', 03:07:12 INFO - 'cart']}, 03:07:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:12 INFO - 'tsvgr_opacity', 03:07:12 INFO - 'tart', 03:07:12 INFO - 'tscrollx', 03:07:12 INFO - 'cart']}, 03:07:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'talos_options': ['--disable-e10s'], 03:07:12 INFO - 'tests': ['tp5o']}, 03:07:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'tests': ['tp5o']}, 03:07:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'talos_options': ['--disable-e10s', 03:07:12 INFO - '--xperf_path', 03:07:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:12 INFO - 'tests': ['tp5n']}, 03:07:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:12 INFO - 'talos_options': ['--xperf_path', 03:07:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:12 INFO - 'tests': ['tp5n']}}, 03:07:12 INFO - 'talos.zip': {'path': '', 03:07:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:12 INFO - Running post-action listener: _resource_record_post_action 03:07:12 INFO - [mozharness: 2017-01-03 11:07:12.874560Z] Finished populate-webroot step (success) 03:07:12 INFO - [mozharness: 2017-01-03 11:07:12.874667Z] Running create-virtualenv step. 03:07:12 INFO - Running pre-action listener: _resource_record_pre_action 03:07:12 INFO - Running main action method: create_virtualenv 03:07:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:07:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:12 INFO - Using real prefix '/usr' 03:07:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:15 INFO - Installing pip.................done. 03:07:15 INFO - Return code: 0 03:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:15 INFO - Reading from file tmpfile_stdout 03:07:15 INFO - Output received: 03:07:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:07:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:07:15 INFO - Using env: {'DISPLAY': ':0', 03:07:15 INFO - 'HOME': '/home/cltbld', 03:07:15 INFO - 'LANG': 'en_US.UTF-8', 03:07:15 INFO - 'LANGUAGE': 'en_US:en', 03:07:15 INFO - 'LOGNAME': 'cltbld', 03:07:15 INFO - 'MAIL': '/var/mail/cltbld', 03:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:15 INFO - 'MOZ_NO_REMOTE': '1', 03:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:15 INFO - 'NO_EM_RESTART': '1', 03:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:15 INFO - 'PWD': '/builds/slave/test', 03:07:15 INFO - 'SHELL': '/bin/bash', 03:07:15 INFO - 'SHLVL': '1', 03:07:15 INFO - 'TERM': 'linux', 03:07:15 INFO - 'TMOUT': '86400', 03:07:15 INFO - 'USER': 'cltbld', 03:07:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:15 INFO - '_': '/tools/buildbot/bin/python'} 03:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:07:15 INFO - Cleaning up... 03:07:15 INFO - Return code: 0 03:07:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:07:15 INFO - Using env: {'DISPLAY': ':0', 03:07:15 INFO - 'HOME': '/home/cltbld', 03:07:15 INFO - 'LANG': 'en_US.UTF-8', 03:07:15 INFO - 'LANGUAGE': 'en_US:en', 03:07:15 INFO - 'LOGNAME': 'cltbld', 03:07:15 INFO - 'MAIL': '/var/mail/cltbld', 03:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:15 INFO - 'MOZ_NO_REMOTE': '1', 03:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:15 INFO - 'NO_EM_RESTART': '1', 03:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:15 INFO - 'PWD': '/builds/slave/test', 03:07:15 INFO - 'SHELL': '/bin/bash', 03:07:15 INFO - 'SHLVL': '1', 03:07:15 INFO - 'TERM': 'linux', 03:07:15 INFO - 'TMOUT': '86400', 03:07:15 INFO - 'USER': 'cltbld', 03:07:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:15 INFO - '_': '/tools/buildbot/bin/python'} 03:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:16 INFO - Downloading/unpacking psutil>=3.1.1 03:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:18 INFO - Installing collected packages: psutil 03:07:18 INFO - Running setup.py install for psutil 03:07:18 INFO - building 'psutil._psutil_linux' extension 03:07:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:07:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:07:18 INFO - building 'psutil._psutil_posix' extension 03:07:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:07:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:07:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:18 INFO - Successfully installed psutil 03:07:18 INFO - Cleaning up... 03:07:18 INFO - Return code: 0 03:07:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:07:18 INFO - Using env: {'DISPLAY': ':0', 03:07:18 INFO - 'HOME': '/home/cltbld', 03:07:18 INFO - 'LANG': 'en_US.UTF-8', 03:07:18 INFO - 'LANGUAGE': 'en_US:en', 03:07:18 INFO - 'LOGNAME': 'cltbld', 03:07:18 INFO - 'MAIL': '/var/mail/cltbld', 03:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:18 INFO - 'MOZ_NO_REMOTE': '1', 03:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:18 INFO - 'NO_EM_RESTART': '1', 03:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:18 INFO - 'PWD': '/builds/slave/test', 03:07:18 INFO - 'SHELL': '/bin/bash', 03:07:18 INFO - 'SHLVL': '1', 03:07:18 INFO - 'TERM': 'linux', 03:07:18 INFO - 'TMOUT': '86400', 03:07:18 INFO - 'USER': 'cltbld', 03:07:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:18 INFO - '_': '/tools/buildbot/bin/python'} 03:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:21 INFO - Installing collected packages: mozsystemmonitor 03:07:21 INFO - Running setup.py install for mozsystemmonitor 03:07:21 INFO - Successfully installed mozsystemmonitor 03:07:21 INFO - Cleaning up... 03:07:21 INFO - Return code: 0 03:07:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:21 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:07:21 INFO - Using env: {'DISPLAY': ':0', 03:07:21 INFO - 'HOME': '/home/cltbld', 03:07:21 INFO - 'LANG': 'en_US.UTF-8', 03:07:21 INFO - 'LANGUAGE': 'en_US:en', 03:07:21 INFO - 'LOGNAME': 'cltbld', 03:07:21 INFO - 'MAIL': '/var/mail/cltbld', 03:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:21 INFO - 'MOZ_NO_REMOTE': '1', 03:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:21 INFO - 'NO_EM_RESTART': '1', 03:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:21 INFO - 'PWD': '/builds/slave/test', 03:07:21 INFO - 'SHELL': '/bin/bash', 03:07:21 INFO - 'SHLVL': '1', 03:07:21 INFO - 'TERM': 'linux', 03:07:21 INFO - 'TMOUT': '86400', 03:07:21 INFO - 'USER': 'cltbld', 03:07:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:21 INFO - '_': '/tools/buildbot/bin/python'} 03:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:23 INFO - warning: no files found matching '*.txt' 03:07:23 INFO - no previously-included directories found matching 'build' 03:07:23 INFO - no previously-included directories found matching 'dist' 03:07:23 INFO - no previously-included directories found matching '.git*' 03:07:23 INFO - Installing collected packages: jsonschema, functools32 03:07:23 INFO - Running setup.py install for functools32 03:07:23 INFO - warning: no files found matching '*.txt' 03:07:23 INFO - no previously-included directories found matching 'build' 03:07:23 INFO - no previously-included directories found matching 'dist' 03:07:23 INFO - no previously-included directories found matching '.git*' 03:07:23 INFO - Successfully installed jsonschema functools32 03:07:23 INFO - Cleaning up... 03:07:23 INFO - Return code: 0 03:07:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:07:23 INFO - Using env: {'DISPLAY': ':0', 03:07:23 INFO - 'HOME': '/home/cltbld', 03:07:23 INFO - 'LANG': 'en_US.UTF-8', 03:07:23 INFO - 'LANGUAGE': 'en_US:en', 03:07:23 INFO - 'LOGNAME': 'cltbld', 03:07:23 INFO - 'MAIL': '/var/mail/cltbld', 03:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:23 INFO - 'MOZ_NO_REMOTE': '1', 03:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:23 INFO - 'NO_EM_RESTART': '1', 03:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:23 INFO - 'PWD': '/builds/slave/test', 03:07:23 INFO - 'SHELL': '/bin/bash', 03:07:23 INFO - 'SHLVL': '1', 03:07:23 INFO - 'TERM': 'linux', 03:07:23 INFO - 'TMOUT': '86400', 03:07:23 INFO - 'USER': 'cltbld', 03:07:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:23 INFO - '_': '/tools/buildbot/bin/python'} 03:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:24 INFO - Cleaning up... 03:07:24 INFO - Return code: 0 03:07:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:24 INFO - Using env: {'DISPLAY': ':0', 03:07:24 INFO - 'HOME': '/home/cltbld', 03:07:24 INFO - 'LANG': 'en_US.UTF-8', 03:07:24 INFO - 'LANGUAGE': 'en_US:en', 03:07:24 INFO - 'LOGNAME': 'cltbld', 03:07:24 INFO - 'MAIL': '/var/mail/cltbld', 03:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:24 INFO - 'MOZ_NO_REMOTE': '1', 03:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:24 INFO - 'NO_EM_RESTART': '1', 03:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:24 INFO - 'PWD': '/builds/slave/test', 03:07:24 INFO - 'SHELL': '/bin/bash', 03:07:24 INFO - 'SHLVL': '1', 03:07:24 INFO - 'TERM': 'linux', 03:07:24 INFO - 'TMOUT': '86400', 03:07:24 INFO - 'USER': 'cltbld', 03:07:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:24 INFO - '_': '/tools/buildbot/bin/python'} 03:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:26 INFO - Downloading docopt-0.6.1.tar.gz 03:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:27 INFO - Running setup.py install for blobuploader 03:07:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:27 INFO - Running setup.py install for requests 03:07:27 INFO - Running setup.py install for docopt 03:07:27 INFO - Successfully installed blobuploader requests docopt 03:07:27 INFO - Cleaning up... 03:07:27 INFO - Return code: 0 03:07:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:27 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:27 INFO - Using env: {'DISPLAY': ':0', 03:07:27 INFO - 'HOME': '/home/cltbld', 03:07:27 INFO - 'LANG': 'en_US.UTF-8', 03:07:27 INFO - 'LANGUAGE': 'en_US:en', 03:07:27 INFO - 'LOGNAME': 'cltbld', 03:07:27 INFO - 'MAIL': '/var/mail/cltbld', 03:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:27 INFO - 'MOZ_NO_REMOTE': '1', 03:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:27 INFO - 'NO_EM_RESTART': '1', 03:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:27 INFO - 'PWD': '/builds/slave/test', 03:07:27 INFO - 'SHELL': '/bin/bash', 03:07:27 INFO - 'SHLVL': '1', 03:07:27 INFO - 'TERM': 'linux', 03:07:27 INFO - 'TMOUT': '86400', 03:07:27 INFO - 'USER': 'cltbld', 03:07:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:27 INFO - '_': '/tools/buildbot/bin/python'} 03:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:27 INFO - Running setup.py (path:/tmp/pip-g4ZpCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:27 INFO - Running setup.py (path:/tmp/pip-DF2QJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:28 INFO - Running setup.py (path:/tmp/pip-wY0I50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:28 INFO - Running setup.py (path:/tmp/pip-lYqty2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:28 INFO - Running setup.py (path:/tmp/pip-EiaJWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:28 INFO - Running setup.py (path:/tmp/pip-XEcpSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:28 INFO - Running setup.py (path:/tmp/pip-wJFBME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:28 INFO - Running setup.py (path:/tmp/pip-5eIGU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:28 INFO - Running setup.py (path:/tmp/pip-tinT6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:28 INFO - Running setup.py (path:/tmp/pip-AfMYwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:28 INFO - Running setup.py (path:/tmp/pip-dRzKx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:28 INFO - Running setup.py (path:/tmp/pip-YzZrM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:28 INFO - Running setup.py (path:/tmp/pip-SMn0HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:28 INFO - Running setup.py (path:/tmp/pip-61pTGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:28 INFO - Running setup.py (path:/tmp/pip-kfXgJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:28 INFO - Running setup.py (path:/tmp/pip-2mW7H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:29 INFO - Running setup.py (path:/tmp/pip-z4t9Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:29 INFO - Running setup.py install for manifestparser 03:07:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Running setup.py install for mozcrash 03:07:29 INFO - Running setup.py install for mozdebug 03:07:29 INFO - Running setup.py install for mozdevice 03:07:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Running setup.py install for mozfile 03:07:29 INFO - Running setup.py install for mozhttpd 03:07:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Running setup.py install for mozinfo 03:07:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Running setup.py install for mozInstall 03:07:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Running setup.py install for mozleak 03:07:30 INFO - Running setup.py install for mozlog 03:07:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Running setup.py install for moznetwork 03:07:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Running setup.py install for mozprocess 03:07:30 INFO - Running setup.py install for mozprofile 03:07:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Running setup.py install for mozrunner 03:07:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Running setup.py install for mozscreenshot 03:07:30 INFO - Running setup.py install for moztest 03:07:30 INFO - Running setup.py install for mozversion 03:07:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:30 INFO - Cleaning up... 03:07:30 INFO - Return code: 0 03:07:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:30 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:30 INFO - Using env: {'DISPLAY': ':0', 03:07:30 INFO - 'HOME': '/home/cltbld', 03:07:30 INFO - 'LANG': 'en_US.UTF-8', 03:07:30 INFO - 'LANGUAGE': 'en_US:en', 03:07:30 INFO - 'LOGNAME': 'cltbld', 03:07:30 INFO - 'MAIL': '/var/mail/cltbld', 03:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:30 INFO - 'MOZ_NO_REMOTE': '1', 03:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:30 INFO - 'NO_EM_RESTART': '1', 03:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:30 INFO - 'PWD': '/builds/slave/test', 03:07:30 INFO - 'SHELL': '/bin/bash', 03:07:30 INFO - 'SHLVL': '1', 03:07:30 INFO - 'TERM': 'linux', 03:07:30 INFO - 'TMOUT': '86400', 03:07:30 INFO - 'USER': 'cltbld', 03:07:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:30 INFO - '_': '/tools/buildbot/bin/python'} 03:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:31 INFO - Running setup.py (path:/tmp/pip-p2oNr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:31 INFO - Running setup.py (path:/tmp/pip-_5_iih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:31 INFO - Running setup.py (path:/tmp/pip-B6733U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:31 INFO - Running setup.py (path:/tmp/pip-sXBTTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:31 INFO - Running setup.py (path:/tmp/pip-qCXOVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:31 INFO - Running setup.py (path:/tmp/pip-q7FPiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:31 INFO - Running setup.py (path:/tmp/pip-Yaid1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:31 INFO - Running setup.py (path:/tmp/pip-h9mo9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:31 INFO - Running setup.py (path:/tmp/pip-7sHHKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:31 INFO - Running setup.py (path:/tmp/pip-Nn38HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:31 INFO - Running setup.py (path:/tmp/pip-lv6wpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:31 INFO - Running setup.py (path:/tmp/pip-EQ4f1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:32 INFO - Running setup.py (path:/tmp/pip-XSPJZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:32 INFO - Running setup.py (path:/tmp/pip-ojcT3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:32 INFO - Running setup.py (path:/tmp/pip-J9gyh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:32 INFO - Running setup.py (path:/tmp/pip-RGYAjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:32 INFO - Running setup.py (path:/tmp/pip-Lg44jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07:34 INFO - Downloading blessings-1.6.tar.gz 03:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:34 INFO - Installing collected packages: blessings 03:07:34 INFO - Running setup.py install for blessings 03:07:34 INFO - Successfully installed blessings 03:07:34 INFO - Cleaning up... 03:07:34 INFO - Return code: 0 03:07:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:34 INFO - Reading from file tmpfile_stdout 03:07:34 INFO - Current package versions: 03:07:34 INFO - argparse == 1.2.1 03:07:34 INFO - blessings == 1.6 03:07:34 INFO - blobuploader == 1.2.4 03:07:34 INFO - docopt == 0.6.1 03:07:34 INFO - functools32 == 3.2.3-2 03:07:34 INFO - jsonschema == 2.5.1 03:07:34 INFO - manifestparser == 1.1 03:07:34 INFO - mozInstall == 1.12 03:07:34 INFO - mozcrash == 1.0 03:07:34 INFO - mozdebug == 0.1 03:07:34 INFO - mozdevice == 0.48 03:07:34 INFO - mozfile == 1.2 03:07:34 INFO - mozhttpd == 0.7 03:07:34 INFO - mozinfo == 0.9 03:07:34 INFO - mozleak == 0.1 03:07:34 INFO - mozlog == 3.4 03:07:34 INFO - moznetwork == 0.27 03:07:34 INFO - mozprocess == 0.23 03:07:34 INFO - mozprofile == 0.28 03:07:34 INFO - mozrunner == 6.13 03:07:34 INFO - mozscreenshot == 0.1 03:07:34 INFO - mozsystemmonitor == 0.3 03:07:34 INFO - moztest == 0.7 03:07:34 INFO - mozversion == 1.4 03:07:34 INFO - psutil == 3.1.1 03:07:34 INFO - requests == 1.2.3 03:07:34 INFO - wsgiref == 0.1.2 03:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:34 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 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:34 INFO - Using env: {'DISPLAY': ':0', 03:07:34 INFO - 'HOME': '/home/cltbld', 03:07:34 INFO - 'LANG': 'en_US.UTF-8', 03:07:34 INFO - 'LANGUAGE': 'en_US:en', 03:07:34 INFO - 'LOGNAME': 'cltbld', 03:07:34 INFO - 'MAIL': '/var/mail/cltbld', 03:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:34 INFO - 'MOZ_NO_REMOTE': '1', 03:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:34 INFO - 'NO_EM_RESTART': '1', 03:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:34 INFO - 'PWD': '/builds/slave/test', 03:07:34 INFO - 'SHELL': '/bin/bash', 03:07:34 INFO - 'SHLVL': '1', 03:07:34 INFO - 'TERM': 'linux', 03:07:34 INFO - 'TMOUT': '86400', 03:07:34 INFO - 'USER': 'cltbld', 03:07:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:34 INFO - '_': '/tools/buildbot/bin/python'} 03:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:07:35 INFO - Cleaning up... 03:07:35 INFO - Return code: 0 03:07:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3ee0fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, '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': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07: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', 'jsonschema'] in /builds/slave/test/build 03:07: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 jsonschema 03:07:35 INFO - Using env: {'DISPLAY': ':0', 03:07:35 INFO - 'HOME': '/home/cltbld', 03:07:35 INFO - 'LANG': 'en_US.UTF-8', 03:07:35 INFO - 'LANGUAGE': 'en_US:en', 03:07:35 INFO - 'LOGNAME': 'cltbld', 03:07:35 INFO - 'MAIL': '/var/mail/cltbld', 03:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:35 INFO - 'MOZ_NO_REMOTE': '1', 03:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:35 INFO - 'NO_EM_RESTART': '1', 03:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:35 INFO - 'PWD': '/builds/slave/test', 03:07:35 INFO - 'SHELL': '/bin/bash', 03:07:35 INFO - 'SHLVL': '1', 03:07:35 INFO - 'TERM': 'linux', 03:07:35 INFO - 'TMOUT': '86400', 03:07:35 INFO - 'USER': 'cltbld', 03:07:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:35 INFO - '_': '/tools/buildbot/bin/python'} 03:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:35 INFO - Cleaning up... 03:07:35 INFO - Return code: 0 03:07:35 INFO - Running post-action listener: _resource_record_post_action 03:07:35 INFO - Running post-action listener: _start_resource_monitoring 03:07:35 INFO - Starting resource monitoring. 03:07:35 INFO - [mozharness: 2017-01-03 11:07:35.367000Z] Finished create-virtualenv step (success) 03:07:35 INFO - [mozharness: 2017-01-03 11:07:35.367458Z] Running install step. 03:07:35 INFO - Running pre-action listener: _resource_record_pre_action 03:07:35 INFO - Running main action method: install 03:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:35 INFO - Reading from file tmpfile_stdout 03:07:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:35 INFO - Reading from file tmpfile_stdout 03:07:35 INFO - Output received: 03:07:35 INFO - Usage: mozinstall [options] installer 03:07:35 INFO - Options: 03:07:35 INFO - -h, --help show this help message and exit 03:07:35 INFO - -d DEST, --destination=DEST 03:07:35 INFO - Directory to install application into. [default: 03:07:35 INFO - "/builds/slave/test"] 03:07:35 INFO - --app=APP Application being installed. [default: firefox] 03:07:35 INFO - mkdir: /builds/slave/test/build/application 03:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:07:51 INFO - Reading from file tmpfile_stdout 03:07:51 INFO - Output received: 03:07:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:51 INFO - Running post-action listener: _resource_record_post_action 03:07:51 INFO - [mozharness: 2017-01-03 11:07:51.598992Z] Finished install step (success) 03:07:51 INFO - [mozharness: 2017-01-03 11:07:51.599234Z] Running run-tests step. 03:07:51 INFO - Running pre-action listener: _resource_record_pre_action 03:07:51 INFO - Running main action method: run_tests 03:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:51 INFO - Python 2.7.3 03:07:51 INFO - Return code: 0 03:07:51 INFO - grabbing minidump binary from tooltool 03:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:51 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 0x1dc4f60>, '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 0x1dc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:07:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:07:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:07:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:51 INFO - Return code: 0 03:07:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:07:51 INFO - Using env: {'DISPLAY': ':0', 03:07:51 INFO - 'HOME': '/home/cltbld', 03:07:51 INFO - 'LANG': 'en_US.UTF-8', 03:07:51 INFO - 'LANGUAGE': 'en_US:en', 03:07:51 INFO - 'LOGNAME': 'cltbld', 03:07:51 INFO - 'MAIL': '/var/mail/cltbld', 03:07:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:51 INFO - 'MOZ_NO_REMOTE': '1', 03:07:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:51 INFO - 'NO_EM_RESTART': '1', 03:07:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:51 INFO - 'PWD': '/builds/slave/test', 03:07:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:51 INFO - 'SHELL': '/bin/bash', 03:07:51 INFO - 'SHLVL': '1', 03:07:51 INFO - 'TERM': 'linux', 03:07:51 INFO - 'TMOUT': '86400', 03:07:51 INFO - 'USER': 'cltbld', 03:07:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527', 03:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:51 INFO - '_': '/tools/buildbot/bin/python'} 03:07:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:07:51 INFO - mozversion application_buildid: 20170103004005 03:07:51 INFO - mozversion application_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 03:07:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:07:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:51 INFO - mozversion application_name: Firefox 03:07:51 INFO - mozversion application_remotingname: firefox-dev 03:07:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:51 INFO - mozversion application_vendor: Mozilla 03:07:51 INFO - mozversion application_version: 52.0a2 03:07:51 INFO - mozversion platform_buildid: 20170103004005 03:07:51 INFO - mozversion platform_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 03:07:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:51 INFO - mozversion platform_version: 52.0a2 03:07:51 INFO - using testdate: 1483441671 03:07:51 INFO - actual date: 1483441671 03:07:51 INFO - starting webserver on 'localhost:43595' 03:07:51 INFO - SUITE-START | Running 2 tests 03:07:51 INFO - TEST-START | dromaeo_css 03:07:51 INFO - operating with platform_type : linux_ 03:07:51 INFO - Initialising browser for dromaeo_css test... 03:07:51 INFO - TEST-INFO | started process 12720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAYB8V/profile http://localhost:43595/getInfo.html) 03:07:56 INFO - PROCESS | 12720 | __metrics Screen width/height:1600/1200 03:07:56 INFO - PROCESS | 12720 | colorDepth:24 03:07:56 INFO - PROCESS | 12720 | Browser inner width/height: 1024/697 03:07:56 INFO - PROCESS | 12720 | __metrics 03:07:56 INFO - PROCESS | 12720 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:07:56 INFO - PROCESS | 12720 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:57 INFO - PROCESS | 12720 | console.error: PushService: 03:07:57 INFO - PROCESS | 12720 | stateChangeProcessEnqueue: Error transitioning state 03:07:57 INFO - PROCESS | 12720 | UnknownError 03:07:58 INFO - TEST-INFO | 12720: exit 0 03:07:58 INFO - Browser initialized. 03:07:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:58 INFO - TEST-INFO | started process 12813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAYB8V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:09 INFO - PROCESS | 12813 | RSS: Main: 144482304 03:08:09 INFO - PROCESS | 12813 | 03:09:01 INFO - PROCESS | 12813 | 1483441741580 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:11:11 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43595/tests/dromaeo/cssquery-ext.html) 03:11:12 INFO - PROCESS | 12813 | RSS: Main: 252358656 03:11:12 INFO - PROCESS | 12813 | 03:14:15 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-ext.html (next: http://localhost:43595/tests/dromaeo/cssquery-jquery.html) 03:14:15 INFO - PROCESS | 12813 | RSS: Main: 230641664 03:14:15 INFO - PROCESS | 12813 | 03:17:17 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43595/tests/dromaeo/cssquery-mootools.html) 03:17:18 INFO - PROCESS | 12813 | RSS: Main: 174825472 03:17:18 INFO - PROCESS | 12813 | 03:20:20 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43595/tests/dromaeo/cssquery-prototype.html) 03:20:21 INFO - PROCESS | 12813 | RSS: Main: 226656256 03:20:21 INFO - PROCESS | 12813 | 03:23:23 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43595/tests/dromaeo/cssquery-yui.html) 03:23:24 INFO - PROCESS | 12813 | RSS: Main: 176005120 03:23:24 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-yui.html (next: http://localhost:43595/tests/dromaeo/cssquery-dojo.html) 03:26:27 INFO - PROCESS | 12813 | RSS: Main: 259309568 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | __start_tp_report 03:26:27 INFO - PROCESS | 12813 | _x_x_mozilla_page_load 03:26:27 INFO - PROCESS | 12813 | _x_x_mozilla_page_load_details 03:26:27 INFO - PROCESS | 12813 | |i|pagename|runs| 03:26:27 INFO - PROCESS | 12813 | |0;dojo.html;3169.6196456425223;3248.090534650298;3254.4955531892565;3275.6724327567263;3284.0312107928157;5485.9725701371535;5544.528715059225;5556.16657501375;5564.888702225958;5570.025245582022;5577.69322687252;5595.356533998592;5600.887982240363;5603.60774745768;5605.663660180392;5072.442031376546;5081.898362032757;5113.054084994269;5114.156164232916;5193.662411943231;4919.901601967977;4966.428860681031;5121.487851214886;5168.8707782305555;5175.974120129394;5035.874103147414;5068.5691716204165;5068.797248110071;5074.695518268897;5083.872903177413;5096.898062038776;5099.33708617881;5112.923306150411;5158.2859445663335;5166.844994650167;5016.44819069902;5096.949030509684;5111.821086261963;5121.615878809104;5145.382554093495;5360;5412.242286079952;5448.37343705471;5466.070767969415;5520.503154716054;5885.70571471429;5905.73424195908;5907.350191478934;5991.281046274475;5999.370066143079;6027.789027384064;6047.5766696331275;6058.666773327465;6060.969695151496;6065.787697430569;5381.434949330264;5407.891842163135;5416.322959630046;5436.6194366393975;5438.564914806845;5954.880902382015;5977.790777322773;5979.611325263844;5982.581219314607;5996.490298324604;5721.199032135504;5731.340895797037;5744.913826292609;5746.080627099727;5749.195112684228;5759.1937128802;5802.767889284381;5879.118132280107;5903.557233207526;5917.437843404869;5958.940410595926;5970.2238708968425;5976.432238937294;6004.099385092271;6014.218151640259;5920.526357891358;5967.46292833647;5980.401959804072;5980.641161530322;5987.311459182162;4538.704984176018;4541.43232095988;4560.931586026212;4580.358749775034;4632.768361581908;4060.6653620352345;4083.97958010214;4092.3452247640234;4131.318332475108;4131.855385061508;5539.501444869981;5628.943710562924;5629.324481062299;5629.690367029771;5654.4062873398525;5895.823125306248;5938.168656388109;5948.434898684618;5951.107333899863;5961.910571341434;5634.408387119375;5663.915041274302;5698.2592263005545;5699.487046165782;5703.828885133453;5187.247849061865;5204.739763011834;5214.113600687892;5215.687058776485;5216.765245563959;6127.387261273926;6135.477655820289;6156.569040167145;6186.938130618636;6198.938010619926;5986.311574169026;5987.251593550806;6001.459868611846;6011.90982135277;6022.277326720821;6214.8135555933395;6221.875562488634;6223.408776166257;6225.533085018551;6238.407351301619;5738.483536481736;5802.274715660543;5805.564582656233;5893;5897.852553686021;5949.405059494016;6043.607165534227;6054.969725151346;6075.27096748393;6094.299155597163;5877.676727779842;5886.793962211302;5889.676067816311;5890.175375447355;5890.852728681817;5592.524635405874;5649.802256920988;5882.735276912635;5893.5874488785375;5897.439743224387;5611.382747897646;5648.378678345461;5659.151127330933;5717.485426311652;5747.252857128714;5817.331006934257;5837.737301821343;5839.065749480063;5843.357230704704;5843.532517398683;5596.580256480862;5699.857503562444;5704.058830293121;5714.085746280575;5714.79998200061 03:26:27 INFO - PROCESS | 12813 | |1;ext.html;586.5923183387547;617.9412955769202;647.621141632145;650.8828410886039;668.335006668365;33915;36904.44643330352;43859.56140438599;45000.09999800002;45047.09905801882;46179.76910115453;46483;46564.301535476996;46629.766851165696;46692.29961550579;8761.430507017056;8908.777280568005;8914.197722205;8951.910480895172;8956.328275379372;8368.623411946446;8596.570171491432;8869.778255543599;10609.204309676805;10927.890721092766;10912.23614346996;10981.780364392707;10987.61543345983;10991.890081099207;10993;10789.946050269738;10798.892011079868;10837.512311945982;10852.620158294421;10859;10678.572857085706;10711.785764284748;10719.62481313158;10742.355458672504;10743.086837618812;43095.56904430947;43323.56676433227;43386.34920476195;43414.782926085485;43524;3736.4955730976512;3762.172322089136;3832.8275227614545;3889.630485103911;3918;32684;32887.835560822285;32969.835150824096;33093.3381332372;33346.33307333864;4451.643868490545;4463.732176069414;4484.618807401374;4536.392553786197;4549.24937385331;356217;356856;357079;357086;358316;61148.082778758355;61374.69312653498;61522;61541;61595;42077.57922420798;42751.57248427476;43060.56939430628;43074;43084.784576077545;19222;19380.612387752168;19386.612267754565;19400.514987125436;19432.902835485733;13560.796588051187;14867.959242853112;14923;14936.925315373353;14977.850221497863;17511.824881751276;19291.228350866088;19696.90151549233;19758.209671612974;20504.58990820205;7223.530470519399;7329.408589791071;7443.665035073434;7626.656800443993;7644.388448924073;1008.8688470498788;1012.8480727890728;1071.6731396923858;1100.873399559061;1160.3965937712342;33232;33438.4984225232;33629.82295619642;34114.82942585321;34423.311533769185;1076.332673742285;1089.9509522071367;1140.2816225777872;1268.194696367813;1295.792673172288;14625;17905.344610401127;18524.81475185258;18662.906685466485;18739.90630046841;531063;532072;533051;533223;533653;61046;61443;61534;61715.38284617186;61780.69109654423;1312.4618906248584;1345.8855997240344;1374.5944946240884;1434.1825159658895;1443.3865607117143;30817.845910770302;34790;35229.82385088058;35371.46942795911;35525.644743552235;52272.47727522676;52968.20547691711;53019;53047.40857774273;53080;313895;315145;315385;315409;315956;30847.2288192797;30965.225869353446;33328.50007249845;33355.49966750452;33779.83110084434;49515;49597.75201124116;49623.751881240365;50023.74988125036;50286;41383.586164137974;41660.1667966645;42616.78691606522;43503.347449787645;44213.55786442223;41807.16385672209;41868;42520.78739606282;42948.78525607352;43272.56727432811;42488.362674559285;42879.14241715211;43061;43423.782881086656;43647.34528982004;36140.63859361478;37771.2445751078;38622;38671.80664096661;38734.2253154941;28449.857750711115;28572.142835714963;28966.565501517915;29225.269368265963;29285.7071429283 03:26:27 INFO - PROCESS | 12813 | |2;jquery.html;408.74861959894673;420.64665680828097;425.4086819321144;435.42523868493583;442.960133587977;15370.69258614827;19937.900310498444;19965.900170499146;20247.291344802936;21437;21017.894910525465;21119;21166.470838229052;21177.788222117775;21408.14367425305;5701.401352857953;5729.684867332306;5874.471297583216;5916.319623243317;5926.140709597106;5713.514351280146;5811.0702287633985;5861.648301101947;5866.5306775458075;5869.618474799146;5623.971880140593;5779.9422005779825;5816;5818.738156782955;5824.301083869942;5589.832305030855;5784.074548072288;5808.767649294024;5812.128180772876;5820.068788993783;5627.718614069321;5710.8001219957105;5712.6286791358425;5713.143028545752;5722.599418040739;14295.642608934755;14455.855441445661;14633.926830365886;14678.339474723556;14839.10965342083;2385.4751954569965;2528.645989561463;2712;2732.7267273272714;3039.8024128431803;10804.891951080546;10820.513076911559;11928.165028448013;15122.470713525085;15258.00822946505;1966.9311574094982;1978.436145698469;2041.2651445479617;2054.496648321156;2056.1980827477296;64493;81122;84893.57553212256;88667;91423.54288228517;10035.79928401428;10442.373457592568;10627.893721062845;10799.298045627009;11117.388543630179;14860.925695371454;14870.256487175599;14900;14960;15030.248487575796;8503.1921967413;8543.658253669908;8575.142485751376;8651.610677519528;8891.555422228863;7624.771256862303;8042.115367309708;8053.355731541463;8719.651213951498;8727.083656216133;4503.234450143484;4510.684252102387;4532.546745325507;4595.862124136282;4638.884027899262;2016.1129103194548;2045.8056484634233;2081.2819577245828;2127.702121702963;2147.3021268087623;906.8911730592371;911.4986757283467;945.9148676619;1008.9848652270222;1013.2350075692805;20439;20636.48408789762;20743.377698669065;20846;20892.79107208939;993.2451336983944;994.7811481474064;1009.6970908727352;1012.7620009297956;1016.217512515359;10628.474980143;11426;11701.473433695504;11717.296962182296;11723.648290551126;441389;442781;446622;459950;485012;74084;78054;95813.5209323949;96576;97718;930.8464103422995;947.7441090905417;968.9660861869942;979.4270351844251;979.7207795778312;17909.910450447664;18232.635347293246;18557.536061598028;18594.22770582469;18715.438536843918;40797.18405631811;44113.338299924886;44206;44347.33478997753;44844.55155448534;52710.472895270555;60351;61446.69276653588;62294.688526557075;63534;8388.958055209929;8748.693795717374;8902.287816974756;9122.179003889682;12377.76222377755;13151.53969611059;13675;13831.654208644864;14056.086354386933;14342.354594043085;12786.424610892345;12996.285204313854;13109.73780524365;13120.212787232796;13189.670258243621;12662.430190641258;12733.236005839679;12746.171498852545;12834.614596914023;13030.934845325713;13198;13218.339083046001;13295.135816171918;13391.263480508665;13591.388387522784;13313.134646247963;13325.533606323732;13445.327733613476;13504.72990540164;13562.728745425233;12746;12773.552925647558;13175.538856139989;13179.60461186166;13453.260070696206 03:26:27 INFO - PROCESS | 12813 | |3;mootools.html;1495.521433141395;1512.5386757039105;1674.3795959323656;1721.8622510199186;1821.5081927879473;7823.413244006701;8427.325813934885;8432.156784321565;8433.45182563133;8436.114208008163;7245.7826265212125;7415.369693576053;7422.962885185567;7601.277878601524;8310.83378332433;2052.722882410878;2338.6024375856146;2387.403149212697;2401.4836810085826;2429.5991161458337;2432.2946345559767;2457.5453541094867;2462.963055554168;2464.297675162579;2467.481828815951;2390.1873363056557;2408.7109546854404;2410.0359856057544;2414.7223069346987;2415.5410472010262;2300.6894069300597;2336.556054349685;2336.696229490164;2339.7426283108844;2341.309313752447;2311.91908283211;2362.303120579433;2390.5816482115733;2392.5454163709014;2397;8414.957925210396;8457.577121143919;8482.321414286904;8484.872726909101;8494.490330580185;5338.62629615927;5455.781768729246;5475.67145971239;5476.17857321401;5481.287432633772;3445.552078229839;3598.5321908151773;3698.0939669780805;3716.5725941516803;3741.7380783345175;1115.397685249964;1144.30769384522;1163.3834067944003;1202.4228370382266;1206.215959626241;11604.30374177552;11622.6513204604;11664.475098620582;11723.355215463145;11752.764944701144;4649.163150632851;4745.1221524018165;4828.734419606885;4840.975795121002;4919.237518184687;9904.504774761233;9923.255755818342;9926.950365248127;9930.553125109243;9933.950330248446;5459.071957767189;5472.91790623141;5478.287822583039;5482.5613950883835;5483.067878460672;4305.97847010763;4956.3804524434445;4990.775415106329;5077.644564880423;5082.161443361804;3747.7376583638884;4029.81865816039;4155.000615081806;4170.520390155171;4183.477065366829;1347.3600039981127;1347.7708789505807;1353.9255340956145;1368.0492058019581;1385.3281158638054;813.7192668529348;854.2615776893991;864.9783755406039;887.1350433327455;895.4045559702855;5742.16738572913;5759.8560035999435;5775.451332123442;5917.437843404869;5950.7917222896995;902.3457992955186;932.1703683721494;940.5579377692474;997.6059456514636;1001.8397056471075;3937.448757173998;4093.3655283431117;4098.467199264077;4136.875893723193;4150.937735933963;10019.098281154585;10224.897751022394;10291.433971131659;10311.742206444898;10345.327553708985;9590.760230994281;10029.147522460673;10033.247506437046;10234.6417875374;10253.94873025645;7811.414143939227;8021.518708877369;8036.919630803617;8050.838983220303;8059.919400806034;5643.915341269966;5783.132530120515;5789.8552536186935;6008.729607167776;6083.482903953213;9181;9229.953850230706;9394.95302523483;9408.905910940803;9469.952650236704;9624.807503850025;9721.56252968604;9738.707838764849;9763.463009534544;9768.120869121813;7468.92531074704;7594.050743657043;7600.745876930466;7615.7334493292465;7628.847423051397;6621.9337806621315;6718.731250750111;7909;8023.318017968538;8249.092599813896;6995.685194166376;7048.259932706992;7113.715451381887;7115.1106111736035;7243.818904527218;7067.646617669199;7106.5736055836815;7185.820354491179;7186.10173728284;7309.926900730925;6841;6849.280825513449;6924.238333783381;6947.40947019509;6969.2682268361095;4920.6063514918005;4943.65394422387;4946.554810067111;4951.10880041596;5031.899362012812;4895.290182923527;5050.823221187241;5057.7724002419245;5133.230015497706;5157.6647517911215 03:26:27 INFO - PROCESS | 12813 | |4;prototype.html;351.4885841101198;360.545712402373;362.5957057880463;368.4725094943086;372.54177361844916;5292.89414211716;5314.707691076989;5321.52106310432;5376.064616737971;5391.2991311129545;5239.816606418776;5276.314079169712;5281.70950597717;5285.814996475124;5306.93861227754;3774.4904437900946;4075.673946084321;4232.6613870890405;4240.300350442173;4265.786710664454;4157.688173387008;4212.031232816454;4232.9788351058205;4236.406903033578;4251.404803327521;4180.540140584533;4183.477065366829;4195.748255104703;4199.9370009449885;4215.43091682622;4025.838966441368;4166.375043743433;4202.327627579572;4206.957930420703;4214.36784482327;3695.8706445274556;3786.129190286222;3795.6773674237725;3802.372608519591;3805.0487378155462;5169.638125331228;5173.896522069537;5203.271541984087;5214.6871187728475;5225.425203227642;4696.272077827942;4849.442314133849;4864.683795553313;4868.756562171912;4880.145974454456;5482.725863706839;5529.529989950819;5535.750891209906;5577.470140336662;5584.883023395337;4131.35963925592;4141.399497072907;4146.419501269825;4148.8133034013545;4154.605312495308;5219.634625576173;5530.723463826793;5641.041023026095;5653.604247702621;5667.3482549506925;4219.43037689914;4222.873313800591;4226.13364260332;4233.470816147981;4258.297380932174;4309.84915527955;4317.525072242051;4325.545817689161;4335.856504034549;4348.239058164809;4565.178267911741;4773.307870358848;4798.904021919612;4827.637927155477;4849.127157111683;5573.554115670737;5580.246666700024;5580.720963951786;5594.748236329294;5637.746301416446;1404.2657318212;1433.6989232261133;1435.6410897275682;1459.4672944375227;1459.6060761972292;965.4834663455018;1004.5128112865254;1008.7377281906757;1012.2559918459926;1029.063552167524;5185.818496352609;5234.162533994542;5234.712090834964;5236.214567814858;5299.44355842631;5490;5498.670079795145;5510.834674959758;5512.283403157564;5523.530499907472;4985.202367621163;5208.713520756395;5219.921701174486;5266.052110620125;5315.521603055666;2929.399473108008;2939.955900661492;2942.867570959312;2943.2788966703297;2967.3768508613434;5667.3482549507335;5681.403452637496;5719.370869204467;5727.3699893011735;5733.6273142246455;5365.597580181502;5550.306211723535;5573.219749235111;5574.777008919597;5593;5624.97187514068;5649.491545760901;5669.659820410789;5670.659760414388;5673.773049078073;5188.242230270277;5455.918161227664;5456.836294911159;5503.422140675331;5518.917216241679;5388.865278368072;5422.451447819676;5433.2665090213895;5441.884413695262;5466.562674986071;5621.4659607337235;5666.631668941505;5786.826395208151;5876.206712093813;5892.322382926019;4138.220565157011;4162.854300099482;4179.2477354076555;4203.369494575838;4211.915761684688;5620.606557540933;5651.8304450866535;5734.913976290442;5745.862978655361;5783.624064435799;5532.778688852401;5537.446255374431;5547.472990065938;5558.749856256559;5562.886103280727;5496.780128794803;5559.52744016747;5572.356154934385;5589.748461319332;5607.915881261866;5311.3891902431715;5514.889702206014;5541.806036788855;5547.750351234124;5593.106032221806;5640.605157638925;5643.181738647955;5653.095504719226;5657.830265092054;5658.462446067617;5428.902147615683;5539.695316757617;5557.805476808292;5568.192612071308;5572.495426234975 03:26:27 INFO - PROCESS | 12813 | |5;yui.html;784.5410434895585;811.059171361221;815.4903185509057;824.8391563645088;845.3786466946789;14152.221627810466;14685.412583496674;14711.852881471195;14731.92634036831;14745.557633270992;14489.63775905603;14754.557363279118;14761.557153285392;14771.335289911953;14780.852191478081;710.2790667472493;725.5936675461732;828.494618282847;842.2251528593678;847.4406891451644;850.783050322167;855.2516548020482;855.3969451536652;855.4696088425154;858.9613467393982;906.9773255668628;907.3331101640289;911.9270458363349;912.5802131019739;912.7307444303947;743.1750756660103;768.757841279995;875.2297977779546;884;898.1467605774541;648.8021153548166;649.759588952086;649.8667773106501;650.6031320894251;650.7657243392422;12433.254004759743;12439.689007774878;12453.190542614791;12457.252564846138;12468.75062498745;14497.492587759483;14553.126812391185;14605.12369257848;14610.342534585969;14750.546630856988;13049;13092;13117.934410327887;13378;13523.661908452268;3844.653981141683;4157.417961485395;4187.246295666779;4221.409002739619;4292.29177185764;53260;57828;63313.683431583006;63405;63916.36083639197;11679.883201167879;11930.463129159209;12008.759824803456;12081;12178.147529672839;20685.17259309641;20692.275770347966;20693.68959465609;20699.482512936996;20722.58554828925;8635.654573816977;8657.134286571292;8912.777180570538;8960.731178064669;9160.45037297751;4783.162946484351;4790.664653474293;4834.299026641117;4888.046830868017;4916.0905232532095;3586.905993671955;3604.351216780952;3664.3953747631876;3677.4667673187237;3701.7784131237167;657.0472814419112;668.866226754651;670.3162773970523;675.0684056002783;679.9762008329784;703.644659446976;734.6547122852251;740.5371642723298;746.7610364683358;763.393102483527;9916.752081197883;10093.5457904393;10254.28220024591;10582.735431614272;10692.144628429707;722.5411863466632;723.7756295548292;740.6000759589868;745.8955746195428;761.3224230434918;4935.90128197434;4936.308916751657;5059.06407314648;5114.360704911886;5149.073166830007;75607.86588201181;88155;90613.54693226492;92602;95180.52409738046;75332;82560.55707535439;83695.58152209321;84535;85718;70979;73196.90204646828;74909.62545187239;76367.23632763712;76873.6156319226;9529.237660987243;9682.806343873224;9812.55843487059;9819.950900245452;9842.803143937224;45401;47333.76333118312;48325;48413.5158648409;48507;60851.69574152278;67147.66426168033;67295;68899.31100688929;70465.29534704793;11505.36720480348;12084.274943503418;12371.814422783485;12520.436580354088;12530.248185108923;13162.341882905625;13322.86677133255;13384.19694818314;13592.048556600943;13629.318534073058;11582.141913878815;13436.19382837033;13522.391492382669;13624.863751362756;13885.65285867821;13239.602811915658;13461.394237259543;13674.042817002713;13860.861391385957;13899.51351702726;13373;13434.328283585977;13808.309584520935;13856.653583660085;14021;10508.947455262674;10636.042756151983;10823.134149268197;10875.891241087487;11328.546858125583;10400.5994005994;10741.946290268499;11458.942705286754;11872.584459543874;12181.87818121843 03:26:27 INFO - PROCESS | 12813 | __end_tp_report 03:26:27 INFO - PROCESS | 12813 | __start_cc_report 03:26:27 INFO - PROCESS | 12813 | _x_x_mozilla_cycle_collect,1096 03:26:27 INFO - PROCESS | 12813 | __end_cc_report 03:26:27 INFO - PROCESS | 12813 | __startTimestamp1483442787362__endTimestamp 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | ------- Summary: start ------- 03:26:27 INFO - PROCESS | 12813 | Number of tests: 6 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#0] dojo.html Cycles:165 Average:5529.55 Median:5704.06 stddev:617.09 (10.8%) stddev-sans-first:590.55 03:26:27 INFO - PROCESS | 12813 | Values: 3169.6 3248.1 3254.5 3275.7 3284.0 5486.0 5544.5 5556.2 5564.9 5570.0 5577.7 5595.4 5600.9 5603.6 5605.7 5072.4 5081.9 5113.1 5114.2 5193.7 4919.9 4966.4 5121.5 5168.9 5176.0 5035.9 5068.6 5068.8 5074.7 5083.9 5096.9 5099.3 5112.9 5158.3 5166.8 5016.4 5096.9 5111.8 5121.6 5145.4 5360.0 5412.2 5448.4 5466.1 5520.5 5885.7 5905.7 5907.4 5991.3 5999.4 6027.8 6047.6 6058.7 6061.0 6065.8 5381.4 5407.9 5416.3 5436.6 5438.6 5954.9 5977.8 5979.6 5982.6 5996.5 5721.2 5731.3 5744.9 5746.1 5749.2 5759.2 5802.8 5879.1 5903.6 5917.4 5958.9 5970.2 5976.4 6004.1 6014.2 5920.5 5967.5 5980.4 5980.6 5987.3 4538.7 4541.4 4560.9 4580.4 4632.8 4060.7 4084.0 4092.3 4131.3 4131.9 5539.5 5628.9 5629.3 5629.7 5654.4 5895.8 5938.2 5948.4 5951.1 5961.9 5634.4 5663.9 5698.3 5699.5 5703.8 5187.2 5204.7 5214.1 5215.7 5216.8 6127.4 6135.5 6156.6 6186.9 6198.9 5986.3 5987.3 6001.5 6011.9 6022.3 6214.8 6221.9 6223.4 6225.5 6238.4 5738.5 5802.3 5805.6 5893.0 5897.9 5949.4 6043.6 6055.0 6075.3 6094.3 5877.7 5886.8 5889.7 5890.2 5890.9 5592.5 5649.8 5882.7 5893.6 5897.4 5611.4 5648.4 5659.2 5717.5 5747.3 5817.3 5837.7 5839.1 5843.4 5843.5 5596.6 5699.9 5704.1 5714.1 5714.8 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#1] ext.html Cycles:180 Average:57634.14 Median:3749.33 stddev:109018.95 (2907.7%) stddev-sans-first:109240.64 03:26:27 INFO - PROCESS | 12813 | Values: 586.6 617.9 647.6 650.9 668.3 33915.0 36904.4 43859.6 45000.1 45047.1 46179.8 46483.0 46564.3 46629.8 46692.3 8761.4 8908.8 8914.2 8951.9 8956.3 8368.6 8596.6 8869.8 10609.2 10927.9 10912.2 10981.8 10987.6 10991.9 10993.0 10789.9 10798.9 10837.5 10852.6 10859.0 10678.6 10711.8 10719.6 10742.4 10743.1 43095.6 43323.6 43386.3 43414.8 43524.0 3736.5 3762.2 3832.8 3889.6 3918.0 32684.0 32887.8 32969.8 33093.3 33346.3 4451.6 4463.7 4484.6 4536.4 4549.2 356217.0 356856.0 357079.0 357086.0 358316.0 61148.1 61374.7 61522.0 61541.0 61595.0 42077.6 42751.6 43060.6 43074.0 43084.8 19222.0 19380.6 19386.6 19400.5 19432.9 13560.8 14868.0 14923.0 14936.9 14977.9 17511.8 19291.2 19696.9 19758.2 20504.6 7223.5 7329.4 7443.7 7626.7 7644.4 1008.9 1012.8 1071.7 1100.9 1160.4 33232.0 33438.5 33629.8 34114.8 34423.3 1076.3 1090.0 1140.3 1268.2 1295.8 14625.0 17905.3 18524.8 18662.9 18739.9 531063.0 532072.0 533051.0 533223.0 533653.0 61046.0 61443.0 61534.0 61715.4 61780.7 1312.5 1345.9 1374.6 1434.2 1443.4 30817.8 34790.0 35229.8 35371.5 35525.6 52272.5 52968.2 53019.0 53047.4 53080.0 313895.0 315145.0 315385.0 315409.0 315956.0 30847.2 30965.2 33328.5 33355.5 33779.8 49515.0 49597.8 49623.8 50023.7 50286.0 41383.6 41660.2 42616.8 43503.3 44213.6 41807.2 41868.0 42520.8 42948.8 43272.6 42488.4 42879.1 43061.0 43423.8 43647.3 36140.6 37771.2 38622.0 38671.8 38734.2 28449.9 28572.1 28966.6 29225.3 29285.7 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#2] jquery.html Cycles:180 Average:28414.07 Median:2266.39 stddev:75226.62 (3319.2%) stddev-sans-first:75408.26 03:26:27 INFO - PROCESS | 12813 | Values: 408.7 420.6 425.4 435.4 443.0 15370.7 19937.9 19965.9 20247.3 21437.0 21017.9 21119.0 21166.5 21177.8 21408.1 5701.4 5729.7 5874.5 5916.3 5926.1 5713.5 5811.1 5861.6 5866.5 5869.6 5624.0 5779.9 5816.0 5818.7 5824.3 5589.8 5784.1 5808.8 5812.1 5820.1 5627.7 5710.8 5712.6 5713.1 5722.6 14295.6 14455.9 14633.9 14678.3 14839.1 2385.5 2528.6 2712.0 2732.7 3039.8 10804.9 10820.5 11928.2 15122.5 15258.0 1966.9 1978.4 2041.3 2054.5 2056.2 64493.0 81122.0 84893.6 88667.0 91423.5 10035.8 10442.4 10627.9 10799.3 11117.4 14860.9 14870.3 14900.0 14960.0 15030.2 8503.2 8543.7 8575.1 8651.6 8891.6 7624.8 8042.1 8053.4 8719.7 8727.1 4503.2 4510.7 4532.5 4595.9 4638.9 2016.1 2045.8 2081.3 2127.7 2147.3 906.9 911.5 945.9 1009.0 1013.2 20439.0 20636.5 20743.4 20846.0 20892.8 993.2 994.8 1009.7 1012.8 1016.2 10628.5 11426.0 11701.5 11717.3 11723.6 441389.0 442781.0 446622.0 459950.0 485012.0 74084.0 78054.0 95813.5 96576.0 97718.0 930.8 947.7 969.0 979.4 979.7 17909.9 18232.6 18557.5 18594.2 18715.4 40797.2 44113.3 44206.0 44347.3 44844.6 52710.5 60351.0 61446.7 62294.7 63534.0 8389.0 8748.7 8902.3 9122.2 12377.8 13151.5 13675.0 13831.7 14056.1 14342.4 12786.4 12996.3 13109.7 13120.2 13189.7 12662.4 12733.2 12746.2 12834.6 13030.9 13198.0 13218.3 13295.1 13391.3 13591.4 13313.1 13325.5 13445.3 13504.7 13562.7 12746.0 12773.6 13175.5 13179.6 13453.3 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#3] mootools.html Cycles:180 Average:5598.11 Median:5397.20 stddev:3025.71 (56.1%) stddev-sans-first:3018.49 03:26:27 INFO - PROCESS | 12813 | Values: 1495.5 1512.5 1674.4 1721.9 1821.5 7823.4 8427.3 8432.2 8433.5 8436.1 7245.8 7415.4 7423.0 7601.3 8310.8 2052.7 2338.6 2387.4 2401.5 2429.6 2432.3 2457.5 2463.0 2464.3 2467.5 2390.2 2408.7 2410.0 2414.7 2415.5 2300.7 2336.6 2336.7 2339.7 2341.3 2311.9 2362.3 2390.6 2392.5 2397.0 8415.0 8457.6 8482.3 8484.9 8494.5 5338.6 5455.8 5475.7 5476.2 5481.3 3445.6 3598.5 3698.1 3716.6 3741.7 1115.4 1144.3 1163.4 1202.4 1206.2 11604.3 11622.7 11664.5 11723.4 11752.8 4649.2 4745.1 4828.7 4841.0 4919.2 9904.5 9923.3 9927.0 9930.6 9934.0 5459.1 5472.9 5478.3 5482.6 5483.1 4306.0 4956.4 4990.8 5077.6 5082.2 3747.7 4029.8 4155.0 4170.5 4183.5 1347.4 1347.8 1353.9 1368.0 1385.3 813.7 854.3 865.0 887.1 895.4 5742.2 5759.9 5775.5 5917.4 5950.8 902.3 932.2 940.6 997.6 1001.8 3937.4 4093.4 4098.5 4136.9 4150.9 10019.1 10224.9 10291.4 10311.7 10345.3 9590.8 10029.1 10033.2 10234.6 10253.9 7811.4 8021.5 8036.9 8050.8 8059.9 5643.9 5783.1 5789.9 6008.7 6083.5 9181.0 9230.0 9395.0 9408.9 9470.0 9624.8 9721.6 9738.7 9763.5 9768.1 7468.9 7594.1 7600.7 7615.7 7628.8 6621.9 6718.7 7909.0 8023.3 8249.1 6995.7 7048.3 7113.7 7115.1 7243.8 7067.6 7106.6 7185.8 7186.1 7309.9 6841.0 6849.3 6924.2 6947.4 6969.3 4920.6 4943.7 4946.6 4951.1 5031.9 4895.3 5050.8 5057.8 5133.2 5157.7 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#4] prototype.html Cycles:180 Average:4671.15 Median:5279.01 stddev:1328.50 (25.2%) stddev-sans-first:1292.06 03:26:27 INFO - PROCESS | 12813 | Values: 351.5 360.5 362.6 368.5 372.5 5292.9 5314.7 5321.5 5376.1 5391.3 5239.8 5276.3 5281.7 5285.8 5306.9 3774.5 4075.7 4232.7 4240.3 4265.8 4157.7 4212.0 4233.0 4236.4 4251.4 4180.5 4183.5 4195.7 4199.9 4215.4 4025.8 4166.4 4202.3 4207.0 4214.4 3695.9 3786.1 3795.7 3802.4 3805.0 5169.6 5173.9 5203.3 5214.7 5225.4 4696.3 4849.4 4864.7 4868.8 4880.1 5482.7 5529.5 5535.8 5577.5 5584.9 4131.4 4141.4 4146.4 4148.8 4154.6 5219.6 5530.7 5641.0 5653.6 5667.3 4219.4 4222.9 4226.1 4233.5 4258.3 4309.8 4317.5 4325.5 4335.9 4348.2 4565.2 4773.3 4798.9 4827.6 4849.1 5573.6 5580.2 5580.7 5594.7 5637.7 1404.3 1433.7 1435.6 1459.5 1459.6 965.5 1004.5 1008.7 1012.3 1029.1 5185.8 5234.2 5234.7 5236.2 5299.4 5490.0 5498.7 5510.8 5512.3 5523.5 4985.2 5208.7 5219.9 5266.1 5315.5 2929.4 2940.0 2942.9 2943.3 2967.4 5667.3 5681.4 5719.4 5727.4 5733.6 5365.6 5550.3 5573.2 5574.8 5593.0 5625.0 5649.5 5669.7 5670.7 5673.8 5188.2 5455.9 5456.8 5503.4 5518.9 5388.9 5422.5 5433.3 5441.9 5466.6 5621.5 5666.6 5786.8 5876.2 5892.3 4138.2 4162.9 4179.2 4203.4 4211.9 5620.6 5651.8 5734.9 5745.9 5783.6 5532.8 5537.4 5547.5 5558.7 5562.9 5496.8 5559.5 5572.4 5589.7 5607.9 5311.4 5514.9 5541.8 5547.8 5593.1 5640.6 5643.2 5653.1 5657.8 5658.5 5428.9 5539.7 5557.8 5568.2 5572.5 03:26:27 INFO - PROCESS | 12813 | 03:26:27 INFO - PROCESS | 12813 | [#5] yui.html Cycles:180 Average:18453.34 Median:48460.26 stddev:24452.42 (50.5%) stddev-sans-first:24485.02 03:26:27 INFO - PROCESS | 12813 | Values: 784.5 811.1 815.5 824.8 845.4 14152.2 14685.4 14711.9 14731.9 14745.6 14489.6 14754.6 14761.6 14771.3 14780.9 710.3 725.6 828.5 842.2 847.4 850.8 855.3 855.4 855.5 859.0 907.0 907.3 911.9 912.6 912.7 743.2 768.8 875.2 884.0 898.1 648.8 649.8 649.9 650.6 650.8 12433.3 12439.7 12453.2 12457.3 12468.8 14497.5 14553.1 14605.1 14610.3 14750.5 13049.0 13092.0 13117.9 13378.0 13523.7 3844.7 4157.4 4187.2 4221.4 4292.3 53260.0 57828.0 63313.7 63405.0 63916.4 11679.9 11930.5 12008.8 12081.0 12178.1 20685.2 20692.3 20693.7 20699.5 20722.6 8635.7 8657.1 8912.8 8960.7 9160.5 4783.2 4790.7 4834.3 4888.0 4916.1 3586.9 3604.4 3664.4 3677.5 3701.8 657.0 668.9 670.3 675.1 680.0 703.6 734.7 740.5 746.8 763.4 9916.8 10093.5 10254.3 10582.7 10692.1 722.5 723.8 740.6 745.9 761.3 4935.9 4936.3 5059.1 5114.4 5149.1 75607.9 88155.0 90613.5 92602.0 95180.5 75332.0 82560.6 83695.6 84535.0 85718.0 70979.0 73196.9 74909.6 76367.2 76873.6 9529.2 9682.8 9812.6 9820.0 9842.8 45401.0 47333.8 48325.0 48413.5 48507.0 60851.7 67147.7 67295.0 68899.3 70465.3 11505.4 12084.3 12371.8 12520.4 12530.2 13162.3 13322.9 13384.2 13592.0 13629.3 11582.1 13436.2 13522.4 13624.9 13885.7 13239.6 13461.4 13674.0 13860.9 13899.5 13373.0 13434.3 13808.3 13856.7 14021.0 10508.9 10636.0 10823.1 10875.9 11328.5 10400.6 10741.9 11458.9 11872.6 12181.9 03:26:27 INFO - PROCESS | 12813 | -------- Summary: end -------- 03:26:27 INFO - PROCESS | 12813 | 03:26:28 INFO - TEST-INFO | 12813: exit 0 03:26:28 INFO - TEST-OK | dromaeo_css | took 1116375ms 03:26:28 INFO - TEST-START | kraken 03:26:28 INFO - operating with platform_type : linux_ 03:26:28 INFO - Initialising browser for kraken test... 03:26:28 INFO - TEST-INFO | started process 13131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRgqWYZ/profile http://localhost:43595/getInfo.html) 03:26:33 INFO - PROCESS | 13131 | __metrics Screen width/height:1600/1200 03:26:33 INFO - PROCESS | 13131 | colorDepth:24 03:26:33 INFO - PROCESS | 13131 | Browser inner width/height: 1024/697 03:26:33 INFO - PROCESS | 13131 | __metrics 03:26:33 INFO - PROCESS | 13131 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:33 INFO - PROCESS | 13131 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:34 INFO - PROCESS | 13131 | console.error: PushService: 03:26:34 INFO - PROCESS | 13131 | stateChangeProcessEnqueue: Error transitioning state 03:26:34 INFO - PROCESS | 13131 | UnknownError 03:26:34 INFO - TEST-INFO | 13131: exit 0 03:26:34 INFO - Browser initialized. 03:26:34 INFO - Running cycle 1/1 for kraken test... 03:26:34 INFO - TEST-INFO | started process 13222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRgqWYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:46 INFO - PROCESS | 13222 | RSS: Main: 148099072 03:26:46 INFO - PROCESS | 13222 | 03:26:49 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:50 INFO - PROCESS | 13222 | RSS: Main: 189095936 03:26:50 INFO - PROCESS | 13222 | 03:26:52 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-dft) 03:26:53 INFO - PROCESS | 13222 | RSS: Main: 178450432 03:26:53 INFO - PROCESS | 13222 | 03:26:55 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-fft) 03:26:56 INFO - PROCESS | 13222 | RSS: Main: 270118912 03:26:56 INFO - PROCESS | 13222 | 03:26:58 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-oscillator) 03:26:59 INFO - PROCESS | 13222 | RSS: Main: 177070080 03:26:59 INFO - PROCESS | 13222 | 03:27:01 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:01 INFO - PROCESS | 13222 | RSS: Main: 179396608 03:27:01 INFO - PROCESS | 13222 | 03:27:04 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:05 INFO - PROCESS | 13222 | RSS: Main: 217743360 03:27:05 INFO - PROCESS | 13222 | 03:27:08 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:09 INFO - PROCESS | 13222 | RSS: Main: 216854528 03:27:09 INFO - PROCESS | 13222 | 03:27:12 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43595/tests/kraken/driver.html?testName=json-parse-financial) 03:27:12 INFO - PROCESS | 13222 | RSS: Main: 215117824 03:27:12 INFO - PROCESS | 13222 | 03:27:14 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:14 INFO - PROCESS | 13222 | RSS: Main: 177471488 03:27:14 INFO - PROCESS | 13222 | 03:27:16 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:17 INFO - PROCESS | 13222 | RSS: Main: 183492608 03:27:17 INFO - PROCESS | 13222 | 03:27:19 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:19 INFO - PROCESS | 13222 | RSS: Main: 190070784 03:27:19 INFO - PROCESS | 13222 | 03:27:22 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:22 INFO - PROCESS | 13222 | RSS: Main: 199069696 03:27:22 INFO - PROCESS | 13222 | 03:27:25 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:26 INFO - PROCESS | 13222 | RSS: Main: 195420160 03:27:26 INFO - PROCESS | 13222 | 03:27:27 INFO - PROCESS | 13222 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43595/tests/kraken/driver.html?testName=ai-astar) 03:27:28 INFO - PROCESS | 13222 | RSS: Main: 247562240 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | __start_tp_report 03:27:28 INFO - PROCESS | 13222 | _x_x_mozilla_page_load 03:27:28 INFO - PROCESS | 13222 | _x_x_mozilla_page_load_details 03:27:28 INFO - PROCESS | 13222 | |i|pagename|runs| 03:27:28 INFO - PROCESS | 13222 | |0;ai-astar;101;111;110;110;113;110;110;109;110;109 03:27:28 INFO - PROCESS | 13222 | |1;audio-beat-detection;147;118;118;152;123;119;119;120;157;119 03:27:28 INFO - PROCESS | 13222 | |2;audio-dft;160;160;161;161;160;161;161;161;159;160 03:27:28 INFO - PROCESS | 13222 | |3;audio-fft;74;76;75;106;75;76;75;76;101;75 03:27:28 INFO - PROCESS | 13222 | |4;audio-oscillator;81;81;122;83;83;82;99;81;82;113 03:27:28 INFO - PROCESS | 13222 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;118;117;116 03:27:28 INFO - PROCESS | 13222 | |6;imaging-darkroom;146;146;146;148;146;146;147;147;145;146 03:27:28 INFO - PROCESS | 13222 | |7;imaging-desaturate;85;85;85;86;85;85;84;84;85;84 03:27:28 INFO - PROCESS | 13222 | |8;json-parse-financial;55;48;50;50;50;49;50;48;49;49 03:27:28 INFO - PROCESS | 13222 | |9;json-stringify-tinderbox;58;60;58;58;59;58;58;58;58;66 03:27:28 INFO - PROCESS | 13222 | |10;stanford-crypto-aes;75;78;74;74;80;77;74;74;74;74 03:27:28 INFO - PROCESS | 13222 | |11;stanford-crypto-ccm;137;140;130;127;121;124;119;119;172;124 03:27:28 INFO - PROCESS | 13222 | |12;stanford-crypto-pbkdf2;151;153;150;152;152;154;153;159;157;157 03:27:28 INFO - PROCESS | 13222 | |13;stanford-crypto-sha256-iterative;65;62;63;63;61;61;63;62;62;61 03:27:28 INFO - PROCESS | 13222 | __end_tp_report 03:27:28 INFO - PROCESS | 13222 | __start_cc_report 03:27:28 INFO - PROCESS | 13222 | _x_x_mozilla_cycle_collect,1603 03:27:28 INFO - PROCESS | 13222 | __end_cc_report 03:27:28 INFO - PROCESS | 13222 | __startTimestamp1483442848068__endTimestamp 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | ------- Summary: start ------- 03:27:28 INFO - PROCESS | 13222 | Number of tests: 14 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.13 (2.8%) stddev-sans-first:1.20 03:27:28 INFO - PROCESS | 13222 | Values: 101.0 111.0 110.0 110.0 113.0 110.0 110.0 109.0 110.0 109.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:121.50 stddev:15.97 (13.1%) stddev-sans-first:15.59 03:27:28 INFO - PROCESS | 13222 | Values: 147.0 118.0 118.0 152.0 123.0 119.0 119.0 120.0 157.0 119.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 03:27:28 INFO - PROCESS | 13222 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 161.0 161.0 159.0 160.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:11.99 (16.0%) stddev-sans-first:12.45 03:27:28 INFO - PROCESS | 13222 | Values: 74.0 76.0 75.0 106.0 75.0 76.0 75.0 76.0 101.0 75.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:15.27 (18.6%) stddev-sans-first:15.79 03:27:28 INFO - PROCESS | 13222 | Values: 81.0 81.0 122.0 83.0 83.0 82.0 99.0 81.0 82.0 113.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:27:28 INFO - PROCESS | 13222 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 116.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 03:27:28 INFO - PROCESS | 13222 | Values: 146.0 146.0 146.0 148.0 146.0 146.0 147.0 147.0 145.0 146.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:27:28 INFO - PROCESS | 13222 | Values: 85.0 85.0 85.0 86.0 85.0 85.0 84.0 84.0 85.0 84.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:1.99 (4.0%) stddev-sans-first:0.83 03:27:28 INFO - PROCESS | 13222 | Values: 55.0 48.0 50.0 50.0 50.0 49.0 50.0 48.0 49.0 49.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.00 stddev:2.51 (4.3%) stddev-sans-first:2.64 03:27:28 INFO - PROCESS | 13222 | Values: 58.0 60.0 58.0 58.0 59.0 58.0 58.0 58.0 58.0 66.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.50 stddev:2.17 (2.9%) stddev-sans-first:2.30 03:27:28 INFO - PROCESS | 13222 | Values: 75.0 78.0 74.0 74.0 80.0 77.0 74.0 74.0 74.0 74.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.50 stddev:15.99 (12.4%) stddev-sans-first:16.82 03:27:28 INFO - PROCESS | 13222 | Values: 137.0 140.0 130.0 127.0 121.0 124.0 119.0 119.0 172.0 124.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:153.50 stddev:2.94 (1.9%) stddev-sans-first:2.93 03:27:28 INFO - PROCESS | 13222 | Values: 151.0 153.0 150.0 152.0 152.0 154.0 153.0 159.0 157.0 157.0 03:27:28 INFO - PROCESS | 13222 | 03:27:28 INFO - PROCESS | 13222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:0.87 03:27:28 INFO - PROCESS | 13222 | Values: 65.0 62.0 63.0 63.0 61.0 61.0 63.0 62.0 62.0 61.0 03:27:28 INFO - PROCESS | 13222 | -------- Summary: end -------- 03:27:28 INFO - PROCESS | 13222 | 03:27:29 INFO - TEST-INFO | 13222: exit 0 03:27:29 INFO - TEST-OK | kraken | took 60895ms 03:27:29 INFO - SUITE-END | took 1177s 03:27:29 INFO - Completed test suite (00:19:37) 03:27:29 INFO - javascript benchmark 03:27:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.6196456425223, 3248.090534650298, 3254.4955531892565, 3275.6724327567263, 3284.0312107928157, 5485.9725701371535, 5544.528715059225, 5556.16657501375, 5564.888702225958, 5570.025245582022, 5577.69322687252, 5595.356533998592, 5600.887982240363, 5603.60774745768, 5605.663660180392, 5072.442031376546, 5081.898362032757, 5113.054084994269, 5114.156164232916, 5193.662411943231, 4919.901601967977, 4966.428860681031, 5121.487851214886, 5168.8707782305555, 5175.974120129394, 5035.874103147414, 5068.5691716204165, 5068.797248110071, 5074.695518268897, 5083.872903177413, 5096.898062038776, 5099.33708617881, 5112.923306150411, 5158.2859445663335, 5166.844994650167, 5016.44819069902, 5096.949030509684, 5111.821086261963, 5121.615878809104, 5145.382554093495, 5360.0, 5412.242286079952, 5448.37343705471, 5466.070767969415, 5520.503154716054, 5885.70571471429, 5905.73424195908, 5907.350191478934, 5991.281046274475, 5999.370066143079, 6027.789027384064, 6047.5766696331275, 6058.666773327465, 6060.969695151496, 6065.787697430569, 5381.434949330264, 5407.891842163135, 5416.322959630046, 5436.6194366393975, 5438.564914806845, 5954.880902382015, 5977.790777322773, 5979.611325263844, 5982.581219314607, 5996.490298324604, 5721.199032135504, 5731.340895797037, 5744.913826292609, 5746.080627099727, 5749.195112684228, 5759.1937128802, 5802.767889284381, 5879.118132280107, 5903.557233207526, 5917.437843404869, 5958.940410595926, 5970.2238708968425, 5976.432238937294, 6004.099385092271, 6014.218151640259, 5920.526357891358, 5967.46292833647, 5980.401959804072, 5980.641161530322, 5987.311459182162, 4538.704984176018, 4541.43232095988, 4560.931586026212, 4580.358749775034, 4632.768361581908, 4060.6653620352345, 4083.97958010214, 4092.3452247640234, 4131.318332475108, 4131.855385061508, 5539.501444869981, 5628.943710562924, 5629.324481062299, 5629.690367029771, 5654.4062873398525, 5895.823125306248, 5938.168656388109, 5948.434898684618, 5951.107333899863, 5961.910571341434, 5634.408387119375, 5663.915041274302, 5698.2592263005545, 5699.487046165782, 5703.828885133453, 5187.247849061865, 5204.739763011834, 5214.113600687892, 5215.687058776485, 5216.765245563959, 6127.387261273926, 6135.477655820289, 6156.569040167145, 6186.938130618636, 6198.938010619926, 5986.311574169026, 5987.251593550806, 6001.459868611846, 6011.90982135277, 6022.277326720821, 6214.8135555933395, 6221.875562488634, 6223.408776166257, 6225.533085018551, 6238.407351301619, 5738.483536481736, 5802.274715660543, 5805.564582656233, 5893.0, 5897.852553686021, 5949.405059494016, 6043.607165534227, 6054.969725151346, 6075.27096748393, 6094.299155597163, 5877.676727779842, 5886.793962211302, 5889.676067816311, 5890.175375447355, 5890.852728681817, 5592.524635405874, 5649.802256920988, 5882.735276912635, 5893.5874488785375, 5897.439743224387, 5611.382747897646, 5648.378678345461, 5659.151127330933, 5717.485426311652, 5747.252857128714, 5817.331006934257, 5837.737301821343, 5839.065749480063, 5843.357230704704, 5843.532517398683, 5596.580256480862, 5699.857503562444, 5704.058830293121, 5714.085746280575, 5714.79998200061], "value": 5488.683172022935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5923183387547, 617.9412955769202, 647.621141632145, 650.8828410886039, 668.335006668365, 33915.0, 36904.44643330352, 43859.56140438599, 45000.09999800002, 45047.09905801882, 46179.76910115453, 46483.0, 46564.301535476996, 46629.766851165696, 46692.29961550579, 8761.430507017056, 8908.777280568005, 8914.197722205, 8951.910480895172, 8956.328275379372, 8368.623411946446, 8596.570171491432, 8869.778255543599, 10609.204309676805, 10927.890721092766, 10912.23614346996, 10981.780364392707, 10987.61543345983, 10991.890081099207, 10993.0, 10789.946050269738, 10798.892011079868, 10837.512311945982, 10852.620158294421, 10859.0, 10678.572857085706, 10711.785764284748, 10719.62481313158, 10742.355458672504, 10743.086837618812, 43095.56904430947, 43323.56676433227, 43386.34920476195, 43414.782926085485, 43524.0, 3736.4955730976512, 3762.172322089136, 3832.8275227614545, 3889.630485103911, 3918.0, 32684.0, 32887.835560822285, 32969.835150824096, 33093.3381332372, 33346.33307333864, 4451.643868490545, 4463.732176069414, 4484.618807401374, 4536.392553786197, 4549.24937385331, 356217.0, 356856.0, 357079.0, 357086.0, 358316.0, 61148.082778758355, 61374.69312653498, 61522.0, 61541.0, 61595.0, 42077.57922420798, 42751.57248427476, 43060.56939430628, 43074.0, 43084.784576077545, 19222.0, 19380.612387752168, 19386.612267754565, 19400.514987125436, 19432.902835485733, 13560.796588051187, 14867.959242853112, 14923.0, 14936.925315373353, 14977.850221497863, 17511.824881751276, 19291.228350866088, 19696.90151549233, 19758.209671612974, 20504.58990820205, 7223.530470519399, 7329.408589791071, 7443.665035073434, 7626.656800443993, 7644.388448924073, 1008.8688470498788, 1012.8480727890728, 1071.6731396923858, 1100.873399559061, 1160.3965937712342, 33232.0, 33438.4984225232, 33629.82295619642, 34114.82942585321, 34423.311533769185, 1076.332673742285, 1089.9509522071367, 1140.2816225777872, 1268.194696367813, 1295.792673172288, 14625.0, 17905.344610401127, 18524.81475185258, 18662.906685466485, 18739.90630046841, 531063.0, 532072.0, 533051.0, 533223.0, 533653.0, 61046.0, 61443.0, 61534.0, 61715.38284617186, 61780.69109654423, 1312.4618906248584, 1345.8855997240344, 1374.5944946240884, 1434.1825159658895, 1443.3865607117143, 30817.845910770302, 34790.0, 35229.82385088058, 35371.46942795911, 35525.644743552235, 52272.47727522676, 52968.20547691711, 53019.0, 53047.40857774273, 53080.0, 313895.0, 315145.0, 315385.0, 315409.0, 315956.0, 30847.2288192797, 30965.225869353446, 33328.50007249845, 33355.49966750452, 33779.83110084434, 49515.0, 49597.75201124116, 49623.751881240365, 50023.74988125036, 50286.0, 41383.586164137974, 41660.1667966645, 42616.78691606522, 43503.347449787645, 44213.55786442223, 41807.16385672209, 41868.0, 42520.78739606282, 42948.78525607352, 43272.56727432811, 42488.362674559285, 42879.14241715211, 43061.0, 43423.782881086656, 43647.34528982004, 36140.63859361478, 37771.2445751078, 38622.0, 38671.80664096661, 38734.2253154941, 28449.857750711115, 28572.142835714963, 28966.565501517915, 29225.269368265963, 29285.7071429283], "value": 20895.831846984973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.74861959894673, 420.64665680828097, 425.4086819321144, 435.42523868493583, 442.960133587977, 15370.69258614827, 19937.900310498444, 19965.900170499146, 20247.291344802936, 21437.0, 21017.894910525465, 21119.0, 21166.470838229052, 21177.788222117775, 21408.14367425305, 5701.401352857953, 5729.684867332306, 5874.471297583216, 5916.319623243317, 5926.140709597106, 5713.514351280146, 5811.0702287633985, 5861.648301101947, 5866.5306775458075, 5869.618474799146, 5623.971880140593, 5779.9422005779825, 5816.0, 5818.738156782955, 5824.301083869942, 5589.832305030855, 5784.074548072288, 5808.767649294024, 5812.128180772876, 5820.068788993783, 5627.718614069321, 5710.8001219957105, 5712.6286791358425, 5713.143028545752, 5722.599418040739, 14295.642608934755, 14455.855441445661, 14633.926830365886, 14678.339474723556, 14839.10965342083, 2385.4751954569965, 2528.645989561463, 2712.0, 2732.7267273272714, 3039.8024128431803, 10804.891951080546, 10820.513076911559, 11928.165028448013, 15122.470713525085, 15258.00822946505, 1966.9311574094982, 1978.436145698469, 2041.2651445479617, 2054.496648321156, 2056.1980827477296, 64493.0, 81122.0, 84893.57553212256, 88667.0, 91423.54288228517, 10035.79928401428, 10442.373457592568, 10627.893721062845, 10799.298045627009, 11117.388543630179, 14860.925695371454, 14870.256487175599, 14900.0, 14960.0, 15030.248487575796, 8503.1921967413, 8543.658253669908, 8575.142485751376, 8651.610677519528, 8891.555422228863, 7624.771256862303, 8042.115367309708, 8053.355731541463, 8719.651213951498, 8727.083656216133, 4503.234450143484, 4510.684252102387, 4532.546745325507, 4595.862124136282, 4638.884027899262, 2016.1129103194548, 2045.8056484634233, 2081.2819577245828, 2127.702121702963, 2147.3021268087623, 906.8911730592371, 911.4986757283467, 945.9148676619, 1008.9848652270222, 1013.2350075692805, 20439.0, 20636.48408789762, 20743.377698669065, 20846.0, 20892.79107208939, 993.2451336983944, 994.7811481474064, 1009.6970908727352, 1012.7620009297956, 1016.217512515359, 10628.474980143, 11426.0, 11701.473433695504, 11717.296962182296, 11723.648290551126, 441389.0, 442781.0, 446622.0, 459950.0, 485012.0, 74084.0, 78054.0, 95813.5209323949, 96576.0, 97718.0, 930.8464103422995, 947.7441090905417, 968.9660861869942, 979.4270351844251, 979.7207795778312, 17909.910450447664, 18232.635347293246, 18557.536061598028, 18594.22770582469, 18715.438536843918, 40797.18405631811, 44113.338299924886, 44206.0, 44347.33478997753, 44844.55155448534, 52710.472895270555, 60351.0, 61446.69276653588, 62294.688526557075, 63534.0, 8388.958055209929, 8748.693795717374, 8902.287816974756, 9122.179003889682, 12377.76222377755, 13151.53969611059, 13675.0, 13831.654208644864, 14056.086354386933, 14342.354594043085, 12786.424610892345, 12996.285204313854, 13109.73780524365, 13120.212787232796, 13189.670258243621, 12662.430190641258, 12733.236005839679, 12746.171498852545, 12834.614596914023, 13030.934845325713, 13198.0, 13218.339083046001, 13295.135816171918, 13391.263480508665, 13591.388387522784, 13313.134646247963, 13325.533606323732, 13445.327733613476, 13504.72990540164, 13562.728745425233, 12746.0, 12773.552925647558, 13175.538856139989, 13179.60461186166, 13453.260070696206], "value": 9587.225320381063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.521433141395, 1512.5386757039105, 1674.3795959323656, 1721.8622510199186, 1821.5081927879473, 7823.413244006701, 8427.325813934885, 8432.156784321565, 8433.45182563133, 8436.114208008163, 7245.7826265212125, 7415.369693576053, 7422.962885185567, 7601.277878601524, 8310.83378332433, 2052.722882410878, 2338.6024375856146, 2387.403149212697, 2401.4836810085826, 2429.5991161458337, 2432.2946345559767, 2457.5453541094867, 2462.963055554168, 2464.297675162579, 2467.481828815951, 2390.1873363056557, 2408.7109546854404, 2410.0359856057544, 2414.7223069346987, 2415.5410472010262, 2300.6894069300597, 2336.556054349685, 2336.696229490164, 2339.7426283108844, 2341.309313752447, 2311.91908283211, 2362.303120579433, 2390.5816482115733, 2392.5454163709014, 2397.0, 8414.957925210396, 8457.577121143919, 8482.321414286904, 8484.872726909101, 8494.490330580185, 5338.62629615927, 5455.781768729246, 5475.67145971239, 5476.17857321401, 5481.287432633772, 3445.552078229839, 3598.5321908151773, 3698.0939669780805, 3716.5725941516803, 3741.7380783345175, 1115.397685249964, 1144.30769384522, 1163.3834067944003, 1202.4228370382266, 1206.215959626241, 11604.30374177552, 11622.6513204604, 11664.475098620582, 11723.355215463145, 11752.764944701144, 4649.163150632851, 4745.1221524018165, 4828.734419606885, 4840.975795121002, 4919.237518184687, 9904.504774761233, 9923.255755818342, 9926.950365248127, 9930.553125109243, 9933.950330248446, 5459.071957767189, 5472.91790623141, 5478.287822583039, 5482.5613950883835, 5483.067878460672, 4305.97847010763, 4956.3804524434445, 4990.775415106329, 5077.644564880423, 5082.161443361804, 3747.7376583638884, 4029.81865816039, 4155.000615081806, 4170.520390155171, 4183.477065366829, 1347.3600039981127, 1347.7708789505807, 1353.9255340956145, 1368.0492058019581, 1385.3281158638054, 813.7192668529348, 854.2615776893991, 864.9783755406039, 887.1350433327455, 895.4045559702855, 5742.16738572913, 5759.8560035999435, 5775.451332123442, 5917.437843404869, 5950.7917222896995, 902.3457992955186, 932.1703683721494, 940.5579377692474, 997.6059456514636, 1001.8397056471075, 3937.448757173998, 4093.3655283431117, 4098.467199264077, 4136.875893723193, 4150.937735933963, 10019.098281154585, 10224.897751022394, 10291.433971131659, 10311.742206444898, 10345.327553708985, 9590.760230994281, 10029.147522460673, 10033.247506437046, 10234.6417875374, 10253.94873025645, 7811.414143939227, 8021.518708877369, 8036.919630803617, 8050.838983220303, 8059.919400806034, 5643.915341269966, 5783.132530120515, 5789.8552536186935, 6008.729607167776, 6083.482903953213, 9181.0, 9229.953850230706, 9394.95302523483, 9408.905910940803, 9469.952650236704, 9624.807503850025, 9721.56252968604, 9738.707838764849, 9763.463009534544, 9768.120869121813, 7468.92531074704, 7594.050743657043, 7600.745876930466, 7615.7334493292465, 7628.847423051397, 6621.9337806621315, 6718.731250750111, 7909.0, 8023.318017968538, 8249.092599813896, 6995.685194166376, 7048.259932706992, 7113.715451381887, 7115.1106111736035, 7243.818904527218, 7067.646617669199, 7106.5736055836815, 7185.820354491179, 7186.10173728284, 7309.926900730925, 6841.0, 6849.280825513449, 6924.238333783381, 6947.40947019509, 6969.2682268361095, 4920.6063514918005, 4943.65394422387, 4946.554810067111, 4951.10880041596, 5031.899362012812, 4895.290182923527, 5050.823221187241, 5057.7724002419245, 5133.230015497706, 5157.6647517911215], "value": 4564.295381639039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4885841101198, 360.545712402373, 362.5957057880463, 368.4725094943086, 372.54177361844916, 5292.89414211716, 5314.707691076989, 5321.52106310432, 5376.064616737971, 5391.2991311129545, 5239.816606418776, 5276.314079169712, 5281.70950597717, 5285.814996475124, 5306.93861227754, 3774.4904437900946, 4075.673946084321, 4232.6613870890405, 4240.300350442173, 4265.786710664454, 4157.688173387008, 4212.031232816454, 4232.9788351058205, 4236.406903033578, 4251.404803327521, 4180.540140584533, 4183.477065366829, 4195.748255104703, 4199.9370009449885, 4215.43091682622, 4025.838966441368, 4166.375043743433, 4202.327627579572, 4206.957930420703, 4214.36784482327, 3695.8706445274556, 3786.129190286222, 3795.6773674237725, 3802.372608519591, 3805.0487378155462, 5169.638125331228, 5173.896522069537, 5203.271541984087, 5214.6871187728475, 5225.425203227642, 4696.272077827942, 4849.442314133849, 4864.683795553313, 4868.756562171912, 4880.145974454456, 5482.725863706839, 5529.529989950819, 5535.750891209906, 5577.470140336662, 5584.883023395337, 4131.35963925592, 4141.399497072907, 4146.419501269825, 4148.8133034013545, 4154.605312495308, 5219.634625576173, 5530.723463826793, 5641.041023026095, 5653.604247702621, 5667.3482549506925, 4219.43037689914, 4222.873313800591, 4226.13364260332, 4233.470816147981, 4258.297380932174, 4309.84915527955, 4317.525072242051, 4325.545817689161, 4335.856504034549, 4348.239058164809, 4565.178267911741, 4773.307870358848, 4798.904021919612, 4827.637927155477, 4849.127157111683, 5573.554115670737, 5580.246666700024, 5580.720963951786, 5594.748236329294, 5637.746301416446, 1404.2657318212, 1433.6989232261133, 1435.6410897275682, 1459.4672944375227, 1459.6060761972292, 965.4834663455018, 1004.5128112865254, 1008.7377281906757, 1012.2559918459926, 1029.063552167524, 5185.818496352609, 5234.162533994542, 5234.712090834964, 5236.214567814858, 5299.44355842631, 5490.0, 5498.670079795145, 5510.834674959758, 5512.283403157564, 5523.530499907472, 4985.202367621163, 5208.713520756395, 5219.921701174486, 5266.052110620125, 5315.521603055666, 2929.399473108008, 2939.955900661492, 2942.867570959312, 2943.2788966703297, 2967.3768508613434, 5667.3482549507335, 5681.403452637496, 5719.370869204467, 5727.3699893011735, 5733.6273142246455, 5365.597580181502, 5550.306211723535, 5573.219749235111, 5574.777008919597, 5593.0, 5624.97187514068, 5649.491545760901, 5669.659820410789, 5670.659760414388, 5673.773049078073, 5188.242230270277, 5455.918161227664, 5456.836294911159, 5503.422140675331, 5518.917216241679, 5388.865278368072, 5422.451447819676, 5433.2665090213895, 5441.884413695262, 5466.562674986071, 5621.4659607337235, 5666.631668941505, 5786.826395208151, 5876.206712093813, 5892.322382926019, 4138.220565157011, 4162.854300099482, 4179.2477354076555, 4203.369494575838, 4211.915761684688, 5620.606557540933, 5651.8304450866535, 5734.913976290442, 5745.862978655361, 5783.624064435799, 5532.778688852401, 5537.446255374431, 5547.472990065938, 5558.749856256559, 5562.886103280727, 5496.780128794803, 5559.52744016747, 5572.356154934385, 5589.748461319332, 5607.915881261866, 5311.3891902431715, 5514.889702206014, 5541.806036788855, 5547.750351234124, 5593.106032221806, 5640.605157638925, 5643.181738647955, 5653.095504719226, 5657.830265092054, 5658.462446067617, 5428.902147615683, 5539.695316757617, 5557.805476808292, 5568.192612071308, 5572.495426234975], "value": 4258.404225894426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.5410434895585, 811.059171361221, 815.4903185509057, 824.8391563645088, 845.3786466946789, 14152.221627810466, 14685.412583496674, 14711.852881471195, 14731.92634036831, 14745.557633270992, 14489.63775905603, 14754.557363279118, 14761.557153285392, 14771.335289911953, 14780.852191478081, 710.2790667472493, 725.5936675461732, 828.494618282847, 842.2251528593678, 847.4406891451644, 850.783050322167, 855.2516548020482, 855.3969451536652, 855.4696088425154, 858.9613467393982, 906.9773255668628, 907.3331101640289, 911.9270458363349, 912.5802131019739, 912.7307444303947, 743.1750756660103, 768.757841279995, 875.2297977779546, 884.0, 898.1467605774541, 648.8021153548166, 649.759588952086, 649.8667773106501, 650.6031320894251, 650.7657243392422, 12433.254004759743, 12439.689007774878, 12453.190542614791, 12457.252564846138, 12468.75062498745, 14497.492587759483, 14553.126812391185, 14605.12369257848, 14610.342534585969, 14750.546630856988, 13049.0, 13092.0, 13117.934410327887, 13378.0, 13523.661908452268, 3844.653981141683, 4157.417961485395, 4187.246295666779, 4221.409002739619, 4292.29177185764, 53260.0, 57828.0, 63313.683431583006, 63405.0, 63916.36083639197, 11679.883201167879, 11930.463129159209, 12008.759824803456, 12081.0, 12178.147529672839, 20685.17259309641, 20692.275770347966, 20693.68959465609, 20699.482512936996, 20722.58554828925, 8635.654573816977, 8657.134286571292, 8912.777180570538, 8960.731178064669, 9160.45037297751, 4783.162946484351, 4790.664653474293, 4834.299026641117, 4888.046830868017, 4916.0905232532095, 3586.905993671955, 3604.351216780952, 3664.3953747631876, 3677.4667673187237, 3701.7784131237167, 657.0472814419112, 668.866226754651, 670.3162773970523, 675.0684056002783, 679.9762008329784, 703.644659446976, 734.6547122852251, 740.5371642723298, 746.7610364683358, 763.393102483527, 9916.752081197883, 10093.5457904393, 10254.28220024591, 10582.735431614272, 10692.144628429707, 722.5411863466632, 723.7756295548292, 740.6000759589868, 745.8955746195428, 761.3224230434918, 4935.90128197434, 4936.308916751657, 5059.06407314648, 5114.360704911886, 5149.073166830007, 75607.86588201181, 88155.0, 90613.54693226492, 92602.0, 95180.52409738046, 75332.0, 82560.55707535439, 83695.58152209321, 84535.0, 85718.0, 70979.0, 73196.90204646828, 74909.62545187239, 76367.23632763712, 76873.6156319226, 9529.237660987243, 9682.806343873224, 9812.55843487059, 9819.950900245452, 9842.803143937224, 45401.0, 47333.76333118312, 48325.0, 48413.5158648409, 48507.0, 60851.69574152278, 67147.66426168033, 67295.0, 68899.31100688929, 70465.29534704793, 11505.36720480348, 12084.274943503418, 12371.814422783485, 12520.436580354088, 12530.248185108923, 13162.341882905625, 13322.86677133255, 13384.19694818314, 13592.048556600943, 13629.318534073058, 11582.141913878815, 13436.19382837033, 13522.391492382669, 13624.863751362756, 13885.65285867821, 13239.602811915658, 13461.394237259543, 13674.042817002713, 13860.861391385957, 13899.51351702726, 13373.0, 13434.328283585977, 13808.309584520935, 13856.653583660085, 14021.0, 10508.947455262674, 10636.042756151983, 10823.134149268197, 10875.891241087487, 11328.546858125583, 10400.5994005994, 10741.946290268499, 11458.942705286754, 11872.584459543874, 12181.87818121843], "value": 7421.934788031113, "unit": "score"}], "name": "dromaeo_css", "value": 7357.566587298851, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 110.0, 113.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 118.0, 152.0, 123.0, 119.0, 119.0, 120.0, 157.0, 119.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 106.0, 75.0, 76.0, 75.0, 76.0, 101.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 122.0, 83.0, 83.0, 82.0, 99.0, 81.0, 82.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 48.0, 50.0, 50.0, 50.0, 49.0, 50.0, 48.0, 49.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 66.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 74.0, 80.0, 77.0, 74.0, 74.0, 74.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 130.0, 127.0, 121.0, 124.0, 119.0, 119.0, 172.0, 124.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 150.0, 152.0, 152.0, 154.0, 153.0, 159.0, 157.0, 157.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 61.0, 61.0, 63.0, 62.0, 62.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1450.1999999999998, "alertThreshold": 2.0}]} 03:27:29 INFO - Return code: 0 03:27:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:29 INFO - # TBPL SUCCESS # 03:27:29 INFO - Running post-action listener: _resource_record_post_action 03:27:29 INFO - [mozharness: 2017-01-03 11:27:29.384105Z] Finished run-tests step (success) 03:27:29 INFO - Running post-run listener: _resource_record_post_run 03:27:29 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 354394112; Read time: 12; Write time: 521452 03:27:29 INFO - TinderboxPrint: CPU usage
13.0% 03:27:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:27:29 INFO - TinderboxPrint: I/O write bytes / time
354,394,112 / 521,452 03:27:29 INFO - TinderboxPrint: CPU idle
8,280.1 (87.0%) 03:27:29 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 03:27:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109977600; Read time: 0; Write time: 216412 03:27:29 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 244084736; Read time: 0; Write time: 305036 03:27:29 INFO - Running post-run listener: _upload_blobber_files 03:27:29 INFO - Blob upload gear active. 03:27:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:27:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:31 INFO - (blobuploader) - INFO - Done attempting. 03:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:35 INFO - (blobuploader) - INFO - Done attempting. 03:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:35 INFO - (blobuploader) - INFO - Done attempting. 03:27:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:35 INFO - Return code: 0 03:27:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6056ee0c15a181b44bf9838d33078eb68c56733198eee9e88ae39e8168eebc333782c4a75ed858825d04c7c227d95ec8df68985a7224cfc9988df5a1703e94b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466cf1aed65b0d52906fd9d4e25ced39f7adbbc82d6bf3d2f1ba20edc3d82119488118ad0630c2bd24692e5be3b230a71cad51a4ff46be6a6765f8134f17c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3863ec63649d7cb00d49160193ac5f5613f20f2a8c32f126860a1499161705c2362e0b609d79166db8ebc5cc424523b73776144c5670c437e9d425db1456b2f9"} 03:27:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:35 INFO - Contents: 03:27:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6056ee0c15a181b44bf9838d33078eb68c56733198eee9e88ae39e8168eebc333782c4a75ed858825d04c7c227d95ec8df68985a7224cfc9988df5a1703e94b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466cf1aed65b0d52906fd9d4e25ced39f7adbbc82d6bf3d2f1ba20edc3d82119488118ad0630c2bd24692e5be3b230a71cad51a4ff46be6a6765f8134f17c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3863ec63649d7cb00d49160193ac5f5613f20f2a8c32f126860a1499161705c2362e0b609d79166db8ebc5cc424523b73776144c5670c437e9d425db1456b2f9"} 03:27:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:35 INFO - Copying logs to upload dir... 03:27:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.692539 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-03 03:27:35.137239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 03:27:35.141039) ========= 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=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6056ee0c15a181b44bf9838d33078eb68c56733198eee9e88ae39e8168eebc333782c4a75ed858825d04c7c227d95ec8df68985a7224cfc9988df5a1703e94b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466cf1aed65b0d52906fd9d4e25ced39f7adbbc82d6bf3d2f1ba20edc3d82119488118ad0630c2bd24692e5be3b230a71cad51a4ff46be6a6765f8134f17c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3863ec63649d7cb00d49160193ac5f5613f20f2a8c32f126860a1499161705c2362e0b609d79166db8ebc5cc424523b73776144c5670c437e9d425db1456b2f9"} build_url:https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011895 build_url: 'https://queue.taskcluster.net/v1/task/arewiM5XQM-DlSuAJLCDXQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6056ee0c15a181b44bf9838d33078eb68c56733198eee9e88ae39e8168eebc333782c4a75ed858825d04c7c227d95ec8df68985a7224cfc9988df5a1703e94b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466cf1aed65b0d52906fd9d4e25ced39f7adbbc82d6bf3d2f1ba20edc3d82119488118ad0630c2bd24692e5be3b230a71cad51a4ff46be6a6765f8134f17c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3863ec63649d7cb00d49160193ac5f5613f20f2a8c32f126860a1499161705c2362e0b609d79166db8ebc5cc424523b73776144c5670c437e9d425db1456b2f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 03:27:35.167349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:27:35.167792) ========= 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=8783db0840cc980e80bb0bd400000236-1483441564.41578-1353970527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 03:27:35.251729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 03:27:35.252221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 03:27:35.252703) ========= ========= Total master_lag: 0.19 =========