builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1476444336.62 results: success (0) buildid: 20161014025735 builduid: 66333b3435d245078e8d5b08ae53cde5 revision: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.620623) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.621151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.621479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.636038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.636347) ========= 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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 04:25:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-10-14 04:25:37 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.739513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.739942) ========= 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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.789691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:36.790075) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da --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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 04:25:37,201 truncating revision to first 12 chars 2016-10-14 04:25:37,201 Setting DEBUG logging. 2016-10-14 04:25:37,201 attempt 1/10 2016-10-14 04:25:37,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a35f6cea288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 04:25:37,507 unpacking tar archive at: mozilla-central-3a35f6cea288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:37.421505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:37.421885) ========= script_repo_revision: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:37.422330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:37.422633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:25:37.431102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 04:25:37.431454) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:25:37 INFO - MultiFileLogger online at 20161014 04:25:37 in /builds/slave/test 04:25:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:25:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:37 INFO - {'append_to_log': False, 04:25:37 INFO - 'base_work_dir': '/builds/slave/test', 04:25:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:25:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:37 INFO - 'branch': 'Firefox-Non-PGO', 04:25:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:37 INFO - 'config_files': ('talos/linux_config.py',), 04:25:37 INFO - 'default_actions': ('clobber', 04:25:37 INFO - 'read-buildbot-config', 04:25:37 INFO - 'download-and-extract', 04:25:37 INFO - 'populate-webroot', 04:25:37 INFO - 'create-virtualenv', 04:25:37 INFO - 'install', 04:25:37 INFO - 'run-tests'), 04:25:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:37 INFO - 'download_minidump_stackwalk': True, 04:25:37 INFO - 'download_symbols': 'ondemand', 04:25:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:37 INFO - 'installer_path': 'installer.exe', 04:25:37 INFO - 'log_level': 'info', 04:25:37 INFO - 'log_name': 'talos', 04:25:37 INFO - 'log_to_console': True, 04:25:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:25:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:25:37 INFO - 'opt_config_files': (), 04:25:37 INFO - 'pip_index': False, 04:25:37 INFO - 'sps_profile': False, 04:25:37 INFO - 'sps_profile_interval': 0, 04:25:37 INFO - 'suite': 'dromaeojs', 04:25:37 INFO - 'system_bits': '32', 04:25:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:37 INFO - 'title': 'talos-linux64-ix-052', 04:25:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:37 INFO - 'use_talos_json': True, 04:25:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:37 INFO - 'work_dir': 'build'} 04:25:37 INFO - [mozharness: 2016-10-14 11:25:37.938089Z] Running clobber step. 04:25:37 INFO - Running pre-action listener: _resource_record_pre_action 04:25:37 INFO - Running main action method: clobber 04:25:37 INFO - rmtree: /builds/slave/test/build 04:25:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:38 INFO - Running post-action listener: _resource_record_post_action 04:25:38 INFO - [mozharness: 2016-10-14 11:25:38.948466Z] Finished clobber step (success) 04:25:38 INFO - [mozharness: 2016-10-14 11:25:38.948564Z] Running read-buildbot-config step. 04:25:38 INFO - Running pre-action listener: _resource_record_pre_action 04:25:38 INFO - Running main action method: read_buildbot_config 04:25:38 INFO - Using buildbot properties: 04:25:38 INFO - { 04:25:38 INFO - "project": "", 04:25:38 INFO - "product": "firefox", 04:25:38 INFO - "script_repo_revision": "production", 04:25:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:25:38 INFO - "repository": "", 04:25:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:25:38 INFO - "buildid": "20161014025735", 04:25:38 INFO - "pgo_build": "False", 04:25:38 INFO - "basedir": "/builds/slave/test", 04:25:38 INFO - "buildnumber": 673, 04:25:38 INFO - "slavename": "talos-linux64-ix-052", 04:25:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:25:38 INFO - "platform": "ubuntu64_hw", 04:25:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:25:38 INFO - "branch": "mozilla-central", 04:25:38 INFO - "repo_path": "mozilla-central", 04:25:38 INFO - "revision": "3a35f6cea288558cd0433f1b8b00c02e8bc3e4da", 04:25:38 INFO - "stage_platform": "linux64", 04:25:38 INFO - "builduid": "66333b3435d245078e8d5b08ae53cde5", 04:25:38 INFO - "slavebuilddir": "test" 04:25:38 INFO - } 04:25:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:25:38 INFO - Running post-action listener: _resource_record_post_action 04:25:38 INFO - [mozharness: 2016-10-14 11:25:38.950983Z] Finished read-buildbot-config step (success) 04:25:38 INFO - [mozharness: 2016-10-14 11:25:38.951070Z] Running download-and-extract step. 04:25:38 INFO - Running pre-action listener: _resource_record_pre_action 04:25:38 INFO - Running main action method: download_and_extract 04:25:38 INFO - mkdir: /builds/slave/test/build/tests 04:25: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')]} 04:25:38 INFO - trying https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:25:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:25:39 INFO - Downloaded 1361 bytes. 04:25:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:25:39 INFO - Using the following test package requirements: 04:25:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:25:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:25:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:25:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'jsshell-linux-x86_64.zip'], 04:25:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:25:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:25:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:25:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:25:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:25:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:25:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:25:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:25:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:25:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:25:40 INFO - Http code: 200 04:25:40 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 04:25:40 INFO - x-amz-cf-id: HFTLYLIyTbuYLUmj2wh9QDDJUfxxCeuaiTtI4SjjfP8PznoDBevuVw== 04:25:40 INFO - x-amz-version-id: ILSbRf8KguA1Rhv4Tli3AHJNRbMqR3uO 04:25:40 INFO - Expected file size: 20552292 04:25:40 INFO - Obtained file size: 20552292 04:25:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:25:45 INFO - Http code: 200 04:25:45 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:25:45 INFO - x-amz-cf-id: cmVkCW2m8ShFt9cLOmCfUm11PPvtgvptDOwderOOcnYBwN1lU5dlGQ== 04:25:45 INFO - x-amz-version-id: ILSbRf8KguA1Rhv4Tli3AHJNRbMqR3uO 04:25:45 INFO - Expected file size: 20552292 04:25:45 INFO - Obtained file size: 20552292 04:25:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:25:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:25:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:25:50 INFO - Http code: 200 04:25:50 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 04:25:50 INFO - x-amz-cf-id: jqxclmVnYAg_BcPTuc9pEd-nqKgzmILKA3nuNoRwBDwDNZgKyyj9Nw== 04:25:50 INFO - x-amz-version-id: uvCgvW7M8prSMZDBe7nY9j5FhDk1ZzO. 04:25:50 INFO - Expected file size: 14409006 04:25:50 INFO - Obtained file size: 14409006 04:25: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')]} 04:25:50 INFO - trying https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:25:51 INFO - Downloaded 55806337 bytes. 04:25:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:51 INFO - mkdir: /builds/slave/test/properties 04:25:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:51 INFO - Contents: 04:25:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:52 INFO - Running post-action listener: _resource_record_post_action 04:25:52 INFO - Running post-action listener: set_extra_try_arguments 04:25:52 INFO - [mozharness: 2016-10-14 11:25:52.397687Z] Finished download-and-extract step (success) 04:25:52 INFO - [mozharness: 2016-10-14 11:25:52.397913Z] Running populate-webroot step. 04:25:52 INFO - Running pre-action listener: _resource_record_pre_action 04:25:52 INFO - Running main action method: populate_webroot 04:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:52 INFO - '--tppagecycles', 04:25:52 INFO - '7'], 04:25:52 INFO - 'tests': ['tsvgm']}}, 04:25:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['damp', 'tps']}, 04:25:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'tests': ['damp', 'tps']}, 04:25:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['dromaeo_dom']}, 04:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['basic_compositor_video']}, 04:25:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['a11yr', 04:25:52 INFO - 'ts_paint', 04:25:52 INFO - 'tpaint', 04:25:52 INFO - 'sessionrestore', 04:25:52 INFO - 'sessionrestore_no_auto_restore', 04:25:52 INFO - 'tabpaint']}, 04:25:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['tsvgx', 04:25:52 INFO - 'tsvgr_opacity', 04:25:52 INFO - 'tart', 04:25:52 INFO - 'tscrollx', 04:25:52 INFO - 'cart']}, 04:25:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:52 INFO - 'tsvgr_opacity', 04:25:52 INFO - 'tart', 04:25:52 INFO - 'tscrollx', 04:25:52 INFO - 'cart']}, 04:25:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'talos_options': ['--disable-e10s'], 04:25:52 INFO - 'tests': ['tp5o']}, 04:25:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'tests': ['tp5o']}, 04:25:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'talos_options': ['--disable-e10s', 04:25:52 INFO - '--xperf_path', 04:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:52 INFO - 'tests': ['tp5n']}, 04:25:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:52 INFO - 'talos_options': ['--xperf_path', 04:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:52 INFO - 'tests': ['tp5n']}}, 04:25:52 INFO - 'talos.zip': {'path': '', 04:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:52 INFO - Running post-action listener: _resource_record_post_action 04:25:52 INFO - [mozharness: 2016-10-14 11:25:52.415967Z] Finished populate-webroot step (success) 04:25:52 INFO - [mozharness: 2016-10-14 11:25:52.416054Z] Running create-virtualenv step. 04:25:52 INFO - Running pre-action listener: _resource_record_pre_action 04:25:52 INFO - Running main action method: create_virtualenv 04:25:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:52 INFO - Using real prefix '/usr' 04:25:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:55 INFO - Installing pip.................done. 04:25:55 INFO - Return code: 0 04:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:55 INFO - Reading from file tmpfile_stdout 04:25:55 INFO - Output received: 04:25:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:25:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:55 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:55 INFO - Using env: {'DISPLAY': ':0', 04:25:55 INFO - 'HOME': '/home/cltbld', 04:25:55 INFO - 'LANG': 'en_US.UTF-8', 04:25:55 INFO - 'LANGUAGE': 'en_US:en', 04:25:55 INFO - 'LOGNAME': 'cltbld', 04:25:55 INFO - 'MAIL': '/var/mail/cltbld', 04:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:55 INFO - 'MOZ_NO_REMOTE': '1', 04:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:55 INFO - 'NO_EM_RESTART': '1', 04:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:55 INFO - 'PWD': '/builds/slave/test', 04:25:55 INFO - 'SHELL': '/bin/bash', 04:25:55 INFO - 'SHLVL': '1', 04:25:55 INFO - 'TERM': 'linux', 04:25:55 INFO - 'TMOUT': '86400', 04:25:55 INFO - 'USER': 'cltbld', 04:25:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:55 INFO - '_': '/tools/buildbot/bin/python'} 04:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:25:55 INFO - Cleaning up... 04:25:55 INFO - Return code: 0 04:25:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:55 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:25:55 INFO - Using env: {'DISPLAY': ':0', 04:25:55 INFO - 'HOME': '/home/cltbld', 04:25:55 INFO - 'LANG': 'en_US.UTF-8', 04:25:55 INFO - 'LANGUAGE': 'en_US:en', 04:25:55 INFO - 'LOGNAME': 'cltbld', 04:25:55 INFO - 'MAIL': '/var/mail/cltbld', 04:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:55 INFO - 'MOZ_NO_REMOTE': '1', 04:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:55 INFO - 'NO_EM_RESTART': '1', 04:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:55 INFO - 'PWD': '/builds/slave/test', 04:25:55 INFO - 'SHELL': '/bin/bash', 04:25:55 INFO - 'SHLVL': '1', 04:25:55 INFO - 'TERM': 'linux', 04:25:55 INFO - 'TMOUT': '86400', 04:25:55 INFO - 'USER': 'cltbld', 04:25:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:55 INFO - '_': '/tools/buildbot/bin/python'} 04:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:55 INFO - Downloading/unpacking psutil>=3.1.1 04:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:57 INFO - Installing collected packages: psutil 04:25:57 INFO - Running setup.py install for psutil 04:25:57 INFO - building 'psutil._psutil_linux' extension 04:25:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:25:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:25:57 INFO - building 'psutil._psutil_posix' extension 04:25:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:25:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:58 INFO - Successfully installed psutil 04:25:58 INFO - Cleaning up... 04:25:58 INFO - Return code: 0 04:25:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:58 INFO - Using env: {'DISPLAY': ':0', 04:25:58 INFO - 'HOME': '/home/cltbld', 04:25:58 INFO - 'LANG': 'en_US.UTF-8', 04:25:58 INFO - 'LANGUAGE': 'en_US:en', 04:25:58 INFO - 'LOGNAME': 'cltbld', 04:25:58 INFO - 'MAIL': '/var/mail/cltbld', 04:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:58 INFO - 'MOZ_NO_REMOTE': '1', 04:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:58 INFO - 'NO_EM_RESTART': '1', 04:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:58 INFO - 'PWD': '/builds/slave/test', 04:25:58 INFO - 'SHELL': '/bin/bash', 04:25:58 INFO - 'SHLVL': '1', 04:25:58 INFO - 'TERM': 'linux', 04:25:58 INFO - 'TMOUT': '86400', 04:25:58 INFO - 'USER': 'cltbld', 04:25:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:58 INFO - '_': '/tools/buildbot/bin/python'} 04:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:00 INFO - Installing collected packages: mozsystemmonitor 04:26:00 INFO - Running setup.py install for mozsystemmonitor 04:26:00 INFO - Successfully installed mozsystemmonitor 04:26:00 INFO - Cleaning up... 04:26:00 INFO - Return code: 0 04:26:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:00 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:26:00 INFO - Using env: {'DISPLAY': ':0', 04:26:00 INFO - 'HOME': '/home/cltbld', 04:26:00 INFO - 'LANG': 'en_US.UTF-8', 04:26:00 INFO - 'LANGUAGE': 'en_US:en', 04:26:00 INFO - 'LOGNAME': 'cltbld', 04:26:00 INFO - 'MAIL': '/var/mail/cltbld', 04:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:00 INFO - 'MOZ_NO_REMOTE': '1', 04:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:00 INFO - 'NO_EM_RESTART': '1', 04:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:00 INFO - 'PWD': '/builds/slave/test', 04:26:00 INFO - 'SHELL': '/bin/bash', 04:26:00 INFO - 'SHLVL': '1', 04:26:00 INFO - 'TERM': 'linux', 04:26:00 INFO - 'TMOUT': '86400', 04:26:00 INFO - 'USER': 'cltbld', 04:26:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:00 INFO - '_': '/tools/buildbot/bin/python'} 04:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:00 INFO - Downloading/unpacking jsonschema==2.5.1 04:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:03 INFO - warning: no files found matching '*.txt' 04:26:03 INFO - no previously-included directories found matching 'build' 04:26:03 INFO - no previously-included directories found matching 'dist' 04:26:03 INFO - no previously-included directories found matching '.git*' 04:26:03 INFO - Installing collected packages: jsonschema, functools32 04:26:03 INFO - Running setup.py install for functools32 04:26:03 INFO - warning: no files found matching '*.txt' 04:26:03 INFO - no previously-included directories found matching 'build' 04:26:03 INFO - no previously-included directories found matching 'dist' 04:26:03 INFO - no previously-included directories found matching '.git*' 04:26:03 INFO - Successfully installed jsonschema functools32 04:26:03 INFO - Cleaning up... 04:26:03 INFO - Return code: 0 04:26:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:03 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:26:03 INFO - Using env: {'DISPLAY': ':0', 04:26:03 INFO - 'HOME': '/home/cltbld', 04:26:03 INFO - 'LANG': 'en_US.UTF-8', 04:26:03 INFO - 'LANGUAGE': 'en_US:en', 04:26:03 INFO - 'LOGNAME': 'cltbld', 04:26:03 INFO - 'MAIL': '/var/mail/cltbld', 04:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:03 INFO - 'MOZ_NO_REMOTE': '1', 04:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:03 INFO - 'NO_EM_RESTART': '1', 04:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:03 INFO - 'PWD': '/builds/slave/test', 04:26:03 INFO - 'SHELL': '/bin/bash', 04:26:03 INFO - 'SHLVL': '1', 04:26:03 INFO - 'TERM': 'linux', 04:26:03 INFO - 'TMOUT': '86400', 04:26:03 INFO - 'USER': 'cltbld', 04:26:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:03 INFO - '_': '/tools/buildbot/bin/python'} 04:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:26:03 INFO - Cleaning up... 04:26:03 INFO - Return code: 0 04:26:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:03 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:26:03 INFO - Using env: {'DISPLAY': ':0', 04:26:03 INFO - 'HOME': '/home/cltbld', 04:26:03 INFO - 'LANG': 'en_US.UTF-8', 04:26:03 INFO - 'LANGUAGE': 'en_US:en', 04:26:03 INFO - 'LOGNAME': 'cltbld', 04:26:03 INFO - 'MAIL': '/var/mail/cltbld', 04:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:03 INFO - 'MOZ_NO_REMOTE': '1', 04:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:03 INFO - 'NO_EM_RESTART': '1', 04:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:03 INFO - 'PWD': '/builds/slave/test', 04:26:03 INFO - 'SHELL': '/bin/bash', 04:26:03 INFO - 'SHLVL': '1', 04:26:03 INFO - 'TERM': 'linux', 04:26:03 INFO - 'TMOUT': '86400', 04:26:03 INFO - 'USER': 'cltbld', 04:26:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:03 INFO - '_': '/tools/buildbot/bin/python'} 04:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:06 INFO - Downloading docopt-0.6.1.tar.gz 04:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:06 INFO - Running setup.py install for blobuploader 04:26:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:06 INFO - Running setup.py install for requests 04:26:06 INFO - Running setup.py install for docopt 04:26:06 INFO - Successfully installed blobuploader requests docopt 04:26:06 INFO - Cleaning up... 04:26:06 INFO - Return code: 0 04:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:07 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:26:07 INFO - Using env: {'DISPLAY': ':0', 04:26:07 INFO - 'HOME': '/home/cltbld', 04:26:07 INFO - 'LANG': 'en_US.UTF-8', 04:26:07 INFO - 'LANGUAGE': 'en_US:en', 04:26:07 INFO - 'LOGNAME': 'cltbld', 04:26:07 INFO - 'MAIL': '/var/mail/cltbld', 04:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:07 INFO - 'MOZ_NO_REMOTE': '1', 04:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:07 INFO - 'NO_EM_RESTART': '1', 04:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:07 INFO - 'PWD': '/builds/slave/test', 04:26:07 INFO - 'SHELL': '/bin/bash', 04:26:07 INFO - 'SHLVL': '1', 04:26:07 INFO - 'TERM': 'linux', 04:26:07 INFO - 'TMOUT': '86400', 04:26:07 INFO - 'USER': 'cltbld', 04:26:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:07 INFO - '_': '/tools/buildbot/bin/python'} 04:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:07 INFO - Running setup.py (path:/tmp/pip-JYqBEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:07 INFO - Running setup.py (path:/tmp/pip-XAhvV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:07 INFO - Running setup.py (path:/tmp/pip-Yv81AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:07 INFO - Running setup.py (path:/tmp/pip-tlxBlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:07 INFO - Running setup.py (path:/tmp/pip-9caf85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:07 INFO - Running setup.py (path:/tmp/pip-YrFYwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:07 INFO - Running setup.py (path:/tmp/pip-bO5A_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:07 INFO - Running setup.py (path:/tmp/pip-S86q5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:07 INFO - Running setup.py (path:/tmp/pip-WwUn5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:07 INFO - Running setup.py (path:/tmp/pip-HhUePr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:07 INFO - Running setup.py (path:/tmp/pip-ZfwjmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:07 INFO - Running setup.py (path:/tmp/pip-U26FOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:08 INFO - Running setup.py (path:/tmp/pip-0SzqTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:08 INFO - Running setup.py (path:/tmp/pip-9AsY7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:08 INFO - Running setup.py (path:/tmp/pip-oBoOLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:08 INFO - Running setup.py (path:/tmp/pip-c3OV3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:08 INFO - Running setup.py (path:/tmp/pip-pEyFYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:08 INFO - Running setup.py install for manifestparser 04:26:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:08 INFO - Running setup.py install for mozcrash 04:26:08 INFO - Running setup.py install for mozdebug 04:26:08 INFO - Running setup.py install for mozdevice 04:26:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:08 INFO - Running setup.py install for mozfile 04:26:08 INFO - Running setup.py install for mozhttpd 04:26:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozinfo 04:26:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozInstall 04:26:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozleak 04:26:09 INFO - Running setup.py install for mozlog 04:26:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for moznetwork 04:26:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozprocess 04:26:09 INFO - Running setup.py install for mozprofile 04:26:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozrunner 04:26:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:09 INFO - Running setup.py install for mozscreenshot 04:26:09 INFO - Running setup.py install for moztest 04:26:10 INFO - Running setup.py install for mozversion 04:26:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:10 INFO - Cleaning up... 04:26:10 INFO - Return code: 0 04:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:10 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:26:10 INFO - Using env: {'DISPLAY': ':0', 04:26:10 INFO - 'HOME': '/home/cltbld', 04:26:10 INFO - 'LANG': 'en_US.UTF-8', 04:26:10 INFO - 'LANGUAGE': 'en_US:en', 04:26:10 INFO - 'LOGNAME': 'cltbld', 04:26:10 INFO - 'MAIL': '/var/mail/cltbld', 04:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:10 INFO - 'MOZ_NO_REMOTE': '1', 04:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:10 INFO - 'NO_EM_RESTART': '1', 04:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:10 INFO - 'PWD': '/builds/slave/test', 04:26:10 INFO - 'SHELL': '/bin/bash', 04:26:10 INFO - 'SHLVL': '1', 04:26:10 INFO - 'TERM': 'linux', 04:26:10 INFO - 'TMOUT': '86400', 04:26:10 INFO - 'USER': 'cltbld', 04:26:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:10 INFO - '_': '/tools/buildbot/bin/python'} 04:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:10 INFO - Running setup.py (path:/tmp/pip-l4bl4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:10 INFO - Running setup.py (path:/tmp/pip-KLUdCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:10 INFO - Running setup.py (path:/tmp/pip-Wj9t4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:10 INFO - Running setup.py (path:/tmp/pip-YjmC45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:10 INFO - Running setup.py (path:/tmp/pip-WPsCGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:10 INFO - Running setup.py (path:/tmp/pip-mTjuv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:10 INFO - Running setup.py (path:/tmp/pip-KdFXiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:10 INFO - Running setup.py (path:/tmp/pip-SBFRsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:11 INFO - Running setup.py (path:/tmp/pip-wd_6ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:11 INFO - Running setup.py (path:/tmp/pip-EKHHNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:11 INFO - Running setup.py (path:/tmp/pip-Kq8Qr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:11 INFO - Running setup.py (path:/tmp/pip-yiBTvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:11 INFO - Running setup.py (path:/tmp/pip-bcJrPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:11 INFO - Running setup.py (path:/tmp/pip-A6dced-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:11 INFO - Running setup.py (path:/tmp/pip-HCW46K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:11 INFO - Running setup.py (path:/tmp/pip-tcOadE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:11 INFO - Running setup.py (path:/tmp/pip-KhcBxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:26:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:13 INFO - Downloading blessings-1.6.tar.gz 04:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:13 INFO - Installing collected packages: blessings 04:26:13 INFO - Running setup.py install for blessings 04:26:13 INFO - Successfully installed blessings 04:26:13 INFO - Cleaning up... 04:26:13 INFO - Return code: 0 04:26:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:14 INFO - Reading from file tmpfile_stdout 04:26:14 INFO - Current package versions: 04:26:14 INFO - argparse == 1.2.1 04:26:14 INFO - blessings == 1.6 04:26:14 INFO - blobuploader == 1.2.4 04:26:14 INFO - docopt == 0.6.1 04:26:14 INFO - functools32 == 3.2.3-2 04:26:14 INFO - jsonschema == 2.5.1 04:26:14 INFO - manifestparser == 1.1 04:26:14 INFO - mozInstall == 1.12 04:26:14 INFO - mozcrash == 0.17 04:26:14 INFO - mozdebug == 0.1 04:26:14 INFO - mozdevice == 0.48 04:26:14 INFO - mozfile == 1.2 04:26:14 INFO - mozhttpd == 0.7 04:26:14 INFO - mozinfo == 0.9 04:26:14 INFO - mozleak == 0.1 04:26:14 INFO - mozlog == 3.4 04:26:14 INFO - moznetwork == 0.27 04:26:14 INFO - mozprocess == 0.23 04:26:14 INFO - mozprofile == 0.28 04:26:14 INFO - mozrunner == 6.12 04:26:14 INFO - mozscreenshot == 0.1 04:26:14 INFO - mozsystemmonitor == 0.3 04:26:14 INFO - moztest == 0.7 04:26:14 INFO - mozversion == 1.4 04:26:14 INFO - psutil == 3.1.1 04:26:14 INFO - requests == 1.2.3 04:26:14 INFO - wsgiref == 0.1.2 04:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:14 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:26:14 INFO - Using env: {'DISPLAY': ':0', 04:26:14 INFO - 'HOME': '/home/cltbld', 04:26:14 INFO - 'LANG': 'en_US.UTF-8', 04:26:14 INFO - 'LANGUAGE': 'en_US:en', 04:26:14 INFO - 'LOGNAME': 'cltbld', 04:26:14 INFO - 'MAIL': '/var/mail/cltbld', 04:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:14 INFO - 'MOZ_NO_REMOTE': '1', 04:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:14 INFO - 'NO_EM_RESTART': '1', 04:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:14 INFO - 'PWD': '/builds/slave/test', 04:26:14 INFO - 'SHELL': '/bin/bash', 04:26:14 INFO - 'SHLVL': '1', 04:26:14 INFO - 'TERM': 'linux', 04:26:14 INFO - 'TMOUT': '86400', 04:26:14 INFO - 'USER': 'cltbld', 04:26:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:14 INFO - '_': '/tools/buildbot/bin/python'} 04:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:26:14 INFO - Cleaning up... 04:26:14 INFO - Return code: 0 04:26:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:14 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 0x7faaf4c1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:26:14 INFO - Using env: {'DISPLAY': ':0', 04:26:14 INFO - 'HOME': '/home/cltbld', 04:26:14 INFO - 'LANG': 'en_US.UTF-8', 04:26:14 INFO - 'LANGUAGE': 'en_US:en', 04:26:14 INFO - 'LOGNAME': 'cltbld', 04:26:14 INFO - 'MAIL': '/var/mail/cltbld', 04:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:14 INFO - 'MOZ_NO_REMOTE': '1', 04:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:14 INFO - 'NO_EM_RESTART': '1', 04:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:14 INFO - 'PWD': '/builds/slave/test', 04:26:14 INFO - 'SHELL': '/bin/bash', 04:26:14 INFO - 'SHLVL': '1', 04:26:14 INFO - 'TERM': 'linux', 04:26:14 INFO - 'TMOUT': '86400', 04:26:14 INFO - 'USER': 'cltbld', 04:26:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:14 INFO - '_': '/tools/buildbot/bin/python'} 04:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:14 INFO - Cleaning up... 04:26:14 INFO - Return code: 0 04:26:14 INFO - Running post-action listener: _resource_record_post_action 04:26:14 INFO - Running post-action listener: _start_resource_monitoring 04:26:14 INFO - Starting resource monitoring. 04:26:14 INFO - [mozharness: 2016-10-14 11:26:14.536668Z] Finished create-virtualenv step (success) 04:26:14 INFO - [mozharness: 2016-10-14 11:26:14.537134Z] Running install step. 04:26:14 INFO - Running pre-action listener: _resource_record_pre_action 04:26:14 INFO - Running main action method: install 04:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:14 INFO - Reading from file tmpfile_stdout 04:26:14 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:14 INFO - Reading from file tmpfile_stdout 04:26:14 INFO - Output received: 04:26:14 INFO - Usage: mozinstall [options] installer 04:26:14 INFO - Options: 04:26:14 INFO - -h, --help show this help message and exit 04:26:14 INFO - -d DEST, --destination=DEST 04:26:14 INFO - Directory to install application into. [default: 04:26:14 INFO - "/builds/slave/test"] 04:26:14 INFO - --app=APP Application being installed. [default: firefox] 04:26:14 INFO - mkdir: /builds/slave/test/build/application 04:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:26:30 INFO - Reading from file tmpfile_stdout 04:26:30 INFO - Output received: 04:26:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:26:30 INFO - Running post-action listener: _resource_record_post_action 04:26:30 INFO - [mozharness: 2016-10-14 11:26:30.967063Z] Finished install step (success) 04:26:30 INFO - [mozharness: 2016-10-14 11:26:30.967308Z] Running run-tests step. 04:26:30 INFO - Running pre-action listener: _resource_record_pre_action 04:26:30 INFO - Running main action method: run_tests 04:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:30 INFO - Python 2.7.3 04:26:30 INFO - Return code: 0 04:26:30 INFO - grabbing minidump binary from tooltool 04:26: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')]} 04:26:30 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 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:26:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:26:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:26:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:31 INFO - Return code: 0 04:26:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:26:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:26:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:26:31 INFO - Using env: {'DISPLAY': ':0', 04:26:31 INFO - 'HOME': '/home/cltbld', 04:26:31 INFO - 'LANG': 'en_US.UTF-8', 04:26:31 INFO - 'LANGUAGE': 'en_US:en', 04:26:31 INFO - 'LOGNAME': 'cltbld', 04:26:31 INFO - 'MAIL': '/var/mail/cltbld', 04:26:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:31 INFO - 'MOZ_NO_REMOTE': '1', 04:26:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:31 INFO - 'NO_EM_RESTART': '1', 04:26:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:31 INFO - 'PWD': '/builds/slave/test', 04:26:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:31 INFO - 'SHELL': '/bin/bash', 04:26:31 INFO - 'SHLVL': '1', 04:26:31 INFO - 'TERM': 'linux', 04:26:31 INFO - 'TMOUT': '86400', 04:26:31 INFO - 'USER': 'cltbld', 04:26:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884', 04:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:31 INFO - '_': '/tools/buildbot/bin/python'} 04:26:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:26:31 INFO - mozversion application_buildid: 20161014025735 04:26:31 INFO - mozversion application_changeset: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da 04:26:31 INFO - mozversion application_display_name: Nightly 04:26:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:31 INFO - mozversion application_name: Firefox 04:26:31 INFO - mozversion application_remotingname: firefox 04:26:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:31 INFO - mozversion application_vendor: Mozilla 04:26:31 INFO - mozversion application_version: 52.0a1 04:26:31 INFO - mozversion platform_buildid: 20161014025735 04:26:31 INFO - mozversion platform_changeset: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da 04:26:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:31 INFO - mozversion platform_version: 52.0a1 04:26:31 INFO - using testdate: 1476444391 04:26:31 INFO - actual date: 1476444391 04:26:31 INFO - starting webserver on 'localhost:57277' 04:26:31 INFO - SUITE-START | Running 2 tests 04:26:31 INFO - TEST-START | dromaeo_css 04:26:31 INFO - operating with platform_type : linux_ 04:26:31 INFO - Initialising browser for dromaeo_css test... 04:26:31 INFO - TEST-INFO | started process 13233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdND3t/profile http://localhost:57277/getInfo.html) 04:26:35 INFO - PROCESS | 13233 | __metrics Screen width/height:1600/1200 04:26:35 INFO - PROCESS | 13233 | colorDepth:24 04:26:35 INFO - PROCESS | 13233 | Browser inner width/height: 1024/697 04:26:35 INFO - PROCESS | 13233 | __metrics 04:26:35 INFO - PROCESS | 13233 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:35 INFO - PROCESS | 13233 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:36 INFO - PROCESS | 13233 | console.error: PushService: 04:26:36 INFO - PROCESS | 13233 | stateChangeProcessEnqueue: Error transitioning state 04:26:36 INFO - PROCESS | 13233 | UnknownError 04:26:37 INFO - TEST-INFO | 13233: exit 0 04:26:37 INFO - Browser initialized. 04:26:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:37 INFO - TEST-INFO | started process 13314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdND3t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:49 INFO - PROCESS | 13314 | RSS: Main: 174870528 04:26:49 INFO - PROCESS | 13314 | 04:27:41 INFO - PROCESS | 13314 | 1476444461173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:29:53 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57277/tests/dromaeo/cssquery-ext.html) 04:29:55 INFO - PROCESS | 13314 | RSS: Main: 409137152 04:29:55 INFO - PROCESS | 13314 | 04:32:58 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-ext.html (next: http://localhost:57277/tests/dromaeo/cssquery-jquery.html) 04:32:59 INFO - PROCESS | 13314 | RSS: Main: 279248896 04:32:59 INFO - PROCESS | 13314 | 04:36:01 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57277/tests/dromaeo/cssquery-mootools.html) 04:36:02 INFO - PROCESS | 13314 | RSS: Main: 220078080 04:36:02 INFO - PROCESS | 13314 | 04:39:04 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57277/tests/dromaeo/cssquery-prototype.html) 04:39:05 INFO - PROCESS | 13314 | RSS: Main: 220721152 04:39:05 INFO - PROCESS | 13314 | 04:42:08 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57277/tests/dromaeo/cssquery-yui.html) 04:42:08 INFO - PROCESS | 13314 | RSS: Main: 220094464 04:42:08 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | Cycle 1(1): loaded http://localhost:57277/tests/dromaeo/cssquery-yui.html (next: http://localhost:57277/tests/dromaeo/cssquery-dojo.html) 04:45:11 INFO - PROCESS | 13314 | RSS: Main: 312102912 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | __start_tp_report 04:45:11 INFO - PROCESS | 13314 | _x_x_mozilla_page_load 04:45:11 INFO - PROCESS | 13314 | _x_x_mozilla_page_load_details 04:45:11 INFO - PROCESS | 13314 | |i|pagename|runs| 04:45:11 INFO - PROCESS | 13314 | |0;dojo.html;2457.5330687169435;2513.534996025734;2556.6165075238714;2571.6142578613208;2584.5864661654127;4455.821767129319;4518.638508919287;4526.253168227243;4560.201964656184;4566.7716614169285;4532.048269863332;4561.771911404425;4581.770911454422;4589.472210695771;4664.2770370592525;4161.292580261363;4171.374293855931;4258.148370325947;4285.078708077763;4294.634956028742;4204.096119334343;4328.523862375137;4358.193734159175;4366.737995720251;4415;4231.4710661167355;4286.742795432268;4296;4298.075913678543;4372.234858899696;4114.979425102855;4164.68764842638;4171.91656166878;4211.178820130076;4261.062566235423;4229.851955181584;4250.489941207075;4266.317389217741;4300.720453170534;4329.913401731979;4566.566176213254;4591.1965406053805;4615.838445654386;4630.328602352673;4684.836030738942;4687.250039993619;4711.293306004127;4718.787654555554;4937.333459982892;4938.975305123451;4911.312416261726;4918.163912134945;4962.156433406293;4971.900561988776;5033.169527028036;4608.769561521911;4615;4618.053299073716;4631.374764406829;4674;4896.436909755424;5068.087744206078;5075.187969924795;5079.619028572872;5132;4719.339292499053;4805.879853003703;4806.903861922812;4808.735519546389;4812.614990800797;4815.181419158752;4851.56335929768;4858.684185527929;4858.708477491291;4888.340074089952;4805.471398146271;4813.566778989838;4816.373871396696;4816.735079570657;4816.8554943351755;4813.205821039489;4833.154198015333;4852.078105160008;4939.827106051271;4943.307936888838;4197.24449599069;4200.096979149436;4200.957990420118;4246.40550322955;4253.425787518645;3677.9264414711556;3689.262147570497;3719.27474142545;3738.887833365003;3782.6406491383823;4146.813393397304;4170.416141740159;4192.45498085247;4194.993201631586;4287.957120428819;4863.756812159449;4883.169861123618;4891.55975962158;4941.283513890466;4953.628477864175;4177.498700156001;4178.22702799983;4200.474940632421;4218.493780746268;4249.128928569636;4338.869833904988;4367.432233809648;4379.321205213197;4384.364267181241;4429.136318417942;4600.746958917158;4608;4608.193566125848;4610.654200934876;4612.400387949545;4907.55831975124;4908.7545622719435;4908.950910490849;4910.337104490848;4922.72924989129;4569.520200378913;4584.587387135174;4601.838935637236;4606.88482787933;4610.700304480198;4873.610111191026;4889.315495830516;4914.336564563881;4918.0901533216465;4923.433805112458;4887.43794463627;4925.482824303396;4933.925991110208;4940.802367905244;4988.12707776145;4781.880452988564;4782.6173906088125;4791.904161916812;4796.496367881322;4861.392325959255;4597.862064138081;4630.3517507548295;4633.698809577501;4681.7190968540635;4694.929576056294;4624.121416930772;4626.444826620827;4648.093621743727;4651.023285110165;4651.534846515321;4738.905221895474;4740.6681532292405;4787.114383839001;4799.784009719641;4833.516648335279;4736.123817093849;4736.19484687597;4780.330753694555;4796.496367881322;4797.64017698681 04:45:11 INFO - PROCESS | 13314 | |1;ext.html;568.7895478672891;575.4590684756326;585.7364186116247;589.7198830555486;590.958632895697;27198.184054478374;37551.11426600414;38080.42879356812;38198.618013819854;41935.79032104843;38605;39016.80491597538;39039;39065.804670976606;39097.609023909754;7606.42951778616;7739.226077392272;7752.689892404297;7756.069271687377;7758.224177582225;7040.859182816366;7219.927800721978;9771.951140244324;10038.698839034803;10041.397516149018;10102.949485252564;10201.489925503733;10203.591856325738;10203.591856325775;10210.693679189637;9787.46168960707;9860.60557577696;9885.654002109963;9887.703368898945;9892.455914924676;9844.261680374;9902.405855648683;9909.355891867006;9912.157466615346;9915.454649994248;35598.82200589006;36094.458583121275;36117;36122.819385902905;36161.81919090414;2839.3895312507702;2930.648322201328;2967.0653744070764;3029.833359165245;3175.555422240888;27000.729992700017;27578.862105689543;27706.307342316402;27757.722422775714;30854.228644284074;3244.3186930744573;3251.089694885436;3330.333933213367;3349.732021438279;3358.983205083983;245362;247134;247531.76234118894;248064;248450;28760.6858971156;53486;54014.72992635012;54033;54035.72982135143;30437;31619.52570711441;31737;31919.042428727174;31922.20194495156;12768.893132633197;12951.676208094874;12954;12955.093143479866;12957.935210323889;9429.528523573794;9624.37441566296;10994;11108.222424430212;11125.276857004268;7359.411247100219;7412.2587741226525;7420.591867447342;7514.736984205527;7750.612469376509;3104.472239719253;3133.6239651242;3140.5760222370145;3142.5757522734593;3160.826154561521;843.5107637570195;856.734412332179;871.9607617657093;891.826093911681;947.9194268487117;26308.473830523282;27485;28028.71971280261;28099.71900280971;28275.15174544767;952.7141857442878;961.5144352102144;975.6536429567543;976.6484065736329;1012.3622118065572;14401.495947641783;14973.850261497464;15230.086194828345;15765.527034188992;16306.918465407596;342180;348834;350033;350832;351803;49513.25730114051;50376.49623503718;50567.24149137766;50643.24035139476;50691.493085069415;1076.101455284846;1126.2735535579504;1174.712195512105;1187.5012494752225;1212.921160124589;25443;28396.290092747848;28803.711962880105;29078.56382154227;29394;41529.79235103805;42105.57894421139;42164.36753448762;42167.57832421637;42253.36619950765;228768;230186;230413;230449;230830;36656.63343366532;37763;38258;40143.3978490317;40516.79741601391;40239;40540.59459405486;41019.7949010265;41366.58633413627;41524;35018.299634007686;35204.29591408209;35241;35739;35811.462828058124;35292.29415411626;35400.46899296461;35515.46726799048;35802.820985894905;35984.28031439409;34497.65502344944;35137.64862351446;35229.82385088058;35446;35758.46362304516;30082.24794380158;31919.6808031926;32259.35481290314;32427.837860810545;32472;24507.63238551459;24582.153257011134;24634.904246130176;24962.37594060163;25241.87379063093 04:45:11 INFO - PROCESS | 13314 | |2;jquery.html;347.29152528841166;354.9414346632806;376.8831662184722;382.08871840660026;390.91009067914376;12073.154879158463;12136.69658258544;12773.425195866184;13150.408231629564;17032.744508832347;15948.122853243067;16036.35854565816;16287.674246515062;16396;16482.34070637176;4817.783199756011;4845.515448455161;4959.876003099916;5023.221400682882;5023.422306434771;3560.8041557714314;4894.486078961693;4967.453580106186;4969.4036715594;4969.652124351297;3737.9626203737885;5465.535429488498;5718.370979192286;5741.942580574203;5842.912356314659;5525.502704756591;5700.429957004308;5818.650880947157;5820.592558520905;5826.912596311059;5075.974620126913;5077.2637967494875;5080.61895357846;5081.110805609003;5081.923771143436;18826.529336766554;19223.423297301102;19366.806331936783;19391.12739926707;19584;1853.33280019193;1897.2505860185288;1906.9713954290696;1918.213532451688;2157.471419502216;12105.939470302592;12462.376881155906;12488.687782805411;12766.553170639076;12894.35528223585;1623.1154021058433;1638.189096397279;1679.5885008173075;1690.433704708924;1716.6137619035742;44455.77772111151;69167.42909423597;70498.64750676265;70538.64730676365;73582.63208683922;7820.804479888048;8325.25072743456;8359.331253499706;8366.748997530083;9255.861162082574;11642.88357116418;11717.945384915398;11721.179517433698;11728.179027467995;11729.003034741972;6577.309382514863;6606.537542372084;6738.707098255192;6811.318868113149;6941.930580694229;6552.115464412339;6715.6977935993;6760.121184246115;6922.826929326707;7017.754378596725;3533.5936367318086;3636.109153257416;3638.472421498868;3725.3294407006997;3730.1607138393642;1779.8932064076198;1819.8180181981695;1820.062667726122;1824.4253060285967;1869.6260747850213;782.2568559868148;799.0890384961149;807.4670717326536;829.8962629671291;875.92992560595;15887.205639717968;15980.121093339978;16152.434664786912;16346.34614615426;16894.57763555921;822.7202751064667;848.3722045686147;855.341387131905;864.6671031652859;911.48956584313;8866.601002954754;9087.681931132378;9319.487428191514;9436.339456237998;9476.763080923032;378883;382942;383350;384786;388760;46425.899137027714;47344;75890;81942.59028704818;82585;878.0999475537625;893.946363218209;897.2507955856802;900.4552245891273;944.8866136063716;15003.2498375083;15056.247187640354;15533.689326213638;15864;15970.121643309265;32876.67123328736;35221.64778352184;37184.81407592945;38224.23551529009;39447.802760986015;49913.500864990885;50486;50545.24182137197;50668.49331506638;52725.472745272054;5294;6674.965380366051;7195.6761945713615;7511;7574.204708505748;8334.416590838584;11198.60804871858;11571.479283432434;11747.941260293645;11831.46758395857;10117;10255.94872025635;10322.535485903303;10392.740181495523;10473.057424831803;9842.409455432697;9929.304948653813;10004.899951000396;10252.948735256276;10290.434026128634;9209.17117459405;9741.464219467998;9894;10246.795064098826;10638.521266543179;6209.5032397409;6587.835304117435;6658.7336506539195;6966.3730264276455;7078.292170782881;4699.859004229878;4884.877878053077;7753.806154846174;9780.288449521448;10584.364938103738 04:45:11 INFO - PROCESS | 13314 | |3;mootools.html;1217.03245919494;1343.952961646342;1378.338397569167;1407.3737186951805;1686.7216909209988;6288.371162883709;7239.710411583537;7514.0607424071995;7556.47104702671;7572.469927105098;7309.926900730991;7499.4000479961605;7613.086429628453;7615.238476152382;7622.65698043588;2083.2812679625504;2129.6379615465407;2129.808317251455;2131.0729832522825;2132.32831658028;2093.884836334001;2143.6677315016195;2155.245664017597;2158.9352319430363;2160.114353115223;2099.9685004724943;2102.0750869617395;2116.7459904811444;2119.5231073008604;2160.3734916874087;2042.765082015565;2048.98975505123;2052.9794702052936;2055.3628375203734;2058.372196480073;1923.2307077169244;2056.9280075197444;2057.4753437873246;2065.0913598016823;2065.9690104648444;7418.666160022812;7420;7550.735724249625;7555.962220188919;7560.31957123856;4295.334223195409;4434.268345722952;4436.356728274414;4439.578240067189;4446.266366049598;2661.5874539446418;2772.88908443662;2825.1524542637126;2826.222788733115;2844.3031457293096;915.839728047589;923.0677016213606;929.1126973740062;935.9298052646079;937.3813283233034;9749.025097490265;9934.90065099347;9938.403695778205;9946.353487023393;9949.452780097092;3854.6723528500393;4027.3354896442347;4144.171165766858;4212.557681443465;4215.262329092397;8683.739487815375;8689.087645797226;8690.391672582986;8697.826043479221;8698.652053917898;4426.667999900021;4427.734335939789;4429.623482004065;4430.313301438282;4430.712003719748;3421.8118003510044;3534.9469757953652;3987.601239875989;4022.738521996061;4031.8387264509092;3442.862285508602;3537.8231088445473;3614.801185934799;3631.94552081719;3653.908652283661;1150.4765331774022;1175.2067354535654;1178.4402408855724;1180.4510902430238;1196.6589521986193;745.411125211088;760.5930827007525;769.103993847173;781.6091954022988;783.1972228465868;4818.807247710052;4916.729579873141;5002.349694539759;5013.573846223039;5130.9230361544605;795.2762985683;803.048387660624;828.7845160258256;859.3211363023141;866.3372520022189;3079.3687294104657;3134.444648466774;3174.3809957058616;3203.759718021158;3227.177069847174;8951.373403861668;9419.199368053654;9433.339666223299;9445.622175112918;9477.715668529956;9253.953730231306;9278.628854845865;9279.582418791171;9288.535573221312;9306;6537.477001839841;7009.264027277164;7119.572825630479;7257.963710181521;7265.927340726631;4932.323010176558;4965.30485732005;5091.898162036812;5101.591872650253;5118.641695081308;8414.3268538518;8440.66237350499;8442.197991190827;8469.5341756204;8611.6985905493;8366.330693544624;8550.657973680984;8681.348898832739;8706.782330441789;8707.3034157266;5421.566274697936;6144.109104179958;6202.503799696104;6222.160008398808;6254.6247225166635;6199.752009919733;6566.967165164144;6792.796216113326;6799.3200679931615;6984.476164287597;6160.630362178284;6322.683865806784;6414.294427613052;6451.838704032437;6477.838054048687;6193;6223.128761973237;6289.7169627365965;6295.874082518232;6353.237611486466;5744.827655170351;5754.712264386848;5802.4197580241635;5825.563082768725;5825.883482330414;4090.2228576570355;4208.473940757405;4271.209826182167;4303.74177549348;4426.623736982393;4064.166845796664;4096.528899176633;4130.896727581834;4132.214879172948;4241.045764702917 04:45:11 INFO - PROCESS | 13314 | |4;prototype.html;293.5757829935743;297.75881535955864;298.1859523500843;300.8465682501924;302.38615610311075;4729.722974796807;4761.190597598408;4761.190597598408;4770.5467980541835;4789.96426518729;4669.6264298856095;4695.319178719093;4706.435227772664;4712.316714076465;4728.314394412808;3547.7516573839844;3655.488231647558;3685.115572262651;3770.3401904666644;3785.5835858055593;3609.855605775766;3656.8171591420455;3673.5937960635692;3732.216234590739;3748.11919198988;3722.311372396102;3723.9813800931092;3739.046543131498;3742.4386342048774;3763.774173549582;3749.381352076904;3762.2287431076566;3769.283836071151;3776.244046518382;3776.6978641708597;3255.153660048381;3295.2585668224697;3309.7683162178655;3322.3853587086464;3334.616519100286;4627.490975992638;4633.235516139833;4633.443986721615;4638.889305366084;4645.86062418128;4214.5364009959185;4254.851080212208;4262.65898728101;4265.549713097562;4276.572342765729;4709.905801883943;4846.321514987904;4890.608751299887;4901.460839307673;4971.950280497185;3576.3204991051875;3587.2287458196615;3593.317269718771;3610.151614370621;3617.764845285048;5061.190209566488;5122.616893438751;5167;5167.9224811627855;5176.120059589879;3607.2984178777974;3698.0939669780537;3703.666669999713;3706.3143318485627;3712.350338690718;3708.7589306694977;3740.7007439404783;3749.8312575934146;3765.679917207013;3776.0937375030344;4209;4231.449911511484;4238.36424536322;4242.193983143193;4248.532661407243;4901.230804595392;4902.240152776325;4913.901721965541;4916.803327866917;4923.113839508923;1231.655136561764;1284.1396264502805;1290.806379043151;1297.8118172864881;1300.7122948281133;894.4767311122936;899.4108858697564;920.1718453392001;922.7462447826902;928.9349745517749;3872.6127387261613;3896.980515097406;3913.72603917723;4188.895277618023;4321.481422229353;4998.9500104999215;5145.588352931756;5146.922796158061;5148.613853960968;5156.948430515722;4401.427814384109;4422.270325396338;4423.447069116361;4430.269005614102;4434.11317736454;2584.9224523264334;2666.360073582326;2668.6664166979126;2694.151342327161;2704.432069265437;4785.832495862628;4798.904021919612;4799.496052914464;4803.751024733525;4821.035063436032;5219.346457479779;5240.248869343549;5257.842264732064;5260.947390526122;5266.2890509781455;4659.767011649404;4779.378680771478;4796.856094317176;4812.315689508644;4846.854594362246;5104.438511763778;5128.410232823273;5145.125328694206;5148.790034341851;5175.08521846919;5012.348394708664;5052.671576347526;5055.620828437808;5062.215356619729;5077.949220507748;4734.313524538991;4790.520947905182;4791.353167322367;4805.591524720298;4845.3216549683775;3547.4745859280756;3551.2187318790857;3571.321448924696;3583.8208089595937;3597.5503062117236;5139.537441630271;5146.305248791366;5152.587792976478;5159.613029022913;5163.251328557413;4804.567588917014;4899.828506002273;4938.900967088901;4957.652964292465;4978.850634480971;4924.335214745964;4937.876553086202;4956.207006879026;4965.925511117408;4989.151844186569;4875.878103047452;4879.365682461257;4924.975375123101;4928.876778080433;4933.827316044065;4772.49888761675;4928.211486162197;4965.1311020571975;5034.421041580119;5052.964142350883;4623.42207224097;4723.4331880174595;4762.261849413347;4868.3427737255015;4873 04:45:11 INFO - PROCESS | 13314 | |5;yui.html;595.4135176850804;604.295995165632;701.4703898556589;727.1092911183797;746.7423738810111;11577.247478913876;12511.874881251184;12534.122611417204;12561.937190314047;12598;12000.819987700192;12216.755664886698;12216.81674774877;12226.08304377173;12232.755344893098;590.1914377303101;603.5654328883197;721.2174790352474;728.6720975561005;741.7440982860904;742.042764833367;748.6481353763722;749.4416659588614;749.7413392379648;749.7563291930118;791.7308115240817;791.7664289034749;792.6116203060487;792.8850316704074;793.0602236349944;620.3734228429274;637.7640273098983;758.5183408535564;774.5391492062214;785.6386062411269;575.9827205183851;576.5531712922477;576.7231728770172;576.9538436925078;577.0363492966756;11177.552897884076;11191.832122518168;11202.551897924073;11205.887941120647;11235.21353505255;11319.320840749582;11633.302001879829;11811.527538898434;11980.940095299467;12561.937190314082;9515.429074255568;9569.712908612753;11483.311001339946;11596.536138554533;11728.53085876564;3963.663088637469;4016.49793775778;4017.3773065174946;4061.8375264989363;4223.113146239262;55718;56007;56045.75245084556;56843.14735278974;57918.420815791724;9491;9575.521223938775;9691.176250018687;9716.708498745049;9733.853992190123;16659.33362665504;16887.493375198763;16955.660886782196;16962.23669934856;16969.0667013313;6130.264368275835;6276.215473065867;6296.401841825019;6352.968235158794;6431.453326467303;3432.5194472773833;3473.7394695397948;3501.562304711911;3565.16218688608;3595.1371670799344;2572.6269690894715;2666.4533770576986;2668.5596876515547;2676.8260063095836;2677.705452400234;454.8612673134726;460.6015796336212;462.9976850115728;470.83050101963266;473.462619926386;377.9149691319431;409.5822261293464;466.2935652486486;491.5404097169158;499.29848562769365;6827.2831352708245;6861.245263021064;7082.716691332392;7094.9290507094265;7328.816779580553;511.83875095473564;516.630609114485;526.9578433725369;533.8211699080774;554.8418700670289;3130.4521708700886;3211.951820722691;3219.597550306212;3317.767756257087;3320.9833950830093;81462.77805832918;89023;94571;95687;96538.51730741301;83201.58399207966;83365;85140;85640.57179714061;85879.14120858836;77395;77569.61215193888;78201.21798782167;78907;79705.60147199227;6034.24571928509;6067.809645570013;6238.594491358047;6365.8726825464155;6426.967865160645;44137;45654.77172614116;46038.309425359315;47372;48136.27795583139;36515.90452286436;39009.80495097506;40401;60554;63110;8183.3862460316905;8233.259006689426;8242.134575869448;8324.791880203044;8478.321734261368;9291.349605527548;9351.625934962525;9365;9429.811403772022;9475.526223688927;9406.153446189875;9597.136257736836;9659.034096590285;9887.505624718591;10014.148797352307;9547.809043818947;9628.9037109628;9695.951520242636;9743.171830394213;9810.018998100133;8807.339449541181;8910.376273660782;8967;9068.093190680878;9096.408733432305;7593.468457207942;7665.118511371264;7723.34351580122;7753.457257991887;8048.5170889746805;7490.962545187239;7631.3131818136635;7674.923250767644;7718.807029824299;7958.602069896598 04:45:11 INFO - PROCESS | 13314 | __end_tp_report 04:45:11 INFO - PROCESS | 13314 | __start_cc_report 04:45:11 INFO - PROCESS | 13314 | _x_x_mozilla_cycle_collect,2700 04:45:11 INFO - PROCESS | 13314 | __end_cc_report 04:45:11 INFO - PROCESS | 13314 | __startTimestamp1476445511905__endTimestamp 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | ------- Summary: start ------- 04:45:11 INFO - PROCESS | 13314 | Number of tests: 6 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#0] dojo.html Cycles:165 Average:4533.01 Median:4626.44 stddev:466.22 (10.1%) stddev-sans-first:438.30 04:45:11 INFO - PROCESS | 13314 | Values: 2457.5 2513.5 2556.6 2571.6 2584.6 4455.8 4518.6 4526.3 4560.2 4566.8 4532.0 4561.8 4581.8 4589.5 4664.3 4161.3 4171.4 4258.1 4285.1 4294.6 4204.1 4328.5 4358.2 4366.7 4415.0 4231.5 4286.7 4296.0 4298.1 4372.2 4115.0 4164.7 4171.9 4211.2 4261.1 4229.9 4250.5 4266.3 4300.7 4329.9 4566.6 4591.2 4615.8 4630.3 4684.8 4687.3 4711.3 4718.8 4937.3 4939.0 4911.3 4918.2 4962.2 4971.9 5033.2 4608.8 4615.0 4618.1 4631.4 4674.0 4896.4 5068.1 5075.2 5079.6 5132.0 4719.3 4805.9 4806.9 4808.7 4812.6 4815.2 4851.6 4858.7 4858.7 4888.3 4805.5 4813.6 4816.4 4816.7 4816.9 4813.2 4833.2 4852.1 4939.8 4943.3 4197.2 4200.1 4201.0 4246.4 4253.4 3677.9 3689.3 3719.3 3738.9 3782.6 4146.8 4170.4 4192.5 4195.0 4288.0 4863.8 4883.2 4891.6 4941.3 4953.6 4177.5 4178.2 4200.5 4218.5 4249.1 4338.9 4367.4 4379.3 4384.4 4429.1 4600.7 4608.0 4608.2 4610.7 4612.4 4907.6 4908.8 4909.0 4910.3 4922.7 4569.5 4584.6 4601.8 4606.9 4610.7 4873.6 4889.3 4914.3 4918.1 4923.4 4887.4 4925.5 4933.9 4940.8 4988.1 4781.9 4782.6 4791.9 4796.5 4861.4 4597.9 4630.4 4633.7 4681.7 4694.9 4624.1 4626.4 4648.1 4651.0 4651.5 4738.9 4740.7 4787.1 4799.8 4833.5 4736.1 4736.2 4780.3 4796.5 4797.6 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#1] ext.html Cycles:180 Average:42854.03 Median:193503.65 stddev:73531.59 (38.0%) stddev-sans-first:73669.33 04:45:11 INFO - PROCESS | 13314 | Values: 568.8 575.5 585.7 589.7 591.0 27198.2 37551.1 38080.4 38198.6 41935.8 38605.0 39016.8 39039.0 39065.8 39097.6 7606.4 7739.2 7752.7 7756.1 7758.2 7040.9 7219.9 9772.0 10038.7 10041.4 10102.9 10201.5 10203.6 10203.6 10210.7 9787.5 9860.6 9885.7 9887.7 9892.5 9844.3 9902.4 9909.4 9912.2 9915.5 35598.8 36094.5 36117.0 36122.8 36161.8 2839.4 2930.6 2967.1 3029.8 3175.6 27000.7 27578.9 27706.3 27757.7 30854.2 3244.3 3251.1 3330.3 3349.7 3359.0 245362.0 247134.0 247531.8 248064.0 248450.0 28760.7 53486.0 54014.7 54033.0 54035.7 30437.0 31619.5 31737.0 31919.0 31922.2 12768.9 12951.7 12954.0 12955.1 12957.9 9429.5 9624.4 10994.0 11108.2 11125.3 7359.4 7412.3 7420.6 7514.7 7750.6 3104.5 3133.6 3140.6 3142.6 3160.8 843.5 856.7 872.0 891.8 947.9 26308.5 27485.0 28028.7 28099.7 28275.2 952.7 961.5 975.7 976.6 1012.4 14401.5 14973.9 15230.1 15765.5 16306.9 342180.0 348834.0 350033.0 350832.0 351803.0 49513.3 50376.5 50567.2 50643.2 50691.5 1076.1 1126.3 1174.7 1187.5 1212.9 25443.0 28396.3 28803.7 29078.6 29394.0 41529.8 42105.6 42164.4 42167.6 42253.4 228768.0 230186.0 230413.0 230449.0 230830.0 36656.6 37763.0 38258.0 40143.4 40516.8 40239.0 40540.6 41019.8 41366.6 41524.0 35018.3 35204.3 35241.0 35739.0 35811.5 35292.3 35400.5 35515.5 35802.8 35984.3 34497.7 35137.6 35229.8 35446.0 35758.5 30082.2 31919.7 32259.4 32427.8 32472.0 24507.6 24582.2 24634.9 24962.4 25241.9 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#2] jquery.html Cycles:180 Average:23331.43 Median:26080.89 stddev:63284.63 (242.6%) stddev-sans-first:63438.63 04:45:11 INFO - PROCESS | 13314 | Values: 347.3 354.9 376.9 382.1 390.9 12073.2 12136.7 12773.4 13150.4 17032.7 15948.1 16036.4 16287.7 16396.0 16482.3 4817.8 4845.5 4959.9 5023.2 5023.4 3560.8 4894.5 4967.5 4969.4 4969.7 3738.0 5465.5 5718.4 5741.9 5842.9 5525.5 5700.4 5818.7 5820.6 5826.9 5076.0 5077.3 5080.6 5081.1 5081.9 18826.5 19223.4 19366.8 19391.1 19584.0 1853.3 1897.3 1907.0 1918.2 2157.5 12105.9 12462.4 12488.7 12766.6 12894.4 1623.1 1638.2 1679.6 1690.4 1716.6 44455.8 69167.4 70498.6 70538.6 73582.6 7820.8 8325.3 8359.3 8366.7 9255.9 11642.9 11717.9 11721.2 11728.2 11729.0 6577.3 6606.5 6738.7 6811.3 6941.9 6552.1 6715.7 6760.1 6922.8 7017.8 3533.6 3636.1 3638.5 3725.3 3730.2 1779.9 1819.8 1820.1 1824.4 1869.6 782.3 799.1 807.5 829.9 875.9 15887.2 15980.1 16152.4 16346.3 16894.6 822.7 848.4 855.3 864.7 911.5 8866.6 9087.7 9319.5 9436.3 9476.8 378883.0 382942.0 383350.0 384786.0 388760.0 46425.9 47344.0 75890.0 81942.6 82585.0 878.1 893.9 897.3 900.5 944.9 15003.2 15056.2 15533.7 15864.0 15970.1 32876.7 35221.6 37184.8 38224.2 39447.8 49913.5 50486.0 50545.2 50668.5 52725.5 5294.0 6675.0 7195.7 7511.0 7574.2 8334.4 11198.6 11571.5 11747.9 11831.5 10117.0 10255.9 10322.5 10392.7 10473.1 9842.4 9929.3 10004.9 10252.9 10290.4 9209.2 9741.5 9894.0 10246.8 10638.5 6209.5 6587.8 6658.7 6966.4 7078.3 4699.9 4884.9 7753.8 9780.3 10584.4 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#3] mootools.html Cycles:180 Average:4861.02 Median:5583.20 stddev:2725.82 (48.8%) stddev-sans-first:2719.71 04:45:11 INFO - PROCESS | 13314 | Values: 1217.0 1344.0 1378.3 1407.4 1686.7 6288.4 7239.7 7514.1 7556.5 7572.5 7309.9 7499.4 7613.1 7615.2 7622.7 2083.3 2129.6 2129.8 2131.1 2132.3 2093.9 2143.7 2155.2 2158.9 2160.1 2100.0 2102.1 2116.7 2119.5 2160.4 2042.8 2049.0 2053.0 2055.4 2058.4 1923.2 2056.9 2057.5 2065.1 2066.0 7418.7 7420.0 7550.7 7556.0 7560.3 4295.3 4434.3 4436.4 4439.6 4446.3 2661.6 2772.9 2825.2 2826.2 2844.3 915.8 923.1 929.1 935.9 937.4 9749.0 9934.9 9938.4 9946.4 9949.5 3854.7 4027.3 4144.2 4212.6 4215.3 8683.7 8689.1 8690.4 8697.8 8698.7 4426.7 4427.7 4429.6 4430.3 4430.7 3421.8 3534.9 3987.6 4022.7 4031.8 3442.9 3537.8 3614.8 3631.9 3653.9 1150.5 1175.2 1178.4 1180.5 1196.7 745.4 760.6 769.1 781.6 783.2 4818.8 4916.7 5002.3 5013.6 5130.9 795.3 803.0 828.8 859.3 866.3 3079.4 3134.4 3174.4 3203.8 3227.2 8951.4 9419.2 9433.3 9445.6 9477.7 9254.0 9278.6 9279.6 9288.5 9306.0 6537.5 7009.3 7119.6 7258.0 7265.9 4932.3 4965.3 5091.9 5101.6 5118.6 8414.3 8440.7 8442.2 8469.5 8611.7 8366.3 8550.7 8681.3 8706.8 8707.3 5421.6 6144.1 6202.5 6222.2 6254.6 6199.8 6567.0 6792.8 6799.3 6984.5 6160.6 6322.7 6414.3 6451.8 6477.8 6193.0 6223.1 6289.7 6295.9 6353.2 5744.8 5754.7 5802.4 5825.6 5825.9 4090.2 4208.5 4271.2 4303.7 4426.6 4064.2 4096.5 4130.9 4132.2 4241.0 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#4] prototype.html Cycles:180 Average:4124.76 Median:4711.11 stddev:1186.63 (25.2%) stddev-sans-first:1154.59 04:45:11 INFO - PROCESS | 13314 | Values: 293.6 297.8 298.2 300.8 302.4 4729.7 4761.2 4761.2 4770.5 4790.0 4669.6 4695.3 4706.4 4712.3 4728.3 3547.8 3655.5 3685.1 3770.3 3785.6 3609.9 3656.8 3673.6 3732.2 3748.1 3722.3 3724.0 3739.0 3742.4 3763.8 3749.4 3762.2 3769.3 3776.2 3776.7 3255.2 3295.3 3309.8 3322.4 3334.6 4627.5 4633.2 4633.4 4638.9 4645.9 4214.5 4254.9 4262.7 4265.5 4276.6 4709.9 4846.3 4890.6 4901.5 4972.0 3576.3 3587.2 3593.3 3610.2 3617.8 5061.2 5122.6 5167.0 5167.9 5176.1 3607.3 3698.1 3703.7 3706.3 3712.4 3708.8 3740.7 3749.8 3765.7 3776.1 4209.0 4231.4 4238.4 4242.2 4248.5 4901.2 4902.2 4913.9 4916.8 4923.1 1231.7 1284.1 1290.8 1297.8 1300.7 894.5 899.4 920.2 922.7 928.9 3872.6 3897.0 3913.7 4188.9 4321.5 4999.0 5145.6 5146.9 5148.6 5156.9 4401.4 4422.3 4423.4 4430.3 4434.1 2584.9 2666.4 2668.7 2694.2 2704.4 4785.8 4798.9 4799.5 4803.8 4821.0 5219.3 5240.2 5257.8 5260.9 5266.3 4659.8 4779.4 4796.9 4812.3 4846.9 5104.4 5128.4 5145.1 5148.8 5175.1 5012.3 5052.7 5055.6 5062.2 5077.9 4734.3 4790.5 4791.4 4805.6 4845.3 3547.5 3551.2 3571.3 3583.8 3597.6 5139.5 5146.3 5152.6 5159.6 5163.3 4804.6 4899.8 4938.9 4957.7 4978.9 4924.3 4937.9 4956.2 4965.9 4989.2 4875.9 4879.4 4925.0 4928.9 4933.8 4772.5 4928.2 4965.1 5034.4 5053.0 4623.4 4723.4 4762.3 4868.3 4873.0 04:45:11 INFO - PROCESS | 13314 | 04:45:11 INFO - PROCESS | 13314 | [#5] yui.html Cycles:180 Average:16394.53 Median:3429.48 stddev:24549.57 (715.8%) stddev-sans-first:24589.78 04:45:11 INFO - PROCESS | 13314 | Values: 595.4 604.3 701.5 727.1 746.7 11577.2 12511.9 12534.1 12561.9 12598.0 12000.8 12216.8 12216.8 12226.1 12232.8 590.2 603.6 721.2 728.7 741.7 742.0 748.6 749.4 749.7 749.8 791.7 791.8 792.6 792.9 793.1 620.4 637.8 758.5 774.5 785.6 576.0 576.6 576.7 577.0 577.0 11177.6 11191.8 11202.6 11205.9 11235.2 11319.3 11633.3 11811.5 11980.9 12561.9 9515.4 9569.7 11483.3 11596.5 11728.5 3963.7 4016.5 4017.4 4061.8 4223.1 55718.0 56007.0 56045.8 56843.1 57918.4 9491.0 9575.5 9691.2 9716.7 9733.9 16659.3 16887.5 16955.7 16962.2 16969.1 6130.3 6276.2 6296.4 6353.0 6431.5 3432.5 3473.7 3501.6 3565.2 3595.1 2572.6 2666.5 2668.6 2676.8 2677.7 454.9 460.6 463.0 470.8 473.5 377.9 409.6 466.3 491.5 499.3 6827.3 6861.2 7082.7 7094.9 7328.8 511.8 516.6 527.0 533.8 554.8 3130.5 3212.0 3219.6 3317.8 3321.0 81462.8 89023.0 94571.0 95687.0 96538.5 83201.6 83365.0 85140.0 85640.6 85879.1 77395.0 77569.6 78201.2 78907.0 79705.6 6034.2 6067.8 6238.6 6365.9 6427.0 44137.0 45654.8 46038.3 47372.0 48136.3 36515.9 39009.8 40401.0 60554.0 63110.0 8183.4 8233.3 8242.1 8324.8 8478.3 9291.3 9351.6 9365.0 9429.8 9475.5 9406.2 9597.1 9659.0 9887.5 10014.1 9547.8 9628.9 9696.0 9743.2 9810.0 8807.3 8910.4 8967.0 9068.1 9096.4 7593.5 7665.1 7723.3 7753.5 8048.5 7491.0 7631.3 7674.9 7718.8 7958.6 04:45:11 INFO - PROCESS | 13314 | -------- Summary: end -------- 04:45:11 INFO - PROCESS | 13314 | 04:45:12 INFO - TEST-INFO | 13314: exit 0 04:45:12 INFO - TEST-OK | dromaeo_css | took 1121724ms 04:45:12 INFO - TEST-START | kraken 04:45:12 INFO - operating with platform_type : linux_ 04:45:12 INFO - Initialising browser for kraken test... 04:45:12 INFO - TEST-INFO | started process 13620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3WuQtt/profile http://localhost:57277/getInfo.html) 04:45:17 INFO - PROCESS | 13620 | __metrics Screen width/height:1600/1200 04:45:17 INFO - PROCESS | 13620 | colorDepth:24 04:45:17 INFO - PROCESS | 13620 | Browser inner width/height: 1024/697 04:45:17 INFO - PROCESS | 13620 | __metrics 04:45:17 INFO - PROCESS | 13620 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:17 INFO - PROCESS | 13620 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:18 INFO - PROCESS | 13620 | console.error: PushService: 04:45:18 INFO - PROCESS | 13620 | stateChangeProcessEnqueue: Error transitioning state 04:45:18 INFO - PROCESS | 13620 | UnknownError 04:45:18 INFO - TEST-INFO | 13620: exit 0 04:45:18 INFO - Browser initialized. 04:45:18 INFO - Running cycle 1/1 for kraken test... 04:45:18 INFO - TEST-INFO | started process 13702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3WuQtt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:31 INFO - PROCESS | 13702 | RSS: Main: 174854144 04:45:31 INFO - PROCESS | 13702 | 04:45:33 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57277/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:34 INFO - PROCESS | 13702 | RSS: Main: 237314048 04:45:34 INFO - PROCESS | 13702 | 04:45:37 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57277/tests/kraken/driver.html?testName=audio-dft) 04:45:38 INFO - PROCESS | 13702 | RSS: Main: 219111424 04:45:38 INFO - PROCESS | 13702 | 04:45:41 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57277/tests/kraken/driver.html?testName=audio-fft) 04:45:42 INFO - PROCESS | 13702 | RSS: Main: 300560384 04:45:42 INFO - PROCESS | 13702 | 04:45:44 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57277/tests/kraken/driver.html?testName=audio-oscillator) 04:45:45 INFO - PROCESS | 13702 | RSS: Main: 211816448 04:45:45 INFO - PROCESS | 13702 | 04:45:47 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:47 INFO - PROCESS | 13702 | RSS: Main: 214167552 04:45:47 INFO - PROCESS | 13702 | 04:45:51 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57277/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:51 INFO - PROCESS | 13702 | RSS: Main: 250101760 04:45:51 INFO - PROCESS | 13702 | 04:45:55 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57277/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:55 INFO - PROCESS | 13702 | RSS: Main: 249487360 04:45:55 INFO - PROCESS | 13702 | 04:45:58 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57277/tests/kraken/driver.html?testName=json-parse-financial) 04:45:59 INFO - PROCESS | 13702 | RSS: Main: 249454592 04:45:59 INFO - PROCESS | 13702 | 04:46:00 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:01 INFO - PROCESS | 13702 | RSS: Main: 211537920 04:46:01 INFO - PROCESS | 13702 | 04:46:03 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:04 INFO - PROCESS | 13702 | RSS: Main: 219668480 04:46:04 INFO - PROCESS | 13702 | 04:46:06 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:06 INFO - PROCESS | 13702 | RSS: Main: 228081664 04:46:06 INFO - PROCESS | 13702 | 04:46:09 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:10 INFO - PROCESS | 13702 | RSS: Main: 236404736 04:46:10 INFO - PROCESS | 13702 | 04:46:13 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:14 INFO - PROCESS | 13702 | RSS: Main: 232992768 04:46:14 INFO - PROCESS | 13702 | 04:46:15 INFO - PROCESS | 13702 | Cycle 1(1): loaded http://localhost:57277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57277/tests/kraken/driver.html?testName=ai-astar) 04:46:16 INFO - PROCESS | 13702 | RSS: Main: 284073984 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | __start_tp_report 04:46:16 INFO - PROCESS | 13702 | _x_x_mozilla_page_load 04:46:16 INFO - PROCESS | 13702 | _x_x_mozilla_page_load_details 04:46:16 INFO - PROCESS | 13702 | |i|pagename|runs| 04:46:16 INFO - PROCESS | 13702 | |0;ai-astar;111;114;113;115;112;116;114;114;115;115 04:46:16 INFO - PROCESS | 13702 | |1;audio-beat-detection;149;128;130;168;130;130;131;126;164;130 04:46:16 INFO - PROCESS | 13702 | |2;audio-dft;169;163;163;164;164;162;164;163;163;162 04:46:16 INFO - PROCESS | 13702 | |3;audio-fft;77;75;75;119;77;78;77;77;101;77 04:46:16 INFO - PROCESS | 13702 | |4;audio-oscillator;85;83;124;84;83;82;107;83;83;120 04:46:16 INFO - PROCESS | 13702 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;117;117;117 04:46:16 INFO - PROCESS | 13702 | |6;imaging-darkroom;145;146;146;146;146;146;146;147;146;145 04:46:16 INFO - PROCESS | 13702 | |7;imaging-desaturate;95;95;94;95;95;95;96;95;94;95 04:46:16 INFO - PROCESS | 13702 | |8;json-parse-financial;65;64;64;64;66;65;66;66;66;65 04:46:16 INFO - PROCESS | 13702 | |9;json-stringify-tinderbox;66;67;65;66;67;67;66;66;67;67 04:46:16 INFO - PROCESS | 13702 | |10;stanford-crypto-aes;93;83;90;84;82;82;83;82;92;83 04:46:16 INFO - PROCESS | 13702 | |11;stanford-crypto-ccm;149;150;140;144;143;140;141;151;186;146 04:46:16 INFO - PROCESS | 13702 | |12;stanford-crypto-pbkdf2;172;177;173;177;172;178;173;174;173;172 04:46:16 INFO - PROCESS | 13702 | |13;stanford-crypto-sha256-iterative;70;69;69;69;70;70;75;69;69;68 04:46:16 INFO - PROCESS | 13702 | __end_tp_report 04:46:16 INFO - PROCESS | 13702 | __start_cc_report 04:46:16 INFO - PROCESS | 13702 | _x_x_mozilla_cycle_collect,1994 04:46:16 INFO - PROCESS | 13702 | __end_cc_report 04:46:16 INFO - PROCESS | 13702 | __startTimestamp1476445576134__endTimestamp 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | ------- Summary: start ------- 04:46:16 INFO - PROCESS | 13702 | Number of tests: 14 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.52 (1.3%) stddev-sans-first:1.20 04:46:16 INFO - PROCESS | 13702 | Values: 111.0 114.0 113.0 115.0 112.0 116.0 114.0 114.0 115.0 115.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:130.50 stddev:15.78 (12.1%) stddev-sans-first:16.29 04:46:16 INFO - PROCESS | 13702 | Values: 149.0 128.0 130.0 168.0 130.0 130.0 131.0 126.0 164.0 130.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.00 (1.2%) stddev-sans-first:0.78 04:46:16 INFO - PROCESS | 13702 | Values: 169.0 163.0 163.0 164.0 164.0 162.0 164.0 163.0 163.0 162.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:14.73 (19.1%) stddev-sans-first:15.44 04:46:16 INFO - PROCESS | 13702 | Values: 77.0 75.0 75.0 119.0 77.0 78.0 77.0 77.0 101.0 77.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.00 stddev:16.83 (20.3%) stddev-sans-first:17.58 04:46:16 INFO - PROCESS | 13702 | Values: 85.0 83.0 124.0 84.0 83.0 82.0 107.0 83.0 83.0 120.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:46:16 INFO - PROCESS | 13702 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 04:46:16 INFO - PROCESS | 13702 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:46:16 INFO - PROCESS | 13702 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 04:46:16 INFO - PROCESS | 13702 | Values: 65.0 64.0 64.0 64.0 66.0 65.0 66.0 66.0 66.0 65.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 04:46:16 INFO - PROCESS | 13702 | Values: 66.0 67.0 65.0 66.0 67.0 67.0 66.0 66.0 67.0 67.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:83.50 stddev:4.43 (5.3%) stddev-sans-first:3.75 04:46:16 INFO - PROCESS | 13702 | Values: 93.0 83.0 90.0 84.0 82.0 82.0 83.0 82.0 92.0 83.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:147.50 stddev:13.62 (9.2%) stddev-sans-first:14.45 04:46:16 INFO - PROCESS | 13702 | Values: 149.0 150.0 140.0 144.0 143.0 140.0 141.0 151.0 186.0 146.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:173.50 stddev:2.33 (1.3%) stddev-sans-first:2.35 04:46:16 INFO - PROCESS | 13702 | Values: 172.0 177.0 173.0 177.0 172.0 178.0 173.0 174.0 173.0 172.0 04:46:16 INFO - PROCESS | 13702 | 04:46:16 INFO - PROCESS | 13702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.93 (2.8%) stddev-sans-first:2.05 04:46:16 INFO - PROCESS | 13702 | Values: 70.0 69.0 69.0 69.0 70.0 70.0 75.0 69.0 69.0 68.0 04:46:16 INFO - PROCESS | 13702 | -------- Summary: end -------- 04:46:16 INFO - PROCESS | 13702 | 04:46:17 INFO - TEST-INFO | 13702: exit 0 04:46:17 INFO - TEST-OK | kraken | took 64438ms 04:46:17 INFO - SUITE-END | took 1186s 04:46:17 INFO - Completed test suite (00:19:46) 04:46:17 INFO - javascript benchmark 04:46:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2457.5330687169435, 2513.534996025734, 2556.6165075238714, 2571.6142578613208, 2584.5864661654127, 4455.821767129319, 4518.638508919287, 4526.253168227243, 4560.201964656184, 4566.7716614169285, 4532.048269863332, 4561.771911404425, 4581.770911454422, 4589.472210695771, 4664.2770370592525, 4161.292580261363, 4171.374293855931, 4258.148370325947, 4285.078708077763, 4294.634956028742, 4204.096119334343, 4328.523862375137, 4358.193734159175, 4366.737995720251, 4415.0, 4231.4710661167355, 4286.742795432268, 4296.0, 4298.075913678543, 4372.234858899696, 4114.979425102855, 4164.68764842638, 4171.91656166878, 4211.178820130076, 4261.062566235423, 4229.851955181584, 4250.489941207075, 4266.317389217741, 4300.720453170534, 4329.913401731979, 4566.566176213254, 4591.1965406053805, 4615.838445654386, 4630.328602352673, 4684.836030738942, 4687.250039993619, 4711.293306004127, 4718.787654555554, 4937.333459982892, 4938.975305123451, 4911.312416261726, 4918.163912134945, 4962.156433406293, 4971.900561988776, 5033.169527028036, 4608.769561521911, 4615.0, 4618.053299073716, 4631.374764406829, 4674.0, 4896.436909755424, 5068.087744206078, 5075.187969924795, 5079.619028572872, 5132.0, 4719.339292499053, 4805.879853003703, 4806.903861922812, 4808.735519546389, 4812.614990800797, 4815.181419158752, 4851.56335929768, 4858.684185527929, 4858.708477491291, 4888.340074089952, 4805.471398146271, 4813.566778989838, 4816.373871396696, 4816.735079570657, 4816.8554943351755, 4813.205821039489, 4833.154198015333, 4852.078105160008, 4939.827106051271, 4943.307936888838, 4197.24449599069, 4200.096979149436, 4200.957990420118, 4246.40550322955, 4253.425787518645, 3677.9264414711556, 3689.262147570497, 3719.27474142545, 3738.887833365003, 3782.6406491383823, 4146.813393397304, 4170.416141740159, 4192.45498085247, 4194.993201631586, 4287.957120428819, 4863.756812159449, 4883.169861123618, 4891.55975962158, 4941.283513890466, 4953.628477864175, 4177.498700156001, 4178.22702799983, 4200.474940632421, 4218.493780746268, 4249.128928569636, 4338.869833904988, 4367.432233809648, 4379.321205213197, 4384.364267181241, 4429.136318417942, 4600.746958917158, 4608.0, 4608.193566125848, 4610.654200934876, 4612.400387949545, 4907.55831975124, 4908.7545622719435, 4908.950910490849, 4910.337104490848, 4922.72924989129, 4569.520200378913, 4584.587387135174, 4601.838935637236, 4606.88482787933, 4610.700304480198, 4873.610111191026, 4889.315495830516, 4914.336564563881, 4918.0901533216465, 4923.433805112458, 4887.43794463627, 4925.482824303396, 4933.925991110208, 4940.802367905244, 4988.12707776145, 4781.880452988564, 4782.6173906088125, 4791.904161916812, 4796.496367881322, 4861.392325959255, 4597.862064138081, 4630.3517507548295, 4633.698809577501, 4681.7190968540635, 4694.929576056294, 4624.121416930772, 4626.444826620827, 4648.093621743727, 4651.023285110165, 4651.534846515321, 4738.905221895474, 4740.6681532292405, 4787.114383839001, 4799.784009719641, 4833.516648335279, 4736.123817093849, 4736.19484687597, 4780.330753694555, 4796.496367881322, 4797.64017698681], "value": 4503.4325642913045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7895478672891, 575.4590684756326, 585.7364186116247, 589.7198830555486, 590.958632895697, 27198.184054478374, 37551.11426600414, 38080.42879356812, 38198.618013819854, 41935.79032104843, 38605.0, 39016.80491597538, 39039.0, 39065.804670976606, 39097.609023909754, 7606.42951778616, 7739.226077392272, 7752.689892404297, 7756.069271687377, 7758.224177582225, 7040.859182816366, 7219.927800721978, 9771.951140244324, 10038.698839034803, 10041.397516149018, 10102.949485252564, 10201.489925503733, 10203.591856325738, 10203.591856325775, 10210.693679189637, 9787.46168960707, 9860.60557577696, 9885.654002109963, 9887.703368898945, 9892.455914924676, 9844.261680374, 9902.405855648683, 9909.355891867006, 9912.157466615346, 9915.454649994248, 35598.82200589006, 36094.458583121275, 36117.0, 36122.819385902905, 36161.81919090414, 2839.3895312507702, 2930.648322201328, 2967.0653744070764, 3029.833359165245, 3175.555422240888, 27000.729992700017, 27578.862105689543, 27706.307342316402, 27757.722422775714, 30854.228644284074, 3244.3186930744573, 3251.089694885436, 3330.333933213367, 3349.732021438279, 3358.983205083983, 245362.0, 247134.0, 247531.76234118894, 248064.0, 248450.0, 28760.6858971156, 53486.0, 54014.72992635012, 54033.0, 54035.72982135143, 30437.0, 31619.52570711441, 31737.0, 31919.042428727174, 31922.20194495156, 12768.893132633197, 12951.676208094874, 12954.0, 12955.093143479866, 12957.935210323889, 9429.528523573794, 9624.37441566296, 10994.0, 11108.222424430212, 11125.276857004268, 7359.411247100219, 7412.2587741226525, 7420.591867447342, 7514.736984205527, 7750.612469376509, 3104.472239719253, 3133.6239651242, 3140.5760222370145, 3142.5757522734593, 3160.826154561521, 843.5107637570195, 856.734412332179, 871.9607617657093, 891.826093911681, 947.9194268487117, 26308.473830523282, 27485.0, 28028.71971280261, 28099.71900280971, 28275.15174544767, 952.7141857442878, 961.5144352102144, 975.6536429567543, 976.6484065736329, 1012.3622118065572, 14401.495947641783, 14973.850261497464, 15230.086194828345, 15765.527034188992, 16306.918465407596, 342180.0, 348834.0, 350033.0, 350832.0, 351803.0, 49513.25730114051, 50376.49623503718, 50567.24149137766, 50643.24035139476, 50691.493085069415, 1076.101455284846, 1126.2735535579504, 1174.712195512105, 1187.5012494752225, 1212.921160124589, 25443.0, 28396.290092747848, 28803.711962880105, 29078.56382154227, 29394.0, 41529.79235103805, 42105.57894421139, 42164.36753448762, 42167.57832421637, 42253.36619950765, 228768.0, 230186.0, 230413.0, 230449.0, 230830.0, 36656.63343366532, 37763.0, 38258.0, 40143.3978490317, 40516.79741601391, 40239.0, 40540.59459405486, 41019.7949010265, 41366.58633413627, 41524.0, 35018.299634007686, 35204.29591408209, 35241.0, 35739.0, 35811.462828058124, 35292.29415411626, 35400.46899296461, 35515.46726799048, 35802.820985894905, 35984.28031439409, 34497.65502344944, 35137.64862351446, 35229.82385088058, 35446.0, 35758.46362304516, 30082.24794380158, 31919.6808031926, 32259.35481290314, 32427.837860810545, 32472.0, 24507.63238551459, 24582.153257011134, 24634.904246130176, 24962.37594060163, 25241.87379063093], "value": 16559.225932925707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.29152528841166, 354.9414346632806, 376.8831662184722, 382.08871840660026, 390.91009067914376, 12073.154879158463, 12136.69658258544, 12773.425195866184, 13150.408231629564, 17032.744508832347, 15948.122853243067, 16036.35854565816, 16287.674246515062, 16396.0, 16482.34070637176, 4817.783199756011, 4845.515448455161, 4959.876003099916, 5023.221400682882, 5023.422306434771, 3560.8041557714314, 4894.486078961693, 4967.453580106186, 4969.4036715594, 4969.652124351297, 3737.9626203737885, 5465.535429488498, 5718.370979192286, 5741.942580574203, 5842.912356314659, 5525.502704756591, 5700.429957004308, 5818.650880947157, 5820.592558520905, 5826.912596311059, 5075.974620126913, 5077.2637967494875, 5080.61895357846, 5081.110805609003, 5081.923771143436, 18826.529336766554, 19223.423297301102, 19366.806331936783, 19391.12739926707, 19584.0, 1853.33280019193, 1897.2505860185288, 1906.9713954290696, 1918.213532451688, 2157.471419502216, 12105.939470302592, 12462.376881155906, 12488.687782805411, 12766.553170639076, 12894.35528223585, 1623.1154021058433, 1638.189096397279, 1679.5885008173075, 1690.433704708924, 1716.6137619035742, 44455.77772111151, 69167.42909423597, 70498.64750676265, 70538.64730676365, 73582.63208683922, 7820.804479888048, 8325.25072743456, 8359.331253499706, 8366.748997530083, 9255.861162082574, 11642.88357116418, 11717.945384915398, 11721.179517433698, 11728.179027467995, 11729.003034741972, 6577.309382514863, 6606.537542372084, 6738.707098255192, 6811.318868113149, 6941.930580694229, 6552.115464412339, 6715.6977935993, 6760.121184246115, 6922.826929326707, 7017.754378596725, 3533.5936367318086, 3636.109153257416, 3638.472421498868, 3725.3294407006997, 3730.1607138393642, 1779.8932064076198, 1819.8180181981695, 1820.062667726122, 1824.4253060285967, 1869.6260747850213, 782.2568559868148, 799.0890384961149, 807.4670717326536, 829.8962629671291, 875.92992560595, 15887.205639717968, 15980.121093339978, 16152.434664786912, 16346.34614615426, 16894.57763555921, 822.7202751064667, 848.3722045686147, 855.341387131905, 864.6671031652859, 911.48956584313, 8866.601002954754, 9087.681931132378, 9319.487428191514, 9436.339456237998, 9476.763080923032, 378883.0, 382942.0, 383350.0, 384786.0, 388760.0, 46425.899137027714, 47344.0, 75890.0, 81942.59028704818, 82585.0, 878.0999475537625, 893.946363218209, 897.2507955856802, 900.4552245891273, 944.8866136063716, 15003.2498375083, 15056.247187640354, 15533.689326213638, 15864.0, 15970.121643309265, 32876.67123328736, 35221.64778352184, 37184.81407592945, 38224.23551529009, 39447.802760986015, 49913.500864990885, 50486.0, 50545.24182137197, 50668.49331506638, 52725.472745272054, 5294.0, 6674.965380366051, 7195.6761945713615, 7511.0, 7574.204708505748, 8334.416590838584, 11198.60804871858, 11571.479283432434, 11747.941260293645, 11831.46758395857, 10117.0, 10255.94872025635, 10322.535485903303, 10392.740181495523, 10473.057424831803, 9842.409455432697, 9929.304948653813, 10004.899951000396, 10252.948735256276, 10290.434026128634, 9209.17117459405, 9741.464219467998, 9894.0, 10246.795064098826, 10638.521266543179, 6209.5032397409, 6587.835304117435, 6658.7336506539195, 6966.3730264276455, 7078.292170782881, 4699.859004229878, 4884.877878053077, 7753.806154846174, 9780.288449521448, 10584.364938103738], "value": 7788.8043843287705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.03245919494, 1343.952961646342, 1378.338397569167, 1407.3737186951805, 1686.7216909209988, 6288.371162883709, 7239.710411583537, 7514.0607424071995, 7556.47104702671, 7572.469927105098, 7309.926900730991, 7499.4000479961605, 7613.086429628453, 7615.238476152382, 7622.65698043588, 2083.2812679625504, 2129.6379615465407, 2129.808317251455, 2131.0729832522825, 2132.32831658028, 2093.884836334001, 2143.6677315016195, 2155.245664017597, 2158.9352319430363, 2160.114353115223, 2099.9685004724943, 2102.0750869617395, 2116.7459904811444, 2119.5231073008604, 2160.3734916874087, 2042.765082015565, 2048.98975505123, 2052.9794702052936, 2055.3628375203734, 2058.372196480073, 1923.2307077169244, 2056.9280075197444, 2057.4753437873246, 2065.0913598016823, 2065.9690104648444, 7418.666160022812, 7420.0, 7550.735724249625, 7555.962220188919, 7560.31957123856, 4295.334223195409, 4434.268345722952, 4436.356728274414, 4439.578240067189, 4446.266366049598, 2661.5874539446418, 2772.88908443662, 2825.1524542637126, 2826.222788733115, 2844.3031457293096, 915.839728047589, 923.0677016213606, 929.1126973740062, 935.9298052646079, 937.3813283233034, 9749.025097490265, 9934.90065099347, 9938.403695778205, 9946.353487023393, 9949.452780097092, 3854.6723528500393, 4027.3354896442347, 4144.171165766858, 4212.557681443465, 4215.262329092397, 8683.739487815375, 8689.087645797226, 8690.391672582986, 8697.826043479221, 8698.652053917898, 4426.667999900021, 4427.734335939789, 4429.623482004065, 4430.313301438282, 4430.712003719748, 3421.8118003510044, 3534.9469757953652, 3987.601239875989, 4022.738521996061, 4031.8387264509092, 3442.862285508602, 3537.8231088445473, 3614.801185934799, 3631.94552081719, 3653.908652283661, 1150.4765331774022, 1175.2067354535654, 1178.4402408855724, 1180.4510902430238, 1196.6589521986193, 745.411125211088, 760.5930827007525, 769.103993847173, 781.6091954022988, 783.1972228465868, 4818.807247710052, 4916.729579873141, 5002.349694539759, 5013.573846223039, 5130.9230361544605, 795.2762985683, 803.048387660624, 828.7845160258256, 859.3211363023141, 866.3372520022189, 3079.3687294104657, 3134.444648466774, 3174.3809957058616, 3203.759718021158, 3227.177069847174, 8951.373403861668, 9419.199368053654, 9433.339666223299, 9445.622175112918, 9477.715668529956, 9253.953730231306, 9278.628854845865, 9279.582418791171, 9288.535573221312, 9306.0, 6537.477001839841, 7009.264027277164, 7119.572825630479, 7257.963710181521, 7265.927340726631, 4932.323010176558, 4965.30485732005, 5091.898162036812, 5101.591872650253, 5118.641695081308, 8414.3268538518, 8440.66237350499, 8442.197991190827, 8469.5341756204, 8611.6985905493, 8366.330693544624, 8550.657973680984, 8681.348898832739, 8706.782330441789, 8707.3034157266, 5421.566274697936, 6144.109104179958, 6202.503799696104, 6222.160008398808, 6254.6247225166635, 6199.752009919733, 6566.967165164144, 6792.796216113326, 6799.3200679931615, 6984.476164287597, 6160.630362178284, 6322.683865806784, 6414.294427613052, 6451.838704032437, 6477.838054048687, 6193.0, 6223.128761973237, 6289.7169627365965, 6295.874082518232, 6353.237611486466, 5744.827655170351, 5754.712264386848, 5802.4197580241635, 5825.563082768725, 5825.883482330414, 4090.2228576570355, 4208.473940757405, 4271.209826182167, 4303.74177549348, 4426.623736982393, 4064.166845796664, 4096.528899176633, 4130.896727581834, 4132.214879172948, 4241.045764702917], "value": 3927.2611112138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5757829935743, 297.75881535955864, 298.1859523500843, 300.8465682501924, 302.38615610311075, 4729.722974796807, 4761.190597598408, 4761.190597598408, 4770.5467980541835, 4789.96426518729, 4669.6264298856095, 4695.319178719093, 4706.435227772664, 4712.316714076465, 4728.314394412808, 3547.7516573839844, 3655.488231647558, 3685.115572262651, 3770.3401904666644, 3785.5835858055593, 3609.855605775766, 3656.8171591420455, 3673.5937960635692, 3732.216234590739, 3748.11919198988, 3722.311372396102, 3723.9813800931092, 3739.046543131498, 3742.4386342048774, 3763.774173549582, 3749.381352076904, 3762.2287431076566, 3769.283836071151, 3776.244046518382, 3776.6978641708597, 3255.153660048381, 3295.2585668224697, 3309.7683162178655, 3322.3853587086464, 3334.616519100286, 4627.490975992638, 4633.235516139833, 4633.443986721615, 4638.889305366084, 4645.86062418128, 4214.5364009959185, 4254.851080212208, 4262.65898728101, 4265.549713097562, 4276.572342765729, 4709.905801883943, 4846.321514987904, 4890.608751299887, 4901.460839307673, 4971.950280497185, 3576.3204991051875, 3587.2287458196615, 3593.317269718771, 3610.151614370621, 3617.764845285048, 5061.190209566488, 5122.616893438751, 5167.0, 5167.9224811627855, 5176.120059589879, 3607.2984178777974, 3698.0939669780537, 3703.666669999713, 3706.3143318485627, 3712.350338690718, 3708.7589306694977, 3740.7007439404783, 3749.8312575934146, 3765.679917207013, 3776.0937375030344, 4209.0, 4231.449911511484, 4238.36424536322, 4242.193983143193, 4248.532661407243, 4901.230804595392, 4902.240152776325, 4913.901721965541, 4916.803327866917, 4923.113839508923, 1231.655136561764, 1284.1396264502805, 1290.806379043151, 1297.8118172864881, 1300.7122948281133, 894.4767311122936, 899.4108858697564, 920.1718453392001, 922.7462447826902, 928.9349745517749, 3872.6127387261613, 3896.980515097406, 3913.72603917723, 4188.895277618023, 4321.481422229353, 4998.9500104999215, 5145.588352931756, 5146.922796158061, 5148.613853960968, 5156.948430515722, 4401.427814384109, 4422.270325396338, 4423.447069116361, 4430.269005614102, 4434.11317736454, 2584.9224523264334, 2666.360073582326, 2668.6664166979126, 2694.151342327161, 2704.432069265437, 4785.832495862628, 4798.904021919612, 4799.496052914464, 4803.751024733525, 4821.035063436032, 5219.346457479779, 5240.248869343549, 5257.842264732064, 5260.947390526122, 5266.2890509781455, 4659.767011649404, 4779.378680771478, 4796.856094317176, 4812.315689508644, 4846.854594362246, 5104.438511763778, 5128.410232823273, 5145.125328694206, 5148.790034341851, 5175.08521846919, 5012.348394708664, 5052.671576347526, 5055.620828437808, 5062.215356619729, 5077.949220507748, 4734.313524538991, 4790.520947905182, 4791.353167322367, 4805.591524720298, 4845.3216549683775, 3547.4745859280756, 3551.2187318790857, 3571.321448924696, 3583.8208089595937, 3597.5503062117236, 5139.537441630271, 5146.305248791366, 5152.587792976478, 5159.613029022913, 5163.251328557413, 4804.567588917014, 4899.828506002273, 4938.900967088901, 4957.652964292465, 4978.850634480971, 4924.335214745964, 4937.876553086202, 4956.207006879026, 4965.925511117408, 4989.151844186569, 4875.878103047452, 4879.365682461257, 4924.975375123101, 4928.876778080433, 4933.827316044065, 4772.49888761675, 4928.211486162197, 4965.1311020571975, 5034.421041580119, 5052.964142350883, 4623.42207224097, 4723.4331880174595, 4762.261849413347, 4868.3427737255015, 4873.0], "value": 3753.721095330946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4135176850804, 604.295995165632, 701.4703898556589, 727.1092911183797, 746.7423738810111, 11577.247478913876, 12511.874881251184, 12534.122611417204, 12561.937190314047, 12598.0, 12000.819987700192, 12216.755664886698, 12216.81674774877, 12226.08304377173, 12232.755344893098, 590.1914377303101, 603.5654328883197, 721.2174790352474, 728.6720975561005, 741.7440982860904, 742.042764833367, 748.6481353763722, 749.4416659588614, 749.7413392379648, 749.7563291930118, 791.7308115240817, 791.7664289034749, 792.6116203060487, 792.8850316704074, 793.0602236349944, 620.3734228429274, 637.7640273098983, 758.5183408535564, 774.5391492062214, 785.6386062411269, 575.9827205183851, 576.5531712922477, 576.7231728770172, 576.9538436925078, 577.0363492966756, 11177.552897884076, 11191.832122518168, 11202.551897924073, 11205.887941120647, 11235.21353505255, 11319.320840749582, 11633.302001879829, 11811.527538898434, 11980.940095299467, 12561.937190314082, 9515.429074255568, 9569.712908612753, 11483.311001339946, 11596.536138554533, 11728.53085876564, 3963.663088637469, 4016.49793775778, 4017.3773065174946, 4061.8375264989363, 4223.113146239262, 55718.0, 56007.0, 56045.75245084556, 56843.14735278974, 57918.420815791724, 9491.0, 9575.521223938775, 9691.176250018687, 9716.708498745049, 9733.853992190123, 16659.33362665504, 16887.493375198763, 16955.660886782196, 16962.23669934856, 16969.0667013313, 6130.264368275835, 6276.215473065867, 6296.401841825019, 6352.968235158794, 6431.453326467303, 3432.5194472773833, 3473.7394695397948, 3501.562304711911, 3565.16218688608, 3595.1371670799344, 2572.6269690894715, 2666.4533770576986, 2668.5596876515547, 2676.8260063095836, 2677.705452400234, 454.8612673134726, 460.6015796336212, 462.9976850115728, 470.83050101963266, 473.462619926386, 377.9149691319431, 409.5822261293464, 466.2935652486486, 491.5404097169158, 499.29848562769365, 6827.2831352708245, 6861.245263021064, 7082.716691332392, 7094.9290507094265, 7328.816779580553, 511.83875095473564, 516.630609114485, 526.9578433725369, 533.8211699080774, 554.8418700670289, 3130.4521708700886, 3211.951820722691, 3219.597550306212, 3317.767756257087, 3320.9833950830093, 81462.77805832918, 89023.0, 94571.0, 95687.0, 96538.51730741301, 83201.58399207966, 83365.0, 85140.0, 85640.57179714061, 85879.14120858836, 77395.0, 77569.61215193888, 78201.21798782167, 78907.0, 79705.60147199227, 6034.24571928509, 6067.809645570013, 6238.594491358047, 6365.8726825464155, 6426.967865160645, 44137.0, 45654.77172614116, 46038.309425359315, 47372.0, 48136.27795583139, 36515.90452286436, 39009.80495097506, 40401.0, 60554.0, 63110.0, 8183.3862460316905, 8233.259006689426, 8242.134575869448, 8324.791880203044, 8478.321734261368, 9291.349605527548, 9351.625934962525, 9365.0, 9429.811403772022, 9475.526223688927, 9406.153446189875, 9597.136257736836, 9659.034096590285, 9887.505624718591, 10014.148797352307, 9547.809043818947, 9628.9037109628, 9695.951520242636, 9743.171830394213, 9810.018998100133, 8807.339449541181, 8910.376273660782, 8967.0, 9068.093190680878, 9096.408733432305, 7593.468457207942, 7665.118511371264, 7723.34351580122, 7753.457257991887, 8048.5170889746805, 7490.962545187239, 7631.3131818136635, 7674.923250767644, 7718.807029824299, 7958.602069896598], "value": 5859.908898004172, "unit": "score"}], "name": "dromaeo_css", "value": 6073.296449066975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 115.0, 112.0, 116.0, 114.0, 114.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 130.0, 168.0, 130.0, 130.0, 131.0, 126.0, 164.0, 130.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 163.0, 164.0, 164.0, 162.0, 164.0, 163.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 119.0, 77.0, 78.0, 77.0, 77.0, 101.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 124.0, 84.0, 83.0, 82.0, 107.0, 83.0, 83.0, 120.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 83.0, 90.0, 84.0, 82.0, 82.0, 83.0, 82.0, 92.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 140.0, 144.0, 143.0, 140.0, 141.0, 151.0, 186.0, 146.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 173.0, 177.0, 172.0, 178.0, 173.0, 174.0, 173.0, 172.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 70.0, 70.0, 75.0, 69.0, 69.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1560.8, "alertThreshold": 2.0}]} 04:46:17 INFO - Return code: 0 04:46:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:17 INFO - # TBPL SUCCESS # 04:46:17 INFO - Running post-action listener: _resource_record_post_action 04:46:17 INFO - [mozharness: 2016-10-14 11:46:17.960248Z] Finished run-tests step (success) 04:46:17 INFO - Running post-run listener: _resource_record_post_run 04:46:18 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 394448896; Read time: 0; Write time: 356488 04:46:18 INFO - TinderboxPrint: CPU usage
13.0% 04:46:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:46:18 INFO - TinderboxPrint: I/O write bytes / time
394,448,896 / 356,488 04:46:18 INFO - TinderboxPrint: CPU idle
8,347.0 (86.9%) 04:46:18 INFO - TinderboxPrint: CPU user
1,204.1 (12.5%) 04:46:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:46:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101281792; Read time: 0; Write time: 125648 04:46:18 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293167104; Read time: 0; Write time: 230840 04:46:18 INFO - Running post-run listener: _upload_blobber_files 04:46:18 INFO - Blob upload gear active. 04:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:46:18 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:46:18 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:46:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:19 INFO - (blobuploader) - INFO - Done attempting. 04:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:23 INFO - (blobuploader) - INFO - Done attempting. 04:46:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:24 INFO - (blobuploader) - INFO - Done attempting. 04:46:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:24 INFO - Return code: 0 04:46:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c806b1ee67b66dc1a45b363daa056666700430621518f2d95f571d7c7d4ddb246573dfcb84b14863f468612905827d1e325829b0408ed2bc77ce580ae5c210e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2e97ca9711ca8a22ef712a01b9fd180f308b4e6c48a5743277ecd516aab3f701cf4a5dd99c71a86e5b8e6fc6cd37c5ed9294aef31591da7a50270d06c73a3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed5b1e18a00e187f2cfa10d03cab31b65b9c5a6a706d2755209f4eeb2ec93fbbd1dc1a3717d775f0f37506a58820991d2b7fb81a06a29cb5ca46df32aeb4b676"} 04:46:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:24 INFO - Contents: 04:46:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c806b1ee67b66dc1a45b363daa056666700430621518f2d95f571d7c7d4ddb246573dfcb84b14863f468612905827d1e325829b0408ed2bc77ce580ae5c210e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2e97ca9711ca8a22ef712a01b9fd180f308b4e6c48a5743277ecd516aab3f701cf4a5dd99c71a86e5b8e6fc6cd37c5ed9294aef31591da7a50270d06c73a3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed5b1e18a00e187f2cfa10d03cab31b65b9c5a6a706d2755209f4eeb2ec93fbbd1dc1a3717d775f0f37506a58820991d2b7fb81a06a29cb5ca46df32aeb4b676"} 04:46:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:24 INFO - Copying logs to upload dir... 04:46:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.260835 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 04:46:23.700215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:46:23.704101) ========= 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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c806b1ee67b66dc1a45b363daa056666700430621518f2d95f571d7c7d4ddb246573dfcb84b14863f468612905827d1e325829b0408ed2bc77ce580ae5c210e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2e97ca9711ca8a22ef712a01b9fd180f308b4e6c48a5743277ecd516aab3f701cf4a5dd99c71a86e5b8e6fc6cd37c5ed9294aef31591da7a50270d06c73a3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed5b1e18a00e187f2cfa10d03cab31b65b9c5a6a706d2755209f4eeb2ec93fbbd1dc1a3717d775f0f37506a58820991d2b7fb81a06a29cb5ca46df32aeb4b676"} build_url:https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011553 build_url: 'https://queue.taskcluster.net/v1/task/Q2UHy96jSBixi8FlGqqdYA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c806b1ee67b66dc1a45b363daa056666700430621518f2d95f571d7c7d4ddb246573dfcb84b14863f468612905827d1e325829b0408ed2bc77ce580ae5c210e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2e97ca9711ca8a22ef712a01b9fd180f308b4e6c48a5743277ecd516aab3f701cf4a5dd99c71a86e5b8e6fc6cd37c5ed9294aef31591da7a50270d06c73a3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed5b1e18a00e187f2cfa10d03cab31b65b9c5a6a706d2755209f4eeb2ec93fbbd1dc1a3717d775f0f37506a58820991d2b7fb81a06a29cb5ca46df32aeb4b676"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:46:23.735360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:46:23.735716) ========= 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=826874ccc97bd7bf541b4875000001d5-1476444336.273848-1291407884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:46:23.819717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:46:23.820078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:46:23.820384) ========= ========= Total master_lag: 0.17 =========