builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1484051494.25 results: success (0) buildid: 20170110025308 builduid: ea292d313f0e44cab11f367734f12420 revision: adba84d693a69f2ee1c8dd23493128d6879b2288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.249129) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.249873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.250337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.266646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.267228) ========= 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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 04:31:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-10 04:31:34 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.385767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.386096) ========= 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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:34.438085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 04:31:34.438685) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev adba84d693a69f2ee1c8dd23493128d6879b2288 --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 adba84d693a69f2ee1c8dd23493128d6879b2288 --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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 04:31:34,606 truncating revision to first 12 chars 2017-01-10 04:31:34,606 Setting DEBUG logging. 2017-01-10 04:31:34,606 attempt 1/10 2017-01-10 04:31:34,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/adba84d693a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 04:31:35,850 unpacking tar archive at: mozilla-aurora-adba84d693a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549312 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 04:31:36.002371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:36.002711) ========= script_repo_revision: adba84d693a69f2ee1c8dd23493128d6879b2288 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:36.003105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:36.003366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 04:31:36.011327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-10 04:31:36.011682) ========= /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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:36 INFO - MultiFileLogger online at 20170110 04:31:36 in /builds/slave/test 04:31:36 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 04:31:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:36 INFO - {'append_to_log': False, 04:31:36 INFO - 'base_work_dir': '/builds/slave/test', 04:31:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:36 INFO - 'branch': 'Mozilla-Aurora', 04:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:36 INFO - 'config_files': ('talos/linux_config.py',), 04:31:36 INFO - 'default_actions': ('clobber', 04:31:36 INFO - 'read-buildbot-config', 04:31:36 INFO - 'download-and-extract', 04:31:36 INFO - 'populate-webroot', 04:31:36 INFO - 'create-virtualenv', 04:31:36 INFO - 'install', 04:31:36 INFO - 'run-tests'), 04:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:36 INFO - 'download_minidump_stackwalk': True, 04:31:36 INFO - 'download_symbols': 'ondemand', 04:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:36 INFO - 'installer_path': 'installer.exe', 04:31:36 INFO - 'log_level': 'info', 04:31:36 INFO - 'log_name': 'talos', 04:31:36 INFO - 'log_to_console': True, 04:31:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:36 INFO - 'opt_config_files': (), 04:31:36 INFO - 'pip_index': False, 04:31:36 INFO - 'sps_profile': False, 04:31:36 INFO - 'sps_profile_interval': 0, 04:31:36 INFO - 'suite': 'dromaeojs', 04:31:36 INFO - 'system_bits': '32', 04:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:36 INFO - 'title': 'talos-linux64-ix-008', 04:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:36 INFO - 'use_talos_json': True, 04:31:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:36 INFO - 'work_dir': 'build'} 04:31:36 INFO - [mozharness: 2017-01-10 12:31:36.269745Z] Running clobber step. 04:31:36 INFO - Running pre-action listener: _resource_record_pre_action 04:31:36 INFO - Running main action method: clobber 04:31:36 INFO - rmtree: /builds/slave/test/build 04:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:37 INFO - Running post-action listener: _resource_record_post_action 04:31:37 INFO - [mozharness: 2017-01-10 12:31:37.277596Z] Finished clobber step (success) 04:31:37 INFO - [mozharness: 2017-01-10 12:31:37.277695Z] Running read-buildbot-config step. 04:31:37 INFO - Running pre-action listener: _resource_record_pre_action 04:31:37 INFO - Running main action method: read_buildbot_config 04:31:37 INFO - Using buildbot properties: 04:31:37 INFO - { 04:31:37 INFO - "project": "", 04:31:37 INFO - "product": "firefox", 04:31:37 INFO - "script_repo_revision": "production", 04:31:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:31:37 INFO - "repository": "", 04:31:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:31:37 INFO - "buildid": "20170110025308", 04:31:37 INFO - "pgo_build": "True", 04:31:37 INFO - "basedir": "/builds/slave/test", 04:31:37 INFO - "buildnumber": 1005, 04:31:37 INFO - "slavename": "talos-linux64-ix-008", 04:31:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:31:37 INFO - "platform": "ubuntu64_hw", 04:31:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:31:37 INFO - "branch": "mozilla-aurora", 04:31:37 INFO - "repo_path": "releases/mozilla-aurora", 04:31:37 INFO - "revision": "adba84d693a69f2ee1c8dd23493128d6879b2288", 04:31:37 INFO - "stage_platform": "linux64-pgo", 04:31:37 INFO - "builduid": "ea292d313f0e44cab11f367734f12420", 04:31:37 INFO - "slavebuilddir": "test" 04:31:37 INFO - } 04:31:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 04:31:37 INFO - Running post-action listener: _resource_record_post_action 04:31:37 INFO - [mozharness: 2017-01-10 12:31:37.280118Z] Finished read-buildbot-config step (success) 04:31:37 INFO - [mozharness: 2017-01-10 12:31:37.280208Z] Running download-and-extract step. 04:31:37 INFO - Running pre-action listener: _resource_record_pre_action 04:31:37 INFO - Running main action method: download_and_extract 04:31:37 INFO - mkdir: /builds/slave/test/build/tests 04:31:37 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')]} 04:31:37 INFO - trying https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:31:37 INFO - Downloading https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/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 04:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/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 04:31:37 INFO - Downloaded 1361 bytes. 04:31:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:31:37 INFO - Using the following test package requirements: 04:31:37 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:31:37 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:37 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:31:37 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'jsshell-linux-x86_64.zip'], 04:31:37 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:37 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:31:37 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:31:37 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:31:37 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:37 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:37 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:37 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:31:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:37 INFO - Fetch https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:31:38 INFO - Http code: 200 04:31:38 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 04:31:38 INFO - x-amz-cf-id: 4E2-AWADBCBrvev6LK9uUMOJYLEy196KVsAkETXKLG8PpriJ4QyROA== 04:31:38 INFO - x-amz-version-id: QDcOQw.9OgEAvCgZYiThFOsty7KGChhw 04:31:38 INFO - Expected file size: 21944840 04:31:38 INFO - Obtained file size: 21944840 04:31:42 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 04:31:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:31:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:31:43 INFO - Http code: 200 04:31:43 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 04:31:43 INFO - x-amz-cf-id: 7_O1c1mMYW8L5jrmUyWsrN8DYP3nrTUKcRg9hR8-RYMVAS_fHPIjJw== 04:31:43 INFO - x-amz-version-id: QDcOQw.9OgEAvCgZYiThFOsty7KGChhw 04:31:43 INFO - Expected file size: 21944840 04:31:43 INFO - Obtained file size: 21944840 04:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:31:48 INFO - Http code: 200 04:31:48 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 04:31:48 INFO - x-amz-cf-id: oNiBjlPFu24tBQcD2V6TmAWCsUTMVj1fwXTjJ10udrnC50eUkzBJYg== 04:31:48 INFO - x-amz-version-id: LBP5MRxDTUbu14vhgJcuyt8DJNVRdQXa 04:31:48 INFO - Expected file size: 14409038 04:31:48 INFO - Obtained file size: 14409038 04:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:49 INFO - trying https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:31:49 INFO - Downloading https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/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 04:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/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 04:31:50 INFO - Downloaded 64087398 bytes. 04:31:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:31:50 INFO - mkdir: /builds/slave/test/properties 04:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:50 INFO - Contents: 04:31:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:31:50 INFO - Running post-action listener: _resource_record_post_action 04:31:50 INFO - Running post-action listener: set_extra_try_arguments 04:31:50 INFO - [mozharness: 2017-01-10 12:31:50.814275Z] Finished download-and-extract step (success) 04:31:50 INFO - [mozharness: 2017-01-10 12:31:50.814501Z] Running populate-webroot step. 04:31:50 INFO - Running pre-action listener: _resource_record_pre_action 04:31:50 INFO - Running main action method: populate_webroot 04:31:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:50 INFO - '--tppagecycles', 04:31:50 INFO - '7'], 04:31:50 INFO - 'tests': ['tsvgm']}}, 04:31:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['damp', 'tps']}, 04:31:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'tests': ['damp', 'tps']}, 04:31:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['dromaeo_dom']}, 04:31:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['basic_compositor_video']}, 04:31:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['a11yr', 04:31:50 INFO - 'ts_paint', 04:31:50 INFO - 'tpaint', 04:31:50 INFO - 'sessionrestore', 04:31:50 INFO - 'sessionrestore_no_auto_restore', 04:31:50 INFO - 'tabpaint']}, 04:31:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['tsvgx', 04:31:50 INFO - 'tsvgr_opacity', 04:31:50 INFO - 'tart', 04:31:50 INFO - 'tscrollx', 04:31:50 INFO - 'cart']}, 04:31:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:50 INFO - 'tsvgr_opacity', 04:31:50 INFO - 'tart', 04:31:50 INFO - 'tscrollx', 04:31:50 INFO - 'cart']}, 04:31:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'talos_options': ['--disable-e10s'], 04:31:50 INFO - 'tests': ['tp5o']}, 04:31:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'tests': ['tp5o']}, 04:31:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'talos_options': ['--disable-e10s', 04:31:50 INFO - '--xperf_path', 04:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:50 INFO - 'tests': ['tp5n']}, 04:31:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:50 INFO - 'talos_options': ['--xperf_path', 04:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:50 INFO - 'tests': ['tp5n']}}, 04:31:50 INFO - 'talos.zip': {'path': '', 04:31:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:50 INFO - Running post-action listener: _resource_record_post_action 04:31:50 INFO - [mozharness: 2017-01-10 12:31:50.832231Z] Finished populate-webroot step (success) 04:31:50 INFO - [mozharness: 2017-01-10 12:31:50.832319Z] Running create-virtualenv step. 04:31:50 INFO - Running pre-action listener: _resource_record_pre_action 04:31:50 INFO - Running main action method: create_virtualenv 04:31:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:50 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 04:31:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:50 INFO - Using real prefix '/usr' 04:31:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:53 INFO - Installing pip.................done. 04:31:53 INFO - Return code: 0 04:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:53 INFO - Reading from file tmpfile_stdout 04:31:53 INFO - Output received: 04:31:53 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) 04:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:53 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')]} 04:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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')]} 04:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:31:53 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 04:31:53 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 04:31:53 INFO - Using env: {'DISPLAY': ':0', 04:31:53 INFO - 'HOME': '/home/cltbld', 04:31:53 INFO - 'LANG': 'en_US.UTF-8', 04:31:53 INFO - 'LANGUAGE': 'en_US:en', 04:31:53 INFO - 'LOGNAME': 'cltbld', 04:31:53 INFO - 'MAIL': '/var/mail/cltbld', 04:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:53 INFO - 'MOZ_NO_REMOTE': '1', 04:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:53 INFO - 'NO_EM_RESTART': '1', 04:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:53 INFO - 'PWD': '/builds/slave/test', 04:31:53 INFO - 'SHELL': '/bin/bash', 04:31:53 INFO - 'SHLVL': '1', 04:31:53 INFO - 'TERM': 'linux', 04:31:53 INFO - 'TMOUT': '86400', 04:31:53 INFO - 'USER': 'cltbld', 04:31:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:53 INFO - '_': '/tools/buildbot/bin/python'} 04:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:53 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 04:31:53 INFO - Cleaning up... 04:31:53 INFO - Return code: 0 04:31:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:53 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')]} 04:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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')]} 04:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:31:53 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 04:31:53 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 04:31:53 INFO - Using env: {'DISPLAY': ':0', 04:31:53 INFO - 'HOME': '/home/cltbld', 04:31:53 INFO - 'LANG': 'en_US.UTF-8', 04:31:53 INFO - 'LANGUAGE': 'en_US:en', 04:31:53 INFO - 'LOGNAME': 'cltbld', 04:31:53 INFO - 'MAIL': '/var/mail/cltbld', 04:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:53 INFO - 'MOZ_NO_REMOTE': '1', 04:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:53 INFO - 'NO_EM_RESTART': '1', 04:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:53 INFO - 'PWD': '/builds/slave/test', 04:31:53 INFO - 'SHELL': '/bin/bash', 04:31:53 INFO - 'SHLVL': '1', 04:31:53 INFO - 'TERM': 'linux', 04:31:53 INFO - 'TMOUT': '86400', 04:31:53 INFO - 'USER': 'cltbld', 04:31:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:53 INFO - '_': '/tools/buildbot/bin/python'} 04:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:54 INFO - Downloading/unpacking psutil>=3.1.1 04:31:54 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 04:31:54 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 04:31:54 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 04:31:54 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 04:31:54 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 04:31:54 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 04:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:56 INFO - Installing collected packages: psutil 04:31:56 INFO - Running setup.py install for psutil 04:31:56 INFO - building 'psutil._psutil_linux' extension 04:31:56 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 04:31:56 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 04:31:56 INFO - building 'psutil._psutil_posix' extension 04:31:56 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 04:31:56 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 04:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:56 INFO - Successfully installed psutil 04:31:56 INFO - Cleaning up... 04:31:56 INFO - Return code: 0 04:31:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:31:56 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 04:31:56 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 04:31:56 INFO - Using env: {'DISPLAY': ':0', 04:31:56 INFO - 'HOME': '/home/cltbld', 04:31:56 INFO - 'LANG': 'en_US.UTF-8', 04:31:56 INFO - 'LANGUAGE': 'en_US:en', 04:31:56 INFO - 'LOGNAME': 'cltbld', 04:31:56 INFO - 'MAIL': '/var/mail/cltbld', 04:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:56 INFO - 'MOZ_NO_REMOTE': '1', 04:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:56 INFO - 'NO_EM_RESTART': '1', 04:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:56 INFO - 'PWD': '/builds/slave/test', 04:31:56 INFO - 'SHELL': '/bin/bash', 04:31:56 INFO - 'SHLVL': '1', 04:31:56 INFO - 'TERM': 'linux', 04:31:56 INFO - 'TMOUT': '86400', 04:31:56 INFO - 'USER': 'cltbld', 04:31:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:56 INFO - '_': '/tools/buildbot/bin/python'} 04:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:57 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 04:31:57 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 04:31:57 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 04:31:57 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 04:31:57 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 04:31:57 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 04:31:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:59 INFO - Installing collected packages: mozsystemmonitor 04:31:59 INFO - Running setup.py install for mozsystemmonitor 04:31:59 INFO - Successfully installed mozsystemmonitor 04:31:59 INFO - Cleaning up... 04:31:59 INFO - Return code: 0 04:31:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:59 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')]} 04:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:59 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')]} 04:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:59 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:31:59 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 04:31:59 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 04:31:59 INFO - Using env: {'DISPLAY': ':0', 04:31:59 INFO - 'HOME': '/home/cltbld', 04:31:59 INFO - 'LANG': 'en_US.UTF-8', 04:31:59 INFO - 'LANGUAGE': 'en_US:en', 04:31:59 INFO - 'LOGNAME': 'cltbld', 04:31:59 INFO - 'MAIL': '/var/mail/cltbld', 04:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:59 INFO - 'MOZ_NO_REMOTE': '1', 04:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:59 INFO - 'NO_EM_RESTART': '1', 04:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:59 INFO - 'PWD': '/builds/slave/test', 04:31:59 INFO - 'SHELL': '/bin/bash', 04:31:59 INFO - 'SHLVL': '1', 04:31:59 INFO - 'TERM': 'linux', 04:31:59 INFO - 'TMOUT': '86400', 04:31:59 INFO - 'USER': 'cltbld', 04:31:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:59 INFO - '_': '/tools/buildbot/bin/python'} 04:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:59 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 04:31:59 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 04:31:59 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 04:31:59 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 04:31:59 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 04:31:59 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 04:32:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:01 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 04:32:01 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 04:32:01 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 04:32:01 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 04:32:01 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 04:32:01 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 04:32:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:01 INFO - warning: no files found matching '*.txt' 04:32:01 INFO - no previously-included directories found matching 'build' 04:32:01 INFO - no previously-included directories found matching 'dist' 04:32:01 INFO - no previously-included directories found matching '.git*' 04:32:01 INFO - Installing collected packages: jsonschema, functools32 04:32:01 INFO - Running setup.py install for functools32 04:32:01 INFO - warning: no files found matching '*.txt' 04:32:01 INFO - no previously-included directories found matching 'build' 04:32:01 INFO - no previously-included directories found matching 'dist' 04:32:01 INFO - no previously-included directories found matching '.git*' 04:32:01 INFO - Successfully installed jsonschema functools32 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:01 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')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 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')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:01 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 04:32:01 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 04:32:01 INFO - Using env: {'DISPLAY': ':0', 04:32:01 INFO - 'HOME': '/home/cltbld', 04:32:01 INFO - 'LANG': 'en_US.UTF-8', 04:32:01 INFO - 'LANGUAGE': 'en_US:en', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MAIL': '/var/mail/cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SHLVL': '1', 04:32:01 INFO - 'TERM': 'linux', 04:32:01 INFO - 'TMOUT': '86400', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - '_': '/tools/buildbot/bin/python'} 04:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:02 INFO - Cleaning up... 04:32:02 INFO - Return code: 0 04:32:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:02 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:02 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 04:32:02 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 04:32:02 INFO - Using env: {'DISPLAY': ':0', 04:32:02 INFO - 'HOME': '/home/cltbld', 04:32:02 INFO - 'LANG': 'en_US.UTF-8', 04:32:02 INFO - 'LANGUAGE': 'en_US:en', 04:32:02 INFO - 'LOGNAME': 'cltbld', 04:32:02 INFO - 'MAIL': '/var/mail/cltbld', 04:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:02 INFO - 'MOZ_NO_REMOTE': '1', 04:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:02 INFO - 'NO_EM_RESTART': '1', 04:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:02 INFO - 'PWD': '/builds/slave/test', 04:32:02 INFO - 'SHELL': '/bin/bash', 04:32:02 INFO - 'SHLVL': '1', 04:32:02 INFO - 'TERM': 'linux', 04:32:02 INFO - 'TMOUT': '86400', 04:32:02 INFO - 'USER': 'cltbld', 04:32:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:02 INFO - '_': '/tools/buildbot/bin/python'} 04:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:02 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 04:32:02 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 04:32:02 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 04:32:02 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 04:32:02 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 04:32:02 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 04:32:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:04 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 04:32:05 INFO - Downloading docopt-0.6.1.tar.gz 04:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:05 INFO - Running setup.py install for blobuploader 04:32:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:05 INFO - Running setup.py install for requests 04:32:05 INFO - Running setup.py install for docopt 04:32:05 INFO - Successfully installed blobuploader requests docopt 04:32:05 INFO - Cleaning up... 04:32:05 INFO - Return code: 0 04:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:05 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')]} 04:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 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')]} 04:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:05 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 04:32:05 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 04:32:05 INFO - Using env: {'DISPLAY': ':0', 04:32:05 INFO - 'HOME': '/home/cltbld', 04:32:05 INFO - 'LANG': 'en_US.UTF-8', 04:32:05 INFO - 'LANGUAGE': 'en_US:en', 04:32:05 INFO - 'LOGNAME': 'cltbld', 04:32:05 INFO - 'MAIL': '/var/mail/cltbld', 04:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:05 INFO - 'MOZ_NO_REMOTE': '1', 04:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:05 INFO - 'NO_EM_RESTART': '1', 04:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:05 INFO - 'PWD': '/builds/slave/test', 04:32:05 INFO - 'SHELL': '/bin/bash', 04:32:05 INFO - 'SHLVL': '1', 04:32:05 INFO - 'TERM': 'linux', 04:32:05 INFO - 'TMOUT': '86400', 04:32:05 INFO - 'USER': 'cltbld', 04:32:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:05 INFO - '_': '/tools/buildbot/bin/python'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:06 INFO - Running setup.py (path:/tmp/pip-0HxKck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:06 INFO - Running setup.py (path:/tmp/pip-QOLibM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:06 INFO - Running setup.py (path:/tmp/pip-gfTNwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:06 INFO - Running setup.py (path:/tmp/pip-o2jXge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:06 INFO - Running setup.py (path:/tmp/pip-99REDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:06 INFO - Running setup.py (path:/tmp/pip-tcWaBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:06 INFO - Running setup.py (path:/tmp/pip-bP5V_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:06 INFO - Running setup.py (path:/tmp/pip-HtCT4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:06 INFO - Running setup.py (path:/tmp/pip-QBFdX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:06 INFO - Running setup.py (path:/tmp/pip-WlPHWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:06 INFO - Running setup.py (path:/tmp/pip-EdhW_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:06 INFO - Running setup.py (path:/tmp/pip-nYGtNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:06 INFO - Running setup.py (path:/tmp/pip-aiiuW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:07 INFO - Running setup.py (path:/tmp/pip-u9zdD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:07 INFO - Running setup.py (path:/tmp/pip-mHA45X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:07 INFO - Running setup.py (path:/tmp/pip-alA_qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:07 INFO - Running setup.py (path:/tmp/pip-rTK_ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:07 INFO - Running setup.py install for manifestparser 04:32:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:07 INFO - Running setup.py install for mozcrash 04:32:07 INFO - Running setup.py install for mozdebug 04:32:07 INFO - Running setup.py install for mozdevice 04:32:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:07 INFO - Running setup.py install for mozfile 04:32:07 INFO - Running setup.py install for mozhttpd 04:32:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:07 INFO - Running setup.py install for mozinfo 04:32:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:07 INFO - Running setup.py install for mozInstall 04:32:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Running setup.py install for mozleak 04:32:08 INFO - Running setup.py install for mozlog 04:32:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Running setup.py install for moznetwork 04:32:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Running setup.py install for mozprocess 04:32:08 INFO - Running setup.py install for mozprofile 04:32:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Running setup.py install for mozrunner 04:32:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:08 INFO - Running setup.py install for mozscreenshot 04:32:08 INFO - Running setup.py install for moztest 04:32:08 INFO - Running setup.py install for mozversion 04:32:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:09 INFO - Cleaning up... 04:32:09 INFO - Return code: 0 04:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:09 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')]} 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:09 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')]} 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:09 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:09 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 04:32:09 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 04:32:09 INFO - Using env: {'DISPLAY': ':0', 04:32:09 INFO - 'HOME': '/home/cltbld', 04:32:09 INFO - 'LANG': 'en_US.UTF-8', 04:32:09 INFO - 'LANGUAGE': 'en_US:en', 04:32:09 INFO - 'LOGNAME': 'cltbld', 04:32:09 INFO - 'MAIL': '/var/mail/cltbld', 04:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:09 INFO - 'MOZ_NO_REMOTE': '1', 04:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:09 INFO - 'NO_EM_RESTART': '1', 04:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:09 INFO - 'PWD': '/builds/slave/test', 04:32:09 INFO - 'SHELL': '/bin/bash', 04:32:09 INFO - 'SHLVL': '1', 04:32:09 INFO - 'TERM': 'linux', 04:32:09 INFO - 'TMOUT': '86400', 04:32:09 INFO - 'USER': 'cltbld', 04:32:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:09 INFO - '_': '/tools/buildbot/bin/python'} 04:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:09 INFO - Running setup.py (path:/tmp/pip-_nFxz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:09 INFO - Running setup.py (path:/tmp/pip-u5mMgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:09 INFO - Running setup.py (path:/tmp/pip-ilrful-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:09 INFO - Running setup.py (path:/tmp/pip-N7RH7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:09 INFO - Running setup.py (path:/tmp/pip-WKcIId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:09 INFO - Running setup.py (path:/tmp/pip-PySSa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:09 INFO - Running setup.py (path:/tmp/pip-NS1WGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:09 INFO - Running setup.py (path:/tmp/pip-xs7Q23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:09 INFO - Running setup.py (path:/tmp/pip-XDHUTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:09 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)) 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:09 INFO - Running setup.py (path:/tmp/pip-imRTTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:10 INFO - Running setup.py (path:/tmp/pip-nHa57o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:10 INFO - Running setup.py (path:/tmp/pip-kZuZyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:10 INFO - Running setup.py (path:/tmp/pip-P4PeGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:10 INFO - Running setup.py (path:/tmp/pip-BGReG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:10 INFO - Running setup.py (path:/tmp/pip-oEAY4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:10 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)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:10 INFO - Running setup.py (path:/tmp/pip-UgYryS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:10 INFO - Running setup.py (path:/tmp/pip-Zlwd5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:10 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)) 04:32:10 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)) 04:32:10 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)) 04:32:10 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)) 04:32:10 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)) 04:32:10 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)) 04:32:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:12 INFO - Downloading blessings-1.6.tar.gz 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:12 INFO - Installing collected packages: blessings 04:32:12 INFO - Running setup.py install for blessings 04:32:12 INFO - Successfully installed blessings 04:32:12 INFO - Cleaning up... 04:32:12 INFO - Return code: 0 04:32:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:13 INFO - Reading from file tmpfile_stdout 04:32:13 INFO - Current package versions: 04:32:13 INFO - argparse == 1.2.1 04:32:13 INFO - blessings == 1.6 04:32:13 INFO - blobuploader == 1.2.4 04:32:13 INFO - docopt == 0.6.1 04:32:13 INFO - functools32 == 3.2.3-2 04:32:13 INFO - jsonschema == 2.5.1 04:32:13 INFO - manifestparser == 1.1 04:32:13 INFO - mozInstall == 1.12 04:32:13 INFO - mozcrash == 1.0 04:32:13 INFO - mozdebug == 0.1 04:32:13 INFO - mozdevice == 0.48 04:32:13 INFO - mozfile == 1.2 04:32:13 INFO - mozhttpd == 0.7 04:32:13 INFO - mozinfo == 0.9 04:32:13 INFO - mozleak == 0.1 04:32:13 INFO - mozlog == 3.4 04:32:13 INFO - moznetwork == 0.27 04:32:13 INFO - mozprocess == 0.23 04:32:13 INFO - mozprofile == 0.28 04:32:13 INFO - mozrunner == 6.13 04:32:13 INFO - mozscreenshot == 0.1 04:32:13 INFO - mozsystemmonitor == 0.3 04:32:13 INFO - moztest == 0.8 04:32:13 INFO - mozversion == 1.4 04:32:13 INFO - psutil == 3.1.1 04:32:13 INFO - requests == 1.2.3 04:32:13 INFO - wsgiref == 0.1.2 04:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 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 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:13 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 04:32:13 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 04:32:13 INFO - Using env: {'DISPLAY': ':0', 04:32:13 INFO - 'HOME': '/home/cltbld', 04:32:13 INFO - 'LANG': 'en_US.UTF-8', 04:32:13 INFO - 'LANGUAGE': 'en_US:en', 04:32:13 INFO - 'LOGNAME': 'cltbld', 04:32:13 INFO - 'MAIL': '/var/mail/cltbld', 04:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:13 INFO - 'MOZ_NO_REMOTE': '1', 04:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:13 INFO - 'NO_EM_RESTART': '1', 04:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:13 INFO - 'PWD': '/builds/slave/test', 04:32:13 INFO - 'SHELL': '/bin/bash', 04:32:13 INFO - 'SHLVL': '1', 04:32:13 INFO - 'TERM': 'linux', 04:32:13 INFO - 'TMOUT': '86400', 04:32:13 INFO - 'USER': 'cltbld', 04:32:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:13 INFO - '_': '/tools/buildbot/bin/python'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 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)) 04:32:13 INFO - Cleaning up... 04:32:13 INFO - Return code: 0 04:32:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c1370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, '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': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', '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 04:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:13 INFO - Using env: {'DISPLAY': ':0', 04:32:13 INFO - 'HOME': '/home/cltbld', 04:32:13 INFO - 'LANG': 'en_US.UTF-8', 04:32:13 INFO - 'LANGUAGE': 'en_US:en', 04:32:13 INFO - 'LOGNAME': 'cltbld', 04:32:13 INFO - 'MAIL': '/var/mail/cltbld', 04:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:13 INFO - 'MOZ_NO_REMOTE': '1', 04:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:13 INFO - 'NO_EM_RESTART': '1', 04:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:13 INFO - 'PWD': '/builds/slave/test', 04:32:13 INFO - 'SHELL': '/bin/bash', 04:32:13 INFO - 'SHLVL': '1', 04:32:13 INFO - 'TERM': 'linux', 04:32:13 INFO - 'TMOUT': '86400', 04:32:13 INFO - 'USER': 'cltbld', 04:32:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:13 INFO - '_': '/tools/buildbot/bin/python'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:13 INFO - Cleaning up... 04:32:13 INFO - Return code: 0 04:32:13 INFO - Running post-action listener: _resource_record_post_action 04:32:13 INFO - Running post-action listener: _start_resource_monitoring 04:32:13 INFO - Starting resource monitoring. 04:32:13 INFO - [mozharness: 2017-01-10 12:32:13.518556Z] Finished create-virtualenv step (success) 04:32:13 INFO - [mozharness: 2017-01-10 12:32:13.519016Z] Running install step. 04:32:13 INFO - Running pre-action listener: _resource_record_pre_action 04:32:13 INFO - Running main action method: install 04:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:13 INFO - Reading from file tmpfile_stdout 04:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:13 INFO - Reading from file tmpfile_stdout 04:32:13 INFO - Output received: 04:32:13 INFO - Usage: mozinstall [options] installer 04:32:13 INFO - Options: 04:32:13 INFO - -h, --help show this help message and exit 04:32:13 INFO - -d DEST, --destination=DEST 04:32:13 INFO - Directory to install application into. [default: 04:32:13 INFO - "/builds/slave/test"] 04:32:13 INFO - --app=APP Application being installed. [default: firefox] 04:32:13 INFO - mkdir: /builds/slave/test/build/application 04:32:13 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'] 04:32:13 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 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Output received: 04:32:29 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:29 INFO - Running post-action listener: _resource_record_post_action 04:32:29 INFO - [mozharness: 2017-01-10 12:32:29.746978Z] Finished install step (success) 04:32:29 INFO - [mozharness: 2017-01-10 12:32:29.747221Z] Running run-tests step. 04:32:29 INFO - Running pre-action listener: _resource_record_pre_action 04:32:29 INFO - Running main action method: run_tests 04:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:29 INFO - Python 2.7.3 04:32:29 INFO - Return code: 0 04:32:29 INFO - grabbing minidump binary from tooltool 04:32:29 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')]} 04:32:29 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 0x18f4f60>, '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 0x18f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:29 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 04:32:29 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 04:32:29 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 04:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:29 INFO - Return code: 0 04:32:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:29 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/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:32:29 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/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 04:32:29 INFO - Using env: {'DISPLAY': ':0', 04:32:29 INFO - 'HOME': '/home/cltbld', 04:32:29 INFO - 'LANG': 'en_US.UTF-8', 04:32:29 INFO - 'LANGUAGE': 'en_US:en', 04:32:29 INFO - 'LOGNAME': 'cltbld', 04:32:29 INFO - 'MAIL': '/var/mail/cltbld', 04:32:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:29 INFO - 'MOZ_NO_REMOTE': '1', 04:32:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:29 INFO - 'NO_EM_RESTART': '1', 04:32:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:29 INFO - 'PWD': '/builds/slave/test', 04:32:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:29 INFO - 'SHELL': '/bin/bash', 04:32:29 INFO - 'SHLVL': '1', 04:32:29 INFO - 'TERM': 'linux', 04:32:29 INFO - 'TMOUT': '86400', 04:32:29 INFO - 'USER': 'cltbld', 04:32:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605', 04:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:29 INFO - '_': '/tools/buildbot/bin/python'} 04:32:29 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/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:32:30 INFO - mozversion application_buildid: 20170110025308 04:32:30 INFO - mozversion application_changeset: adba84d693a69f2ee1c8dd23493128d6879b2288 04:32:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:30 INFO - mozversion application_name: Firefox 04:32:30 INFO - mozversion application_remotingname: firefox-dev 04:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:32:30 INFO - mozversion application_vendor: Mozilla 04:32:30 INFO - mozversion application_version: 52.0a2 04:32:30 INFO - mozversion platform_buildid: 20170110025308 04:32:30 INFO - mozversion platform_changeset: adba84d693a69f2ee1c8dd23493128d6879b2288 04:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:32:30 INFO - mozversion platform_version: 52.0a2 04:32:30 INFO - using testdate: 1484051550 04:32:30 INFO - actual date: 1484051550 04:32:30 INFO - starting webserver on 'localhost:56666' 04:32:30 INFO - SUITE-START | Running 2 tests 04:32:30 INFO - TEST-START | dromaeo_css 04:32:30 INFO - operating with platform_type : linux_ 04:32:30 INFO - Initialising browser for dromaeo_css test... 04:32:30 INFO - TEST-INFO | started process 2486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgshFbC/profile http://localhost:56666/getInfo.html) 04:32:33 INFO - PROCESS | 2486 | __metrics Screen width/height:1600/1200 04:32:33 INFO - PROCESS | 2486 | colorDepth:24 04:32:33 INFO - PROCESS | 2486 | Browser inner width/height: 1024/697 04:32:33 INFO - PROCESS | 2486 | __metrics 04:32:34 INFO - PROCESS | 2486 | 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" 04:32:34 INFO - PROCESS | 2486 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:34 INFO - PROCESS | 2486 | console.error: PushService: 04:32:34 INFO - PROCESS | 2486 | stateChangeProcessEnqueue: Error transitioning state 04:32:34 INFO - PROCESS | 2486 | UnknownError 04:32:35 INFO - TEST-INFO | 2486: exit 0 04:32:35 INFO - Browser initialized. 04:32:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:35 INFO - TEST-INFO | started process 2594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgshFbC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:47 INFO - PROCESS | 2594 | RSS: Main: 144293888 04:32:47 INFO - PROCESS | 2594 | 04:35:49 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56666/tests/dromaeo/cssquery-ext.html) 04:35:50 INFO - PROCESS | 2594 | RSS: Main: 234471424 04:35:50 INFO - PROCESS | 2594 | 04:38:52 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-ext.html (next: http://localhost:56666/tests/dromaeo/cssquery-jquery.html) 04:38:53 INFO - PROCESS | 2594 | RSS: Main: 235253760 04:38:53 INFO - PROCESS | 2594 | 04:41:55 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56666/tests/dromaeo/cssquery-mootools.html) 04:41:55 INFO - PROCESS | 2594 | RSS: Main: 200957952 04:41:55 INFO - PROCESS | 2594 | 04:44:57 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56666/tests/dromaeo/cssquery-prototype.html) 04:44:58 INFO - PROCESS | 2594 | RSS: Main: 220930048 04:44:58 INFO - PROCESS | 2594 | 04:48:00 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56666/tests/dromaeo/cssquery-yui.html) 04:48:01 INFO - PROCESS | 2594 | RSS: Main: 176508928 04:48:01 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-yui.html (next: http://localhost:56666/tests/dromaeo/cssquery-dojo.html) 04:51:04 INFO - PROCESS | 2594 | RSS: Main: 269611008 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | __start_tp_report 04:51:04 INFO - PROCESS | 2594 | _x_x_mozilla_page_load 04:51:04 INFO - PROCESS | 2594 | _x_x_mozilla_page_load_details 04:51:04 INFO - PROCESS | 2594 | |i|pagename|runs| 04:51:04 INFO - PROCESS | 2594 | |0;dojo.html;3240.4653232216683;3264.72249858762;3282.2122690554274;3287.030326053814;3295;5496.80761173359;5558.777648894044;5579.804706835262;5583.13461413481;5586.497215250627;5538;5572;5597.832065038046;5599.8600034999145;5607.243022192013;5031.295618613388;5070.847874563769;5097.184450487923;5139.357580302462;5172.6379153459275;4964.726940018316;5095.3885533736;5125.051865404912;5130.820421285256;5133.435322114565;4997.975010124963;5052.242163675442;5071.7210553419545;5087.923681144785;5113.923291150636;5127.128388174019;5158.329417175743;5159.819406320779;5216.087184742655;5218.765155568009;5046.343975283226;5116.053530096944;5168.638195326329;5177.8187763428095;5209.895802083975;5376.650517716375;5417.6478528895495;5493.752781124859;5505.119180931032;5549.334079910396;5969.970150149222;5973.133895585159;5975.7609695612555;6061.454469097758;6063.272407311107;6109.14471973924;6110.297315808694;6112.205413296288;6114.327423983358;6122.632642041492;5437.184422336682;5447.400785913546;5541.667499950016;5592.692401917933;5597.412271711493;6113.908291375633;6139.570230083851;6143.539234557426;6150.231221097363;6164.5684802064325;5912.379200184005;5915.408459154136;5916.290045194518;5923.229980102646;5934.37689042653;5710.885782284331;5780.942190578125;5843.795467158629;5909.202257695156;5911;5932.080527518242;5943.494802941798;5947.524198064145;5963.940360596339;5977.581569290108;5883.411658834082;5926.288845338587;5936.7031648417405;5942.821715348547;5963.2844058713235;4419.491758447755;4453.109378124388;4553.749543775058;4583.564561366665;4591.79336929839;4110.547839737626;4111.362738775495;4130.194612050621;4153.397757325231;4172.269852775752;5641.661500309994;5653.406392328829;5653.886922261532;5658.801941932013;5675.631083979528;5682.062459694104;5727.799527016535;6017.69911504423;6025;6025.879482410327;5520.53075488588;5531.308586426697;5559.972200138974;5593.496585307342;5633.492985631313;5091.363579552556;5093.388793344822;5104;5107.948920510822;5125;6046.879062418639;6136.500946189649;6154.96450016433;6187.597806142587;6193.566450348432;5870.412958704095;5915.438033386821;6013.158157857816;6013.398660133952;6121.1430399743185;6286.402791734778;6329.5252856036905;6331.05034244867;6335.239771227482;6340.461060809883;5962.314333851489;5963.232039940554;5964.5526585505395;5965.164876917148;5967.791127310524;5779.682117483579;5802.332731735735;5888.528917686489;5903.350631430453;5934.347221805511;5834.27071616048;5835.649861008353;5836.591438599427;5847.795327163529;5870.735816888165;5763.250777398911;5805.245318108618;5820.097884827858;5826.213461182686;5829.09649004405;5613.74738136793;5664.915026274692;5708.343540492897;5750.597458178055;5776.075827867521;5913.763449461973;5925.140854575976;5957.314908785545;5965.135055417027;5970.134330522137;5543.0022595931505;5807.738651760766;5808.912866306924;5814.592978491465;5816.5055970243 04:51:04 INFO - PROCESS | 2594 | |1;ext.html;591.03956071384;617.3086143519259;639.4149353341694;663.5288944849157;672.8149758816328;35541.64458355416;37637.81181094094;49016.999999999956;49994.750026249814;50014.24978625323;46484.76757616207;47293.29060064093;47313.52686473134;47356.52643473564;47429;8260;8762.430442021248;8886.911130888673;8904;8907.331950103735;8311.83376332473;10523.210759193053;10773.407462589554;10783.191260655443;11062.723431914186;10878.075363594104;10946.069584085362;10947.069499092548;10949.562017519289;10950.780984380308;10685.358878467277;10732.409717465498;10741.248112632118;10745.14038876888;10757.83863242052;10552.47237638115;10573.259871808976;10583.894161058368;10598.470076496144;10601.469926503722;43412.34881476781;43474.13051738979;43665.56334436647;43851.78074109641;43859.342109868376;3591.317649646585;3685.262947410502;3725.869594564177;3825.9043523911846;4065;33046.33907321864;33281.167970800925;33320.50019249713;33424.83287583571;33506.32987340264;3620.366435873738;3634.1459756957092;3703.3704270273847;3731.9440208396895;3789.0148561373967;247451;248411;248734;249059.75470122715;249960;38597.42103868444;63796;63823;64074;64270;39533;41722.791386042874;41854.58145418507;41920.79039604782;41922;15670.059796412252;15801.920990394974;15810.446634367741;15819.367225310858;15861.286242119133;13257.07200495956;13554.59336219915;13606.795898061537;13666.93166534161;13900.652483687989;9559.522023898777;9593.760155996017;9668.178204852666;9719.805603887882;9772.511374431393;3628.2199327144262;3662.304162209172;3732.346839303111;3748.962510374916;3753.9249215015548;1061.936283822973;1082.5615625671617;1092.579356947581;1099.219554116586;1131.7365269461077;34715.65284347175;34933;35110.47334289987;35189.29621407558;35378.64621353753;1123.2081382625229;1155.6764106050318;1208.7763763703742;1239.7148655809215;1255.6923553729396;18056.27774889016;18138.455846324632;18241.7263741044;18363.449096527125;18408.907955460138;513285;513696;514588;517260;517300;63155.684221578595;63861;63892.36107638864;63897.680511597144;64003;1322.2793577500286;1372.293268966483;1377.6349267444136;1453.9200343980972;1478.2978085409559;31433.8428307857;35668.82165589155;35742.64257357393;38396.50422722514;38433.2313353737;61055;61932;61975.38024619696;61988.38011619826;62043.689781550805;371304;373702;374331;375138;375412;28373.43253134967;29613.85193074021;31313.530297046018;31963.680363197;32426;50734.23898641449;51290;51664;51757;52970.47029529655;42603.57396425996;44405;44559;44866.327005094296;45514.31728524141;42852;43327;43692.781536092116;44319.33520997123;45024.54975450334;45272.547274526834;45658.315125272486;45799.542004579525;45897.31154032626;45915.77042114768;36706.63293367032;39549.60450395459;39689.60310396859;39801.12926597619;40226.79886600548;29971;30015.3996920056;30216;30363.848180758956;30447.54328685116 04:51:04 INFO - PROCESS | 2594 | |2;jquery.html;399.2753153027255;401.81315688204995;406.99186016279657;413.83446621351453;415.10130567321744;14423.5672929812;18706.812931870678;19933.900330498363;20696.793032069654;20719.689204661925;16140.596485087879;16729.498115056536;16738.246778894947;19496.415107546796;19619.70570441441;5578.30271216098;5822.214001109838;5829.621074630157;5832.096025116092;5832.9708351458185;5482.725863706819;5603.943960560403;5660.462256085665;5673.6879471629045;5674.829755107354;5693.829185124432;5695.772169113251;5704.372519022904;5706.857328566777;5707.229524014268;5503.394626591092;5605.523530499912;5657.8019769307875;5695.345035320929;5703.8574035649235;5095.847124586231;5096.821611243588;5099.056674515226;5102.336696229503;5103.438621751604;22782.202622908284;23400.18099366531;23561.7643823563;23631.527369452688;23904.880475597685;2255.1994042114975;2283.178055899875;2504.561701702213;2508.611165269368;2848.700886406939;10259.743506412326;10604.628837990633;10696.893031069667;13976.371063302176;15365.923170384189;1943.689009758446;2028.8782673039666;2032.1261857401312;2058.495668561197;2067.3074520035807;86954.5652271741;90776.54611726965;92063;92524;93304;11611.65165045033;11715.297082175097;11748.177627565989;11749.353785541878;11917.404129793476;16752.83247167537;16760.748588771177;16772.916135419244;16775.2451139699;16783.748243776354;7124.323189297009;7135.179454362711;7941.483803552751;7978.6808527659405;8195.46729462583;7423.777286681408;7564.848703025908;7756.379489640815;7881.448298619041;7921.564313962787;5053.36832895888;5054.494550544916;5065.696058236517;5079.958608485252;5139.691618502902;1894;1940.4760714606978;1969.271369593231;1984.295575070858;2003.228756928593;875.7285241575005;938.7230766923774;1015.9796804064025;1057.9180410686174;1108.2630051016145;19296.517587060156;19901.502462438555;20053;20193.59612807765;20236.89881550583;1005.9195264378832;1011.3072545306488;1012.7366884610054;1019.4800651667555;1053.1311667874033;9896.254545995756;10570.365778053341;10862.72843178911;11254.49354779037;11414.600488983011;507117;508257.5119278502;509410;515704;520967;98742.5062874681;102200;105973.47013264884;107981;109233.45383273033;1014.7615310402198;1017.2777328097134;1017.5980487707315;1036.0934182590233;1058.962936297226;17928;18250.36123735663;18332.358367457076;18576.907115464335;18799.154038068045;44256;44465.55534444614;45908.54091459043;46313.53686463227;46697.53302466932;64129.35870641234;64333.67833160804;64463.355366445736;65876.0118598231;65984.67007664932;8041.195880411912;8742.868856967278;8943.508107053915;9154.992950775277;9222;13200.009999249902;13638.93180534091;13705.725885482434;13917.721645567235;13931.512397066053;10920.617778377718;11482.311061336013;11496;11659.53361865516;11807.232529885874;5614.29821272341;9393.577289021874;11507.827382589101;11611.490506234135;12030.75938481208;11572.537098516303;11732.12009099338;11883.940580297043;12099.57651482194;12764.808527871903;8234.752957411047;8265.876011859707;8436.409451338348;8514.957425212835;8555.786105347168;9007.414518056305;11238.438078095898;11477.426128693698;11783.116266279892;11982.161248712506 04:51:04 INFO - PROCESS | 2594 | |3;mootools.html;1342.570377479207;1516.4843953055959;1528.7171873203458;1644.1861278667054;1761.4891681412382;7651.846963060735;8212.219839115282;8451.19713627206;8483.575821208939;8736.257418119467;8522.40343175978;8581.09898460662;8591.699290524833;8594.398392112555;8596.312295016383;2483.7143728471233;2508.184839927022;2511.208969174704;2513.0576033987254;2514.660520829683;2436.707595088583;2506.7994560435122;2508.82438229324;2518.937026574341;2523.3060908250195;2436.8537887726707;2452.16626347042;2481.3424442522746;2485.8135639826996;2486.415692312305;2360.5868972929757;2385.2009576791797;2410.8553486790847;2412.9758702413014;2420.9152679656304;2411.0958390603523;2418.286605451396;2441.8534887906603;2443.3525115844313;2485.0680994627014;8780.25367843734;8849.911500884973;8870.201681848665;8918.375713700043;8964.238039766627;5416.620836541444;5506.972465137689;5507.228987941691;5513.724313784295;5529.529989950859;3554.6445355464507;3611.3138503684218;3669.94495082574;3690.852365905361;3716.0524066363173;1116.263266244283;1117.80997230471;1118.72031992002;1165.74936388676;1175.676688910548;12316.261024338568;12379.257244565355;12430.37848107591;12430.564930227489;12442.066844986663;4351.73889566627;4700.247960326331;4728.196206644879;4754.952450475451;4785.59322457595;9771.560279787427;9772;9785.951070244746;9842.212622990144;9844.556994935245;5452.482014208644;5452.645578037414;5454.481824226692;5454.781808727606;5456.48163424474;4323.416338794285;4499.68502204849;5121.564667003272;5126.974365128225;5172.379314482287;3977.880663580097;3995.2409042281874;4064.634182923492;4071.3892916062237;4100.569440208735;1248.8813562711528;1259.93535462534;1267.537348867675;1276.508544210467;1287.1762072273752;834.7287131682227;934.6868798952427;1000.3597697473623;1007.3049595778889;1021.065724861758;5957.49361304294;6045.425684559959;6100.206973093469;6129.478994285447;6237.438630523275;965.9034096590285;987.7728122531857;991.6330957545754;1002.4336250018716;1024.6772266735954;4185.22573323936;4272.423222864873;4279.2083464559155;4448.221561226773;4449.28811390176;10512.526936287886;11067.889321106686;11073.557057717762;11075.612353567587;11084.337349397494;10432.478376081166;10978.451077446096;10990.285631433931;10997.835032474519;11012.229143959847;8144.267015968473;8560.914390856136;8563.443376180529;8563.743087707378;8567.61445734931;6038.879222415615;6163.35284795108;6168.784092556739;6245.531585131042;6361.745530178741;10007.199424045913;10017.599296028076;10033.648822291185;10063;10117.392956422638;9866.112049915542;9998;10070.44612546317;10320.587176512856;10326.535305911402;7953.960230198812;7959.522428654299;7993;8025.438219324591;8034.919650803417;8563.357748169037;8613.87079193825;8630.266427353745;8632.223099921037;8633.525156116473;7214.675339609626;7374.373178279691;7557.244275572399;7588.772336829904;7794.2985131338455;7328.487005909748;7347.889781653386;7485.251474852471;7485.326320631169;7517.361024312994;6913.1358580177475;7007.824804379931;7016.5088443808445;7018.75434359795;7020.613866237406;5179.715115668674;5309;5324.307839980777;5348.732563371738;5351.331083614548;5342.252084708066;5453.727313634382;5456.645318054314;5461.8361449155;5483.725813709379 04:51:04 INFO - PROCESS | 2594 | |4;prototype.html;339.6823969588435;344.2220581485841;348.7436734000509;353.6057296114833;359.8380728672098;5171.327727395443;5321.122014867552;5359.866003349918;5405.216243644674;5411.540019098381;5143.691378517282;5258.7633556489955;5270.9736451317685;5278.788848446067;5292.153255479124;4216.599423054812;4220;4222.894427639303;4238.8766976751185;4241.766702831343;4161.354989976543;4240.858366524916;4251.2347777400055;4253.064325848309;4259.339802330628;4204.348326009458;4214.452121224236;4225.8448191422285;4228.372076750443;4230.76730779807;4171.97914010431;4179;4191.97904010481;4196.160767846428;4198.958010419888;3557.4130268505664;3679.816009199556;3700.759450635727;3700.8712342735453;3768.472413862034;5180.409795102449;5181.326427564431;5194.0910340690225;5202.205239192473;5222.477752224785;4782.497837727058;4798.496157903405;4800.7518045308125;4807;4821.951780482185;5358.223057656657;5459.672419654833;5537.695426751527;5606.635568688022;5622.662640241599;4068.2677118118727;4069.1515938842927;4070.715049946505;4073.97963010186;4075.7758323292205;5767.913481297784;5776.393478684719;5779.653220806723;5787.623804452739;5820.185174075633;4043.7775922323967;4139.2135494256;4202.453681021448;4231.78841057952;4301.720388174758;4311.417958575615;4330.696851220448;4331;4334;4334.157982857273;4805.399325084364;4806.327114204014;4806.855794326176;4854.732989685601;4863.95136048635;5330.626856120112;5548.306461692288;5650.180723795027;5653.293338332708;5680;1376.1399125546534;1403.4736973634888;1411.5412490940485;1456.2645863838693;1456.841810760448;996.3772642098688;1002.6340385759291;1018.8283474004805;1029.8815636201932;1034.3225187502198;5151.4333423323405;5168.741562921914;5175.560077393388;5178.533931946143;5217.373915130209;5423.267858839006;5477.260569823103;5502.80740174092;5511.200875872976;5524.558035357242;5119.59043276537;5128.692278463304;5133.563647089964;5141.534662621135;5471;2949.926251843678;2961.5557666349787;2966.9554956675233;2969.228000719785;2972.7324540791433;5800.448957349129;5806.970965145232;5816.080693371177;5823.82528524145;5838.941610583925;5539.196816461671;5630.577706672016;5680.289963754531;5682.573806964494;5705.088795253637;5790.507806836466;5801.461108723675;5801.593888427854;5802.506786923159;5811.651300921958;5352.652077614943;5581.190727344593;5583.42660697146;5607.093588180039;5614.831555053355;5552.389806955937;5567.610267281413;5588.133839254922;5588.552915766811;5592.5525957922455;5730.398308177748;5775.306963164279;5793.420657934173;5825.650460972355;5854.696797853489;3865.9561918281343;4000.3199456093116;4035.9798201008807;4050.683527853518;4053;5514.476124768141;5553.278073850373;5563.666180029211;5588.916166257428;5643.686088703612;5536.972315138399;5628.240187574789;5640.943590564206;5642.407547207484;5666;5637.689927053887;5642.943570564242;5657.60396772222;5664.518515926193;5668.659880407189;5379.892402151857;5600.551955843442;5617.382087970238;5624.3250809903075;5658.377578466448;5677.943220567907;5682.687452190169;5697.404726676537;5701.572382071444;5733.655980641008;5416.4041955385665;5494.917576236439;5563.916541251803;5565.666060036411;5621.7189140542 04:51:04 INFO - PROCESS | 2594 | |5;yui.html;790.5651891459692;795.4869109424421;824.1552408781;832.384035813498;833.3166803221361;14931.552053438387;16126.354945802183;16166.11086390248;16208.351665933378;16222.432214872482;14778.334974926127;14900.552983410515;14930.925345373285;14933.92533037336;14946.476873309437;720.1466262478979;736.2931585677755;838.7190291252423;852.4544291653347;870.2124577257592;840.2185967050671;845.1632883445407;846.7756044648173;847.8812966184739;849.4181485682327;921.5622579274858;923.1875949164726;923.4182465047011;923.7875288683607;923.9907600924006;764.1899586438366;772.2740623813626;887.5340446265698;893.4148132972913;913.4884464699757;669.6283562622742;669.6885948034187;669.7287598522606;670.0284587348365;670.2694063470791;14773.113613183243;14827.406903723839;14850.628734281621;14873.851261487354;14874.628134296621;13110.934445327808;13774.517891873737;13876.722465550733;13888.513902013483;13960.301984900714;12019.819702704466;12204.267743935303;12436.19164754288;12695.428705708266;12837.550685726048;4405.140997505488;4409.294512877957;4421.270490369086;4449.644028477714;4535.138323718483;60772.39227607712;60783.392166078214;60837.47906302378;61543.69228153831;62821.68589157025;11198.440077996067;11201.271917325348;11309.60416385439;11310.321380717183;11486.0811135109;19576.90211548933;19647.901760491106;19651.705224421647;19656;19661.213551458066;8280.420370574122;8314.127016663164;8376.455530390505;8415.537145456936;8704.434211776213;4781.282807578821;4837.346958160603;4896.314515967767;5076.3908330999775;5183.766730497136;3359.764816462824;3436.810975396327;3454.4300190468794;3475.496053072341;3486.2504561519395;587.0724255676022;598.6767145741251;602.0157043234343;614.1524695919692;615.5691016288616;667.9198496180393;683.4634811672813;703.1772825793834;707.745211723779;711.6228398948566;9176.770580735401;9189.3108016899;9347.859782103274;9397.953010234905;9496.335256531976;688.7520492622651;699.7026263837848;704.3308856586264;721.2390927571357;729.0012682624838;4456.264716321835;4813.566778989908;5114.452065720169;5128.179719164009;5319.7340132993195;70741.64629176821;91435;93012;94083;94106.5294673536;77841.2215877834;80882.59558702169;81206;83152;87238.56380718056;73589.63205184047;75680;76254;76787.84818227732;76949;9940.751481213027;10149.238807089645;10161.187105031431;10282.280240383101;10309.123724483203;48553;48942.75528622477;49446.258306126154;49524.75237623789;49633.75183124061;63253;65599.34400656124;69167;69606.95589566059;72053;12950.481980720666;12982.740345193231;13170.868291317347;13777.517786877412;14264.358103885557;15115.395384184509;15192.316345764246;15497;16116.758248626515;16163.838361616234;12782.68043298925;12957;12992.090553661154;13386.464541418234;13851.515196968057;13047.076723313241;13691.383887725275;13696.452141914611;14037.578872633838;14343.497977570734;12967.351632418153;13265.933670331586;13494.32528373597;13960.58118256454;14091.601908997858;11077.501512431798;11379.715507112058;11466.656000320003;11564.653060408202;12361.62915112548;11655.825162622397;12131.150819442908;12142;12297.877021229673;12571.87428125707 04:51:04 INFO - PROCESS | 2594 | __end_tp_report 04:51:04 INFO - PROCESS | 2594 | __start_cc_report 04:51:04 INFO - PROCESS | 2594 | _x_x_mozilla_cycle_collect,925 04:51:04 INFO - PROCESS | 2594 | __end_cc_report 04:51:04 INFO - PROCESS | 2594 | __startTimestamp1484052664414__endTimestamp 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | ------- Summary: start ------- 04:51:04 INFO - PROCESS | 2594 | Number of tests: 6 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#0] dojo.html Cycles:165 Average:5548.75 Median:5750.60 stddev:625.19 (10.9%) stddev-sans-first:600.31 04:51:04 INFO - PROCESS | 2594 | Values: 3240.5 3264.7 3282.2 3287.0 3295.0 5496.8 5558.8 5579.8 5583.1 5586.5 5538.0 5572.0 5597.8 5599.9 5607.2 5031.3 5070.8 5097.2 5139.4 5172.6 4964.7 5095.4 5125.1 5130.8 5133.4 4998.0 5052.2 5071.7 5087.9 5113.9 5127.1 5158.3 5159.8 5216.1 5218.8 5046.3 5116.1 5168.6 5177.8 5209.9 5376.7 5417.6 5493.8 5505.1 5549.3 5970.0 5973.1 5975.8 6061.5 6063.3 6109.1 6110.3 6112.2 6114.3 6122.6 5437.2 5447.4 5541.7 5592.7 5597.4 6113.9 6139.6 6143.5 6150.2 6164.6 5912.4 5915.4 5916.3 5923.2 5934.4 5710.9 5780.9 5843.8 5909.2 5911.0 5932.1 5943.5 5947.5 5963.9 5977.6 5883.4 5926.3 5936.7 5942.8 5963.3 4419.5 4453.1 4553.7 4583.6 4591.8 4110.5 4111.4 4130.2 4153.4 4172.3 5641.7 5653.4 5653.9 5658.8 5675.6 5682.1 5727.8 6017.7 6025.0 6025.9 5520.5 5531.3 5560.0 5593.5 5633.5 5091.4 5093.4 5104.0 5107.9 5125.0 6046.9 6136.5 6155.0 6187.6 6193.6 5870.4 5915.4 6013.2 6013.4 6121.1 6286.4 6329.5 6331.1 6335.2 6340.5 5962.3 5963.2 5964.6 5965.2 5967.8 5779.7 5802.3 5888.5 5903.4 5934.3 5834.3 5835.6 5836.6 5847.8 5870.7 5763.3 5805.2 5820.1 5826.2 5829.1 5613.7 5664.9 5708.3 5750.6 5776.1 5913.8 5925.1 5957.3 5965.1 5970.1 5543.0 5807.7 5808.9 5814.6 5816.5 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#1] ext.html Cycles:180 Average:55922.81 Median:374016.50 stddev:104513.87 (27.9%) stddev-sans-first:104724.49 04:51:04 INFO - PROCESS | 2594 | Values: 591.0 617.3 639.4 663.5 672.8 35541.6 37637.8 49017.0 49994.8 50014.2 46484.8 47293.3 47313.5 47356.5 47429.0 8260.0 8762.4 8886.9 8904.0 8907.3 8311.8 10523.2 10773.4 10783.2 11062.7 10878.1 10946.1 10947.1 10949.6 10950.8 10685.4 10732.4 10741.2 10745.1 10757.8 10552.5 10573.3 10583.9 10598.5 10601.5 43412.3 43474.1 43665.6 43851.8 43859.3 3591.3 3685.3 3725.9 3825.9 4065.0 33046.3 33281.2 33320.5 33424.8 33506.3 3620.4 3634.1 3703.4 3731.9 3789.0 247451.0 248411.0 248734.0 249059.8 249960.0 38597.4 63796.0 63823.0 64074.0 64270.0 39533.0 41722.8 41854.6 41920.8 41922.0 15670.1 15801.9 15810.4 15819.4 15861.3 13257.1 13554.6 13606.8 13666.9 13900.7 9559.5 9593.8 9668.2 9719.8 9772.5 3628.2 3662.3 3732.3 3749.0 3753.9 1061.9 1082.6 1092.6 1099.2 1131.7 34715.7 34933.0 35110.5 35189.3 35378.6 1123.2 1155.7 1208.8 1239.7 1255.7 18056.3 18138.5 18241.7 18363.4 18408.9 513285.0 513696.0 514588.0 517260.0 517300.0 63155.7 63861.0 63892.4 63897.7 64003.0 1322.3 1372.3 1377.6 1453.9 1478.3 31433.8 35668.8 35742.6 38396.5 38433.2 61055.0 61932.0 61975.4 61988.4 62043.7 371304.0 373702.0 374331.0 375138.0 375412.0 28373.4 29613.9 31313.5 31963.7 32426.0 50734.2 51290.0 51664.0 51757.0 52970.5 42603.6 44405.0 44559.0 44866.3 45514.3 42852.0 43327.0 43692.8 44319.3 45024.5 45272.5 45658.3 45799.5 45897.3 45915.8 36706.6 39549.6 39689.6 39801.1 40226.8 29971.0 30015.4 30216.0 30363.8 30447.5 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#2] jquery.html Cycles:180 Average:30621.29 Median:12841.68 stddev:84914.33 (661.2%) stddev-sans-first:85122.22 04:51:04 INFO - PROCESS | 2594 | Values: 399.3 401.8 407.0 413.8 415.1 14423.6 18706.8 19933.9 20696.8 20719.7 16140.6 16729.5 16738.2 19496.4 19619.7 5578.3 5822.2 5829.6 5832.1 5833.0 5482.7 5603.9 5660.5 5673.7 5674.8 5693.8 5695.8 5704.4 5706.9 5707.2 5503.4 5605.5 5657.8 5695.3 5703.9 5095.8 5096.8 5099.1 5102.3 5103.4 22782.2 23400.2 23561.8 23631.5 23904.9 2255.2 2283.2 2504.6 2508.6 2848.7 10259.7 10604.6 10696.9 13976.4 15365.9 1943.7 2028.9 2032.1 2058.5 2067.3 86954.6 90776.5 92063.0 92524.0 93304.0 11611.7 11715.3 11748.2 11749.4 11917.4 16752.8 16760.7 16772.9 16775.2 16783.7 7124.3 7135.2 7941.5 7978.7 8195.5 7423.8 7564.8 7756.4 7881.4 7921.6 5053.4 5054.5 5065.7 5080.0 5139.7 1894.0 1940.5 1969.3 1984.3 2003.2 875.7 938.7 1016.0 1057.9 1108.3 19296.5 19901.5 20053.0 20193.6 20236.9 1005.9 1011.3 1012.7 1019.5 1053.1 9896.3 10570.4 10862.7 11254.5 11414.6 507117.0 508257.5 509410.0 515704.0 520967.0 98742.5 102200.0 105973.5 107981.0 109233.5 1014.8 1017.3 1017.6 1036.1 1059.0 17928.0 18250.4 18332.4 18576.9 18799.2 44256.0 44465.6 45908.5 46313.5 46697.5 64129.4 64333.7 64463.4 65876.0 65984.7 8041.2 8742.9 8943.5 9155.0 9222.0 13200.0 13638.9 13705.7 13917.7 13931.5 10920.6 11482.3 11496.0 11659.5 11807.2 5614.3 9393.6 11507.8 11611.5 12030.8 11572.5 11732.1 11883.9 12099.6 12764.8 8234.8 8265.9 8436.4 8515.0 8555.8 9007.4 11238.4 11477.4 11783.1 11982.2 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#3] mootools.html Cycles:180 Average:5853.82 Median:5124.27 stddev:3236.52 (63.2%) stddev-sans-first:3227.83 04:51:04 INFO - PROCESS | 2594 | Values: 1342.6 1516.5 1528.7 1644.2 1761.5 7651.8 8212.2 8451.2 8483.6 8736.3 8522.4 8581.1 8591.7 8594.4 8596.3 2483.7 2508.2 2511.2 2513.1 2514.7 2436.7 2506.8 2508.8 2518.9 2523.3 2436.9 2452.2 2481.3 2485.8 2486.4 2360.6 2385.2 2410.9 2413.0 2420.9 2411.1 2418.3 2441.9 2443.4 2485.1 8780.3 8849.9 8870.2 8918.4 8964.2 5416.6 5507.0 5507.2 5513.7 5529.5 3554.6 3611.3 3669.9 3690.9 3716.1 1116.3 1117.8 1118.7 1165.7 1175.7 12316.3 12379.3 12430.4 12430.6 12442.1 4351.7 4700.2 4728.2 4755.0 4785.6 9771.6 9772.0 9786.0 9842.2 9844.6 5452.5 5452.6 5454.5 5454.8 5456.5 4323.4 4499.7 5121.6 5127.0 5172.4 3977.9 3995.2 4064.6 4071.4 4100.6 1248.9 1259.9 1267.5 1276.5 1287.2 834.7 934.7 1000.4 1007.3 1021.1 5957.5 6045.4 6100.2 6129.5 6237.4 965.9 987.8 991.6 1002.4 1024.7 4185.2 4272.4 4279.2 4448.2 4449.3 10512.5 11067.9 11073.6 11075.6 11084.3 10432.5 10978.5 10990.3 10997.8 11012.2 8144.3 8560.9 8563.4 8563.7 8567.6 6038.9 6163.4 6168.8 6245.5 6361.7 10007.2 10017.6 10033.6 10063.0 10117.4 9866.1 9998.0 10070.4 10320.6 10326.5 7954.0 7959.5 7993.0 8025.4 8034.9 8563.4 8613.9 8630.3 8632.2 8633.5 7214.7 7374.4 7557.2 7588.8 7794.3 7328.5 7347.9 7485.3 7485.3 7517.4 6913.1 7007.8 7016.5 7018.8 7020.6 5179.7 5309.0 5324.3 5348.7 5351.3 5342.3 5453.7 5456.6 5461.8 5483.7 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#4] prototype.html Cycles:180 Average:4691.13 Median:5264.87 stddev:1351.07 (25.7%) stddev-sans-first:1314.79 04:51:04 INFO - PROCESS | 2594 | Values: 339.7 344.2 348.7 353.6 359.8 5171.3 5321.1 5359.9 5405.2 5411.5 5143.7 5258.8 5271.0 5278.8 5292.2 4216.6 4220.0 4222.9 4238.9 4241.8 4161.4 4240.9 4251.2 4253.1 4259.3 4204.3 4214.5 4225.8 4228.4 4230.8 4172.0 4179.0 4192.0 4196.2 4199.0 3557.4 3679.8 3700.8 3700.9 3768.5 5180.4 5181.3 5194.1 5202.2 5222.5 4782.5 4798.5 4800.8 4807.0 4822.0 5358.2 5459.7 5537.7 5606.6 5622.7 4068.3 4069.2 4070.7 4074.0 4075.8 5767.9 5776.4 5779.7 5787.6 5820.2 4043.8 4139.2 4202.5 4231.8 4301.7 4311.4 4330.7 4331.0 4334.0 4334.2 4805.4 4806.3 4806.9 4854.7 4864.0 5330.6 5548.3 5650.2 5653.3 5680.0 1376.1 1403.5 1411.5 1456.3 1456.8 996.4 1002.6 1018.8 1029.9 1034.3 5151.4 5168.7 5175.6 5178.5 5217.4 5423.3 5477.3 5502.8 5511.2 5524.6 5119.6 5128.7 5133.6 5141.5 5471.0 2949.9 2961.6 2967.0 2969.2 2972.7 5800.4 5807.0 5816.1 5823.8 5838.9 5539.2 5630.6 5680.3 5682.6 5705.1 5790.5 5801.5 5801.6 5802.5 5811.7 5352.7 5581.2 5583.4 5607.1 5614.8 5552.4 5567.6 5588.1 5588.6 5592.6 5730.4 5775.3 5793.4 5825.7 5854.7 3866.0 4000.3 4036.0 4050.7 4053.0 5514.5 5553.3 5563.7 5588.9 5643.7 5537.0 5628.2 5640.9 5642.4 5666.0 5637.7 5642.9 5657.6 5664.5 5668.7 5379.9 5600.6 5617.4 5624.3 5658.4 5677.9 5682.7 5697.4 5701.6 5733.7 5416.4 5494.9 5563.9 5565.7 5621.7 04:51:04 INFO - PROCESS | 2594 | 04:51:04 INFO - PROCESS | 2594 | [#5] yui.html Cycles:180 Average:18716.26 Median:27171.29 stddev:24676.91 (90.8%) stddev-sans-first:24709.43 04:51:04 INFO - PROCESS | 2594 | Values: 790.6 795.5 824.2 832.4 833.3 14931.6 16126.4 16166.1 16208.4 16222.4 14778.3 14900.6 14930.9 14933.9 14946.5 720.1 736.3 838.7 852.5 870.2 840.2 845.2 846.8 847.9 849.4 921.6 923.2 923.4 923.8 924.0 764.2 772.3 887.5 893.4 913.5 669.6 669.7 669.7 670.0 670.3 14773.1 14827.4 14850.6 14873.9 14874.6 13110.9 13774.5 13876.7 13888.5 13960.3 12019.8 12204.3 12436.2 12695.4 12837.6 4405.1 4409.3 4421.3 4449.6 4535.1 60772.4 60783.4 60837.5 61543.7 62821.7 11198.4 11201.3 11309.6 11310.3 11486.1 19576.9 19647.9 19651.7 19656.0 19661.2 8280.4 8314.1 8376.5 8415.5 8704.4 4781.3 4837.3 4896.3 5076.4 5183.8 3359.8 3436.8 3454.4 3475.5 3486.3 587.1 598.7 602.0 614.2 615.6 667.9 683.5 703.2 707.7 711.6 9176.8 9189.3 9347.9 9398.0 9496.3 688.8 699.7 704.3 721.2 729.0 4456.3 4813.6 5114.5 5128.2 5319.7 70741.6 91435.0 93012.0 94083.0 94106.5 77841.2 80882.6 81206.0 83152.0 87238.6 73589.6 75680.0 76254.0 76787.8 76949.0 9940.8 10149.2 10161.2 10282.3 10309.1 48553.0 48942.8 49446.3 49524.8 49633.8 63253.0 65599.3 69167.0 69607.0 72053.0 12950.5 12982.7 13170.9 13777.5 14264.4 15115.4 15192.3 15497.0 16116.8 16163.8 12782.7 12957.0 12992.1 13386.5 13851.5 13047.1 13691.4 13696.5 14037.6 14343.5 12967.4 13265.9 13494.3 13960.6 14091.6 11077.5 11379.7 11466.7 11564.7 12361.6 11655.8 12131.2 12142.0 12297.9 12571.9 04:51:04 INFO - PROCESS | 2594 | -------- Summary: end -------- 04:51:04 INFO - PROCESS | 2594 | 04:51:05 INFO - TEST-INFO | 2594: exit 0 04:51:05 INFO - TEST-OK | dromaeo_css | took 1115187ms 04:51:05 INFO - TEST-START | kraken 04:51:05 INFO - operating with platform_type : linux_ 04:51:05 INFO - Initialising browser for kraken test... 04:51:05 INFO - TEST-INFO | started process 3018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNK6Jct/profile http://localhost:56666/getInfo.html) 04:51:09 INFO - PROCESS | 3018 | __metrics Screen width/height:1600/1200 04:51:09 INFO - PROCESS | 3018 | colorDepth:24 04:51:09 INFO - PROCESS | 3018 | Browser inner width/height: 1024/697 04:51:09 INFO - PROCESS | 3018 | __metrics 04:51:09 INFO - PROCESS | 3018 | 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" 04:51:09 INFO - PROCESS | 3018 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:10 INFO - PROCESS | 3018 | console.error: PushService: 04:51:10 INFO - PROCESS | 3018 | stateChangeProcessEnqueue: Error transitioning state 04:51:10 INFO - PROCESS | 3018 | UnknownError 04:51:10 INFO - TEST-INFO | 3018: exit 0 04:51:10 INFO - Browser initialized. 04:51:10 INFO - Running cycle 1/1 for kraken test... 04:51:10 INFO - TEST-INFO | started process 3111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNK6Jct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:22 INFO - PROCESS | 3111 | RSS: Main: 143491072 04:51:22 INFO - PROCESS | 3111 | 04:51:25 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:25 INFO - PROCESS | 3111 | RSS: Main: 184803328 04:51:25 INFO - PROCESS | 3111 | 04:51:28 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-dft) 04:51:29 INFO - PROCESS | 3111 | RSS: Main: 174903296 04:51:29 INFO - PROCESS | 3111 | 04:51:31 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-fft) 04:51:32 INFO - PROCESS | 3111 | RSS: Main: 265863168 04:51:32 INFO - PROCESS | 3111 | 04:51:34 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-oscillator) 04:51:35 INFO - PROCESS | 3111 | RSS: Main: 172326912 04:51:35 INFO - PROCESS | 3111 | 04:51:37 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:37 INFO - PROCESS | 3111 | RSS: Main: 174784512 04:51:37 INFO - PROCESS | 3111 | 04:51:40 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:41 INFO - PROCESS | 3111 | RSS: Main: 213975040 04:51:41 INFO - PROCESS | 3111 | 04:51:44 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:45 INFO - PROCESS | 3111 | RSS: Main: 212824064 04:51:45 INFO - PROCESS | 3111 | 04:51:47 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56666/tests/kraken/driver.html?testName=json-parse-financial) 04:51:48 INFO - PROCESS | 3111 | RSS: Main: 211107840 04:51:48 INFO - PROCESS | 3111 | 04:51:50 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56666/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:50 INFO - PROCESS | 3111 | RSS: Main: 173531136 04:51:50 INFO - PROCESS | 3111 | 04:51:52 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:52 INFO - PROCESS | 3111 | RSS: Main: 180236288 04:51:52 INFO - PROCESS | 3111 | 04:51:54 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:55 INFO - PROCESS | 3111 | RSS: Main: 189227008 04:51:55 INFO - PROCESS | 3111 | 04:51:58 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:58 INFO - PROCESS | 3111 | RSS: Main: 197668864 04:51:58 INFO - PROCESS | 3111 | 04:52:01 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:02 INFO - PROCESS | 3111 | RSS: Main: 194420736 04:52:02 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56666/tests/kraken/driver.html?testName=ai-astar) 04:52:03 INFO - PROCESS | 3111 | RSS: Main: 246669312 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | __start_tp_report 04:52:03 INFO - PROCESS | 3111 | _x_x_mozilla_page_load 04:52:03 INFO - PROCESS | 3111 | _x_x_mozilla_page_load_details 04:52:03 INFO - PROCESS | 3111 | |i|pagename|runs| 04:52:03 INFO - PROCESS | 3111 | |0;ai-astar;102;113;113;113;115;112;112;113;112;112 04:52:03 INFO - PROCESS | 3111 | |1;audio-beat-detection;145;122;117;164;127;118;117;118;151;116 04:52:03 INFO - PROCESS | 3111 | |2;audio-dft;160;159;161;161;160;159;160;160;160;159 04:52:03 INFO - PROCESS | 3111 | |3;audio-fft;75;75;74;109;75;77;75;77;103;74 04:52:03 INFO - PROCESS | 3111 | |4;audio-oscillator;82;82;117;82;82;81;102;81;81;120 04:52:03 INFO - PROCESS | 3111 | |5;imaging-gaussian-blur;117;116;117;118;117;117;117;116;116;117 04:52:03 INFO - PROCESS | 3111 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;146;146 04:52:03 INFO - PROCESS | 3111 | |7;imaging-desaturate;85;85;85;85;85;85;84;85;84;84 04:52:03 INFO - PROCESS | 3111 | |8;json-parse-financial;49;49;51;51;50;51;50;51;50;52 04:52:03 INFO - PROCESS | 3111 | |9;json-stringify-tinderbox;59;59;59;60;59;59;59;60;60;60 04:52:03 INFO - PROCESS | 3111 | |10;stanford-crypto-aes;78;81;75;76;75;76;76;75;83;80 04:52:03 INFO - PROCESS | 3111 | |11;stanford-crypto-ccm;128;122;124;121;128;121;121;134;179;124 04:52:03 INFO - PROCESS | 3111 | |12;stanford-crypto-pbkdf2;156;154;151;153;153;158;155;152;158;155 04:52:03 INFO - PROCESS | 3111 | |13;stanford-crypto-sha256-iterative;66;62;63;62;62;62;62;64;62;62 04:52:03 INFO - PROCESS | 3111 | __end_tp_report 04:52:03 INFO - PROCESS | 3111 | __start_cc_report 04:52:03 INFO - PROCESS | 3111 | _x_x_mozilla_cycle_collect,1613 04:52:03 INFO - PROCESS | 3111 | __end_cc_report 04:52:03 INFO - PROCESS | 3111 | __startTimestamp1484052723953__endTimestamp 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | ------- Summary: start ------- 04:52:03 INFO - PROCESS | 3111 | Number of tests: 14 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.53 (3.1%) stddev-sans-first:0.97 04:52:03 INFO - PROCESS | 3111 | Values: 102.0 113.0 113.0 113.0 115.0 112.0 112.0 113.0 112.0 112.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:124.50 stddev:17.37 (13.9%) stddev-sans-first:17.49 04:52:03 INFO - PROCESS | 3111 | Values: 145.0 122.0 117.0 164.0 127.0 118.0 117.0 118.0 151.0 116.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:52:03 INFO - PROCESS | 3111 | Values: 160.0 159.0 161.0 161.0 160.0 159.0 160.0 160.0 160.0 159.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.08 (17.4%) stddev-sans-first:13.67 04:52:03 INFO - PROCESS | 3111 | Values: 75.0 75.0 74.0 109.0 75.0 77.0 75.0 77.0 103.0 74.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.50 stddev:15.85 (19.5%) stddev-sans-first:16.48 04:52:03 INFO - PROCESS | 3111 | Values: 82.0 82.0 117.0 82.0 82.0 81.0 102.0 81.0 81.0 120.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:52:03 INFO - PROCESS | 3111 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 117.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:52:03 INFO - PROCESS | 3111 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 04:52:03 INFO - PROCESS | 3111 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:0.88 04:52:03 INFO - PROCESS | 3111 | Values: 49.0 49.0 51.0 51.0 50.0 51.0 50.0 51.0 50.0 52.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 04:52:03 INFO - PROCESS | 3111 | Values: 59.0 59.0 59.0 60.0 59.0 59.0 59.0 60.0 60.0 60.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.88 (3.7%) stddev-sans-first:3.05 04:52:03 INFO - PROCESS | 3111 | Values: 78.0 81.0 75.0 76.0 75.0 76.0 76.0 75.0 83.0 80.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:126.00 stddev:17.65 (14.0%) stddev-sans-first:18.70 04:52:03 INFO - PROCESS | 3111 | Values: 128.0 122.0 124.0 121.0 128.0 121.0 121.0 134.0 179.0 124.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:2.37 (1.5%) stddev-sans-first:2.45 04:52:03 INFO - PROCESS | 3111 | Values: 156.0 154.0 151.0 153.0 153.0 158.0 155.0 152.0 158.0 155.0 04:52:03 INFO - PROCESS | 3111 | 04:52:03 INFO - PROCESS | 3111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:0.71 04:52:03 INFO - PROCESS | 3111 | Values: 66.0 62.0 63.0 62.0 62.0 62.0 62.0 64.0 62.0 62.0 04:52:03 INFO - PROCESS | 3111 | -------- Summary: end -------- 04:52:03 INFO - PROCESS | 3111 | 04:52:05 INFO - TEST-INFO | 3111: exit 0 04:52:05 INFO - TEST-OK | kraken | took 59902ms 04:52:05 INFO - SUITE-END | took 1175s 04:52:05 INFO - Completed test suite (00:19:35) 04:52:05 INFO - javascript benchmark 04:52:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.4653232216683, 3264.72249858762, 3282.2122690554274, 3287.030326053814, 3295.0, 5496.80761173359, 5558.777648894044, 5579.804706835262, 5583.13461413481, 5586.497215250627, 5538.0, 5572.0, 5597.832065038046, 5599.8600034999145, 5607.243022192013, 5031.295618613388, 5070.847874563769, 5097.184450487923, 5139.357580302462, 5172.6379153459275, 4964.726940018316, 5095.3885533736, 5125.051865404912, 5130.820421285256, 5133.435322114565, 4997.975010124963, 5052.242163675442, 5071.7210553419545, 5087.923681144785, 5113.923291150636, 5127.128388174019, 5158.329417175743, 5159.819406320779, 5216.087184742655, 5218.765155568009, 5046.343975283226, 5116.053530096944, 5168.638195326329, 5177.8187763428095, 5209.895802083975, 5376.650517716375, 5417.6478528895495, 5493.752781124859, 5505.119180931032, 5549.334079910396, 5969.970150149222, 5973.133895585159, 5975.7609695612555, 6061.454469097758, 6063.272407311107, 6109.14471973924, 6110.297315808694, 6112.205413296288, 6114.327423983358, 6122.632642041492, 5437.184422336682, 5447.400785913546, 5541.667499950016, 5592.692401917933, 5597.412271711493, 6113.908291375633, 6139.570230083851, 6143.539234557426, 6150.231221097363, 6164.5684802064325, 5912.379200184005, 5915.408459154136, 5916.290045194518, 5923.229980102646, 5934.37689042653, 5710.885782284331, 5780.942190578125, 5843.795467158629, 5909.202257695156, 5911.0, 5932.080527518242, 5943.494802941798, 5947.524198064145, 5963.940360596339, 5977.581569290108, 5883.411658834082, 5926.288845338587, 5936.7031648417405, 5942.821715348547, 5963.2844058713235, 4419.491758447755, 4453.109378124388, 4553.749543775058, 4583.564561366665, 4591.79336929839, 4110.547839737626, 4111.362738775495, 4130.194612050621, 4153.397757325231, 4172.269852775752, 5641.661500309994, 5653.406392328829, 5653.886922261532, 5658.801941932013, 5675.631083979528, 5682.062459694104, 5727.799527016535, 6017.69911504423, 6025.0, 6025.879482410327, 5520.53075488588, 5531.308586426697, 5559.972200138974, 5593.496585307342, 5633.492985631313, 5091.363579552556, 5093.388793344822, 5104.0, 5107.948920510822, 5125.0, 6046.879062418639, 6136.500946189649, 6154.96450016433, 6187.597806142587, 6193.566450348432, 5870.412958704095, 5915.438033386821, 6013.158157857816, 6013.398660133952, 6121.1430399743185, 6286.402791734778, 6329.5252856036905, 6331.05034244867, 6335.239771227482, 6340.461060809883, 5962.314333851489, 5963.232039940554, 5964.5526585505395, 5965.164876917148, 5967.791127310524, 5779.682117483579, 5802.332731735735, 5888.528917686489, 5903.350631430453, 5934.347221805511, 5834.27071616048, 5835.649861008353, 5836.591438599427, 5847.795327163529, 5870.735816888165, 5763.250777398911, 5805.245318108618, 5820.097884827858, 5826.213461182686, 5829.09649004405, 5613.74738136793, 5664.915026274692, 5708.343540492897, 5750.597458178055, 5776.075827867521, 5913.763449461973, 5925.140854575976, 5957.314908785545, 5965.135055417027, 5970.134330522137, 5543.0022595931505, 5807.738651760766, 5808.912866306924, 5814.592978491465, 5816.5055970243], "value": 5507.305148803312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.03956071384, 617.3086143519259, 639.4149353341694, 663.5288944849157, 672.8149758816328, 35541.64458355416, 37637.81181094094, 49016.999999999956, 49994.750026249814, 50014.24978625323, 46484.76757616207, 47293.29060064093, 47313.52686473134, 47356.52643473564, 47429.0, 8260.0, 8762.430442021248, 8886.911130888673, 8904.0, 8907.331950103735, 8311.83376332473, 10523.210759193053, 10773.407462589554, 10783.191260655443, 11062.723431914186, 10878.075363594104, 10946.069584085362, 10947.069499092548, 10949.562017519289, 10950.780984380308, 10685.358878467277, 10732.409717465498, 10741.248112632118, 10745.14038876888, 10757.83863242052, 10552.47237638115, 10573.259871808976, 10583.894161058368, 10598.470076496144, 10601.469926503722, 43412.34881476781, 43474.13051738979, 43665.56334436647, 43851.78074109641, 43859.342109868376, 3591.317649646585, 3685.262947410502, 3725.869594564177, 3825.9043523911846, 4065.0, 33046.33907321864, 33281.167970800925, 33320.50019249713, 33424.83287583571, 33506.32987340264, 3620.366435873738, 3634.1459756957092, 3703.3704270273847, 3731.9440208396895, 3789.0148561373967, 247451.0, 248411.0, 248734.0, 249059.75470122715, 249960.0, 38597.42103868444, 63796.0, 63823.0, 64074.0, 64270.0, 39533.0, 41722.791386042874, 41854.58145418507, 41920.79039604782, 41922.0, 15670.059796412252, 15801.920990394974, 15810.446634367741, 15819.367225310858, 15861.286242119133, 13257.07200495956, 13554.59336219915, 13606.795898061537, 13666.93166534161, 13900.652483687989, 9559.522023898777, 9593.760155996017, 9668.178204852666, 9719.805603887882, 9772.511374431393, 3628.2199327144262, 3662.304162209172, 3732.346839303111, 3748.962510374916, 3753.9249215015548, 1061.936283822973, 1082.5615625671617, 1092.579356947581, 1099.219554116586, 1131.7365269461077, 34715.65284347175, 34933.0, 35110.47334289987, 35189.29621407558, 35378.64621353753, 1123.2081382625229, 1155.6764106050318, 1208.7763763703742, 1239.7148655809215, 1255.6923553729396, 18056.27774889016, 18138.455846324632, 18241.7263741044, 18363.449096527125, 18408.907955460138, 513285.0, 513696.0, 514588.0, 517260.0, 517300.0, 63155.684221578595, 63861.0, 63892.36107638864, 63897.680511597144, 64003.0, 1322.2793577500286, 1372.293268966483, 1377.6349267444136, 1453.9200343980972, 1478.2978085409559, 31433.8428307857, 35668.82165589155, 35742.64257357393, 38396.50422722514, 38433.2313353737, 61055.0, 61932.0, 61975.38024619696, 61988.38011619826, 62043.689781550805, 371304.0, 373702.0, 374331.0, 375138.0, 375412.0, 28373.43253134967, 29613.85193074021, 31313.530297046018, 31963.680363197, 32426.0, 50734.23898641449, 51290.0, 51664.0, 51757.0, 52970.47029529655, 42603.57396425996, 44405.0, 44559.0, 44866.327005094296, 45514.31728524141, 42852.0, 43327.0, 43692.781536092116, 44319.33520997123, 45024.54975450334, 45272.547274526834, 45658.315125272486, 45799.542004579525, 45897.31154032626, 45915.77042114768, 36706.63293367032, 39549.60450395459, 39689.60310396859, 39801.12926597619, 40226.79886600548, 29971.0, 30015.3996920056, 30216.0, 30363.848180758956, 30447.54328685116], "value": 20055.58043180301, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.2753153027255, 401.81315688204995, 406.99186016279657, 413.83446621351453, 415.10130567321744, 14423.5672929812, 18706.812931870678, 19933.900330498363, 20696.793032069654, 20719.689204661925, 16140.596485087879, 16729.498115056536, 16738.246778894947, 19496.415107546796, 19619.70570441441, 5578.30271216098, 5822.214001109838, 5829.621074630157, 5832.096025116092, 5832.9708351458185, 5482.725863706819, 5603.943960560403, 5660.462256085665, 5673.6879471629045, 5674.829755107354, 5693.829185124432, 5695.772169113251, 5704.372519022904, 5706.857328566777, 5707.229524014268, 5503.394626591092, 5605.523530499912, 5657.8019769307875, 5695.345035320929, 5703.8574035649235, 5095.847124586231, 5096.821611243588, 5099.056674515226, 5102.336696229503, 5103.438621751604, 22782.202622908284, 23400.18099366531, 23561.7643823563, 23631.527369452688, 23904.880475597685, 2255.1994042114975, 2283.178055899875, 2504.561701702213, 2508.611165269368, 2848.700886406939, 10259.743506412326, 10604.628837990633, 10696.893031069667, 13976.371063302176, 15365.923170384189, 1943.689009758446, 2028.8782673039666, 2032.1261857401312, 2058.495668561197, 2067.3074520035807, 86954.5652271741, 90776.54611726965, 92063.0, 92524.0, 93304.0, 11611.65165045033, 11715.297082175097, 11748.177627565989, 11749.353785541878, 11917.404129793476, 16752.83247167537, 16760.748588771177, 16772.916135419244, 16775.2451139699, 16783.748243776354, 7124.323189297009, 7135.179454362711, 7941.483803552751, 7978.6808527659405, 8195.46729462583, 7423.777286681408, 7564.848703025908, 7756.379489640815, 7881.448298619041, 7921.564313962787, 5053.36832895888, 5054.494550544916, 5065.696058236517, 5079.958608485252, 5139.691618502902, 1894.0, 1940.4760714606978, 1969.271369593231, 1984.295575070858, 2003.228756928593, 875.7285241575005, 938.7230766923774, 1015.9796804064025, 1057.9180410686174, 1108.2630051016145, 19296.517587060156, 19901.502462438555, 20053.0, 20193.59612807765, 20236.89881550583, 1005.9195264378832, 1011.3072545306488, 1012.7366884610054, 1019.4800651667555, 1053.1311667874033, 9896.254545995756, 10570.365778053341, 10862.72843178911, 11254.49354779037, 11414.600488983011, 507117.0, 508257.5119278502, 509410.0, 515704.0, 520967.0, 98742.5062874681, 102200.0, 105973.47013264884, 107981.0, 109233.45383273033, 1014.7615310402198, 1017.2777328097134, 1017.5980487707315, 1036.0934182590233, 1058.962936297226, 17928.0, 18250.36123735663, 18332.358367457076, 18576.907115464335, 18799.154038068045, 44256.0, 44465.55534444614, 45908.54091459043, 46313.53686463227, 46697.53302466932, 64129.35870641234, 64333.67833160804, 64463.355366445736, 65876.0118598231, 65984.67007664932, 8041.195880411912, 8742.868856967278, 8943.508107053915, 9154.992950775277, 9222.0, 13200.009999249902, 13638.93180534091, 13705.725885482434, 13917.721645567235, 13931.512397066053, 10920.617778377718, 11482.311061336013, 11496.0, 11659.53361865516, 11807.232529885874, 5614.29821272341, 9393.577289021874, 11507.827382589101, 11611.490506234135, 12030.75938481208, 11572.537098516303, 11732.12009099338, 11883.940580297043, 12099.57651482194, 12764.808527871903, 8234.752957411047, 8265.876011859707, 8436.409451338348, 8514.957425212835, 8555.786105347168, 9007.414518056305, 11238.438078095898, 11477.426128693698, 11783.116266279892, 11982.161248712506], "value": 9413.80503907205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.570377479207, 1516.4843953055959, 1528.7171873203458, 1644.1861278667054, 1761.4891681412382, 7651.846963060735, 8212.219839115282, 8451.19713627206, 8483.575821208939, 8736.257418119467, 8522.40343175978, 8581.09898460662, 8591.699290524833, 8594.398392112555, 8596.312295016383, 2483.7143728471233, 2508.184839927022, 2511.208969174704, 2513.0576033987254, 2514.660520829683, 2436.707595088583, 2506.7994560435122, 2508.82438229324, 2518.937026574341, 2523.3060908250195, 2436.8537887726707, 2452.16626347042, 2481.3424442522746, 2485.8135639826996, 2486.415692312305, 2360.5868972929757, 2385.2009576791797, 2410.8553486790847, 2412.9758702413014, 2420.9152679656304, 2411.0958390603523, 2418.286605451396, 2441.8534887906603, 2443.3525115844313, 2485.0680994627014, 8780.25367843734, 8849.911500884973, 8870.201681848665, 8918.375713700043, 8964.238039766627, 5416.620836541444, 5506.972465137689, 5507.228987941691, 5513.724313784295, 5529.529989950859, 3554.6445355464507, 3611.3138503684218, 3669.94495082574, 3690.852365905361, 3716.0524066363173, 1116.263266244283, 1117.80997230471, 1118.72031992002, 1165.74936388676, 1175.676688910548, 12316.261024338568, 12379.257244565355, 12430.37848107591, 12430.564930227489, 12442.066844986663, 4351.73889566627, 4700.247960326331, 4728.196206644879, 4754.952450475451, 4785.59322457595, 9771.560279787427, 9772.0, 9785.951070244746, 9842.212622990144, 9844.556994935245, 5452.482014208644, 5452.645578037414, 5454.481824226692, 5454.781808727606, 5456.48163424474, 4323.416338794285, 4499.68502204849, 5121.564667003272, 5126.974365128225, 5172.379314482287, 3977.880663580097, 3995.2409042281874, 4064.634182923492, 4071.3892916062237, 4100.569440208735, 1248.8813562711528, 1259.93535462534, 1267.537348867675, 1276.508544210467, 1287.1762072273752, 834.7287131682227, 934.6868798952427, 1000.3597697473623, 1007.3049595778889, 1021.065724861758, 5957.49361304294, 6045.425684559959, 6100.206973093469, 6129.478994285447, 6237.438630523275, 965.9034096590285, 987.7728122531857, 991.6330957545754, 1002.4336250018716, 1024.6772266735954, 4185.22573323936, 4272.423222864873, 4279.2083464559155, 4448.221561226773, 4449.28811390176, 10512.526936287886, 11067.889321106686, 11073.557057717762, 11075.612353567587, 11084.337349397494, 10432.478376081166, 10978.451077446096, 10990.285631433931, 10997.835032474519, 11012.229143959847, 8144.267015968473, 8560.914390856136, 8563.443376180529, 8563.743087707378, 8567.61445734931, 6038.879222415615, 6163.35284795108, 6168.784092556739, 6245.531585131042, 6361.745530178741, 10007.199424045913, 10017.599296028076, 10033.648822291185, 10063.0, 10117.392956422638, 9866.112049915542, 9998.0, 10070.44612546317, 10320.587176512856, 10326.535305911402, 7953.960230198812, 7959.522428654299, 7993.0, 8025.438219324591, 8034.919650803417, 8563.357748169037, 8613.87079193825, 8630.266427353745, 8632.223099921037, 8633.525156116473, 7214.675339609626, 7374.373178279691, 7557.244275572399, 7588.772336829904, 7794.2985131338455, 7328.487005909748, 7347.889781653386, 7485.251474852471, 7485.326320631169, 7517.361024312994, 6913.1358580177475, 7007.824804379931, 7016.5088443808445, 7018.75434359795, 7020.613866237406, 5179.715115668674, 5309.0, 5324.307839980777, 5348.732563371738, 5351.331083614548, 5342.252084708066, 5453.727313634382, 5456.645318054314, 5461.8361449155, 5483.725813709379], "value": 4728.477284504456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.6823969588435, 344.2220581485841, 348.7436734000509, 353.6057296114833, 359.8380728672098, 5171.327727395443, 5321.122014867552, 5359.866003349918, 5405.216243644674, 5411.540019098381, 5143.691378517282, 5258.7633556489955, 5270.9736451317685, 5278.788848446067, 5292.153255479124, 4216.599423054812, 4220.0, 4222.894427639303, 4238.8766976751185, 4241.766702831343, 4161.354989976543, 4240.858366524916, 4251.2347777400055, 4253.064325848309, 4259.339802330628, 4204.348326009458, 4214.452121224236, 4225.8448191422285, 4228.372076750443, 4230.76730779807, 4171.97914010431, 4179.0, 4191.97904010481, 4196.160767846428, 4198.958010419888, 3557.4130268505664, 3679.816009199556, 3700.759450635727, 3700.8712342735453, 3768.472413862034, 5180.409795102449, 5181.326427564431, 5194.0910340690225, 5202.205239192473, 5222.477752224785, 4782.497837727058, 4798.496157903405, 4800.7518045308125, 4807.0, 4821.951780482185, 5358.223057656657, 5459.672419654833, 5537.695426751527, 5606.635568688022, 5622.662640241599, 4068.2677118118727, 4069.1515938842927, 4070.715049946505, 4073.97963010186, 4075.7758323292205, 5767.913481297784, 5776.393478684719, 5779.653220806723, 5787.623804452739, 5820.185174075633, 4043.7775922323967, 4139.2135494256, 4202.453681021448, 4231.78841057952, 4301.720388174758, 4311.417958575615, 4330.696851220448, 4331.0, 4334.0, 4334.157982857273, 4805.399325084364, 4806.327114204014, 4806.855794326176, 4854.732989685601, 4863.95136048635, 5330.626856120112, 5548.306461692288, 5650.180723795027, 5653.293338332708, 5680.0, 1376.1399125546534, 1403.4736973634888, 1411.5412490940485, 1456.2645863838693, 1456.841810760448, 996.3772642098688, 1002.6340385759291, 1018.8283474004805, 1029.8815636201932, 1034.3225187502198, 5151.4333423323405, 5168.741562921914, 5175.560077393388, 5178.533931946143, 5217.373915130209, 5423.267858839006, 5477.260569823103, 5502.80740174092, 5511.200875872976, 5524.558035357242, 5119.59043276537, 5128.692278463304, 5133.563647089964, 5141.534662621135, 5471.0, 2949.926251843678, 2961.5557666349787, 2966.9554956675233, 2969.228000719785, 2972.7324540791433, 5800.448957349129, 5806.970965145232, 5816.080693371177, 5823.82528524145, 5838.941610583925, 5539.196816461671, 5630.577706672016, 5680.289963754531, 5682.573806964494, 5705.088795253637, 5790.507806836466, 5801.461108723675, 5801.593888427854, 5802.506786923159, 5811.651300921958, 5352.652077614943, 5581.190727344593, 5583.42660697146, 5607.093588180039, 5614.831555053355, 5552.389806955937, 5567.610267281413, 5588.133839254922, 5588.552915766811, 5592.5525957922455, 5730.398308177748, 5775.306963164279, 5793.420657934173, 5825.650460972355, 5854.696797853489, 3865.9561918281343, 4000.3199456093116, 4035.9798201008807, 4050.683527853518, 4053.0, 5514.476124768141, 5553.278073850373, 5563.666180029211, 5588.916166257428, 5643.686088703612, 5536.972315138399, 5628.240187574789, 5640.943590564206, 5642.407547207484, 5666.0, 5637.689927053887, 5642.943570564242, 5657.60396772222, 5664.518515926193, 5668.659880407189, 5379.892402151857, 5600.551955843442, 5617.382087970238, 5624.3250809903075, 5658.377578466448, 5677.943220567907, 5682.687452190169, 5697.404726676537, 5701.572382071444, 5733.655980641008, 5416.4041955385665, 5494.917576236439, 5563.916541251803, 5565.666060036411, 5621.7189140542], "value": 4267.627830471487, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.5651891459692, 795.4869109424421, 824.1552408781, 832.384035813498, 833.3166803221361, 14931.552053438387, 16126.354945802183, 16166.11086390248, 16208.351665933378, 16222.432214872482, 14778.334974926127, 14900.552983410515, 14930.925345373285, 14933.92533037336, 14946.476873309437, 720.1466262478979, 736.2931585677755, 838.7190291252423, 852.4544291653347, 870.2124577257592, 840.2185967050671, 845.1632883445407, 846.7756044648173, 847.8812966184739, 849.4181485682327, 921.5622579274858, 923.1875949164726, 923.4182465047011, 923.7875288683607, 923.9907600924006, 764.1899586438366, 772.2740623813626, 887.5340446265698, 893.4148132972913, 913.4884464699757, 669.6283562622742, 669.6885948034187, 669.7287598522606, 670.0284587348365, 670.2694063470791, 14773.113613183243, 14827.406903723839, 14850.628734281621, 14873.851261487354, 14874.628134296621, 13110.934445327808, 13774.517891873737, 13876.722465550733, 13888.513902013483, 13960.301984900714, 12019.819702704466, 12204.267743935303, 12436.19164754288, 12695.428705708266, 12837.550685726048, 4405.140997505488, 4409.294512877957, 4421.270490369086, 4449.644028477714, 4535.138323718483, 60772.39227607712, 60783.392166078214, 60837.47906302378, 61543.69228153831, 62821.68589157025, 11198.440077996067, 11201.271917325348, 11309.60416385439, 11310.321380717183, 11486.0811135109, 19576.90211548933, 19647.901760491106, 19651.705224421647, 19656.0, 19661.213551458066, 8280.420370574122, 8314.127016663164, 8376.455530390505, 8415.537145456936, 8704.434211776213, 4781.282807578821, 4837.346958160603, 4896.314515967767, 5076.3908330999775, 5183.766730497136, 3359.764816462824, 3436.810975396327, 3454.4300190468794, 3475.496053072341, 3486.2504561519395, 587.0724255676022, 598.6767145741251, 602.0157043234343, 614.1524695919692, 615.5691016288616, 667.9198496180393, 683.4634811672813, 703.1772825793834, 707.745211723779, 711.6228398948566, 9176.770580735401, 9189.3108016899, 9347.859782103274, 9397.953010234905, 9496.335256531976, 688.7520492622651, 699.7026263837848, 704.3308856586264, 721.2390927571357, 729.0012682624838, 4456.264716321835, 4813.566778989908, 5114.452065720169, 5128.179719164009, 5319.7340132993195, 70741.64629176821, 91435.0, 93012.0, 94083.0, 94106.5294673536, 77841.2215877834, 80882.59558702169, 81206.0, 83152.0, 87238.56380718056, 73589.63205184047, 75680.0, 76254.0, 76787.84818227732, 76949.0, 9940.751481213027, 10149.238807089645, 10161.187105031431, 10282.280240383101, 10309.123724483203, 48553.0, 48942.75528622477, 49446.258306126154, 49524.75237623789, 49633.75183124061, 63253.0, 65599.34400656124, 69167.0, 69606.95589566059, 72053.0, 12950.481980720666, 12982.740345193231, 13170.868291317347, 13777.517786877412, 14264.358103885557, 15115.395384184509, 15192.316345764246, 15497.0, 16116.758248626515, 16163.838361616234, 12782.68043298925, 12957.0, 12992.090553661154, 13386.464541418234, 13851.515196968057, 13047.076723313241, 13691.383887725275, 13696.452141914611, 14037.578872633838, 14343.497977570734, 12967.351632418153, 13265.933670331586, 13494.32528373597, 13960.58118256454, 14091.601908997858, 11077.501512431798, 11379.715507112058, 11466.656000320003, 11564.653060408202, 12361.62915112548, 11655.825162622397, 12131.150819442908, 12142.0, 12297.877021229673, 12571.87428125707], "value": 7478.56254493526, "unit": "score"}], "name": "dromaeo_css", "value": 7344.318651522532, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 113.0, 115.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 117.0, 164.0, 127.0, 118.0, 117.0, 118.0, 151.0, 116.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 161.0, 160.0, 159.0, 160.0, 160.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 109.0, 75.0, 77.0, 75.0, 77.0, 103.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 82.0, 82.0, 81.0, 102.0, 81.0, 81.0, 120.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 51.0, 50.0, 51.0, 50.0, 51.0, 50.0, 52.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 75.0, 76.0, 75.0, 76.0, 76.0, 75.0, 83.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 124.0, 121.0, 128.0, 121.0, 121.0, 134.0, 179.0, 124.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 151.0, 153.0, 153.0, 158.0, 155.0, 152.0, 158.0, 155.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 64.0, 62.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1455.9, "alertThreshold": 2.0}]} 04:52:05 INFO - Return code: 0 04:52:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:05 INFO - # TBPL SUCCESS # 04:52:05 INFO - Running post-action listener: _resource_record_post_action 04:52:05 INFO - [mozharness: 2017-01-10 12:52:05.780605Z] Finished run-tests step (success) 04:52:05 INFO - Running post-run listener: _resource_record_post_run 04:52:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357502976; Read time: 40; Write time: 215232 04:52:05 INFO - TinderboxPrint: CPU usage
13.0% 04:52:05 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 04:52:05 INFO - TinderboxPrint: I/O write bytes / time
357,502,976 / 215,232 04:52:05 INFO - TinderboxPrint: CPU idle
8,276.1 (87.0%) 04:52:05 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 04:52:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107409408; Read time: 0; Write time: 66248 04:52:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248795136; Read time: 16; Write time: 148948 04:52:06 INFO - Running post-run listener: _upload_blobber_files 04:52:06 INFO - Blob upload gear active. 04:52:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:06 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 04:52:06 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'] 04:52:06 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 04:52:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:14 INFO - (blobuploader) - INFO - Done attempting. 04:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:15 INFO - (blobuploader) - INFO - Done attempting. 04:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:15 INFO - (blobuploader) - INFO - Done attempting. 04:52:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:15 INFO - Return code: 0 04:52:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a4d0a437aad4e287aa1b3a6897ab94c5885e317204ef4524645bbf8773a5129476199d883f771fde3f7fa579e28c1d51169868d2445e8d2fffa21897b4d862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b11c73e3bfadde526d5d1eaf865820fe7408400344398216e8166b66771aef39a2b662f20f236975d774285ee3af1f558fde9960b8c7e41c45e4e90506c6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963d0504a9145b26dc64c46d34f21bf910f195000287e9ecabec6348a93e5da7c590f03fb6e23ffa45ac6ac67f669e153110ce232eb8138a1d336378ad419e35"} 04:52:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:15 INFO - Contents: 04:52:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a4d0a437aad4e287aa1b3a6897ab94c5885e317204ef4524645bbf8773a5129476199d883f771fde3f7fa579e28c1d51169868d2445e8d2fffa21897b4d862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b11c73e3bfadde526d5d1eaf865820fe7408400344398216e8166b66771aef39a2b662f20f236975d774285ee3af1f558fde9960b8c7e41c45e4e90506c6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963d0504a9145b26dc64c46d34f21bf910f195000287e9ecabec6348a93e5da7c590f03fb6e23ffa45ac6ac67f669e153110ce232eb8138a1d336378ad419e35"} 04:52:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:15 INFO - Copying logs to upload dir... 04:52:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.878123 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-10 04:52:15.898652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 04:52:15.901920) ========= 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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 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/02a4d0a437aad4e287aa1b3a6897ab94c5885e317204ef4524645bbf8773a5129476199d883f771fde3f7fa579e28c1d51169868d2445e8d2fffa21897b4d862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b11c73e3bfadde526d5d1eaf865820fe7408400344398216e8166b66771aef39a2b662f20f236975d774285ee3af1f558fde9960b8c7e41c45e4e90506c6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963d0504a9145b26dc64c46d34f21bf910f195000287e9ecabec6348a93e5da7c590f03fb6e23ffa45ac6ac67f669e153110ce232eb8138a1d336378ad419e35"} build_url:https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/cTFq-EY2RRWXwY_npK2LnA/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/02a4d0a437aad4e287aa1b3a6897ab94c5885e317204ef4524645bbf8773a5129476199d883f771fde3f7fa579e28c1d51169868d2445e8d2fffa21897b4d862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b11c73e3bfadde526d5d1eaf865820fe7408400344398216e8166b66771aef39a2b662f20f236975d774285ee3af1f558fde9960b8c7e41c45e4e90506c6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963d0504a9145b26dc64c46d34f21bf910f195000287e9ecabec6348a93e5da7c590f03fb6e23ffa45ac6ac67f669e153110ce232eb8138a1d336378ad419e35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 04:52:15.926446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:52:15.926735) ========= 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=32c5991c409366f7fec8a718000001d2-1484051493.682301-797439605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:52:16.009091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 04:52:16.009370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 04:52:16.009638) ========= ========= Total master_lag: 0.17 =========