builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1483968435.18 results: success (0) buildid: 20170109034708 builduid: c7c16ab1be1141c08e12a90dbbecff37 revision: 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.175388) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.175847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.176150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.190929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.191271) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 05:27:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2017-01-09 05:27:16 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.341998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.342794) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:15.393854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 05:27:15.394457) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 --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 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 --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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 05:27:16,743 truncating revision to first 12 chars 2017-01-09 05:27:16,743 Setting DEBUG logging. 2017-01-09 05:27:16,743 attempt 1/10 2017-01-09 05:27:16,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2e25a162cd98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 05:27:17,846 unpacking tar archive at: mozilla-aurora-2e25a162cd98/testing/mozharness/ program finished with exit code 0 elapsedTime=1.434411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 05:27:16.844607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:16.845095) ========= script_repo_revision: 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:16.845686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:16.846074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 05:27:16.856833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-09 05:27:16.857177) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:27:18 INFO - MultiFileLogger online at 20170109 05:27:18 in /builds/slave/test 05:27:18 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 05:27:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:18 INFO - {'append_to_log': False, 05:27:18 INFO - 'base_work_dir': '/builds/slave/test', 05:27:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:27:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:18 INFO - 'branch': 'Mozilla-Aurora', 05:27:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:18 INFO - 'config_files': ('talos/linux_config.py',), 05:27:18 INFO - 'default_actions': ('clobber', 05:27:18 INFO - 'read-buildbot-config', 05:27:18 INFO - 'download-and-extract', 05:27:18 INFO - 'populate-webroot', 05:27:18 INFO - 'create-virtualenv', 05:27:18 INFO - 'install', 05:27:18 INFO - 'run-tests'), 05:27:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:18 INFO - 'download_minidump_stackwalk': True, 05:27:18 INFO - 'download_symbols': 'ondemand', 05:27:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:18 INFO - 'installer_path': 'installer.exe', 05:27:18 INFO - 'log_level': 'info', 05:27:18 INFO - 'log_name': 'talos', 05:27:18 INFO - 'log_to_console': True, 05:27:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:27:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:27:18 INFO - 'opt_config_files': (), 05:27:18 INFO - 'pip_index': False, 05:27:18 INFO - 'sps_profile': False, 05:27:18 INFO - 'sps_profile_interval': 0, 05:27:18 INFO - 'suite': 'dromaeojs', 05:27:18 INFO - 'system_bits': '32', 05:27:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:18 INFO - 'title': 'talos-linux64-ix-005', 05:27:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:18 INFO - 'use_talos_json': True, 05:27:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:18 INFO - 'work_dir': 'build'} 05:27:18 INFO - [mozharness: 2017-01-09 13:27:18.306369Z] Running clobber step. 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: clobber 05:27:18 INFO - rmtree: /builds/slave/test/build 05:27:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:18 INFO - Running post-action listener: _resource_record_post_action 05:27:18 INFO - [mozharness: 2017-01-09 13:27:18.766777Z] Finished clobber step (success) 05:27:18 INFO - [mozharness: 2017-01-09 13:27:18.766876Z] Running read-buildbot-config step. 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: read_buildbot_config 05:27:18 INFO - Using buildbot properties: 05:27:18 INFO - { 05:27:18 INFO - "project": "", 05:27:18 INFO - "product": "firefox", 05:27:18 INFO - "script_repo_revision": "production", 05:27:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:27:18 INFO - "repository": "", 05:27:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:27:18 INFO - "buildid": "20170109034708", 05:27:18 INFO - "pgo_build": "True", 05:27:18 INFO - "basedir": "/builds/slave/test", 05:27:18 INFO - "buildnumber": 686, 05:27:18 INFO - "slavename": "talos-linux64-ix-005", 05:27:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:27:18 INFO - "platform": "ubuntu64_hw", 05:27:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:27:18 INFO - "branch": "mozilla-aurora", 05:27:18 INFO - "repo_path": "releases/mozilla-aurora", 05:27:18 INFO - "revision": "2e25a162cd9893c3f9fa168b9b00f6f3e260abe3", 05:27:18 INFO - "stage_platform": "linux64-pgo", 05:27:18 INFO - "builduid": "c7c16ab1be1141c08e12a90dbbecff37", 05:27:18 INFO - "slavebuilddir": "test" 05:27:18 INFO - } 05:27:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 05:27:18 INFO - Running post-action listener: _resource_record_post_action 05:27:18 INFO - [mozharness: 2017-01-09 13:27:18.769293Z] Finished read-buildbot-config step (success) 05:27:18 INFO - [mozharness: 2017-01-09 13:27:18.769381Z] Running download-and-extract step. 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: download_and_extract 05:27:18 INFO - mkdir: /builds/slave/test/build/tests 05:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:18 INFO - trying https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:27:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/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 05:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/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 05:27:19 INFO - Downloaded 1361 bytes. 05:27:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:27:19 INFO - Using the following test package requirements: 05:27:19 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:27:19 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:27:19 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:27:19 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'jsshell-linux-x86_64.zip'], 05:27:19 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:27:19 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:27:19 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:27:19 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:27:19 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:27:19 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:27:19 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:27:19 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:27:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 05:27:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:27:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 05:27:19 INFO - Http code: 200 05:27:19 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 05:27:19 INFO - x-amz-cf-id: QoMD3JfXtXZBD9xxfywqAeFbE68IbuisWrak17P-1mZPK3u_EJI4HA== 05:27:19 INFO - x-amz-version-id: HqbMyYYPgy97UbktJteY13e7M1S197uO 05:27:20 INFO - Expected file size: 21943635 05:27:20 INFO - Obtained file size: 21943635 05:27:24 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 05:27:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 05:27:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:27:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 05:27:24 INFO - Http code: 200 05:27:24 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 05:27:24 INFO - x-amz-cf-id: sOv7V4Y9IsmOhELAbNeKg5MvHjVRi1hxV7X48f2iSuUojDk0iLooLA== 05:27:24 INFO - x-amz-version-id: HqbMyYYPgy97UbktJteY13e7M1S197uO 05:27:24 INFO - Expected file size: 21943635 05:27:24 INFO - Obtained file size: 21943635 05:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 05:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 05:27:29 INFO - Http code: 200 05:27:29 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 05:27:29 INFO - x-amz-cf-id: DuqTxdevU-N-Z03ddha2rJydzlNFpJmjEPtvX61Thoe_A7hrbUdl3A== 05:27:29 INFO - x-amz-version-id: i9Bc3dwuhZwDB9Iwdusz4UsugN0So1eC 05:27:30 INFO - Expected file size: 14409038 05:27:30 INFO - Obtained file size: 14409038 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - trying https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/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 05:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/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 05:27:31 INFO - Downloaded 64094460 bytes. 05:27:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:27:31 INFO - mkdir: /builds/slave/test/properties 05:27:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:31 INFO - Contents: 05:27:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:27:32 INFO - Running post-action listener: _resource_record_post_action 05:27:32 INFO - Running post-action listener: set_extra_try_arguments 05:27:32 INFO - [mozharness: 2017-01-09 13:27:32.109742Z] Finished download-and-extract step (success) 05:27:32 INFO - [mozharness: 2017-01-09 13:27:32.109969Z] Running populate-webroot step. 05:27:32 INFO - Running pre-action listener: _resource_record_pre_action 05:27:32 INFO - Running main action method: populate_webroot 05:27:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:32 INFO - '--tppagecycles', 05:27:32 INFO - '7'], 05:27:32 INFO - 'tests': ['tsvgm']}}, 05:27:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['damp', 'tps']}, 05:27:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'tests': ['damp', 'tps']}, 05:27:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['dromaeo_dom']}, 05:27:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['basic_compositor_video']}, 05:27:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['a11yr', 05:27:32 INFO - 'ts_paint', 05:27:32 INFO - 'tpaint', 05:27:32 INFO - 'sessionrestore', 05:27:32 INFO - 'sessionrestore_no_auto_restore', 05:27:32 INFO - 'tabpaint']}, 05:27:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['tsvgx', 05:27:32 INFO - 'tsvgr_opacity', 05:27:32 INFO - 'tart', 05:27:32 INFO - 'tscrollx', 05:27:32 INFO - 'cart']}, 05:27:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:32 INFO - 'tsvgr_opacity', 05:27:32 INFO - 'tart', 05:27:32 INFO - 'tscrollx', 05:27:32 INFO - 'cart']}, 05:27:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'talos_options': ['--disable-e10s'], 05:27:32 INFO - 'tests': ['tp5o']}, 05:27:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'tests': ['tp5o']}, 05:27:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'talos_options': ['--disable-e10s', 05:27:32 INFO - '--xperf_path', 05:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:32 INFO - 'tests': ['tp5n']}, 05:27:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:32 INFO - 'talos_options': ['--xperf_path', 05:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:32 INFO - 'tests': ['tp5n']}}, 05:27:32 INFO - 'talos.zip': {'path': '', 05:27:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:32 INFO - Running post-action listener: _resource_record_post_action 05:27:32 INFO - [mozharness: 2017-01-09 13:27:32.126287Z] Finished populate-webroot step (success) 05:27:32 INFO - [mozharness: 2017-01-09 13:27:32.126375Z] Running create-virtualenv step. 05:27:32 INFO - Running pre-action listener: _resource_record_pre_action 05:27:32 INFO - Running main action method: create_virtualenv 05:27:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:32 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 05:27:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:32 INFO - Using real prefix '/usr' 05:27:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:34 INFO - Installing pip.................done. 05:27:34 INFO - Return code: 0 05:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:27:34 INFO - Reading from file tmpfile_stdout 05:27:34 INFO - Output received: 05:27:34 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) 05:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:34 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 05:27:34 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 05:27:34 INFO - Using env: {'DISPLAY': ':0', 05:27:34 INFO - 'HOME': '/home/cltbld', 05:27:34 INFO - 'LANG': 'en_US.UTF-8', 05:27:34 INFO - 'LANGUAGE': 'en_US:en', 05:27:34 INFO - 'LOGNAME': 'cltbld', 05:27:34 INFO - 'MAIL': '/var/mail/cltbld', 05:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:34 INFO - 'MOZ_NO_REMOTE': '1', 05:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:34 INFO - 'NO_EM_RESTART': '1', 05:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:34 INFO - 'PWD': '/builds/slave/test', 05:27:34 INFO - 'SHELL': '/bin/bash', 05:27:34 INFO - 'SHLVL': '1', 05:27:34 INFO - 'TERM': 'linux', 05:27:34 INFO - 'TMOUT': '86400', 05:27:34 INFO - 'USER': 'cltbld', 05:27:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:34 INFO - '_': '/tools/buildbot/bin/python'} 05:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:35 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 05:27:35 INFO - Cleaning up... 05:27:35 INFO - Return code: 0 05:27:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:27:35 INFO - Using env: {'DISPLAY': ':0', 05:27:35 INFO - 'HOME': '/home/cltbld', 05:27:35 INFO - 'LANG': 'en_US.UTF-8', 05:27:35 INFO - 'LANGUAGE': 'en_US:en', 05:27:35 INFO - 'LOGNAME': 'cltbld', 05:27:35 INFO - 'MAIL': '/var/mail/cltbld', 05:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:35 INFO - 'MOZ_NO_REMOTE': '1', 05:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:35 INFO - 'NO_EM_RESTART': '1', 05:27:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:35 INFO - 'PWD': '/builds/slave/test', 05:27:35 INFO - 'SHELL': '/bin/bash', 05:27:35 INFO - 'SHLVL': '1', 05:27:35 INFO - 'TERM': 'linux', 05:27:35 INFO - 'TMOUT': '86400', 05:27:35 INFO - 'USER': 'cltbld', 05:27:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:35 INFO - '_': '/tools/buildbot/bin/python'} 05:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:35 INFO - Downloading/unpacking psutil>=3.1.1 05:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:37 INFO - Installing collected packages: psutil 05:27:37 INFO - Running setup.py install for psutil 05:27:37 INFO - building 'psutil._psutil_linux' extension 05:27:37 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 05:27:37 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 05:27:37 INFO - building 'psutil._psutil_posix' extension 05:27:37 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 05:27:37 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 05:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:37 INFO - Successfully installed psutil 05:27:37 INFO - Cleaning up... 05:27:38 INFO - Return code: 0 05:27:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:27:38 INFO - Using env: {'DISPLAY': ':0', 05:27:38 INFO - 'HOME': '/home/cltbld', 05:27:38 INFO - 'LANG': 'en_US.UTF-8', 05:27:38 INFO - 'LANGUAGE': 'en_US:en', 05:27:38 INFO - 'LOGNAME': 'cltbld', 05:27:38 INFO - 'MAIL': '/var/mail/cltbld', 05:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:38 INFO - 'MOZ_NO_REMOTE': '1', 05:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:38 INFO - 'NO_EM_RESTART': '1', 05:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:38 INFO - 'PWD': '/builds/slave/test', 05:27:38 INFO - 'SHELL': '/bin/bash', 05:27:38 INFO - 'SHLVL': '1', 05:27:38 INFO - 'TERM': 'linux', 05:27:38 INFO - 'TMOUT': '86400', 05:27:38 INFO - 'USER': 'cltbld', 05:27:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:38 INFO - '_': '/tools/buildbot/bin/python'} 05:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:40 INFO - Installing collected packages: mozsystemmonitor 05:27:40 INFO - Running setup.py install for mozsystemmonitor 05:27:40 INFO - Successfully installed mozsystemmonitor 05:27:40 INFO - Cleaning up... 05:27:40 INFO - Return code: 0 05:27:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:40 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')]} 05:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:40 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')]} 05:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:40 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:40 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 05:27:40 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 05:27:40 INFO - Using env: {'DISPLAY': ':0', 05:27:40 INFO - 'HOME': '/home/cltbld', 05:27:40 INFO - 'LANG': 'en_US.UTF-8', 05:27:40 INFO - 'LANGUAGE': 'en_US:en', 05:27:40 INFO - 'LOGNAME': 'cltbld', 05:27:40 INFO - 'MAIL': '/var/mail/cltbld', 05:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:40 INFO - 'MOZ_NO_REMOTE': '1', 05:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:40 INFO - 'NO_EM_RESTART': '1', 05:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:40 INFO - 'PWD': '/builds/slave/test', 05:27:40 INFO - 'SHELL': '/bin/bash', 05:27:40 INFO - 'SHLVL': '1', 05:27:40 INFO - 'TERM': 'linux', 05:27:40 INFO - 'TMOUT': '86400', 05:27:40 INFO - 'USER': 'cltbld', 05:27:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:40 INFO - '_': '/tools/buildbot/bin/python'} 05:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:27:40 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 05:27:40 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 05:27:40 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 05:27:40 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 05:27:40 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 05:27:40 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 05:27:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:42 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 05:27:42 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 05:27:42 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 05:27:42 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 05:27:42 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 05:27:42 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 05:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:42 INFO - warning: no files found matching '*.txt' 05:27:42 INFO - no previously-included directories found matching 'build' 05:27:42 INFO - no previously-included directories found matching 'dist' 05:27:42 INFO - no previously-included directories found matching '.git*' 05:27:43 INFO - Installing collected packages: jsonschema, functools32 05:27:43 INFO - Running setup.py install for functools32 05:27:43 INFO - warning: no files found matching '*.txt' 05:27:43 INFO - no previously-included directories found matching 'build' 05:27:43 INFO - no previously-included directories found matching 'dist' 05:27:43 INFO - no previously-included directories found matching '.git*' 05:27:43 INFO - Successfully installed jsonschema functools32 05:27:43 INFO - Cleaning up... 05:27:43 INFO - Return code: 0 05:27:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:43 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')]} 05:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:43 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')]} 05:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:43 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:43 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 05:27:43 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 05:27:43 INFO - Using env: {'DISPLAY': ':0', 05:27:43 INFO - 'HOME': '/home/cltbld', 05:27:43 INFO - 'LANG': 'en_US.UTF-8', 05:27:43 INFO - 'LANGUAGE': 'en_US:en', 05:27:43 INFO - 'LOGNAME': 'cltbld', 05:27:43 INFO - 'MAIL': '/var/mail/cltbld', 05:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:43 INFO - 'MOZ_NO_REMOTE': '1', 05:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:43 INFO - 'NO_EM_RESTART': '1', 05:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:43 INFO - 'PWD': '/builds/slave/test', 05:27:43 INFO - 'SHELL': '/bin/bash', 05:27:43 INFO - 'SHLVL': '1', 05:27:43 INFO - 'TERM': 'linux', 05:27:43 INFO - 'TMOUT': '86400', 05:27:43 INFO - 'USER': 'cltbld', 05:27:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:43 INFO - '_': '/tools/buildbot/bin/python'} 05:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:43 INFO - Cleaning up... 05:27:43 INFO - Return code: 0 05:27:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:43 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')]} 05:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:43 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')]} 05:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:43 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:43 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 05:27:43 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 05:27:43 INFO - Using env: {'DISPLAY': ':0', 05:27:43 INFO - 'HOME': '/home/cltbld', 05:27:43 INFO - 'LANG': 'en_US.UTF-8', 05:27:43 INFO - 'LANGUAGE': 'en_US:en', 05:27:43 INFO - 'LOGNAME': 'cltbld', 05:27:43 INFO - 'MAIL': '/var/mail/cltbld', 05:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:43 INFO - 'MOZ_NO_REMOTE': '1', 05:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:43 INFO - 'NO_EM_RESTART': '1', 05:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:43 INFO - 'PWD': '/builds/slave/test', 05:27:43 INFO - 'SHELL': '/bin/bash', 05:27:43 INFO - 'SHLVL': '1', 05:27:43 INFO - 'TERM': 'linux', 05:27:43 INFO - 'TMOUT': '86400', 05:27:43 INFO - 'USER': 'cltbld', 05:27:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:43 INFO - '_': '/tools/buildbot/bin/python'} 05:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:45 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 05:27:45 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 05:27:45 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 05:27:45 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 05:27:45 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 05:27:45 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 05:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:46 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 05:27:46 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 05:27:46 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 05:27:46 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 05:27:46 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 05:27:46 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 05:27:46 INFO - Downloading docopt-0.6.1.tar.gz 05:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:46 INFO - Running setup.py install for blobuploader 05:27:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:46 INFO - Running setup.py install for requests 05:27:46 INFO - Running setup.py install for docopt 05:27:47 INFO - Successfully installed blobuploader requests docopt 05:27:47 INFO - Cleaning up... 05:27:47 INFO - Return code: 0 05:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:47 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')]} 05:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:47 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')]} 05:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:47 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:47 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 05:27:47 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 05:27:47 INFO - Using env: {'DISPLAY': ':0', 05:27:47 INFO - 'HOME': '/home/cltbld', 05:27:47 INFO - 'LANG': 'en_US.UTF-8', 05:27:47 INFO - 'LANGUAGE': 'en_US:en', 05:27:47 INFO - 'LOGNAME': 'cltbld', 05:27:47 INFO - 'MAIL': '/var/mail/cltbld', 05:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:47 INFO - 'MOZ_NO_REMOTE': '1', 05:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:47 INFO - 'NO_EM_RESTART': '1', 05:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:47 INFO - 'PWD': '/builds/slave/test', 05:27:47 INFO - 'SHELL': '/bin/bash', 05:27:47 INFO - 'SHLVL': '1', 05:27:47 INFO - 'TERM': 'linux', 05:27:47 INFO - 'TMOUT': '86400', 05:27:47 INFO - 'USER': 'cltbld', 05:27:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:47 INFO - '_': '/tools/buildbot/bin/python'} 05:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:47 INFO - Running setup.py (path:/tmp/pip-L4kcaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:47 INFO - Running setup.py (path:/tmp/pip-ztpX8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:47 INFO - Running setup.py (path:/tmp/pip-UIlslI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:47 INFO - Running setup.py (path:/tmp/pip-gtLnnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:47 INFO - Running setup.py (path:/tmp/pip-tjGKqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:47 INFO - Running setup.py (path:/tmp/pip-5Ssx46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:47 INFO - Running setup.py (path:/tmp/pip-BvWRuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:47 INFO - Running setup.py (path:/tmp/pip-DqQduk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:47 INFO - Running setup.py (path:/tmp/pip-6qTvMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:47 INFO - Running setup.py (path:/tmp/pip-90xQjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:48 INFO - Running setup.py (path:/tmp/pip-50Ru47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:48 INFO - Running setup.py (path:/tmp/pip-lH_Osd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:48 INFO - Running setup.py (path:/tmp/pip-5wNLqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:48 INFO - Running setup.py (path:/tmp/pip-dYa3hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:48 INFO - Running setup.py (path:/tmp/pip-ni6Lh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:48 INFO - Running setup.py (path:/tmp/pip-QdmlI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:48 INFO - Running setup.py (path:/tmp/pip-1UJaQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:48 INFO - Running setup.py install for manifestparser 05:27:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Running setup.py install for mozcrash 05:27:48 INFO - Running setup.py install for mozdebug 05:27:48 INFO - Running setup.py install for mozdevice 05:27:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Running setup.py install for mozfile 05:27:49 INFO - Running setup.py install for mozhttpd 05:27:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozinfo 05:27:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozInstall 05:27:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozleak 05:27:49 INFO - Running setup.py install for mozlog 05:27:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for moznetwork 05:27:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozprocess 05:27:49 INFO - Running setup.py install for mozprofile 05:27:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozrunner 05:27:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:49 INFO - Running setup.py install for mozscreenshot 05:27:50 INFO - Running setup.py install for moztest 05:27:50 INFO - Running setup.py install for mozversion 05:27:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:50 INFO - Cleaning up... 05:27:50 INFO - Return code: 0 05:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:50 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')]} 05:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 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')]} 05:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:50 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 05:27:50 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 05:27:50 INFO - Using env: {'DISPLAY': ':0', 05:27:50 INFO - 'HOME': '/home/cltbld', 05:27:50 INFO - 'LANG': 'en_US.UTF-8', 05:27:50 INFO - 'LANGUAGE': 'en_US:en', 05:27:50 INFO - 'LOGNAME': 'cltbld', 05:27:50 INFO - 'MAIL': '/var/mail/cltbld', 05:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:50 INFO - 'MOZ_NO_REMOTE': '1', 05:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:50 INFO - 'NO_EM_RESTART': '1', 05:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:50 INFO - 'PWD': '/builds/slave/test', 05:27:50 INFO - 'SHELL': '/bin/bash', 05:27:50 INFO - 'SHLVL': '1', 05:27:50 INFO - 'TERM': 'linux', 05:27:50 INFO - 'TMOUT': '86400', 05:27:50 INFO - 'USER': 'cltbld', 05:27:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:50 INFO - '_': '/tools/buildbot/bin/python'} 05:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 INFO - Running setup.py (path:/tmp/pip-AjaCD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 INFO - Running setup.py (path:/tmp/pip-X0508i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 INFO - Running setup.py (path:/tmp/pip-6Fl0Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 INFO - Running setup.py (path:/tmp/pip-avO5C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:50 INFO - Running setup.py (path:/tmp/pip-8CnI7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 INFO - Running setup.py (path:/tmp/pip-G47SC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:50 INFO - Running setup.py (path:/tmp/pip-msP7YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:51 INFO - Running setup.py (path:/tmp/pip-1IiCOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:51 INFO - Running setup.py (path:/tmp/pip-p2nmlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:51 INFO - Running setup.py (path:/tmp/pip-gFUBAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 INFO - Running setup.py (path:/tmp/pip-cojj_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 INFO - Running setup.py (path:/tmp/pip-L5SiUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 INFO - Running setup.py (path:/tmp/pip-JH3zDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 INFO - Running setup.py (path:/tmp/pip-jdRStX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 INFO - Running setup.py (path:/tmp/pip-QRbxPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:51 INFO - Running setup.py (path:/tmp/pip-ZyavOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:51 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)) 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:51 INFO - Running setup.py (path:/tmp/pip-DuWGrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:51 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)) 05:27:51 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)) 05:27:51 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)) 05:27:51 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)) 05:27:51 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)) 05:27:51 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)) 05:27:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:51 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 05:27:51 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 05:27:51 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 05:27:51 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 05:27:51 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 05:27:51 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 05:27:53 INFO - Downloading blessings-1.6.tar.gz 05:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:53 INFO - Installing collected packages: blessings 05:27:53 INFO - Running setup.py install for blessings 05:27:53 INFO - Successfully installed blessings 05:27:53 INFO - Cleaning up... 05:27:54 INFO - Return code: 0 05:27:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:54 INFO - Reading from file tmpfile_stdout 05:27:54 INFO - Current package versions: 05:27:54 INFO - argparse == 1.2.1 05:27:54 INFO - blessings == 1.6 05:27:54 INFO - blobuploader == 1.2.4 05:27:54 INFO - docopt == 0.6.1 05:27:54 INFO - functools32 == 3.2.3-2 05:27:54 INFO - jsonschema == 2.5.1 05:27:54 INFO - manifestparser == 1.1 05:27:54 INFO - mozInstall == 1.12 05:27:54 INFO - mozcrash == 1.0 05:27:54 INFO - mozdebug == 0.1 05:27:54 INFO - mozdevice == 0.48 05:27:54 INFO - mozfile == 1.2 05:27:54 INFO - mozhttpd == 0.7 05:27:54 INFO - mozinfo == 0.9 05:27:54 INFO - mozleak == 0.1 05:27:54 INFO - mozlog == 3.4 05:27:54 INFO - moznetwork == 0.27 05:27:54 INFO - mozprocess == 0.23 05:27:54 INFO - mozprofile == 0.28 05:27:54 INFO - mozrunner == 6.13 05:27:54 INFO - mozscreenshot == 0.1 05:27:54 INFO - mozsystemmonitor == 0.3 05:27:54 INFO - moztest == 0.8 05:27:54 INFO - mozversion == 1.4 05:27:54 INFO - psutil == 3.1.1 05:27:54 INFO - requests == 1.2.3 05:27:54 INFO - wsgiref == 0.1.2 05:27:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:54 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')]} 05:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:54 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')]} 05:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:54 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:54 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 05:27:54 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 05:27:54 INFO - Using env: {'DISPLAY': ':0', 05:27:54 INFO - 'HOME': '/home/cltbld', 05:27:54 INFO - 'LANG': 'en_US.UTF-8', 05:27:54 INFO - 'LANGUAGE': 'en_US:en', 05:27:54 INFO - 'LOGNAME': 'cltbld', 05:27:54 INFO - 'MAIL': '/var/mail/cltbld', 05:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:54 INFO - 'MOZ_NO_REMOTE': '1', 05:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:54 INFO - 'NO_EM_RESTART': '1', 05:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:54 INFO - 'PWD': '/builds/slave/test', 05:27:54 INFO - 'SHELL': '/bin/bash', 05:27:54 INFO - 'SHLVL': '1', 05:27:54 INFO - 'TERM': 'linux', 05:27:54 INFO - 'TMOUT': '86400', 05:27:54 INFO - 'USER': 'cltbld', 05:27:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:54 INFO - '_': '/tools/buildbot/bin/python'} 05:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 INFO - Cleaning up... 05:27:54 INFO - Return code: 0 05:27:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:54 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')]} 05:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:54 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')]} 05:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:54 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 0x7fef4b1b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', '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 05:27:54 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 05:27:54 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 05:27:54 INFO - Using env: {'DISPLAY': ':0', 05:27:54 INFO - 'HOME': '/home/cltbld', 05:27:54 INFO - 'LANG': 'en_US.UTF-8', 05:27:54 INFO - 'LANGUAGE': 'en_US:en', 05:27:54 INFO - 'LOGNAME': 'cltbld', 05:27:54 INFO - 'MAIL': '/var/mail/cltbld', 05:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:54 INFO - 'MOZ_NO_REMOTE': '1', 05:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:54 INFO - 'NO_EM_RESTART': '1', 05:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:54 INFO - 'PWD': '/builds/slave/test', 05:27:54 INFO - 'SHELL': '/bin/bash', 05:27:54 INFO - 'SHLVL': '1', 05:27:54 INFO - 'TERM': 'linux', 05:27:54 INFO - 'TMOUT': '86400', 05:27:54 INFO - 'USER': 'cltbld', 05:27:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:54 INFO - '_': '/tools/buildbot/bin/python'} 05:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:54 INFO - Cleaning up... 05:27:54 INFO - Return code: 0 05:27:54 INFO - Running post-action listener: _resource_record_post_action 05:27:54 INFO - Running post-action listener: _start_resource_monitoring 05:27:54 INFO - Starting resource monitoring. 05:27:54 INFO - [mozharness: 2017-01-09 13:27:54.729544Z] Finished create-virtualenv step (success) 05:27:54 INFO - [mozharness: 2017-01-09 13:27:54.730035Z] Running install step. 05:27:54 INFO - Running pre-action listener: _resource_record_pre_action 05:27:54 INFO - Running main action method: install 05:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:54 INFO - Reading from file tmpfile_stdout 05:27:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:55 INFO - Reading from file tmpfile_stdout 05:27:55 INFO - Output received: 05:27:55 INFO - Usage: mozinstall [options] installer 05:27:55 INFO - Options: 05:27:55 INFO - -h, --help show this help message and exit 05:27:55 INFO - -d DEST, --destination=DEST 05:27:55 INFO - Directory to install application into. [default: 05:27:55 INFO - "/builds/slave/test"] 05:27:55 INFO - --app=APP Application being installed. [default: firefox] 05:27:55 INFO - mkdir: /builds/slave/test/build/application 05:27:55 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'] 05:27:55 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 05:28:10 INFO - Reading from file tmpfile_stdout 05:28:10 INFO - Output received: 05:28:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:28:10 INFO - Running post-action listener: _resource_record_post_action 05:28:10 INFO - [mozharness: 2017-01-09 13:28:10.977469Z] Finished install step (success) 05:28:10 INFO - [mozharness: 2017-01-09 13:28:10.977711Z] Running run-tests step. 05:28:10 INFO - Running pre-action listener: _resource_record_pre_action 05:28:10 INFO - Running main action method: run_tests 05:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:10 INFO - Python 2.7.3 05:28:10 INFO - Return code: 0 05:28:10 INFO - grabbing minidump binary from tooltool 05:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:10 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 0xe29f60>, '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 0xe2ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:10 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 05:28:10 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 05:28:10 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 05:28:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:11 INFO - Return code: 0 05:28:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:28:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:28:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:11 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/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 05:28:11 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/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 05:28:11 INFO - Using env: {'DISPLAY': ':0', 05:28:11 INFO - 'HOME': '/home/cltbld', 05:28:11 INFO - 'LANG': 'en_US.UTF-8', 05:28:11 INFO - 'LANGUAGE': 'en_US:en', 05:28:11 INFO - 'LOGNAME': 'cltbld', 05:28:11 INFO - 'MAIL': '/var/mail/cltbld', 05:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:11 INFO - 'MOZ_NO_REMOTE': '1', 05:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:11 INFO - 'NO_EM_RESTART': '1', 05:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:11 INFO - 'PWD': '/builds/slave/test', 05:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:11 INFO - 'SHELL': '/bin/bash', 05:28:11 INFO - 'SHLVL': '1', 05:28:11 INFO - 'TERM': 'linux', 05:28:11 INFO - 'TMOUT': '86400', 05:28:11 INFO - 'USER': 'cltbld', 05:28:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104', 05:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:11 INFO - '_': '/tools/buildbot/bin/python'} 05:28:11 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/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 05:28:11 INFO - mozversion application_buildid: 20170109034708 05:28:11 INFO - mozversion application_changeset: 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 05:28:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:28:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:11 INFO - mozversion application_name: Firefox 05:28:11 INFO - mozversion application_remotingname: firefox-dev 05:28:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:28:11 INFO - mozversion application_vendor: Mozilla 05:28:11 INFO - mozversion application_version: 52.0a2 05:28:11 INFO - mozversion platform_buildid: 20170109034708 05:28:11 INFO - mozversion platform_changeset: 2e25a162cd9893c3f9fa168b9b00f6f3e260abe3 05:28:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:28:11 INFO - mozversion platform_version: 52.0a2 05:28:11 INFO - using testdate: 1483968491 05:28:11 INFO - actual date: 1483968491 05:28:11 INFO - starting webserver on 'localhost:41802' 05:28:11 INFO - SUITE-START | Running 2 tests 05:28:11 INFO - TEST-START | dromaeo_css 05:28:11 INFO - operating with platform_type : linux_ 05:28:11 INFO - Initialising browser for dromaeo_css test... 05:28:11 INFO - TEST-INFO | started process 14064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCdRJf/profile http://localhost:41802/getInfo.html) 05:28:15 INFO - PROCESS | 14064 | __metrics Screen width/height:1600/1200 05:28:15 INFO - PROCESS | 14064 | colorDepth:24 05:28:15 INFO - PROCESS | 14064 | Browser inner width/height: 1024/697 05:28:15 INFO - PROCESS | 14064 | __metrics 05:28:15 INFO - PROCESS | 14064 | 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" 05:28:15 INFO - PROCESS | 14064 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:16 INFO - PROCESS | 14064 | console.error: PushService: 05:28:16 INFO - PROCESS | 14064 | stateChangeProcessEnqueue: Error transitioning state 05:28:16 INFO - PROCESS | 14064 | UnknownError 05:28:16 INFO - TEST-INFO | 14064: exit 0 05:28:16 INFO - Browser initialized. 05:28:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:16 INFO - TEST-INFO | started process 14156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCdRJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:28 INFO - PROCESS | 14156 | RSS: Main: 144625664 05:28:28 INFO - PROCESS | 14156 | 05:31:30 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41802/tests/dromaeo/cssquery-ext.html) 05:31:31 INFO - PROCESS | 14156 | RSS: Main: 278433792 05:31:31 INFO - PROCESS | 14156 | 05:34:34 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-ext.html (next: http://localhost:41802/tests/dromaeo/cssquery-jquery.html) 05:34:34 INFO - PROCESS | 14156 | RSS: Main: 233611264 05:34:34 INFO - PROCESS | 14156 | 05:37:36 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41802/tests/dromaeo/cssquery-mootools.html) 05:37:37 INFO - PROCESS | 14156 | RSS: Main: 177352704 05:37:37 INFO - PROCESS | 14156 | 05:40:39 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41802/tests/dromaeo/cssquery-prototype.html) 05:40:39 INFO - PROCESS | 14156 | RSS: Main: 214151168 05:40:39 INFO - PROCESS | 14156 | 05:43:42 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41802/tests/dromaeo/cssquery-yui.html) 05:43:43 INFO - PROCESS | 14156 | RSS: Main: 176783360 05:43:43 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | Cycle 1(1): loaded http://localhost:41802/tests/dromaeo/cssquery-yui.html (next: http://localhost:41802/tests/dromaeo/cssquery-dojo.html) 05:46:45 INFO - PROCESS | 14156 | RSS: Main: 264933376 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | __start_tp_report 05:46:45 INFO - PROCESS | 14156 | _x_x_mozilla_page_load 05:46:45 INFO - PROCESS | 14156 | _x_x_mozilla_page_load_details 05:46:45 INFO - PROCESS | 14156 | |i|pagename|runs| 05:46:45 INFO - PROCESS | 14156 | |0;dojo.html;3222.5649537312465;3249.9512507312393;3250.8862189823376;3279.393312237235;3297.6867197616216;5500.064988951878;5529.529989950854;5551.028570000249;5578;5578.63738856974;5541.390447050821;5592.496675299222;5592.6085174037835;5606.915896261559;5634.4928956393915;5034.672746271499;5065.088284108859;5094;5106.974465127669;5138.537531622153;4883.29192267121;4906.337644417994;5107.565856902168;5152.896942061157;5155.355580552431;4963.230699241623;4965.155923492996;4999.225120106371;5026.070177017245;5060.11447996601;5084.389873215201;5106.387233531963;5144.279800827887;5150.639455238135;5175.0943584872875;4794.208955522335;5036.6726162799305;5061.721605311706;5092.643514953955;5121.923171152435;5372.677639341613;5402.837914862561;5451.3458384993655;5504.284443022421;5559.138333558305;5863.53091752663;5916.881662366729;5951.970240148815;5956.315023772235;5958.195643588104;5795.275590551181;5989.580729348947;5998.820035398945;6001.189839371673;6014.458698717092;5442.020436321461;5451.536619387357;5482.0406428874785;5493.258410114663;5507.421720719347;5994.07091900756;6002.969985150046;6004.159417681528;6008.609440386361;6009.188759517497;5638.859028524238;5778.653280803165;5785.623934444247;5792.362840087587;5792.826215213466;5752.165935939265;5854.297484301911;5890.558208134407;5905.586608937333;5973.342932277446;5905.291365036223;5908.143319218775;5914.408559144051;5923.911141332884;5944.7919322824355;5880.970595147082;5921.970390148022;5930.733117009745;5936.1095835625;5936.317323507852;4453.821847126143;4483.30508771141;4486.057927835126;4530.048689775118;4538.228501154812;4015.4177644242004;4077.7553346799286;4086.959130408717;4099.487564054493;4112.732672376286;5538.086215774352;5630.0991841305195;5643.661380317194;5645.858853528613;5652.660840349592;5904.5571582131515;5913.64518128905;5918.556108291896;5919.852003699856;5920.674362910081;5559.24950131727;5613.101903695389;5613.186088017214;5619.381867994517;5625.156226566048;4969.875753106201;4998.550130488274;5049.368828896388;5057.367829021372;5058.9494105058475;6184.350643182401;6184.381561843779;6191.318954915046;6192.876142477216;6197.690115494297;5872.383399743137;5920.822375328747;5934.495567876779;5937.079752638348;5940.1683764272175;5872.442117998783;5943.286805583358;6106.816795496142;6109.877802444015;6158.261008678808;5863.765449382147;5864.06175011996;5864.794732184524;5888.94111058901;5889.646621202742;5965.821025369246;5969.04495280753;5975.581709280309;5978.163057171912;5979.252593425822;5558.583106267127;5634.971825140848;5736.168255602831;5737.053386191398;5852.970735146297;5758.827235182951;5794.101914203306;5813.3895940925595;5836.037053886062;5848.385919478564;5744.396838331915;5802.216700745345;5809.302883653989;5815.6219845711585;5818.650880947157;5563.499285064364;5640.266765320482;5733.483986441241;5843.561732869966;5859.824205273849;5584.944150558443;5689.715514224355;5699;5718.857028574319;5719.399463056319 05:46:45 INFO - PROCESS | 14156 | |1;ext.html;549.3545084525681;591.8461200087977;616.6546733829053;624.1231070346164;639.0669622351367;33221.50167747483;44974.32538511925;45399.77300113495;45643.543564564345;45673.54326456734;47010.29484557726;47097.29354059692;47576.76211618946;47683.046339073284;47721.52278477214;8374;8837.337199710015;8977.416467929595;8980.8652870207;8982.550872456384;8458.238758511732;10868.402237876953;11113.277636953613;11140.888591114106;11145.275557088804;10887;10936.179786516004;10942.507587158558;10960.177986651033;10962.835557466644;10716.517756700967;10760.946195269053;10767.784644307148;10769.246152769309;10773.515191816348;10608.310459820086;10628.734281642943;10662.413567253798;10680.839787403194;10697;44202.33696494555;44722.10555788899;44726.55273447256;44818.77590612026;44875.55124448746;3748.962510374916;3922.4704664870164;3991.481107456012;4147.740855845094;4322.265214913472;32585.83707081473;33089.3382132356;33531.83234083814;34437.655623443694;34542;4473.105378924228;4501.7974191161475;4512.638988880914;4546.340780586796;4628.352030715702;369509;370424.1478792616;370705;371063;371445;38387.6161238384;62414.0637890432;62639.373606264264;62648;62685.686571566854;39764.801175994515;41660.37509437361;41827;41886.581134188265;41909;15477.380904763684;15604.765928511082;15613.531594052196;15641.60895977587;15728.528144155694;11302.265352752209;11554.133439992034;12201;12837.293948832903;12949.611511654666;9415.435073895589;9524.90475095254;9542;9633.133018028411;9636.614535418505;3619.968309031913;3650.8539658413365;3668.614795446493;3691.8338674759702;3710.257948410275;1006.3961623026272;1011.4538149399389;1052.705242532077;1081.1783044885942;1091.3560999010463;26428.207153785417;26835.26589364231;27146;27524.03665871685;34909.301813963575;1021.2391768132788;1091.7052395853234;1131.9094472442184;1144.3591588710349;1249.6438515023174;16022.919885400499;17803.19885605151;17974;18667.626647466976;18786.53033674169;578107;582590;584502;584646;585137;62085.37914620886;62813.37186628167;62883.37116628866;62963;62975.53634550052;1285.2866659004155;1318.9868101318864;1351.6485713714505;1379.2345248387041;1398.6713122416224;30775.538366924065;34583.5791494603;35524;35630;35864.462033069;53497.46502534925;54214.18678719743;54302.728486358894;54312.18531722106;54405;430485;435112;435228;435245;435765;30373;31556.053318400485;33087.66912330846;33133.33733325368;33307.500387493725;49880.750596246784;51169;51671.741641291555;51974.740126299126;52755;42656.78671606622;42788.78605606952;43427.34858977181;44186;44770.328445074;43569.97569082676;43664.34503482387;43675;43900.341494878245;43952.56047439485;43443.782781085894;44203.557964419946;44345.77827110844;44406.77796610996;44725.105497889206;35741.46387804237;38492.61507385002;38655.80672096622;38816;39208.411873822486;28973.275668108465;29046.564301535916;29128.907430621846;29384.11847644574;29526.557101643062 05:46:45 INFO - PROCESS | 14156 | |2;jquery.html;383.6968794652225;415.70692661673513;418.2534176494956;420.7118124085002;428.5264782415431;15317.92341038296;19747.901260493676;19786.604267914634;19921.900390498064;19975.400737977867;19019.904900475514;20144.697829532568;20217.898910505428;20364.796352036476;20391.082401291977;4751.833685820997;5420.783168673248;5611.410801865806;6007.519398448136;6055.818325450222;5968.074948382986;5970.492508136814;6012.609180403259;6013.879722405549;6017.187679663255;5405.243265942751;5493.587980901429;5535.308086489189;5537.141743029817;5870.796486720234;5450.419378380265;5482.533984611293;5522.723863806834;5525.171224316365;5528.44715528446;5303.681779093266;5368.651037682538;5420.620556561043;5424.593155513352;5427.62006659534;23314.417139571477;23675;23846;23978.400539986465;24013.159539416036;2485.9751402485927;2507.059852555292;2900.1879473747385;3109.5802066721158;3209.823459709715;10970.341779493256;11058.502367393487;11201.27191732543;11447.123008946643;11521.942390287995;2011.6781314989678;2068.1830676882546;2079.812816846491;2090.9163633454646;2092.257248676728;62837;67673.96978090666;68942;87708.12291877063;90409.54795226047;11603.361815100081;11692.94153529227;11738.941305293589;11854.703632409086;12105.273683579013;17056.403025894033;17059.91470042642;17062.061586612606;17070.743938840926;17078.23147958345;8309.916900831035;8488.787780305542;8563.914360856312;8625.654973800978;8686.218240358397;8067.435279530494;8078.23256790604;8216.507009579444;8246.237510434072;8316.916830831615;5033.370828646419;5146.330976972969;5180.663256888291;5182.714950677673;5196.8960620787375;2022.6561484547663;2034.1964923854994;2054.2810016494404;2100.7500537180354;2127.2022991378235;927.958241879117;992.7964767222702;1000.314784372707;1017.1557607186018;1091.8635170603675;19861.00694965246;20111.698324525143;20510.692339614918;20990.370288891358;21043.47391315199;1032.200044965143;1038.6883934819523;1054.0671505717496;1077.7790552936629;1079.643717573199;10614.097801686788;11523.423828808525;11558;11580.420978951019;11631.59289424883;461027;469259;469877;480860;484924;90293.54853225824;90846;91665.5416722912;92911.0708892916;93261;1019.7603563162651;1019.7705516258634;1047.4919663963124;1047.6647472808781;1054.7204990677476;17281.308747649953;17802.732959005367;18097.457076287734;18141.27434902642;18300.816991830445;43035;43223;43266;43823.780881095394;44006.55993440025;57881.710591446776;58553;58929.41070589239;59294.40705593061;59524.40475595362;8475.110113438246;8848.247898928663;8940.46357218569;8965.327600430124;8970.775730606787;13038.543650972171;13047.34763261814;13096;13947.790783138058;13972.720545589234;11484.310941343547;11587.073034157416;11725;11932.22440541362;12369.257844529357;11728.765424691288;11852.70368240801;11897.46461409256;11963.880361196276;12262.141650084408;12201.20692155007;12255.509779608716;12372.381380931098;12436.31600261958;12550.372481375713;8416.074231834371;8634.697785577475;8691.782705432415;8786.077461866667;8960.820783584422;11767.411629418666;11792.29246245228;11962.282263064244;12138.271703697807;12439.875601243872 05:46:45 INFO - PROCESS | 14156 | |3;mootools.html;1400.7548678981188;1492.6566889615387;1536.931832376498;1654.3134599141356;1804.7383129446223;7869.960650196748;8772.956135219323;9005.864912026325;9021.3685042047;9240.676576319831;9010.324225683067;9072.637094516227;9085.454872707642;9088.50013249271;9095.636174553027;2456.778889899909;2478.2069737683946;2480.082369523279;2482.429041320497;2486.1298545509107;2364.160722943356;2448.155386391701;2450.8529488230765;2452.791512721421;2456.385903524119;2299.0803678528555;2305.7463678995296;2329.1731435340466;2333.7432882382923;2336.5910965581043;2303.49323148907;2330.976690233093;2349.0721165139757;2372.1104585780417;2374.050379848066;2413.3001429585574;2423.7455067217866;2436.549238390903;2444.804415646744;2445.2419749877417;8798.912010879938;8988.101189881025;8993.325500587416;9074.092590740873;9114.40756350835;5302;5539.19681646159;5542.4457554244655;5551.666899986014;5555.666660000373;3365.5793025871767;3489.180042689966;3554.1470047188745;3611.20553478237;3616.6202548732267;1092.6175838456556;1099.5326986030905;1102.6251074634583;1106.651404807483;1112.1825458288151;12480.81278780819;12495.187812792139;12531.624051278477;12547.686307842285;12620.81068783969;4745.1221524018165;4784.234522476387;4835.8065677372515;4871.098846713369;4923.507649235048;9560.61757529691;9574.425534467955;9575.377600455948;9612.75968100789;9613.423194608205;5504.642198257181;5510.559155267649;5510.752016159283;5516.613837031369;5516.668999860021;4277.486701595828;4516.88707782308;4543.954560454353;5062.392512898476;5158.303629010035;3998.2403343364667;4071.246819338432;4148.460700109027;4177.791110444527;4190.958090419057;1251.1367156662056;1274.095392271479;1275.253976423784;1276.974460510803;1292.3925754895183;955.9139677429065;963.942163470194;986.556049777603;993.1955116355631;999.7200783780553;5935.258092738408;6016.879662406727;6042.637441753509;6059.484943779828;6095.969520152459;480.17889409110114;494.1426624805959;495.68028621538906;499.1340025056524;510.5252115532516;4049.838006479708;4101.651359634465;4107.67138628909;4194.916101677949;4251.277282861921;10890.346579205274;11215.55137794479;11278.323300601991;11292.153088518395;11307.321560706385;10409.53157107932;10901.945490272497;10917.617883374043;11200.887991120147;11244.212905096729;8394.706185283485;8557.871631925525;8594.22651961314;8597.226249637562;8604.655813767378;6019.909701354396;6178.598391104564;6222.191115155001;6309.652969086561;6427.453666438218;10237.488125593542;10332.328398654063;10338.172946164139;10373.948130259301;10393.896061039293;9171.541422928693;9463.621455141718;10203.183745300506;10438.425886576008;10634.30876992993;7850.293473587176;8077.27304542594;8290.33677305802;8297.336213103057;8303.875441868257;8627.827443451222;8817.206451419403;8819.470831750115;8820.338474614302;8822.25010874083;7515.13575938774;7628.313451789366;7692.730754423568;7738.342240909586;7835.412344074103;7729.613519323899;7799.025121859768;7812.257835505845;7910.248526389983;7953.6818527258265;6878.415334696607;6987.615681137586;6991.265917078634;7003.719851205895;7024.824379390352;5229.372475302988;5256.684598924076;5262.236975638588;5299.814506492255;5376.712498820691;5082.33929589151;5124.538791508782;5171.974140129275;5235.869103272448;5303.231031500488 05:46:45 INFO - PROCESS | 14156 | |4;prototype.html;345.69578770681795;352.413231968772;354.33208402161927;356.5258206585242;361.87153560486024;5315.255864179013;5320.574354051676;5347.91978120328;5365.490278423548;5370.194470829368;4943.728094954776;5054;5064.873378165547;5121.897562048757;5275.182346736253;4171.436856024443;4181.163767246563;4188.476440444937;4192.727472714264;4214.662826973835;4198.769067701275;4208.537060923296;4229.577042295777;4230.51349094855;4230.619244268015;3916.5104361954754;3995.720299579031;4063.674906007512;4160.188763191179;4196.286631272676;4159.459270294842;4160.625543701066;4185.518665353493;4186.958130418718;4187.1625674865145;3749.343864823645;3752.2683076800035;3752.7185461090526;3760.811959402019;3779.981100094509;5024.949750502521;5092;5106.719130447824;5195.584353251731;5207.375114986188;4760.357351757503;4789.353437285957;4792.400949881265;4804.063207674505;4804.5195480451675;5499.835004949858;5500.80747173851;5509.256250406184;5527.640703354309;5557.6109672322955;4020.6530812177957;4141.503019637663;4170.207660544487;4172.895677608054;4177.540470548237;5637.661740295595;5652.123920792284;5660.433956604348;5665.971670141664;5680.602357834953;4198.6221240088535;4209.7474151551005;4211.904904724794;4241.321388577812;4258.701096165699;3923.3918742594374;4061.78146556032;4274.691666500117;4286.571342865751;4292.785360731951;4671.626269898468;4701.858944231679;4703.435587729495;4710.905781884343;4712.929306060412;5526.198701188305;5527.723613819293;5532.640378375393;5541.556675465953;5557.944420555824;1314.6779039135472;1353.262471952788;1363.9181649101085;1365.8019587159806;1366.6993261482457;956.1538038835541;973.1825266775942;976.5800705696477;984.8128855517429;988.8220120378257;5159.974200128975;5204.661696989683;5211.400688920823;5238.449962753933;5275.920861187085;5454.8909021819345;5456.345238571317;5466.3440387153005;5475.835724928259;5475.972620136874;4945.629077819106;5207.947920520746;5215.504527069922;5234.659747116425;5235.65968212065;2897.797154199186;2902.6661933877454;2905.302727345464;2912.839793811361;2919.927001824929;5684.658920464785;5694.174344720075;5694.971525142348;5719;5745.798897038583;5323.22813192085;5534.806281780118;5565.638233514808;5572.17707495668;5572.916406253909;5626.521745651666;5658.405867383865;5664.858378540487;5680.857978550486;5694.914576281442;5242.606804489602;5435.483629055391;5474.452554744494;5480.0271902116;5516.7105651155925;5350.652207606493;5356.866078348073;5363.919541206963;5401.918971215357;5420.750388588692;5622.634528755618;5627.803026894039;5651.745671444713;5669.092945128759;5674.659520428788;3920.6079392061706;4010.699197560253;4015.6185162409524;4023.798810059544;4039.3133167362207;5407.7025763581805;5434.940186663563;5445.482679145475;5502.367227768697;5539.279893613965;5317.521423071942;5329.840104796862;5364;5410.756515956713;5423.972880135574;5101.234814777665;5265.868353291198;5284.735763211747;5326.177126123006;5329.214713071165;5260.026895024433;5288.603354748332;5314.280003997294;5323;5326.414094449685;5352.812651557177;5371.5702743781185;5374.570034397317;5384.550029736539;5394.597404674734;5183.201071421541;5221.530062294411;5383.596230282823;5495.835124946258;5497.890042199054 05:46:45 INFO - PROCESS | 14156 | |5;yui.html;699.3740602161066;735.205977544252;765.0742601452242;807.4832107451228;833.4999000599641;15169.696606067886;15351.616209594751;15364.385424583032;15432.537023889287;15571.29929153188;14146.434142634282;14172.645683857909;14176.50382236622;14193.71612567748;14391.352389142488;717.5407739047014;735.2059775442509;836.2807985132796;849.9575021248944;855.3328403845011;864.9870251946226;866.8223014282057;867.0722327109995;867.1025488619281;867.7093173786789;913.0504275553417;913.4017218721748;914.8719179314901;914.9588268527899;914.9634014639406;758.8178837079089;773.1920143450108;882.5675419044686;897.7890195803981;910.5219759626216;666.0708311904914;666.9166354205724;667.3993405934649;667.4393509452035;669.280523437302;14400.495982640661;14427.855721442862;14430.494932677306;14434;14434.566962991126;12689.619311420673;12952.935235323763;13401.66495837602;13562.932185339108;13887.097338672955;12320.383980801014;12408.069394795426;12744.044196685192;12919.806202906964;13148.868511314955;4181.393697913785;4203.717065160612;4287.464066991626;4326.6538676905775;4389.056352884145;67824.6608766953;68440.6577967112;69407;69423.14038017341;69644.6517767413;10735.141188704885;10739.624113156002;10814.729631759268;10825.83761243582;10870.402127882884;19636.607267854848;19826.1078251479;19900.303489377802;20051.598968020557;20341.898290508452;7391.334779869838;7517.624118794039;7635.121960974559;7798.376129909594;7922.128565857751;4799.448063472675;4848.660593758474;4945.109880221523;4994.350734404504;5034.748262586856;3459.9654003460146;3507.5790905091553;3540.2388486475015;3588.3540962626457;3596.5504311961004;600.9519238460913;605.9242594675666;607.8936186167404;614.7878981751288;625.8216408323606;601.9819405417844;690.8031211104811;707.1372925031453;715.7208688611446;719.9640017999079;8933.19601235892;9522.0954009369;9687.41875487473;9697.6605818796;9790.706278811647;549.154302374347;606.5147881694627;620.1627802466634;675.2100042949761;678.9845869510378;4030.2946984277633;4186.28833098374;4187.748735075906;4313.827446902152;4370.497392799869;56815;86224.56887715521;92534.53732731294;94212;95724.52137739267;62233;62631.37368626347;83959;85229.57385213034;86800;58028.70985645045;73330;73782.63108684422;74162.14594635069;76653;8046.476978996347;8205.302549283379;8671.69649062305;8783.912160878564;8843.51360675169;50938.490615093375;51201.7439912813;51938.74030629823;52185.7390713044;52980.94038119293;43458.782706087535;57876.4212357871;57892.421075788705;58947.70526147342;62911.685441572496;12871.485140594272;13291.335433228493;13332.93333533326;13535.51109377948;13610.727785444038;13621.591352259447;14226.430942762174;14378.137311761328;14819.40722371093;14852.480163194236;13488.865111348761;13969.650758731113;14085.647858803612;14302.213378264296;14564.781528276872;11787.646370608896;11837.348945807718;12037.518499259932;12171.695707607381;12487.188332758342;12212.633620991384;12500.749985000431;12581.056420768296;12901.290429026494;13100.082994190316;10265.023143288363;10416.531256093645;10445.791084178425;10802.89197108019;10917.181211409335;11680.94159529231;11832.76334473323;11912.642620721392;12006.939965300118;12231 05:46:45 INFO - PROCESS | 14156 | __end_tp_report 05:46:45 INFO - PROCESS | 14156 | __start_cc_report 05:46:45 INFO - PROCESS | 14156 | _x_x_mozilla_cycle_collect,1345 05:46:45 INFO - PROCESS | 14156 | __end_cc_report 05:46:45 INFO - PROCESS | 14156 | __startTimestamp1483969605684__endTimestamp 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | ------- Summary: start ------- 05:46:45 INFO - PROCESS | 14156 | Number of tests: 6 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#0] dojo.html Cycles:165 Average:5498.58 Median:5699.00 stddev:614.91 (10.8%) stddev-sans-first:590.31 05:46:45 INFO - PROCESS | 14156 | Values: 3222.6 3250.0 3250.9 3279.4 3297.7 5500.1 5529.5 5551.0 5578.0 5578.6 5541.4 5592.5 5592.6 5606.9 5634.5 5034.7 5065.1 5094.0 5107.0 5138.5 4883.3 4906.3 5107.6 5152.9 5155.4 4963.2 4965.2 4999.2 5026.1 5060.1 5084.4 5106.4 5144.3 5150.6 5175.1 4794.2 5036.7 5061.7 5092.6 5121.9 5372.7 5402.8 5451.3 5504.3 5559.1 5863.5 5916.9 5952.0 5956.3 5958.2 5795.3 5989.6 5998.8 6001.2 6014.5 5442.0 5451.5 5482.0 5493.3 5507.4 5994.1 6003.0 6004.2 6008.6 6009.2 5638.9 5778.7 5785.6 5792.4 5792.8 5752.2 5854.3 5890.6 5905.6 5973.3 5905.3 5908.1 5914.4 5923.9 5944.8 5881.0 5922.0 5930.7 5936.1 5936.3 4453.8 4483.3 4486.1 4530.0 4538.2 4015.4 4077.8 4087.0 4099.5 4112.7 5538.1 5630.1 5643.7 5645.9 5652.7 5904.6 5913.6 5918.6 5919.9 5920.7 5559.2 5613.1 5613.2 5619.4 5625.2 4969.9 4998.6 5049.4 5057.4 5058.9 6184.4 6184.4 6191.3 6192.9 6197.7 5872.4 5920.8 5934.5 5937.1 5940.2 5872.4 5943.3 6106.8 6109.9 6158.3 5863.8 5864.1 5864.8 5888.9 5889.6 5965.8 5969.0 5975.6 5978.2 5979.3 5558.6 5635.0 5736.2 5737.1 5853.0 5758.8 5794.1 5813.4 5836.0 5848.4 5744.4 5802.2 5809.3 5815.6 5818.7 5563.5 5640.3 5733.5 5843.6 5859.8 5584.9 5689.7 5699.0 5718.9 5719.4 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#1] ext.html Cycles:180 Average:62271.74 Median:39012.21 stddev:125158.18 (320.8%) stddev-sans-first:125423.49 05:46:45 INFO - PROCESS | 14156 | Values: 549.4 591.8 616.7 624.1 639.1 33221.5 44974.3 45399.8 45643.5 45673.5 47010.3 47097.3 47576.8 47683.0 47721.5 8374.0 8837.3 8977.4 8980.9 8982.6 8458.2 10868.4 11113.3 11140.9 11145.3 10887.0 10936.2 10942.5 10960.2 10962.8 10716.5 10760.9 10767.8 10769.2 10773.5 10608.3 10628.7 10662.4 10680.8 10697.0 44202.3 44722.1 44726.6 44818.8 44875.6 3749.0 3922.5 3991.5 4147.7 4322.3 32585.8 33089.3 33531.8 34437.7 34542.0 4473.1 4501.8 4512.6 4546.3 4628.4 369509.0 370424.1 370705.0 371063.0 371445.0 38387.6 62414.1 62639.4 62648.0 62685.7 39764.8 41660.4 41827.0 41886.6 41909.0 15477.4 15604.8 15613.5 15641.6 15728.5 11302.3 11554.1 12201.0 12837.3 12949.6 9415.4 9524.9 9542.0 9633.1 9636.6 3620.0 3650.9 3668.6 3691.8 3710.3 1006.4 1011.5 1052.7 1081.2 1091.4 26428.2 26835.3 27146.0 27524.0 34909.3 1021.2 1091.7 1131.9 1144.4 1249.6 16022.9 17803.2 17974.0 18667.6 18786.5 578107.0 582590.0 584502.0 584646.0 585137.0 62085.4 62813.4 62883.4 62963.0 62975.5 1285.3 1319.0 1351.6 1379.2 1398.7 30775.5 34583.6 35524.0 35630.0 35864.5 53497.5 54214.2 54302.7 54312.2 54405.0 430485.0 435112.0 435228.0 435245.0 435765.0 30373.0 31556.1 33087.7 33133.3 33307.5 49880.8 51169.0 51671.7 51974.7 52755.0 42656.8 42788.8 43427.3 44186.0 44770.3 43570.0 43664.3 43675.0 43900.3 43952.6 43443.8 44203.6 44345.8 44406.8 44725.1 35741.5 38492.6 38655.8 38816.0 39208.4 28973.3 29046.6 29128.9 29384.1 29526.6 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#2] jquery.html Cycles:180 Average:28748.65 Median:23912.20 stddev:78008.27 (326.2%) stddev-sans-first:78198.03 05:46:45 INFO - PROCESS | 14156 | Values: 383.7 415.7 418.3 420.7 428.5 15317.9 19747.9 19786.6 19921.9 19975.4 19019.9 20144.7 20217.9 20364.8 20391.1 4751.8 5420.8 5611.4 6007.5 6055.8 5968.1 5970.5 6012.6 6013.9 6017.2 5405.2 5493.6 5535.3 5537.1 5870.8 5450.4 5482.5 5522.7 5525.2 5528.4 5303.7 5368.7 5420.6 5424.6 5427.6 23314.4 23675.0 23846.0 23978.4 24013.2 2486.0 2507.1 2900.2 3109.6 3209.8 10970.3 11058.5 11201.3 11447.1 11521.9 2011.7 2068.2 2079.8 2090.9 2092.3 62837.0 67674.0 68942.0 87708.1 90409.5 11603.4 11692.9 11738.9 11854.7 12105.3 17056.4 17059.9 17062.1 17070.7 17078.2 8309.9 8488.8 8563.9 8625.7 8686.2 8067.4 8078.2 8216.5 8246.2 8316.9 5033.4 5146.3 5180.7 5182.7 5196.9 2022.7 2034.2 2054.3 2100.8 2127.2 928.0 992.8 1000.3 1017.2 1091.9 19861.0 20111.7 20510.7 20990.4 21043.5 1032.2 1038.7 1054.1 1077.8 1079.6 10614.1 11523.4 11558.0 11580.4 11631.6 461027.0 469259.0 469877.0 480860.0 484924.0 90293.5 90846.0 91665.5 92911.1 93261.0 1019.8 1019.8 1047.5 1047.7 1054.7 17281.3 17802.7 18097.5 18141.3 18300.8 43035.0 43223.0 43266.0 43823.8 44006.6 57881.7 58553.0 58929.4 59294.4 59524.4 8475.1 8848.2 8940.5 8965.3 8970.8 13038.5 13047.3 13096.0 13947.8 13972.7 11484.3 11587.1 11725.0 11932.2 12369.3 11728.8 11852.7 11897.5 11963.9 12262.1 12201.2 12255.5 12372.4 12436.3 12550.4 8416.1 8634.7 8691.8 8786.1 8960.8 11767.4 11792.3 11962.3 12138.3 12439.9 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#3] mootools.html Cycles:180 Average:5886.77 Median:5072.37 stddev:3335.40 (65.8%) stddev-sans-first:3327.71 05:46:45 INFO - PROCESS | 14156 | Values: 1400.8 1492.7 1536.9 1654.3 1804.7 7870.0 8773.0 9005.9 9021.4 9240.7 9010.3 9072.6 9085.5 9088.5 9095.6 2456.8 2478.2 2480.1 2482.4 2486.1 2364.2 2448.2 2450.9 2452.8 2456.4 2299.1 2305.7 2329.2 2333.7 2336.6 2303.5 2331.0 2349.1 2372.1 2374.1 2413.3 2423.7 2436.5 2444.8 2445.2 8798.9 8988.1 8993.3 9074.1 9114.4 5302.0 5539.2 5542.4 5551.7 5555.7 3365.6 3489.2 3554.1 3611.2 3616.6 1092.6 1099.5 1102.6 1106.7 1112.2 12480.8 12495.2 12531.6 12547.7 12620.8 4745.1 4784.2 4835.8 4871.1 4923.5 9560.6 9574.4 9575.4 9612.8 9613.4 5504.6 5510.6 5510.8 5516.6 5516.7 4277.5 4516.9 4544.0 5062.4 5158.3 3998.2 4071.2 4148.5 4177.8 4191.0 1251.1 1274.1 1275.3 1277.0 1292.4 955.9 963.9 986.6 993.2 999.7 5935.3 6016.9 6042.6 6059.5 6096.0 480.2 494.1 495.7 499.1 510.5 4049.8 4101.7 4107.7 4194.9 4251.3 10890.3 11215.6 11278.3 11292.2 11307.3 10409.5 10901.9 10917.6 11200.9 11244.2 8394.7 8557.9 8594.2 8597.2 8604.7 6019.9 6178.6 6222.2 6309.7 6427.5 10237.5 10332.3 10338.2 10373.9 10393.9 9171.5 9463.6 10203.2 10438.4 10634.3 7850.3 8077.3 8290.3 8297.3 8303.9 8627.8 8817.2 8819.5 8820.3 8822.3 7515.1 7628.3 7692.7 7738.3 7835.4 7729.6 7799.0 7812.3 7910.2 7953.7 6878.4 6987.6 6991.3 7003.7 7024.8 5229.4 5256.7 5262.2 5299.8 5376.7 5082.3 5124.5 5172.0 5235.9 5303.2 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#4] prototype.html Cycles:180 Average:4600.73 Median:5240.53 stddev:1311.03 (25.0%) stddev-sans-first:1275.21 05:46:45 INFO - PROCESS | 14156 | Values: 345.7 352.4 354.3 356.5 361.9 5315.3 5320.6 5347.9 5365.5 5370.2 4943.7 5054.0 5064.9 5121.9 5275.2 4171.4 4181.2 4188.5 4192.7 4214.7 4198.8 4208.5 4229.6 4230.5 4230.6 3916.5 3995.7 4063.7 4160.2 4196.3 4159.5 4160.6 4185.5 4187.0 4187.2 3749.3 3752.3 3752.7 3760.8 3780.0 5024.9 5092.0 5106.7 5195.6 5207.4 4760.4 4789.4 4792.4 4804.1 4804.5 5499.8 5500.8 5509.3 5527.6 5557.6 4020.7 4141.5 4170.2 4172.9 4177.5 5637.7 5652.1 5660.4 5666.0 5680.6 4198.6 4209.7 4211.9 4241.3 4258.7 3923.4 4061.8 4274.7 4286.6 4292.8 4671.6 4701.9 4703.4 4710.9 4712.9 5526.2 5527.7 5532.6 5541.6 5557.9 1314.7 1353.3 1363.9 1365.8 1366.7 956.2 973.2 976.6 984.8 988.8 5160.0 5204.7 5211.4 5238.4 5275.9 5454.9 5456.3 5466.3 5475.8 5476.0 4945.6 5207.9 5215.5 5234.7 5235.7 2897.8 2902.7 2905.3 2912.8 2919.9 5684.7 5694.2 5695.0 5719.0 5745.8 5323.2 5534.8 5565.6 5572.2 5572.9 5626.5 5658.4 5664.9 5680.9 5694.9 5242.6 5435.5 5474.5 5480.0 5516.7 5350.7 5356.9 5363.9 5401.9 5420.8 5622.6 5627.8 5651.7 5669.1 5674.7 3920.6 4010.7 4015.6 4023.8 4039.3 5407.7 5434.9 5445.5 5502.4 5539.3 5317.5 5329.8 5364.0 5410.8 5424.0 5101.2 5265.9 5284.7 5326.2 5329.2 5260.0 5288.6 5314.3 5323.0 5326.4 5352.8 5371.6 5374.6 5384.6 5394.6 5183.2 5221.5 5383.6 5495.8 5497.9 05:46:45 INFO - PROCESS | 14156 | 05:46:45 INFO - PROCESS | 14156 | [#5] yui.html Cycles:180 Average:18019.49 Median:27986.62 stddev:23868.92 (85.3%) stddev-sans-first:23900.44 05:46:45 INFO - PROCESS | 14156 | Values: 699.4 735.2 765.1 807.5 833.5 15169.7 15351.6 15364.4 15432.5 15571.3 14146.4 14172.6 14176.5 14193.7 14391.4 717.5 735.2 836.3 850.0 855.3 865.0 866.8 867.1 867.1 867.7 913.1 913.4 914.9 915.0 915.0 758.8 773.2 882.6 897.8 910.5 666.1 666.9 667.4 667.4 669.3 14400.5 14427.9 14430.5 14434.0 14434.6 12689.6 12952.9 13401.7 13562.9 13887.1 12320.4 12408.1 12744.0 12919.8 13148.9 4181.4 4203.7 4287.5 4326.7 4389.1 67824.7 68440.7 69407.0 69423.1 69644.7 10735.1 10739.6 10814.7 10825.8 10870.4 19636.6 19826.1 19900.3 20051.6 20341.9 7391.3 7517.6 7635.1 7798.4 7922.1 4799.4 4848.7 4945.1 4994.4 5034.7 3460.0 3507.6 3540.2 3588.4 3596.6 601.0 605.9 607.9 614.8 625.8 602.0 690.8 707.1 715.7 720.0 8933.2 9522.1 9687.4 9697.7 9790.7 549.2 606.5 620.2 675.2 679.0 4030.3 4186.3 4187.7 4313.8 4370.5 56815.0 86224.6 92534.5 94212.0 95724.5 62233.0 62631.4 83959.0 85229.6 86800.0 58028.7 73330.0 73782.6 74162.1 76653.0 8046.5 8205.3 8671.7 8783.9 8843.5 50938.5 51201.7 51938.7 52185.7 52980.9 43458.8 57876.4 57892.4 58947.7 62911.7 12871.5 13291.3 13332.9 13535.5 13610.7 13621.6 14226.4 14378.1 14819.4 14852.5 13488.9 13969.7 14085.6 14302.2 14564.8 11787.6 11837.3 12037.5 12171.7 12487.2 12212.6 12500.7 12581.1 12901.3 13100.1 10265.0 10416.5 10445.8 10802.9 10917.2 11680.9 11832.8 11912.6 12006.9 12231.0 05:46:45 INFO - PROCESS | 14156 | -------- Summary: end -------- 05:46:45 INFO - PROCESS | 14156 | 05:46:46 INFO - TEST-INFO | 14156: exit 0 05:46:46 INFO - TEST-OK | dromaeo_css | took 1115238ms 05:46:46 INFO - TEST-START | kraken 05:46:46 INFO - operating with platform_type : linux_ 05:46:46 INFO - Initialising browser for kraken test... 05:46:46 INFO - TEST-INFO | started process 14473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkR54JR/profile http://localhost:41802/getInfo.html) 05:46:50 INFO - PROCESS | 14473 | __metrics Screen width/height:1600/1200 05:46:50 INFO - PROCESS | 14473 | colorDepth:24 05:46:50 INFO - PROCESS | 14473 | Browser inner width/height: 1024/697 05:46:50 INFO - PROCESS | 14473 | __metrics 05:46:50 INFO - PROCESS | 14473 | 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" 05:46:50 INFO - PROCESS | 14473 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:51 INFO - PROCESS | 14473 | console.error: PushService: 05:46:51 INFO - PROCESS | 14473 | stateChangeProcessEnqueue: Error transitioning state 05:46:51 INFO - PROCESS | 14473 | UnknownError 05:46:51 INFO - TEST-INFO | 14473: exit 0 05:46:51 INFO - Browser initialized. 05:46:51 INFO - Running cycle 1/1 for kraken test... 05:46:51 INFO - TEST-INFO | started process 14567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkR54JR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:03 INFO - PROCESS | 14567 | RSS: Main: 144908288 05:47:03 INFO - PROCESS | 14567 | 05:47:06 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41802/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:07 INFO - PROCESS | 14567 | RSS: Main: 186249216 05:47:07 INFO - PROCESS | 14567 | 05:47:09 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41802/tests/kraken/driver.html?testName=audio-dft) 05:47:10 INFO - PROCESS | 14567 | RSS: Main: 175366144 05:47:10 INFO - PROCESS | 14567 | 05:47:12 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41802/tests/kraken/driver.html?testName=audio-fft) 05:47:13 INFO - PROCESS | 14567 | RSS: Main: 267141120 05:47:13 INFO - PROCESS | 14567 | 05:47:15 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41802/tests/kraken/driver.html?testName=audio-oscillator) 05:47:16 INFO - PROCESS | 14567 | RSS: Main: 172613632 05:47:16 INFO - PROCESS | 14567 | 05:47:18 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:18 INFO - PROCESS | 14567 | RSS: Main: 175620096 05:47:18 INFO - PROCESS | 14567 | 05:47:21 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41802/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:22 INFO - PROCESS | 14567 | RSS: Main: 214323200 05:47:22 INFO - PROCESS | 14567 | 05:47:25 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41802/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:26 INFO - PROCESS | 14567 | RSS: Main: 212914176 05:47:26 INFO - PROCESS | 14567 | 05:47:29 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41802/tests/kraken/driver.html?testName=json-parse-financial) 05:47:29 INFO - PROCESS | 14567 | RSS: Main: 211402752 05:47:29 INFO - PROCESS | 14567 | 05:47:31 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:31 INFO - PROCESS | 14567 | RSS: Main: 173592576 05:47:31 INFO - PROCESS | 14567 | 05:47:33 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:34 INFO - PROCESS | 14567 | RSS: Main: 181125120 05:47:34 INFO - PROCESS | 14567 | 05:47:35 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:36 INFO - PROCESS | 14567 | RSS: Main: 190038016 05:47:36 INFO - PROCESS | 14567 | 05:47:39 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:39 INFO - PROCESS | 14567 | RSS: Main: 198889472 05:47:39 INFO - PROCESS | 14567 | 05:47:42 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:43 INFO - PROCESS | 14567 | RSS: Main: 195018752 05:47:43 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | Cycle 1(1): loaded http://localhost:41802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41802/tests/kraken/driver.html?testName=ai-astar) 05:47:44 INFO - PROCESS | 14567 | RSS: Main: 247005184 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | __start_tp_report 05:47:44 INFO - PROCESS | 14567 | _x_x_mozilla_page_load 05:47:44 INFO - PROCESS | 14567 | _x_x_mozilla_page_load_details 05:47:44 INFO - PROCESS | 14567 | |i|pagename|runs| 05:47:44 INFO - PROCESS | 14567 | |0;ai-astar;102;111;111;110;118;113;110;110;111;111 05:47:44 INFO - PROCESS | 14567 | |1;audio-beat-detection;143;122;118;161;117;119;117;118;148;119 05:47:44 INFO - PROCESS | 14567 | |2;audio-dft;162;162;162;162;161;159;161;160;161;159 05:47:44 INFO - PROCESS | 14567 | |3;audio-fft;75;75;77;117;75;76;76;78;108;74 05:47:44 INFO - PROCESS | 14567 | |4;audio-oscillator;82;81;125;81;82;81;98;81;81;117 05:47:44 INFO - PROCESS | 14567 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;118;117;118 05:47:44 INFO - PROCESS | 14567 | |6;imaging-darkroom;146;147;147;146;146;146;146;146;147;147 05:47:44 INFO - PROCESS | 14567 | |7;imaging-desaturate;85;84;84;84;84;84;84;85;84;85 05:47:44 INFO - PROCESS | 14567 | |8;json-parse-financial;51;51;51;51;52;52;56;52;52;57 05:47:44 INFO - PROCESS | 14567 | |9;json-stringify-tinderbox;59;60;58;61;58;59;60;59;59;59 05:47:44 INFO - PROCESS | 14567 | |10;stanford-crypto-aes;76;80;75;77;75;77;74;74;74;76 05:47:44 INFO - PROCESS | 14567 | |11;stanford-crypto-ccm;122;123;121;120;127;121;119;124;177;120 05:47:44 INFO - PROCESS | 14567 | |12;stanford-crypto-pbkdf2;152;155;153;151;154;151;157;155;159;152 05:47:44 INFO - PROCESS | 14567 | |13;stanford-crypto-sha256-iterative;63;62;67;64;62;62;62;61;61;60 05:47:44 INFO - PROCESS | 14567 | __end_tp_report 05:47:44 INFO - PROCESS | 14567 | __start_cc_report 05:47:44 INFO - PROCESS | 14567 | _x_x_mozilla_cycle_collect,1620 05:47:44 INFO - PROCESS | 14567 | __end_cc_report 05:47:44 INFO - PROCESS | 14567 | __startTimestamp1483969664957__endTimestamp 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | ------- Summary: start ------- 05:47:44 INFO - PROCESS | 14567 | Number of tests: 14 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:2.55 05:47:44 INFO - PROCESS | 14567 | Values: 102.0 111.0 111.0 110.0 118.0 113.0 110.0 110.0 111.0 111.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:120.50 stddev:16.17 (13.4%) stddev-sans-first:16.24 05:47:44 INFO - PROCESS | 14567 | Values: 143.0 122.0 118.0 161.0 117.0 119.0 117.0 118.0 148.0 119.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.20 05:47:44 INFO - PROCESS | 14567 | Values: 162.0 162.0 162.0 162.0 161.0 159.0 161.0 160.0 161.0 159.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.50 stddev:15.68 (20.8%) stddev-sans-first:16.36 05:47:44 INFO - PROCESS | 14567 | Values: 75.0 75.0 77.0 117.0 75.0 76.0 76.0 78.0 108.0 74.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:81.00 stddev:16.81 (20.8%) stddev-sans-first:17.52 05:47:44 INFO - PROCESS | 14567 | Values: 82.0 81.0 125.0 81.0 82.0 81.0 98.0 81.0 81.0 117.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:47:44 INFO - PROCESS | 14567 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:47:44 INFO - PROCESS | 14567 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 05:47:44 INFO - PROCESS | 14567 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:2.17 (4.2%) stddev-sans-first:2.24 05:47:44 INFO - PROCESS | 14567 | Values: 51.0 51.0 51.0 51.0 52.0 52.0 56.0 52.0 52.0 57.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 05:47:44 INFO - PROCESS | 14567 | Values: 59.0 60.0 58.0 61.0 58.0 59.0 60.0 59.0 59.0 59.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.87 (2.5%) stddev-sans-first:1.99 05:47:44 INFO - PROCESS | 14567 | Values: 76.0 80.0 75.0 77.0 75.0 77.0 74.0 74.0 74.0 76.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:122.50 stddev:17.58 (14.4%) stddev-sans-first:18.54 05:47:44 INFO - PROCESS | 14567 | Values: 122.0 123.0 121.0 120.0 127.0 121.0 119.0 124.0 177.0 120.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.50 stddev:2.64 (1.7%) stddev-sans-first:2.71 05:47:44 INFO - PROCESS | 14567 | Values: 152.0 155.0 153.0 151.0 154.0 151.0 157.0 155.0 159.0 152.0 05:47:44 INFO - PROCESS | 14567 | 05:47:44 INFO - PROCESS | 14567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.96 (3.2%) stddev-sans-first:2.06 05:47:44 INFO - PROCESS | 14567 | Values: 63.0 62.0 67.0 64.0 62.0 62.0 62.0 61.0 61.0 60.0 05:47:44 INFO - PROCESS | 14567 | -------- Summary: end -------- 05:47:44 INFO - PROCESS | 14567 | 05:47:45 INFO - TEST-INFO | 14567: exit 0 05:47:46 INFO - TEST-OK | kraken | took 59554ms 05:47:46 INFO - SUITE-END | took 1174s 05:47:46 INFO - Completed test suite (00:19:34) 05:47:46 INFO - javascript benchmark 05:47:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.5649537312465, 3249.9512507312393, 3250.8862189823376, 3279.393312237235, 3297.6867197616216, 5500.064988951878, 5529.529989950854, 5551.028570000249, 5578.0, 5578.63738856974, 5541.390447050821, 5592.496675299222, 5592.6085174037835, 5606.915896261559, 5634.4928956393915, 5034.672746271499, 5065.088284108859, 5094.0, 5106.974465127669, 5138.537531622153, 4883.29192267121, 4906.337644417994, 5107.565856902168, 5152.896942061157, 5155.355580552431, 4963.230699241623, 4965.155923492996, 4999.225120106371, 5026.070177017245, 5060.11447996601, 5084.389873215201, 5106.387233531963, 5144.279800827887, 5150.639455238135, 5175.0943584872875, 4794.208955522335, 5036.6726162799305, 5061.721605311706, 5092.643514953955, 5121.923171152435, 5372.677639341613, 5402.837914862561, 5451.3458384993655, 5504.284443022421, 5559.138333558305, 5863.53091752663, 5916.881662366729, 5951.970240148815, 5956.315023772235, 5958.195643588104, 5795.275590551181, 5989.580729348947, 5998.820035398945, 6001.189839371673, 6014.458698717092, 5442.020436321461, 5451.536619387357, 5482.0406428874785, 5493.258410114663, 5507.421720719347, 5994.07091900756, 6002.969985150046, 6004.159417681528, 6008.609440386361, 6009.188759517497, 5638.859028524238, 5778.653280803165, 5785.623934444247, 5792.362840087587, 5792.826215213466, 5752.165935939265, 5854.297484301911, 5890.558208134407, 5905.586608937333, 5973.342932277446, 5905.291365036223, 5908.143319218775, 5914.408559144051, 5923.911141332884, 5944.7919322824355, 5880.970595147082, 5921.970390148022, 5930.733117009745, 5936.1095835625, 5936.317323507852, 4453.821847126143, 4483.30508771141, 4486.057927835126, 4530.048689775118, 4538.228501154812, 4015.4177644242004, 4077.7553346799286, 4086.959130408717, 4099.487564054493, 4112.732672376286, 5538.086215774352, 5630.0991841305195, 5643.661380317194, 5645.858853528613, 5652.660840349592, 5904.5571582131515, 5913.64518128905, 5918.556108291896, 5919.852003699856, 5920.674362910081, 5559.24950131727, 5613.101903695389, 5613.186088017214, 5619.381867994517, 5625.156226566048, 4969.875753106201, 4998.550130488274, 5049.368828896388, 5057.367829021372, 5058.9494105058475, 6184.350643182401, 6184.381561843779, 6191.318954915046, 6192.876142477216, 6197.690115494297, 5872.383399743137, 5920.822375328747, 5934.495567876779, 5937.079752638348, 5940.1683764272175, 5872.442117998783, 5943.286805583358, 6106.816795496142, 6109.877802444015, 6158.261008678808, 5863.765449382147, 5864.06175011996, 5864.794732184524, 5888.94111058901, 5889.646621202742, 5965.821025369246, 5969.04495280753, 5975.581709280309, 5978.163057171912, 5979.252593425822, 5558.583106267127, 5634.971825140848, 5736.168255602831, 5737.053386191398, 5852.970735146297, 5758.827235182951, 5794.101914203306, 5813.3895940925595, 5836.037053886062, 5848.385919478564, 5744.396838331915, 5802.216700745345, 5809.302883653989, 5815.6219845711585, 5818.650880947157, 5563.499285064364, 5640.266765320482, 5733.483986441241, 5843.561732869966, 5859.824205273849, 5584.944150558443, 5689.715514224355, 5699.0, 5718.857028574319, 5719.399463056319], "value": 5458.0532687812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3545084525681, 591.8461200087977, 616.6546733829053, 624.1231070346164, 639.0669622351367, 33221.50167747483, 44974.32538511925, 45399.77300113495, 45643.543564564345, 45673.54326456734, 47010.29484557726, 47097.29354059692, 47576.76211618946, 47683.046339073284, 47721.52278477214, 8374.0, 8837.337199710015, 8977.416467929595, 8980.8652870207, 8982.550872456384, 8458.238758511732, 10868.402237876953, 11113.277636953613, 11140.888591114106, 11145.275557088804, 10887.0, 10936.179786516004, 10942.507587158558, 10960.177986651033, 10962.835557466644, 10716.517756700967, 10760.946195269053, 10767.784644307148, 10769.246152769309, 10773.515191816348, 10608.310459820086, 10628.734281642943, 10662.413567253798, 10680.839787403194, 10697.0, 44202.33696494555, 44722.10555788899, 44726.55273447256, 44818.77590612026, 44875.55124448746, 3748.962510374916, 3922.4704664870164, 3991.481107456012, 4147.740855845094, 4322.265214913472, 32585.83707081473, 33089.3382132356, 33531.83234083814, 34437.655623443694, 34542.0, 4473.105378924228, 4501.7974191161475, 4512.638988880914, 4546.340780586796, 4628.352030715702, 369509.0, 370424.1478792616, 370705.0, 371063.0, 371445.0, 38387.6161238384, 62414.0637890432, 62639.373606264264, 62648.0, 62685.686571566854, 39764.801175994515, 41660.37509437361, 41827.0, 41886.581134188265, 41909.0, 15477.380904763684, 15604.765928511082, 15613.531594052196, 15641.60895977587, 15728.528144155694, 11302.265352752209, 11554.133439992034, 12201.0, 12837.293948832903, 12949.611511654666, 9415.435073895589, 9524.90475095254, 9542.0, 9633.133018028411, 9636.614535418505, 3619.968309031913, 3650.8539658413365, 3668.614795446493, 3691.8338674759702, 3710.257948410275, 1006.3961623026272, 1011.4538149399389, 1052.705242532077, 1081.1783044885942, 1091.3560999010463, 26428.207153785417, 26835.26589364231, 27146.0, 27524.03665871685, 34909.301813963575, 1021.2391768132788, 1091.7052395853234, 1131.9094472442184, 1144.3591588710349, 1249.6438515023174, 16022.919885400499, 17803.19885605151, 17974.0, 18667.626647466976, 18786.53033674169, 578107.0, 582590.0, 584502.0, 584646.0, 585137.0, 62085.37914620886, 62813.37186628167, 62883.37116628866, 62963.0, 62975.53634550052, 1285.2866659004155, 1318.9868101318864, 1351.6485713714505, 1379.2345248387041, 1398.6713122416224, 30775.538366924065, 34583.5791494603, 35524.0, 35630.0, 35864.462033069, 53497.46502534925, 54214.18678719743, 54302.728486358894, 54312.18531722106, 54405.0, 430485.0, 435112.0, 435228.0, 435245.0, 435765.0, 30373.0, 31556.053318400485, 33087.66912330846, 33133.33733325368, 33307.500387493725, 49880.750596246784, 51169.0, 51671.741641291555, 51974.740126299126, 52755.0, 42656.78671606622, 42788.78605606952, 43427.34858977181, 44186.0, 44770.328445074, 43569.97569082676, 43664.34503482387, 43675.0, 43900.341494878245, 43952.56047439485, 43443.782781085894, 44203.557964419946, 44345.77827110844, 44406.77796610996, 44725.105497889206, 35741.46387804237, 38492.61507385002, 38655.80672096622, 38816.0, 39208.411873822486, 28973.275668108465, 29046.564301535916, 29128.907430621846, 29384.11847644574, 29526.557101643062], "value": 20137.826371366024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6968794652225, 415.70692661673513, 418.2534176494956, 420.7118124085002, 428.5264782415431, 15317.92341038296, 19747.901260493676, 19786.604267914634, 19921.900390498064, 19975.400737977867, 19019.904900475514, 20144.697829532568, 20217.898910505428, 20364.796352036476, 20391.082401291977, 4751.833685820997, 5420.783168673248, 5611.410801865806, 6007.519398448136, 6055.818325450222, 5968.074948382986, 5970.492508136814, 6012.609180403259, 6013.879722405549, 6017.187679663255, 5405.243265942751, 5493.587980901429, 5535.308086489189, 5537.141743029817, 5870.796486720234, 5450.419378380265, 5482.533984611293, 5522.723863806834, 5525.171224316365, 5528.44715528446, 5303.681779093266, 5368.651037682538, 5420.620556561043, 5424.593155513352, 5427.62006659534, 23314.417139571477, 23675.0, 23846.0, 23978.400539986465, 24013.159539416036, 2485.9751402485927, 2507.059852555292, 2900.1879473747385, 3109.5802066721158, 3209.823459709715, 10970.341779493256, 11058.502367393487, 11201.27191732543, 11447.123008946643, 11521.942390287995, 2011.6781314989678, 2068.1830676882546, 2079.812816846491, 2090.9163633454646, 2092.257248676728, 62837.0, 67673.96978090666, 68942.0, 87708.12291877063, 90409.54795226047, 11603.361815100081, 11692.94153529227, 11738.941305293589, 11854.703632409086, 12105.273683579013, 17056.403025894033, 17059.91470042642, 17062.061586612606, 17070.743938840926, 17078.23147958345, 8309.916900831035, 8488.787780305542, 8563.914360856312, 8625.654973800978, 8686.218240358397, 8067.435279530494, 8078.23256790604, 8216.507009579444, 8246.237510434072, 8316.916830831615, 5033.370828646419, 5146.330976972969, 5180.663256888291, 5182.714950677673, 5196.8960620787375, 2022.6561484547663, 2034.1964923854994, 2054.2810016494404, 2100.7500537180354, 2127.2022991378235, 927.958241879117, 992.7964767222702, 1000.314784372707, 1017.1557607186018, 1091.8635170603675, 19861.00694965246, 20111.698324525143, 20510.692339614918, 20990.370288891358, 21043.47391315199, 1032.200044965143, 1038.6883934819523, 1054.0671505717496, 1077.7790552936629, 1079.643717573199, 10614.097801686788, 11523.423828808525, 11558.0, 11580.420978951019, 11631.59289424883, 461027.0, 469259.0, 469877.0, 480860.0, 484924.0, 90293.54853225824, 90846.0, 91665.5416722912, 92911.0708892916, 93261.0, 1019.7603563162651, 1019.7705516258634, 1047.4919663963124, 1047.6647472808781, 1054.7204990677476, 17281.308747649953, 17802.732959005367, 18097.457076287734, 18141.27434902642, 18300.816991830445, 43035.0, 43223.0, 43266.0, 43823.780881095394, 44006.55993440025, 57881.710591446776, 58553.0, 58929.41070589239, 59294.40705593061, 59524.40475595362, 8475.110113438246, 8848.247898928663, 8940.46357218569, 8965.327600430124, 8970.775730606787, 13038.543650972171, 13047.34763261814, 13096.0, 13947.790783138058, 13972.720545589234, 11484.310941343547, 11587.073034157416, 11725.0, 11932.22440541362, 12369.257844529357, 11728.765424691288, 11852.70368240801, 11897.46461409256, 11963.880361196276, 12262.141650084408, 12201.20692155007, 12255.509779608716, 12372.381380931098, 12436.31600261958, 12550.372481375713, 8416.074231834371, 8634.697785577475, 8691.782705432415, 8786.077461866667, 8960.820783584422, 11767.411629418666, 11792.29246245228, 11962.282263064244, 12138.271703697807, 12439.875601243872], "value": 9521.847525210806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.7548678981188, 1492.6566889615387, 1536.931832376498, 1654.3134599141356, 1804.7383129446223, 7869.960650196748, 8772.956135219323, 9005.864912026325, 9021.3685042047, 9240.676576319831, 9010.324225683067, 9072.637094516227, 9085.454872707642, 9088.50013249271, 9095.636174553027, 2456.778889899909, 2478.2069737683946, 2480.082369523279, 2482.429041320497, 2486.1298545509107, 2364.160722943356, 2448.155386391701, 2450.8529488230765, 2452.791512721421, 2456.385903524119, 2299.0803678528555, 2305.7463678995296, 2329.1731435340466, 2333.7432882382923, 2336.5910965581043, 2303.49323148907, 2330.976690233093, 2349.0721165139757, 2372.1104585780417, 2374.050379848066, 2413.3001429585574, 2423.7455067217866, 2436.549238390903, 2444.804415646744, 2445.2419749877417, 8798.912010879938, 8988.101189881025, 8993.325500587416, 9074.092590740873, 9114.40756350835, 5302.0, 5539.19681646159, 5542.4457554244655, 5551.666899986014, 5555.666660000373, 3365.5793025871767, 3489.180042689966, 3554.1470047188745, 3611.20553478237, 3616.6202548732267, 1092.6175838456556, 1099.5326986030905, 1102.6251074634583, 1106.651404807483, 1112.1825458288151, 12480.81278780819, 12495.187812792139, 12531.624051278477, 12547.686307842285, 12620.81068783969, 4745.1221524018165, 4784.234522476387, 4835.8065677372515, 4871.098846713369, 4923.507649235048, 9560.61757529691, 9574.425534467955, 9575.377600455948, 9612.75968100789, 9613.423194608205, 5504.642198257181, 5510.559155267649, 5510.752016159283, 5516.613837031369, 5516.668999860021, 4277.486701595828, 4516.88707782308, 4543.954560454353, 5062.392512898476, 5158.303629010035, 3998.2403343364667, 4071.246819338432, 4148.460700109027, 4177.791110444527, 4190.958090419057, 1251.1367156662056, 1274.095392271479, 1275.253976423784, 1276.974460510803, 1292.3925754895183, 955.9139677429065, 963.942163470194, 986.556049777603, 993.1955116355631, 999.7200783780553, 5935.258092738408, 6016.879662406727, 6042.637441753509, 6059.484943779828, 6095.969520152459, 480.17889409110114, 494.1426624805959, 495.68028621538906, 499.1340025056524, 510.5252115532516, 4049.838006479708, 4101.651359634465, 4107.67138628909, 4194.916101677949, 4251.277282861921, 10890.346579205274, 11215.55137794479, 11278.323300601991, 11292.153088518395, 11307.321560706385, 10409.53157107932, 10901.945490272497, 10917.617883374043, 11200.887991120147, 11244.212905096729, 8394.706185283485, 8557.871631925525, 8594.22651961314, 8597.226249637562, 8604.655813767378, 6019.909701354396, 6178.598391104564, 6222.191115155001, 6309.652969086561, 6427.453666438218, 10237.488125593542, 10332.328398654063, 10338.172946164139, 10373.948130259301, 10393.896061039293, 9171.541422928693, 9463.621455141718, 10203.183745300506, 10438.425886576008, 10634.30876992993, 7850.293473587176, 8077.27304542594, 8290.33677305802, 8297.336213103057, 8303.875441868257, 8627.827443451222, 8817.206451419403, 8819.470831750115, 8820.338474614302, 8822.25010874083, 7515.13575938774, 7628.313451789366, 7692.730754423568, 7738.342240909586, 7835.412344074103, 7729.613519323899, 7799.025121859768, 7812.257835505845, 7910.248526389983, 7953.6818527258265, 6878.415334696607, 6987.615681137586, 6991.265917078634, 7003.719851205895, 7024.824379390352, 5229.372475302988, 5256.684598924076, 5262.236975638588, 5299.814506492255, 5376.712498820691, 5082.33929589151, 5124.538791508782, 5171.974140129275, 5235.869103272448, 5303.231031500488], "value": 4645.799579736074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.69578770681795, 352.413231968772, 354.33208402161927, 356.5258206585242, 361.87153560486024, 5315.255864179013, 5320.574354051676, 5347.91978120328, 5365.490278423548, 5370.194470829368, 4943.728094954776, 5054.0, 5064.873378165547, 5121.897562048757, 5275.182346736253, 4171.436856024443, 4181.163767246563, 4188.476440444937, 4192.727472714264, 4214.662826973835, 4198.769067701275, 4208.537060923296, 4229.577042295777, 4230.51349094855, 4230.619244268015, 3916.5104361954754, 3995.720299579031, 4063.674906007512, 4160.188763191179, 4196.286631272676, 4159.459270294842, 4160.625543701066, 4185.518665353493, 4186.958130418718, 4187.1625674865145, 3749.343864823645, 3752.2683076800035, 3752.7185461090526, 3760.811959402019, 3779.981100094509, 5024.949750502521, 5092.0, 5106.719130447824, 5195.584353251731, 5207.375114986188, 4760.357351757503, 4789.353437285957, 4792.400949881265, 4804.063207674505, 4804.5195480451675, 5499.835004949858, 5500.80747173851, 5509.256250406184, 5527.640703354309, 5557.6109672322955, 4020.6530812177957, 4141.503019637663, 4170.207660544487, 4172.895677608054, 4177.540470548237, 5637.661740295595, 5652.123920792284, 5660.433956604348, 5665.971670141664, 5680.602357834953, 4198.6221240088535, 4209.7474151551005, 4211.904904724794, 4241.321388577812, 4258.701096165699, 3923.3918742594374, 4061.78146556032, 4274.691666500117, 4286.571342865751, 4292.785360731951, 4671.626269898468, 4701.858944231679, 4703.435587729495, 4710.905781884343, 4712.929306060412, 5526.198701188305, 5527.723613819293, 5532.640378375393, 5541.556675465953, 5557.944420555824, 1314.6779039135472, 1353.262471952788, 1363.9181649101085, 1365.8019587159806, 1366.6993261482457, 956.1538038835541, 973.1825266775942, 976.5800705696477, 984.8128855517429, 988.8220120378257, 5159.974200128975, 5204.661696989683, 5211.400688920823, 5238.449962753933, 5275.920861187085, 5454.8909021819345, 5456.345238571317, 5466.3440387153005, 5475.835724928259, 5475.972620136874, 4945.629077819106, 5207.947920520746, 5215.504527069922, 5234.659747116425, 5235.65968212065, 2897.797154199186, 2902.6661933877454, 2905.302727345464, 2912.839793811361, 2919.927001824929, 5684.658920464785, 5694.174344720075, 5694.971525142348, 5719.0, 5745.798897038583, 5323.22813192085, 5534.806281780118, 5565.638233514808, 5572.17707495668, 5572.916406253909, 5626.521745651666, 5658.405867383865, 5664.858378540487, 5680.857978550486, 5694.914576281442, 5242.606804489602, 5435.483629055391, 5474.452554744494, 5480.0271902116, 5516.7105651155925, 5350.652207606493, 5356.866078348073, 5363.919541206963, 5401.918971215357, 5420.750388588692, 5622.634528755618, 5627.803026894039, 5651.745671444713, 5669.092945128759, 5674.659520428788, 3920.6079392061706, 4010.699197560253, 4015.6185162409524, 4023.798810059544, 4039.3133167362207, 5407.7025763581805, 5434.940186663563, 5445.482679145475, 5502.367227768697, 5539.279893613965, 5317.521423071942, 5329.840104796862, 5364.0, 5410.756515956713, 5423.972880135574, 5101.234814777665, 5265.868353291198, 5284.735763211747, 5326.177126123006, 5329.214713071165, 5260.026895024433, 5288.603354748332, 5314.280003997294, 5323.0, 5326.414094449685, 5352.812651557177, 5371.5702743781185, 5374.570034397317, 5384.550029736539, 5394.597404674734, 5183.201071421541, 5221.530062294411, 5383.596230282823, 5495.835124946258, 5497.890042199054], "value": 4189.030499969688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3740602161066, 735.205977544252, 765.0742601452242, 807.4832107451228, 833.4999000599641, 15169.696606067886, 15351.616209594751, 15364.385424583032, 15432.537023889287, 15571.29929153188, 14146.434142634282, 14172.645683857909, 14176.50382236622, 14193.71612567748, 14391.352389142488, 717.5407739047014, 735.2059775442509, 836.2807985132796, 849.9575021248944, 855.3328403845011, 864.9870251946226, 866.8223014282057, 867.0722327109995, 867.1025488619281, 867.7093173786789, 913.0504275553417, 913.4017218721748, 914.8719179314901, 914.9588268527899, 914.9634014639406, 758.8178837079089, 773.1920143450108, 882.5675419044686, 897.7890195803981, 910.5219759626216, 666.0708311904914, 666.9166354205724, 667.3993405934649, 667.4393509452035, 669.280523437302, 14400.495982640661, 14427.855721442862, 14430.494932677306, 14434.0, 14434.566962991126, 12689.619311420673, 12952.935235323763, 13401.66495837602, 13562.932185339108, 13887.097338672955, 12320.383980801014, 12408.069394795426, 12744.044196685192, 12919.806202906964, 13148.868511314955, 4181.393697913785, 4203.717065160612, 4287.464066991626, 4326.6538676905775, 4389.056352884145, 67824.6608766953, 68440.6577967112, 69407.0, 69423.14038017341, 69644.6517767413, 10735.141188704885, 10739.624113156002, 10814.729631759268, 10825.83761243582, 10870.402127882884, 19636.607267854848, 19826.1078251479, 19900.303489377802, 20051.598968020557, 20341.898290508452, 7391.334779869838, 7517.624118794039, 7635.121960974559, 7798.376129909594, 7922.128565857751, 4799.448063472675, 4848.660593758474, 4945.109880221523, 4994.350734404504, 5034.748262586856, 3459.9654003460146, 3507.5790905091553, 3540.2388486475015, 3588.3540962626457, 3596.5504311961004, 600.9519238460913, 605.9242594675666, 607.8936186167404, 614.7878981751288, 625.8216408323606, 601.9819405417844, 690.8031211104811, 707.1372925031453, 715.7208688611446, 719.9640017999079, 8933.19601235892, 9522.0954009369, 9687.41875487473, 9697.6605818796, 9790.706278811647, 549.154302374347, 606.5147881694627, 620.1627802466634, 675.2100042949761, 678.9845869510378, 4030.2946984277633, 4186.28833098374, 4187.748735075906, 4313.827446902152, 4370.497392799869, 56815.0, 86224.56887715521, 92534.53732731294, 94212.0, 95724.52137739267, 62233.0, 62631.37368626347, 83959.0, 85229.57385213034, 86800.0, 58028.70985645045, 73330.0, 73782.63108684422, 74162.14594635069, 76653.0, 8046.476978996347, 8205.302549283379, 8671.69649062305, 8783.912160878564, 8843.51360675169, 50938.490615093375, 51201.7439912813, 51938.74030629823, 52185.7390713044, 52980.94038119293, 43458.782706087535, 57876.4212357871, 57892.421075788705, 58947.70526147342, 62911.685441572496, 12871.485140594272, 13291.335433228493, 13332.93333533326, 13535.51109377948, 13610.727785444038, 13621.591352259447, 14226.430942762174, 14378.137311761328, 14819.40722371093, 14852.480163194236, 13488.865111348761, 13969.650758731113, 14085.647858803612, 14302.213378264296, 14564.781528276872, 11787.646370608896, 11837.348945807718, 12037.518499259932, 12171.695707607381, 12487.188332758342, 12212.633620991384, 12500.749985000431, 12581.056420768296, 12901.290429026494, 13100.082994190316, 10265.023143288363, 10416.531256093645, 10445.791084178425, 10802.89197108019, 10917.181211409335, 11680.94159529231, 11832.76334473323, 11912.642620721392, 12006.939965300118, 12231.0], "value": 7214.35961013036, "unit": "score"}], "name": "dromaeo_css", "value": 7264.372814115521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 118.0, 113.0, 110.0, 110.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 118.0, 161.0, 117.0, 119.0, 117.0, 118.0, 148.0, 119.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 159.0, 161.0, 160.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 117.0, 75.0, 76.0, 76.0, 78.0, 108.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 125.0, 81.0, 82.0, 81.0, 98.0, 81.0, 81.0, 117.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 52.0, 52.0, 56.0, 52.0, 52.0, 57.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 61.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 75.0, 77.0, 75.0, 77.0, 74.0, 74.0, 74.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 121.0, 120.0, 127.0, 121.0, 119.0, 124.0, 177.0, 120.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 153.0, 151.0, 154.0, 151.0, 157.0, 155.0, 159.0, 152.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 67.0, 64.0, 62.0, 62.0, 62.0, 61.0, 61.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1453.2, "alertThreshold": 2.0}]} 05:47:46 INFO - Return code: 0 05:47:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:46 INFO - # TBPL SUCCESS # 05:47:46 INFO - Running post-action listener: _resource_record_post_action 05:47:46 INFO - [mozharness: 2017-01-09 13:47:46.268346Z] Finished run-tests step (success) 05:47:46 INFO - Running post-run listener: _resource_record_post_run 05:47:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363581440; Read time: 16; Write time: 248832 05:47:46 INFO - TinderboxPrint: CPU usage
13.0% 05:47:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 05:47:46 INFO - TinderboxPrint: I/O write bytes / time
363,581,440 / 248,832 05:47:46 INFO - TinderboxPrint: CPU idle
8,268.2 (87.0%) 05:47:46 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 05:47:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:47:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114053120; Read time: 0; Write time: 82744 05:47:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249147392; Read time: 8; Write time: 166064 05:47:46 INFO - Running post-run listener: _upload_blobber_files 05:47:46 INFO - Blob upload gear active. 05:47:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:46 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 05:47:46 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'] 05:47:46 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 05:47:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:48 INFO - (blobuploader) - INFO - Done attempting. 05:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:48 INFO - (blobuploader) - INFO - Done attempting. 05:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:51 INFO - (blobuploader) - INFO - Done attempting. 05:47:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:51 INFO - Return code: 0 05:47:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b81e8f3a61a125087dcca70b4f50eea11f953bb556b199e5bfa2d27c8577f90db39182828a8ca201558c3f45e0b01ce5ed90e319d690b3b9310a7931f656718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/737a578f0103c9289f3df637f1b7a5c01d28af262c2cbff487adda58513e103d001d8bb18909bb33ec2f48eae78add255f6ea699dc6587b9575b3cee7dd567b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db9c8fe65f54ffb178a67439ef6c9fe5d4478d7936d9047bbb8ae7d0f12338052a8442f3fd73af8a982b6827cc227970714e469f5f88729e84fb5b637d61696"} 05:47:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:51 INFO - Contents: 05:47:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b81e8f3a61a125087dcca70b4f50eea11f953bb556b199e5bfa2d27c8577f90db39182828a8ca201558c3f45e0b01ce5ed90e319d690b3b9310a7931f656718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/737a578f0103c9289f3df637f1b7a5c01d28af262c2cbff487adda58513e103d001d8bb18909bb33ec2f48eae78add255f6ea699dc6587b9575b3cee7dd567b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db9c8fe65f54ffb178a67439ef6c9fe5d4478d7936d9047bbb8ae7d0f12338052a8442f3fd73af8a982b6827cc227970714e469f5f88729e84fb5b637d61696"} 05:47:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:51 INFO - Copying logs to upload dir... 05:47:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.784367 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-09 05:47:50.653477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 05:47:50.656607) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 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/5b81e8f3a61a125087dcca70b4f50eea11f953bb556b199e5bfa2d27c8577f90db39182828a8ca201558c3f45e0b01ce5ed90e319d690b3b9310a7931f656718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/737a578f0103c9289f3df637f1b7a5c01d28af262c2cbff487adda58513e103d001d8bb18909bb33ec2f48eae78add255f6ea699dc6587b9575b3cee7dd567b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db9c8fe65f54ffb178a67439ef6c9fe5d4478d7936d9047bbb8ae7d0f12338052a8442f3fd73af8a982b6827cc227970714e469f5f88729e84fb5b637d61696"} build_url:https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/ECcE_PLmQiGXleo2pI3yzg/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/5b81e8f3a61a125087dcca70b4f50eea11f953bb556b199e5bfa2d27c8577f90db39182828a8ca201558c3f45e0b01ce5ed90e319d690b3b9310a7931f656718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/737a578f0103c9289f3df637f1b7a5c01d28af262c2cbff487adda58513e103d001d8bb18909bb33ec2f48eae78add255f6ea699dc6587b9575b3cee7dd567b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db9c8fe65f54ffb178a67439ef6c9fe5d4478d7936d9047bbb8ae7d0f12338052a8442f3fd73af8a982b6827cc227970714e469f5f88729e84fb5b637d61696"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 05:47:50.681668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:47:50.681988) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1483968435.829416-1201631104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 05:47:50.764011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 05:47:50.764372) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 05:47:50.764652) ========= ========= Total master_lag: 0.16 =========