builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1476256678.87 results: success (0) buildid: 20161011213002 builduid: e23fe4e6e4cc478fb15cd528b1f85c43 revision: aa789d732c6c2a7c17bf96dff3fecddc91afc3ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:58.870944) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:58.871556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:58.871852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:58.983543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:58.983932) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 00:17:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.9M=0.001s 2016-10-12 00:17:59 (20.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.123863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.124186) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018729 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.174641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.174951) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aa789d732c6c2a7c17bf96dff3fecddc91afc3ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aa789d732c6c2a7c17bf96dff3fecddc91afc3ab --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 00:17:59,705 truncating revision to first 12 chars 2016-10-12 00:17:59,705 Setting DEBUG logging. 2016-10-12 00:17:59,705 attempt 1/10 2016-10-12 00:17:59,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/aa789d732c6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 00:18:00,001 unpacking tar archive at: mozilla-inbound-aa789d732c6c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.821071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.821357) ========= script_repo_revision: aa789d732c6c2a7c17bf96dff3fecddc91afc3ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.821721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.821987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 00:17:59.838104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-10-12 00:17:59.838461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:18:00 INFO - MultiFileLogger online at 20161012 00:18:00 in /builds/slave/test 00:18:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:18:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:18:00 INFO - {'append_to_log': False, 00:18:00 INFO - 'base_work_dir': '/builds/slave/test', 00:18:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:18:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:18:00 INFO - 'branch': 'Mozilla-Inbound', 00:18:00 INFO - 'buildbot_json_path': 'buildprops.json', 00:18:00 INFO - 'config_files': ('talos/linux_config.py',), 00:18:00 INFO - 'default_actions': ('clobber', 00:18:00 INFO - 'read-buildbot-config', 00:18:00 INFO - 'download-and-extract', 00:18:00 INFO - 'populate-webroot', 00:18:00 INFO - 'create-virtualenv', 00:18:00 INFO - 'install', 00:18:00 INFO - 'run-tests'), 00:18:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:18:00 INFO - 'download_minidump_stackwalk': True, 00:18:00 INFO - 'download_symbols': 'ondemand', 00:18:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:18:00 INFO - 'tooltool.py': '/tools/tooltool.py', 00:18:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:18:00 INFO - '/tools/misc-python/virtualenv.py')}, 00:18:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:18:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:18:00 INFO - 'installer_path': 'installer.exe', 00:18:00 INFO - 'log_level': 'info', 00:18:00 INFO - 'log_name': 'talos', 00:18:00 INFO - 'log_to_console': True, 00:18:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:18:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:18:00 INFO - 'opt_config_files': (), 00:18:00 INFO - 'pip_index': False, 00:18:00 INFO - 'sps_profile': False, 00:18:00 INFO - 'sps_profile_interval': 0, 00:18:00 INFO - 'suite': 'dromaeojs', 00:18:00 INFO - 'system_bits': '32', 00:18:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:18:00 INFO - 'title': 'talos-linux64-ix-008', 00:18:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:18:00 INFO - 'use_talos_json': True, 00:18:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:18:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:18:00 INFO - 'work_dir': 'build'} 00:18:00 INFO - [mozharness: 2016-10-12 07:18:00.463491Z] Running clobber step. 00:18:00 INFO - Running pre-action listener: _resource_record_pre_action 00:18:00 INFO - Running main action method: clobber 00:18:00 INFO - rmtree: /builds/slave/test/build 00:18:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:18:01 INFO - Running post-action listener: _resource_record_post_action 00:18:01 INFO - [mozharness: 2016-10-12 07:18:01.449497Z] Finished clobber step (success) 00:18:01 INFO - [mozharness: 2016-10-12 07:18:01.449596Z] Running read-buildbot-config step. 00:18:01 INFO - Running pre-action listener: _resource_record_pre_action 00:18:01 INFO - Running main action method: read_buildbot_config 00:18:01 INFO - Using buildbot properties: 00:18:01 INFO - { 00:18:01 INFO - "project": "", 00:18:01 INFO - "product": "firefox", 00:18:01 INFO - "script_repo_revision": "production", 00:18:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:18:01 INFO - "repository": "", 00:18:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:18:01 INFO - "buildid": "20161011213002", 00:18:01 INFO - "pgo_build": "True", 00:18:01 INFO - "basedir": "/builds/slave/test", 00:18:01 INFO - "buildnumber": 1667, 00:18:01 INFO - "slavename": "talos-linux64-ix-008", 00:18:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:18:01 INFO - "platform": "ubuntu64_hw", 00:18:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:18:01 INFO - "branch": "mozilla-inbound", 00:18:01 INFO - "repo_path": "integration/mozilla-inbound", 00:18:01 INFO - "revision": "aa789d732c6c2a7c17bf96dff3fecddc91afc3ab", 00:18:01 INFO - "stage_platform": "linux64-pgo", 00:18:01 INFO - "builduid": "e23fe4e6e4cc478fb15cd528b1f85c43", 00:18:01 INFO - "slavebuilddir": "test" 00:18:01 INFO - } 00:18:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:18:01 INFO - Running post-action listener: _resource_record_post_action 00:18:01 INFO - [mozharness: 2016-10-12 07:18:01.452016Z] Finished read-buildbot-config step (success) 00:18:01 INFO - [mozharness: 2016-10-12 07:18:01.452104Z] Running download-and-extract step. 00:18:01 INFO - Running pre-action listener: _resource_record_pre_action 00:18:01 INFO - Running main action method: download_and_extract 00:18:01 INFO - mkdir: /builds/slave/test/build/tests 00:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:01 INFO - trying https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/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 00:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/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 00:18:02 INFO - Downloaded 1361 bytes. 00:18:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:02 INFO - Using the following test package requirements: 00:18:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:18:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:18:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'jsshell-linux-x86_64.zip'], 00:18:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:18:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:18:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:18:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:18:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:18:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:18:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:02 INFO - Fetch https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:02 INFO - Http code: 200 00:18:02 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 00:18:02 INFO - x-amz-cf-id: UuMGqQxkv9d8PgLLPy9bYg2FIXH9AGmxcMs6Ssez-VGhg3fgTWg6Xg== 00:18:02 INFO - x-amz-version-id: p0N.cOLfx2refnweGTkJlSxrbTuZ4ayp 00:18:13 INFO - Expected file size: 22116746 00:18:13 INFO - Obtained file size: 22116746 00:18:17 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 00:18:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:18 INFO - Http code: 200 00:18:18 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 00:18:18 INFO - x-amz-cf-id: 6Ih638EsqwNaaWmxiTMbTY29af3uFHHeE7CmZEQNue7dNo--9om_Hg== 00:18:18 INFO - x-amz-version-id: p0N.cOLfx2refnweGTkJlSxrbTuZ4ayp 00:18:18 INFO - Expected file size: 22116746 00:18:18 INFO - Obtained file size: 22116746 00:18:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:18:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:18:23 INFO - Fetch https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:18:23 INFO - Http code: 200 00:18:23 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 00:18:23 INFO - x-amz-cf-id: HcmPldZZ69WRtZxIc2gycU3XPSPN1-cpNVIAqGPINYHTfkfhpe75Hg== 00:18:23 INFO - x-amz-version-id: 9yV2JPpMdFjIKOWvGOwQvu64E4YldiAI 00:18:24 INFO - Expected file size: 14409006 00:18:24 INFO - Obtained file size: 14409006 00:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:24 INFO - trying https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/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 00:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/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 00:18:27 INFO - Downloaded 59782240 bytes. 00:18:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:27 INFO - mkdir: /builds/slave/test/properties 00:18:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:18:27 INFO - Writing to file /builds/slave/test/properties/build_url 00:18:27 INFO - Contents: 00:18:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:28 INFO - Running post-action listener: _resource_record_post_action 00:18:28 INFO - Running post-action listener: set_extra_try_arguments 00:18:28 INFO - [mozharness: 2016-10-12 07:18:28.055788Z] Finished download-and-extract step (success) 00:18:28 INFO - [mozharness: 2016-10-12 07:18:28.056026Z] Running populate-webroot step. 00:18:28 INFO - Running pre-action listener: _resource_record_pre_action 00:18:28 INFO - Running main action method: populate_webroot 00:18:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:18:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:18:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:18:28 INFO - '--tppagecycles', 00:18:28 INFO - '7'], 00:18:28 INFO - 'tests': ['tsvgm']}}, 00:18:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:18:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:18:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:18:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:18:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['damp', 'tps']}, 00:18:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'tests': ['damp', 'tps']}, 00:18:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['dromaeo_dom']}, 00:18:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:18:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['basic_compositor_video']}, 00:18:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:18:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'other-e10s': {'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['a11yr', 00:18:28 INFO - 'ts_paint', 00:18:28 INFO - 'tpaint', 00:18:28 INFO - 'sessionrestore', 00:18:28 INFO - 'sessionrestore_no_auto_restore', 00:18:28 INFO - 'tabpaint']}, 00:18:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['tsvgx', 00:18:28 INFO - 'tsvgr_opacity', 00:18:28 INFO - 'tart', 00:18:28 INFO - 'tscrollx', 00:18:28 INFO - 'cart']}, 00:18:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:18:28 INFO - 'tsvgr_opacity', 00:18:28 INFO - 'tart', 00:18:28 INFO - 'tscrollx', 00:18:28 INFO - 'cart']}, 00:18:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'talos_options': ['--disable-e10s'], 00:18:28 INFO - 'tests': ['tp5o']}, 00:18:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'tests': ['tp5o']}, 00:18:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'talos_options': ['--disable-e10s', 00:18:28 INFO - '--xperf_path', 00:18:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:28 INFO - 'tests': ['tp5n']}, 00:18:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:28 INFO - 'talos_options': ['--xperf_path', 00:18:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:28 INFO - 'tests': ['tp5n']}}, 00:18:28 INFO - 'talos.zip': {'path': '', 00:18:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:18:28 INFO - Running post-action listener: _resource_record_post_action 00:18:28 INFO - [mozharness: 2016-10-12 07:18:28.076701Z] Finished populate-webroot step (success) 00:18:28 INFO - [mozharness: 2016-10-12 07:18:28.076789Z] Running create-virtualenv step. 00:18:28 INFO - Running pre-action listener: _resource_record_pre_action 00:18:28 INFO - Running main action method: create_virtualenv 00:18:28 INFO - Creating virtualenv /builds/slave/test/build/venv 00:18:28 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 00:18:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:18:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:18:28 INFO - Using real prefix '/usr' 00:18:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:18:28 INFO - Installing distribute.............................................................................................................................................................................................done. 00:18:30 INFO - Installing pip.................done. 00:18:30 INFO - Return code: 0 00:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:18:30 INFO - Reading from file tmpfile_stdout 00:18:30 INFO - Output received: 00:18:30 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) 00:18:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:18: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')]} 00:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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')]} 00:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:18:30 INFO - Using env: {'DISPLAY': ':0', 00:18:30 INFO - 'HOME': '/home/cltbld', 00:18:30 INFO - 'LANG': 'en_US.UTF-8', 00:18:30 INFO - 'LANGUAGE': 'en_US:en', 00:18:30 INFO - 'LOGNAME': 'cltbld', 00:18:30 INFO - 'MAIL': '/var/mail/cltbld', 00:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:30 INFO - 'MOZ_NO_REMOTE': '1', 00:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:30 INFO - 'NO_EM_RESTART': '1', 00:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:30 INFO - 'PWD': '/builds/slave/test', 00:18:30 INFO - 'SHELL': '/bin/bash', 00:18:30 INFO - 'SHLVL': '1', 00:18:30 INFO - 'TERM': 'linux', 00:18:30 INFO - 'TMOUT': '86400', 00:18:30 INFO - 'USER': 'cltbld', 00:18:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:30 INFO - '_': '/tools/buildbot/bin/python'} 00:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:31 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 00:18:31 INFO - Cleaning up... 00:18:31 INFO - Return code: 0 00:18:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:18:31 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')]} 00:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:31 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')]} 00:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:31 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:31 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 00:18:31 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 00:18:31 INFO - Using env: {'DISPLAY': ':0', 00:18:31 INFO - 'HOME': '/home/cltbld', 00:18:31 INFO - 'LANG': 'en_US.UTF-8', 00:18:31 INFO - 'LANGUAGE': 'en_US:en', 00:18:31 INFO - 'LOGNAME': 'cltbld', 00:18:31 INFO - 'MAIL': '/var/mail/cltbld', 00:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:31 INFO - 'MOZ_NO_REMOTE': '1', 00:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:31 INFO - 'NO_EM_RESTART': '1', 00:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:31 INFO - 'PWD': '/builds/slave/test', 00:18:31 INFO - 'SHELL': '/bin/bash', 00:18:31 INFO - 'SHLVL': '1', 00:18:31 INFO - 'TERM': 'linux', 00:18:31 INFO - 'TMOUT': '86400', 00:18:31 INFO - 'USER': 'cltbld', 00:18:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:31 INFO - '_': '/tools/buildbot/bin/python'} 00:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:31 INFO - Downloading/unpacking psutil>=3.1.1 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:33 INFO - Installing collected packages: psutil 00:18:33 INFO - Running setup.py install for psutil 00:18:33 INFO - building 'psutil._psutil_linux' extension 00:18:33 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 00:18:33 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 00:18:33 INFO - building 'psutil._psutil_posix' extension 00:18:33 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 00:18:33 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 00:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:34 INFO - Successfully installed psutil 00:18:34 INFO - Cleaning up... 00:18:34 INFO - Return code: 0 00:18:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:18:34 INFO - Using env: {'DISPLAY': ':0', 00:18:34 INFO - 'HOME': '/home/cltbld', 00:18:34 INFO - 'LANG': 'en_US.UTF-8', 00:18:34 INFO - 'LANGUAGE': 'en_US:en', 00:18:34 INFO - 'LOGNAME': 'cltbld', 00:18:34 INFO - 'MAIL': '/var/mail/cltbld', 00:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:34 INFO - 'MOZ_NO_REMOTE': '1', 00:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:34 INFO - 'NO_EM_RESTART': '1', 00:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:34 INFO - 'PWD': '/builds/slave/test', 00:18:34 INFO - 'SHELL': '/bin/bash', 00:18:34 INFO - 'SHLVL': '1', 00:18:34 INFO - 'TERM': 'linux', 00:18:34 INFO - 'TMOUT': '86400', 00:18:34 INFO - 'USER': 'cltbld', 00:18:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:34 INFO - '_': '/tools/buildbot/bin/python'} 00:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:18:36 INFO - Installing collected packages: mozsystemmonitor 00:18:36 INFO - Running setup.py install for mozsystemmonitor 00:18:36 INFO - Successfully installed mozsystemmonitor 00:18:36 INFO - Cleaning up... 00:18:36 INFO - Return code: 0 00:18:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:18:36 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')]} 00:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:36 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')]} 00:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:36 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:36 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 00:18:36 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 00:18:36 INFO - Using env: {'DISPLAY': ':0', 00:18:36 INFO - 'HOME': '/home/cltbld', 00:18:36 INFO - 'LANG': 'en_US.UTF-8', 00:18:36 INFO - 'LANGUAGE': 'en_US:en', 00:18:36 INFO - 'LOGNAME': 'cltbld', 00:18:36 INFO - 'MAIL': '/var/mail/cltbld', 00:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:36 INFO - 'MOZ_NO_REMOTE': '1', 00:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:36 INFO - 'NO_EM_RESTART': '1', 00:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:36 INFO - 'PWD': '/builds/slave/test', 00:18:36 INFO - 'SHELL': '/bin/bash', 00:18:36 INFO - 'SHLVL': '1', 00:18:36 INFO - 'TERM': 'linux', 00:18:36 INFO - 'TMOUT': '86400', 00:18:36 INFO - 'USER': 'cltbld', 00:18:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:36 INFO - '_': '/tools/buildbot/bin/python'} 00:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 00:18:36 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 00:18:36 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 00:18:36 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 00:18:36 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 00:18:36 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 00:18:36 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 00:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:18:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 00:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:18:38 INFO - warning: no files found matching '*.txt' 00:18:38 INFO - no previously-included directories found matching 'build' 00:18:38 INFO - no previously-included directories found matching 'dist' 00:18:38 INFO - no previously-included directories found matching '.git*' 00:18:38 INFO - Installing collected packages: jsonschema, functools32 00:18:38 INFO - Running setup.py install for functools32 00:18:38 INFO - warning: no files found matching '*.txt' 00:18:38 INFO - no previously-included directories found matching 'build' 00:18:38 INFO - no previously-included directories found matching 'dist' 00:18:38 INFO - no previously-included directories found matching '.git*' 00:18:38 INFO - Successfully installed jsonschema functools32 00:18:38 INFO - Cleaning up... 00:18:39 INFO - Return code: 0 00:18:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:39 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:39 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 00:18:39 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 00:18:39 INFO - Using env: {'DISPLAY': ':0', 00:18:39 INFO - 'HOME': '/home/cltbld', 00:18:39 INFO - 'LANG': 'en_US.UTF-8', 00:18:39 INFO - 'LANGUAGE': 'en_US:en', 00:18:39 INFO - 'LOGNAME': 'cltbld', 00:18:39 INFO - 'MAIL': '/var/mail/cltbld', 00:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:39 INFO - 'MOZ_NO_REMOTE': '1', 00:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:39 INFO - 'NO_EM_RESTART': '1', 00:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:39 INFO - 'PWD': '/builds/slave/test', 00:18:39 INFO - 'SHELL': '/bin/bash', 00:18:39 INFO - 'SHLVL': '1', 00:18:39 INFO - 'TERM': 'linux', 00:18:39 INFO - 'TMOUT': '86400', 00:18:39 INFO - 'USER': 'cltbld', 00:18:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:39 INFO - '_': '/tools/buildbot/bin/python'} 00:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:18:39 INFO - Cleaning up... 00:18:39 INFO - Return code: 0 00:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:39 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:39 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 00:18:39 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 00:18:39 INFO - Using env: {'DISPLAY': ':0', 00:18:39 INFO - 'HOME': '/home/cltbld', 00:18:39 INFO - 'LANG': 'en_US.UTF-8', 00:18:39 INFO - 'LANGUAGE': 'en_US:en', 00:18:39 INFO - 'LOGNAME': 'cltbld', 00:18:39 INFO - 'MAIL': '/var/mail/cltbld', 00:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:39 INFO - 'MOZ_NO_REMOTE': '1', 00:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:39 INFO - 'NO_EM_RESTART': '1', 00:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:39 INFO - 'PWD': '/builds/slave/test', 00:18:39 INFO - 'SHELL': '/bin/bash', 00:18:39 INFO - 'SHLVL': '1', 00:18:39 INFO - 'TERM': 'linux', 00:18:39 INFO - 'TMOUT': '86400', 00:18:39 INFO - 'USER': 'cltbld', 00:18:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:39 INFO - '_': '/tools/buildbot/bin/python'} 00:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 00:18:39 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 00:18:39 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 00:18:39 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 00:18:39 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 00:18:39 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 00:18:39 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 00:18:41 INFO - Downloading blobuploader-1.2.4.tar.gz 00:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:18:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:18:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:42 INFO - Downloading docopt-0.6.1.tar.gz 00:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 00:18:42 INFO - Running setup.py install for blobuploader 00:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:18:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:18:42 INFO - Running setup.py install for requests 00:18:42 INFO - Running setup.py install for docopt 00:18:42 INFO - Successfully installed blobuploader requests docopt 00:18:42 INFO - Cleaning up... 00:18:42 INFO - Return code: 0 00:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:42 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:42 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 00:18:42 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 00:18:42 INFO - Using env: {'DISPLAY': ':0', 00:18:42 INFO - 'HOME': '/home/cltbld', 00:18:42 INFO - 'LANG': 'en_US.UTF-8', 00:18:42 INFO - 'LANGUAGE': 'en_US:en', 00:18:42 INFO - 'LOGNAME': 'cltbld', 00:18:42 INFO - 'MAIL': '/var/mail/cltbld', 00:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:42 INFO - 'MOZ_NO_REMOTE': '1', 00:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:42 INFO - 'NO_EM_RESTART': '1', 00:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:42 INFO - 'PWD': '/builds/slave/test', 00:18:42 INFO - 'SHELL': '/bin/bash', 00:18:42 INFO - 'SHLVL': '1', 00:18:42 INFO - 'TERM': 'linux', 00:18:42 INFO - 'TMOUT': '86400', 00:18:42 INFO - 'USER': 'cltbld', 00:18:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:42 INFO - '_': '/tools/buildbot/bin/python'} 00:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:43 INFO - Running setup.py (path:/tmp/pip-xYUtod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:43 INFO - Running setup.py (path:/tmp/pip-WNj8_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:43 INFO - Running setup.py (path:/tmp/pip-KyqFCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:43 INFO - Running setup.py (path:/tmp/pip-67FWPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:43 INFO - Running setup.py (path:/tmp/pip-9gwLFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:43 INFO - Running setup.py (path:/tmp/pip-Yjpywi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:43 INFO - Running setup.py (path:/tmp/pip-sydWgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:43 INFO - Running setup.py (path:/tmp/pip-BOa4Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:43 INFO - Running setup.py (path:/tmp/pip-IKq6Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:43 INFO - Running setup.py (path:/tmp/pip-EhptcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:43 INFO - Running setup.py (path:/tmp/pip-0e2uGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:43 INFO - Running setup.py (path:/tmp/pip-v015HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:43 INFO - Running setup.py (path:/tmp/pip-wPv72Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:43 INFO - Running setup.py (path:/tmp/pip-9e_UlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:44 INFO - Running setup.py (path:/tmp/pip-fpWNs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:44 INFO - Running setup.py (path:/tmp/pip-i4TcUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:44 INFO - Running setup.py (path:/tmp/pip-41W5gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:18:44 INFO - Running setup.py install for manifestparser 00:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:18:44 INFO - Running setup.py install for mozcrash 00:18:44 INFO - Running setup.py install for mozdebug 00:18:44 INFO - Running setup.py install for mozdevice 00:18:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:18:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:18:44 INFO - Running setup.py install for mozfile 00:18:44 INFO - Running setup.py install for mozhttpd 00:18:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:18:44 INFO - Running setup.py install for mozinfo 00:18:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:18:44 INFO - Running setup.py install for mozInstall 00:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Running setup.py install for mozleak 00:18:45 INFO - Running setup.py install for mozlog 00:18:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Running setup.py install for moznetwork 00:18:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Running setup.py install for mozprocess 00:18:45 INFO - Running setup.py install for mozprofile 00:18:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Running setup.py install for mozrunner 00:18:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:18:45 INFO - Running setup.py install for mozscreenshot 00:18:45 INFO - Running setup.py install for moztest 00:18:45 INFO - Running setup.py install for mozversion 00:18:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:18:46 INFO - Cleaning up... 00:18:46 INFO - Return code: 0 00:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:46 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:46 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 00:18:46 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 00:18:46 INFO - Using env: {'DISPLAY': ':0', 00:18:46 INFO - 'HOME': '/home/cltbld', 00:18:46 INFO - 'LANG': 'en_US.UTF-8', 00:18:46 INFO - 'LANGUAGE': 'en_US:en', 00:18:46 INFO - 'LOGNAME': 'cltbld', 00:18:46 INFO - 'MAIL': '/var/mail/cltbld', 00:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:46 INFO - 'MOZ_NO_REMOTE': '1', 00:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:46 INFO - 'NO_EM_RESTART': '1', 00:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:46 INFO - 'PWD': '/builds/slave/test', 00:18:46 INFO - 'SHELL': '/bin/bash', 00:18:46 INFO - 'SHLVL': '1', 00:18:46 INFO - 'TERM': 'linux', 00:18:46 INFO - 'TMOUT': '86400', 00:18:46 INFO - 'USER': 'cltbld', 00:18:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:46 INFO - '_': '/tools/buildbot/bin/python'} 00:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:46 INFO - Running setup.py (path:/tmp/pip-mzkaey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:46 INFO - Running setup.py (path:/tmp/pip-rK7wp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:46 INFO - Running setup.py (path:/tmp/pip-_TURAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:46 INFO - Running setup.py (path:/tmp/pip-TOaTMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:46 INFO - Running setup.py (path:/tmp/pip-oQvCcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:46 INFO - Running setup.py (path:/tmp/pip-T0FUBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:46 INFO - Running setup.py (path:/tmp/pip-hd5wOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:46 INFO - Running setup.py (path:/tmp/pip-h0Uf0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:46 INFO - Running setup.py (path:/tmp/pip-pLaQcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:46 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)) 00:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:46 INFO - Running setup.py (path:/tmp/pip-GEZLyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:47 INFO - Running setup.py (path:/tmp/pip-V7p9hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:47 INFO - Running setup.py (path:/tmp/pip-YMqBiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:47 INFO - Running setup.py (path:/tmp/pip-NnpiS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:47 INFO - Running setup.py (path:/tmp/pip-0dgr51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:47 INFO - Running setup.py (path:/tmp/pip-X5t8eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:47 INFO - Running setup.py (path:/tmp/pip-1XGdwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:47 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)) 00:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:47 INFO - Running setup.py (path:/tmp/pip-gKHuEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:47 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)) 00:18:47 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)) 00:18:47 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)) 00:18:47 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)) 00:18:47 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)) 00:18:47 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)) 00:18:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:18:47 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 00:18:47 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 00:18:47 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 00:18:47 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 00:18:47 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 00:18:47 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 00:18:49 INFO - Downloading blessings-1.6.tar.gz 00:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:18:49 INFO - Installing collected packages: blessings 00:18:49 INFO - Running setup.py install for blessings 00:18:49 INFO - Successfully installed blessings 00:18:49 INFO - Cleaning up... 00:18:49 INFO - Return code: 0 00:18:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:49 INFO - Reading from file tmpfile_stdout 00:18:49 INFO - Current package versions: 00:18:49 INFO - argparse == 1.2.1 00:18:49 INFO - blessings == 1.6 00:18:49 INFO - blobuploader == 1.2.4 00:18:49 INFO - docopt == 0.6.1 00:18:49 INFO - functools32 == 3.2.3-2 00:18:49 INFO - jsonschema == 2.5.1 00:18:49 INFO - manifestparser == 1.1 00:18:49 INFO - mozInstall == 1.12 00:18:49 INFO - mozcrash == 0.17 00:18:49 INFO - mozdebug == 0.1 00:18:49 INFO - mozdevice == 0.48 00:18:49 INFO - mozfile == 1.2 00:18:49 INFO - mozhttpd == 0.7 00:18:49 INFO - mozinfo == 0.9 00:18:49 INFO - mozleak == 0.1 00:18:49 INFO - mozlog == 3.4 00:18:49 INFO - moznetwork == 0.27 00:18:49 INFO - mozprocess == 0.23 00:18:49 INFO - mozprofile == 0.28 00:18:49 INFO - mozrunner == 6.12 00:18:49 INFO - mozscreenshot == 0.1 00:18:49 INFO - mozsystemmonitor == 0.3 00:18:49 INFO - moztest == 0.7 00:18:49 INFO - mozversion == 1.4 00:18:49 INFO - psutil == 3.1.1 00:18:49 INFO - requests == 1.2.3 00:18:49 INFO - wsgiref == 0.1.2 00:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:49 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:49 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 00:18:49 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 00:18:49 INFO - Using env: {'DISPLAY': ':0', 00:18:49 INFO - 'HOME': '/home/cltbld', 00:18:49 INFO - 'LANG': 'en_US.UTF-8', 00:18:49 INFO - 'LANGUAGE': 'en_US:en', 00:18:49 INFO - 'LOGNAME': 'cltbld', 00:18:49 INFO - 'MAIL': '/var/mail/cltbld', 00:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:49 INFO - 'MOZ_NO_REMOTE': '1', 00:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:49 INFO - 'NO_EM_RESTART': '1', 00:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:49 INFO - 'PWD': '/builds/slave/test', 00:18:49 INFO - 'SHELL': '/bin/bash', 00:18:49 INFO - 'SHLVL': '1', 00:18:49 INFO - 'TERM': 'linux', 00:18:49 INFO - 'TMOUT': '86400', 00:18:49 INFO - 'USER': 'cltbld', 00:18:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:49 INFO - '_': '/tools/buildbot/bin/python'} 00:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 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)) 00:18:50 INFO - Cleaning up... 00:18:50 INFO - Return code: 0 00:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:18: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')]} 00:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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')]} 00:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:50 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 0x7f7fab295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', '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 00:18:50 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 00:18:50 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 00:18:50 INFO - Using env: {'DISPLAY': ':0', 00:18:50 INFO - 'HOME': '/home/cltbld', 00:18:50 INFO - 'LANG': 'en_US.UTF-8', 00:18:50 INFO - 'LANGUAGE': 'en_US:en', 00:18:50 INFO - 'LOGNAME': 'cltbld', 00:18:50 INFO - 'MAIL': '/var/mail/cltbld', 00:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:50 INFO - 'MOZ_NO_REMOTE': '1', 00:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:50 INFO - 'NO_EM_RESTART': '1', 00:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:50 INFO - 'PWD': '/builds/slave/test', 00:18:50 INFO - 'SHELL': '/bin/bash', 00:18:50 INFO - 'SHLVL': '1', 00:18:50 INFO - 'TERM': 'linux', 00:18:50 INFO - 'TMOUT': '86400', 00:18:50 INFO - 'USER': 'cltbld', 00:18:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:50 INFO - '_': '/tools/buildbot/bin/python'} 00:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:18:50 INFO - Cleaning up... 00:18:50 INFO - Return code: 0 00:18:50 INFO - Running post-action listener: _resource_record_post_action 00:18:50 INFO - Running post-action listener: _start_resource_monitoring 00:18:50 INFO - Starting resource monitoring. 00:18:50 INFO - [mozharness: 2016-10-12 07:18:50.380197Z] Finished create-virtualenv step (success) 00:18:50 INFO - [mozharness: 2016-10-12 07:18:50.380699Z] Running install step. 00:18:50 INFO - Running pre-action listener: _resource_record_pre_action 00:18:50 INFO - Running main action method: install 00:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:50 INFO - Reading from file tmpfile_stdout 00:18:50 INFO - Detecting whether we're running mozinstall >=1.0... 00:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:18:50 INFO - Reading from file tmpfile_stdout 00:18:50 INFO - Output received: 00:18:50 INFO - Usage: mozinstall [options] installer 00:18:50 INFO - Options: 00:18:50 INFO - -h, --help show this help message and exit 00:18:50 INFO - -d DEST, --destination=DEST 00:18:50 INFO - Directory to install application into. [default: 00:18:50 INFO - "/builds/slave/test"] 00:18:50 INFO - --app=APP Application being installed. [default: firefox] 00:18:50 INFO - mkdir: /builds/slave/test/build/application 00:18:50 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'] 00:18:50 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 00:19:07 INFO - Reading from file tmpfile_stdout 00:19:07 INFO - Output received: 00:19:07 INFO - /builds/slave/test/build/application/firefox/firefox 00:19:07 INFO - Running post-action listener: _resource_record_post_action 00:19:07 INFO - [mozharness: 2016-10-12 07:19:07.705887Z] Finished install step (success) 00:19:07 INFO - [mozharness: 2016-10-12 07:19:07.706131Z] Running run-tests step. 00:19:07 INFO - Running pre-action listener: _resource_record_pre_action 00:19:07 INFO - Running main action method: run_tests 00:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:19:07 INFO - Python 2.7.3 00:19:07 INFO - Return code: 0 00:19:07 INFO - grabbing minidump binary from tooltool 00:19:07 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')]} 00:19:07 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 0xe5af60>, '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 0xe5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:19:07 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 00:19:07 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 00:19:07 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 00:19:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:19:07 INFO - Return code: 0 00:19:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:19:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:19:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:19:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:19:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:19:07 INFO - Using env: {'DISPLAY': ':0', 00:19:07 INFO - 'HOME': '/home/cltbld', 00:19:07 INFO - 'LANG': 'en_US.UTF-8', 00:19:07 INFO - 'LANGUAGE': 'en_US:en', 00:19:07 INFO - 'LOGNAME': 'cltbld', 00:19:07 INFO - 'MAIL': '/var/mail/cltbld', 00:19:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:19:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:07 INFO - 'MOZ_NO_REMOTE': '1', 00:19:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:07 INFO - 'NO_EM_RESTART': '1', 00:19:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:07 INFO - 'PWD': '/builds/slave/test', 00:19:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:19:07 INFO - 'SHELL': '/bin/bash', 00:19:07 INFO - 'SHLVL': '1', 00:19:07 INFO - 'TERM': 'linux', 00:19:07 INFO - 'TMOUT': '86400', 00:19:07 INFO - 'USER': 'cltbld', 00:19:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657', 00:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:07 INFO - '_': '/tools/buildbot/bin/python'} 00:19:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:19:07 INFO - mozversion application_buildid: 20161011213002 00:19:07 INFO - mozversion application_changeset: aa789d732c6c2a7c17bf96dff3fecddc91afc3ab 00:19:07 INFO - mozversion application_display_name: Nightly 00:19:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:19:07 INFO - mozversion application_name: Firefox 00:19:07 INFO - mozversion application_remotingname: firefox 00:19:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:19:07 INFO - mozversion application_vendor: Mozilla 00:19:07 INFO - mozversion application_version: 52.0a1 00:19:07 INFO - mozversion platform_buildid: 20161011213002 00:19:07 INFO - mozversion platform_changeset: aa789d732c6c2a7c17bf96dff3fecddc91afc3ab 00:19:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:19:07 INFO - mozversion platform_version: 52.0a1 00:19:07 INFO - using testdate: 1476256747 00:19:07 INFO - actual date: 1476256747 00:19:07 INFO - starting webserver on 'localhost:58393' 00:19:07 INFO - SUITE-START | Running 2 tests 00:19:07 INFO - TEST-START | dromaeo_css 00:19:07 INFO - operating with platform_type : linux_ 00:19:07 INFO - Initialising browser for dromaeo_css test... 00:19:07 INFO - TEST-INFO | started process 5355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWtCSr/profile http://localhost:58393/getInfo.html) 00:19:11 INFO - PROCESS | 5355 | __metrics Screen width/height:1600/1200 00:19:11 INFO - PROCESS | 5355 | colorDepth:24 00:19:11 INFO - PROCESS | 5355 | Browser inner width/height: 1024/697 00:19:11 INFO - PROCESS | 5355 | __metrics 00:19:12 INFO - PROCESS | 5355 | 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" 00:19:12 INFO - PROCESS | 5355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:19:13 INFO - PROCESS | 5355 | console.error: PushService: 00:19:13 INFO - PROCESS | 5355 | stateChangeProcessEnqueue: Error transitioning state 00:19:13 INFO - PROCESS | 5355 | UnknownError 00:19:13 INFO - TEST-INFO | 5355: exit 0 00:19:13 INFO - Browser initialized. 00:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 00:19:13 INFO - TEST-INFO | started process 5437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWtCSr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:25 INFO - PROCESS | 5437 | RSS: Main: 172384256 00:19:25 INFO - PROCESS | 5437 | 00:20:16 INFO - PROCESS | 5437 | 1476256816865 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] 00:22:28 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58393/tests/dromaeo/cssquery-ext.html) 00:22:29 INFO - PROCESS | 5437 | RSS: Main: 292978688 00:22:29 INFO - PROCESS | 5437 | 00:25:31 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-ext.html (next: http://localhost:58393/tests/dromaeo/cssquery-jquery.html) 00:25:32 INFO - PROCESS | 5437 | RSS: Main: 277467136 00:25:32 INFO - PROCESS | 5437 | 00:28:34 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58393/tests/dromaeo/cssquery-mootools.html) 00:28:35 INFO - PROCESS | 5437 | RSS: Main: 245616640 00:28:35 INFO - PROCESS | 5437 | 00:31:37 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58393/tests/dromaeo/cssquery-prototype.html) 00:31:37 INFO - PROCESS | 5437 | RSS: Main: 256303104 00:31:37 INFO - PROCESS | 5437 | 00:34:40 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58393/tests/dromaeo/cssquery-yui.html) 00:34:41 INFO - PROCESS | 5437 | RSS: Main: 219222016 00:34:41 INFO - PROCESS | 5437 | 00:37:43 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-yui.html (next: http://localhost:58393/tests/dromaeo/cssquery-dojo.html) 00:37:43 INFO - PROCESS | 5437 | RSS: Main: 308203520 00:37:43 INFO - PROCESS | 5437 | 00:37:43 INFO - PROCESS | 5437 | __start_tp_report 00:37:43 INFO - PROCESS | 5437 | _x_x_mozilla_page_load 00:37:43 INFO - PROCESS | 5437 | _x_x_mozilla_page_load_details 00:37:43 INFO - PROCESS | 5437 | |i|pagename|runs| 00:37:43 INFO - PROCESS | 5437 | |0;dojo.html;2941.176470588236;2979.6126503554533;2998.1155559110075;3019.305559721264;3054.358584697214;5205.3233079699585;5232.790688372465;5263.86840328992;5326.9733651331735;5348.759305831237;5291.206319052144;5307.442718514559;5312.787488500456;5316.680999140054;5323.228131920879;4815.398075240586;4843.200871856139;4860.368152140217;4895.898422854865;4914.680545764514;4904.901901961958;4912.557869791718;4939.950600494003;4942.382202224722;4944.87637809054;4821.831235906744;4839.5644392004715;4874.878128046809;4885.145099607572;4928.728919909404;4896.853094407174;4923.48303428142;4929.137400954819;4943.826966056171;4998.40019197695;4691.906161876777;4740.810367585293;4772.928406073912;4832.347633069526;4884.7069175849565;5242.292290540767;5256.763445644955;5257.263983042377;5274.841754747364;5349.946500534984;5606.719664016783;5675.2054712340305;5682.516986056149;5682.573806964494;5683.857903552403;5402.837914862521;5461.69960652164;5630.887382252332;5729.1119876419225;5782.392848750863;5312.601554883399;5333.226682131147;5334.91997620036;5377.489138531794;5395.109806881821;5793.623414478046;5799.826005219766;5802.535797136219;5803.912941305884;5804.651720896675;5353.223782551586;5457.426970168154;5568.498835104779;5570.997220500268;5573.693446860461;5566.6381685191145;5577.358603760538;5610.158476228598;5630;5703.486686198262;5583.162525621108;5625.46558076982;5629.296337957755;5634.267545219095;5638.520725738276;5523.7790488380815;5637.830865074055;5638.97180514103;5641.069223578145;5646.435356464321;4320.1143765527995;4351.086271882877;4377.409049778303;4382.408374869416;4388.495323037828;3861.131245469803;3873.8837834865;3880.3015457217407;3917.1578110705764;3923.7841918694744;5375.5162035416215;5387.218853266255;5388.91916621251;5390.299261096111;5443.918341224885;5386.299781028441;5403.162509810907;5663.405342438985;5689.061304884648;5711.343195532484;5391.81128660495;5392.595555333366;5398.433164517748;5438.564914806885;5456.563474921997;4902.509749025069;4910.852674419773;4912.066707325596;4913.06651736169;4927.1131196384995;5633.436656334334;5635.605507614428;5813.6221145625395;5870;5880.323762767251;5706.600537962303;5722.799702010409;5728.570357223141;5775.537956963517;5791.942080579309;5864.736086876186;5866.325372582208;5885.823425297248;5895.67573783446;5897.764089436375;5488.231647569263;5536.557075434036;5635.380108188014;5649.20911072442;5650.547956163579;5641.802536911188;5664;5683.857903552444;5687.146927960839;5758.0499217630295;5497.642653227527;5542.528885044816;5565.193047008081;5566.165075238747;5573;5440.238366628596;5485.067538518541;5520.282363292747;5543.279373681396;5605.691686957093;5419.268398766116;5439.646422982493;5458.836234912959;5484.753186106715;5573.498385145356;5553.8333849984565;5584.916226256691;5593.916091258716;5598.440155984369;5601.915971260516;5344.331958505187;5384.219288203267;5384.6769193848495;5466.8906621866545;5479.479449452296 00:37:43 INFO - PROCESS | 5437 | |1;ext.html;555.7577486401149;583.131134609432;590.1884908251154;591.9200907877437;608.9543284253681;31109;43205.13589728204;43523.56476435235;43691;43750.34374484381;44928.77535612325;45181.09637807242;45297.320540191926;45298.09403811922;45359.54640453595;7873.212678732139;8055;8847.823043539109;9005.54972251388;9005.639774409015;10293.691189264335;10544.15646748262;10551.10315623173;10909.890901090967;10917.781644367107;10715.035646791786;10808.567657293699;10815.621453249138;10815.621453249138;10821.188410869177;10647.254692171551;10699.411532365717;10711.625093121782;10738.248322617419;10738.30201036934;10504.317219380715;10560.47197640115;10569.682909512727;10570.577176912915;10574.365538067663;41392.79303603493;41665.1666966662;41825.163496729896;41825.37261941074;41867.162656747;3327.236564620755;3429.3484237994703;3448.827558622084;3454.896353109411;3477.3566890125153;31152.53271200934;31712;31936;33193;33237.16907077318;4239.385289133058;4288.16380805743;4315.870523884289;4343.804528796211;4455.22033644111;337025;340216.66858305654;341841;342179;342234;34722.652773472444;58098.7095064522;58371.70814145902;58611;58636.06819659;35340.46989295162;35380.29239415197;35386.46920296198;35414.82292588521;35431;14940;15066.773998390034;15079.698406032037;15121.773173402407;15136.848631513763;9656.75858103539;9748.853767193497;11556.075513959031;12157.574484892986;12238.694032649077;8452.450590711584;8501.362397820189;8503;8575.399722019523;8585.828283434297;3324.5511855899144;3337.0656216259486;3344.2642618623863;3365.6129545102135;3424.092615456906;1005.939643621385;1016.7254841192837;1050.810854046279;1069.0989661733493;1076.805510068379;30752.38495230083;30804.691953080182;30935.845320773704;31138.532922006187;31462.842685786425;1013.4527355228241;1091.7270682329417;1100.2573263047411;1140.7604403075281;1160.1356989043047;16134.480656412772;16484.6703065938;16657;16721.749173762404;16737.748933766004;473595;475007;476019;477885;478965;56312;56736.71631641898;56774;56817.14774278389;56846.147307790416;1145.7823013627385;1208.6011616166468;1211.7515909238762;1295.6631275868153;1312.5143696832042;26293.342666432727;29615.407691845612;31162.532562011136;33586.83206583952;33614.49578256377;54112.45887541074;54797.45202548083;54812.17781733357;54812.451875480736;54843.45156548543;337572;339465;341385.8099223642;342165;342419;24503.38741531476;25011.624825627267;26441.603375949762;28096.64502002193;28280.71719282863;40801.795991019855;45555.77222113868;45653.315200272686;45669.54330456786;47509;37475.06312342213;39156;39333.606663932995;40166.799166003984;41401;39637.80181099076;39763.204735905696;40025.799871001625;41079;41800.58199418089;38218.808905955295;39600.80199598984;40248.1950360997;40249.19501609893;40297.798511007255;33245.50131747977;35924.4611330825;36203.63796362003;36520.63479365279;37093.62906370902;27198.320041999108;27270;27450.313742156606;27515;27714.861425692743 00:37:43 INFO - PROCESS | 5437 | |2;jquery.html;380.6669164481078;385.1930206217974;387.4517557655917;397.5190020075708;407.33400889545624;17256;19428.514287142792;19861.801381986177;20075.59848803023;20082.096305666244;18589.60577956652;18979;19214;19423.514412139702;19460.51348716283;5600.663960162403;5602.971985140069;5790.942090579104;5859.296884373881;5860.706964651772;5727.112297593859;5732.369439361667;5778.971105144468;5780.393058728836;5783.334916484616;5485.890282194354;5612.466815652527;5687.17535957286;5741.770329186827;5747.42525747424;5687;5731.914021289684;5735.397783232784;5740.712964351807;5747;5098.643094983316;5153.304303918998;5382.6232163748555;5430.3755068167275;5465.699386533739;13948.651283717887;14226.715465690628;14226.92886535571;20784.376468705963;21379.786202137933;2095.5808838232415;2098.8320934325216;2106.104905415192;2293.048384920256;2495.8752062396807;10157;10636.414997175152;10684.893151068467;10767.300125491818;11068.667939961813;1886.7735871695347;1896.0709252466331;1930.7779605345424;1938.709193620954;1965.7346258255238;60318.39681603215;63538;63680.68159659265;83954;85481;9677.758056048515;10419.687409377731;10428.478576071166;10525.947370263253;10688.51901664427;15592.220388980733;15638.687226255412;15639;15650.608734781494;15654.45209417665;7833.897371320667;7888.48724832884;8022;8158.83682326362;8303.501789892505;7747.883781743279;7771.222877712296;7919.20807919215;7974.60126993648;7986.480878742979;4710.152172608895;4722.787474563653;4839.322494850724;4850.927236091461;4987.905079866465;2014.617222727677;2045.6829191475344;2052.9486762831048;2053.2813515269536;2058.217877206652;826.4834478450969;906.9252935271724;949.7720547068653;1026.7298653787561;1068.3589846092439;17525.38661146879;17895.284188632308;18592.349267775564;18794.718079228824;18828.52928676794;902.6930843513237;913.3878704087291;937.5234006439885;953.7186529973675;981.3326937682444;9759.463229522444;10364.170866330676;10502.317349372266;10598.735031624272;10611.84082238767;303719;309678;309704;426999;427352;57414.7129264351;57669.423305767246;72014.63992680107;79376;89707;949.0699114867331;1003.859459675646;1016.2632091733434;1024.2778840917135;1041.1982773264544;12878.356082195665;15714.76427853606;15743.842561574238;16543.420980266113;17103.973761574347;38684;39089.41365879457;39171.80414098025;40216.396754048124;41738.165236695706;56897.43102569087;58004.12993805012;58156;58234;59467;8662.133786621287;8663.220310172115;8704.477731336141;8797.692080777142;8896.599653015759;9917.553710082919;13202.603921882359;13205.537806176737;13241.205527668371;13605.591832244652;11288.429359906162;11399.373034483184;11549.595764148215;11862.82205766897;12295;10969.725756856142;11253.7749245013;11283.379414132301;11518.712032198926;11586.536538538365;11709.590164344207;11900.940495297467;11986.101042422028;12107.576234831738;12267.69330766738;8572.614232359434;8655.826883462421;8662.82674346497;8849.115088491099;8966;8664.82670346577;10464.058234758908;11039;11379.658610241706;11766.941165294118 00:37:44 INFO - PROCESS | 5437 | |3;mootools.html;1435.11740279728;1481.251967756283;1599.4561848971348;1700.7959044914612;1740.208205266603;7553.546787192772;7856.9607151964165;8236.91763082369;9257.907420925789;9275.53622318884;8302.41883068184;8585.613647385868;8600.397972141953;9122.087791220874;9158.954205228982;2311.4683622766775;2338.3920180752957;2340.356401989458;2340.4031971847157;2341.274204996448;2026.9493262668404;2315.3979965209082;2333.474968132165;2339.3800642829665;2357.634566642173;2038.337540299401;2244.5735310290993;2321.025169428844;2327.290176496168;2336.649502574619;2261.21987914171;2273.5793878132517;2279.122537822942;2281.498070424504;2294.9770502295096;2259.45773014477;2266.1275408967504;2276.032686108414;2278.498730279336;2289.8053665438456;8786;8837.116288371175;8851.64593416269;8857.867131993025;8868.423552469068;5151.716655583941;5193.350831146106;5232.162853943389;5246.658967167122;5273.050850846846;3307.206270495088;3327.73378129749;3373.325334932999;3382.6109997350372;3391.3217356528794;1062.383817385922;1072.903438690514;1073.2272763610188;1079.4602698650674;1090.1224514266012;11637.70905727355;11733.12001599875;11738.237014594024;11771.646850594496;11772.882271177265;4423.6903416760515;4483.892570491864;4661.603763680125;4675.3220782986955;4710.364100846342;9920;9946.651867184759;9950.900490995142;9954.402735835729;9959.103680668775;5234.607404444682;5259.76331065103;5275.947240527622;5318.122509785842;5318.282031925641;4742.146413645577;4821.975890120527;4827.903441931142;4848.369711937426;4852.272159176152;3806.410006449005;3870.4968354113785;3889.4943657324366;3895.1235971906663;3933.2330195612153;1122.1583812140893;1160.9245399049034;1161.1349544589334;1261.1172179474404;1268.8604253532103;869.096140014378;925.2921515040999;970.5292932927524;972.9902700973041;977.8044391121804;5829.533637309005;5991.670458124845;6129.877402452015;6183.412575805291;6267.709959335397;937.8311903857372;938.0994245524237;944.3342443577261;960.8846938367441;974.6637410093506;4110.383442483651;4162.105147393265;4181.330987042059;4199.475065616798;4227.365895115758;10522.158227341793;11015.559377624966;11018.338899666045;11021.338719676845;11033.668989930315;10564.154867610572;10881;10982;11033.448327583588;11047.944760276147;8174.959125204336;8196.754097376968;8268.586570671321;8279.130691277449;8329.916700833035;5836.095405212199;5836.299644042742;5857.648541087548;6002.969985150221;6044.90932636002;9715.805683886141;9882.357646752938;9934.254930880357;9992;10030.548625311732;9782.85325720129;10010.549525271526;10146.594136234764;10225.48872556384;10324.793504130026;7574.545527268381;7752;7856.214378562098;7902;8100;8667.696630617898;8749.387542872193;8762.561871906251;8762.824743504967;8770.166834150745;7662.501937374052;7736.2650548197835;7892;8028.43800933929;8045.919540804751;7494.662740176596;7500.849983000418;7618.733344332922;7763.340116090196;7769.106552746506;6909.136357955255;7006.719731210695;7011.579305241702;7012.474064445289;7030.367266945999;5130.846074617767;5143.588512918883;5150.175971844487;5250.474952504872;5457.508824205841;5225.242339860622;5245.003449344612;5263.6578622389425;5296.655717378358;5472.671639701631 00:37:44 INFO - PROCESS | 5437 | |4;prototype.html;331.7495291055254;332.71903172784783;339.4263694356537;342.18047775577475;343.0001545494882;5158.380994280692;5303.946960530394;5335.173048177529;5374.071131233477;5420.701861397626;5076.603933918174;5214.687118772877;5231.947680523193;5239.842804715865;5240;4142.461480007595;4166.270902592049;4187.874363769077;4189.120284740208;4211.705180637349;3980.5024371953505;4137.338025915854;4154.8130334134885;4173.749575025508;4200.810963506634;4130.760771768458;4135.0978549867095;4138.668906487489;4144.254034273829;4145.129522800215;4112.465379500661;4123.299039163349;4126.319157339036;4128.236276288896;4135.66914646829;3646.2889736501393;3649.543807024122;3652.4886515887797;3655.1958569114754;3665.259001974068;5146.639735218536;5167.328247327823;5195.974020129913;5219.530242278213;5224.085784987612;4760.309755085528;4779.545943135397;4783.162946484351;4790.449098353664;4796.56830885222;5424.562490939904;5582.665040097567;5601.29983752031;5627.437256274381;5628.774849006035;3997.1805779815068;4000.8199631016673;4019.799010049486;4031.4154447604933;4050.696197785178;5717.656940583578;5754.935336962633;5755.107958266475;5756.971215143939;5766.135079738073;4069.694772892045;4099.262132816122;4110.979445102756;4122.525909520384;4136.793160341971;4017.31705610047;4151.232022075926;4160;4160.3343465046055;4179.373094035919;4728.645351598644;4754.096721622881;4763.118823017753;4790.8323208687525;4791.808327666924;5564.66612003273;5569.164625306155;5575.8884822304135;5589.245451863946;5625.156226565966;1327.81824176483;1338.8259526261718;1413.1662319231702;1417.7944198091218;1425.3181246129666;883.9204471597587;907.6823111910778;918.6233644205844;922.9769255768659;923.831353338028;4676.573645038228;4728.243481043085;4753.358296629911;4755.643326750507;4759.16714574948;5050.292958985745;5058.949410505921;5069.645124841226;5080.441151473335;5088.465711100355;4445.977080428397;4779.689320194177;4793.856184314476;4794.9280760788615;4809.196551293265;2640.735926407344;2658.800589955761;2671.572548392248;2685.328667833042;2694.205209463213;5136.512031357015;5162.483751624807;5163.251328557338;5170.715610641376;5180.507851754077;4759.001219487824;5084.822031228963;5102.413222479388;5160.92258616121;5169.405518365361;5079.187330027252;5117.360329958829;5131.948680513147;5142.768575414116;5180.404253510895;4961.950380496149;4965.857852693973;4973.234501751826;4986.47641997585;5054.924176137434;4726.740029298421;4932.630052745986;4944.233643785219;4974.651774375759;5000.024995125916;5080.618953578571;5081.898362032813;5100.62283183531;5161.225816127611;5175.741212939262;3689.520362352877;3728.179800443898;3731.235096805203;3734.831932562987;3746.1758413149064;4704.435467743892;4977.875553111201;5042.747862606929;5070.467600901852;5085.203138274009;4888.802243450377;4898.485659005753;4909.95090049095;4938.530839570235;4951.9752401237765;4857.255650557424;4895.755212239445;4896.461389247252;4929.926051109308;4950.727709975986;4841.419029716457;4852.514748525119;4924.291639598135;5135.409427915688;5491.450854914637;5625.212470254086;5629.802956896489;5630.943690563042;5646.971765141148;5650.463205995424;5460.5904557159165;5483.8080667176455;5516.172574113915;5539.559714474346;5557.527610153183 00:37:44 INFO - PROCESS | 5437 | |5;yui.html;685.6537448588462;695.8608278344333;754.7358424551404;773.3156156801231;773.570668279105;15287.388504459823;16634.66730665389;16651.50045498634;16737;16848.32606695732;14920.626984325398;15055.171965541891;15079.92460037701;15081.245937703126;15104.924475377607;642.3159335307905;654.3031671270082;776.9883451748228;783.3811289081633;802.506458528004;795.129333379948;798.0144521515953;799.1489064146695;799.8320352725934;800.0039950261933;851.2338894994492;856.6230858422274;857.8370109679172;858.3948316436897;858.4291446188278;694.260612447744;701.2531653788699;823.892893923792;840.2269911681268;853.6884037326362;611.4344231585766;613.932467428587;614.3027663601799;614.3457218062749;614.5237440983274;14605.78091328631;14634.268286585628;14689.559313220621;14714.779278310834;14749.852501475063;14004.92997535016;14119.505817296447;14426.422943082263;14546.636334091732;14605.853941460555;12842.550510732079;12929.612111636667;13138.86861131386;13235.938059790564;13401.597952061455;4255.851045213433;4321.286987647034;4329.5453977332245;4332.826686932519;4384.167008268419;78596.60701696512;79049;80419;80481.59759201224;80536;10418.426986515815;11161.274517156358;11239.325640461599;11319.717007074889;11456.713582160346;19867.503312417306;21233.78766212349;21238.46903827417;21244.25645102414;21364.679529807065;7970.2029797021;7973.401994850409;7977.441579089408;7979.122296547375;8350.4154709171;4522.4573051234065;4612.561806628365;4677.953220467752;4756.667033307635;4773.76131193439;3461.44616861301;3576.624454432299;3582.7671201371827;3690.741648084662;3736.1593641431004;610.9419605137593;618.0451202891543;622.7166639179162;643.6106155775782;669.9497537684693;623.6102435977514;729.7044696897765;739.5451797144717;750.8873668949701;782.4695015858118;9913.75215619601;9923.40459572428;10028.144793213132;10158.593656253815;10533.788614309453;690.4683393786756;690.5131882023162;699.5697645947705;723.8588475247382;734.8309888725623;4681.391419115494;4830.154722923475;4843.636727245471;4911.287863259808;4942.703437793743;65969.34030659728;111467.44266278617;119484.40257798655;122555.38722306331;126392;65717.34282657207;75278.61246243822;104435.21171124004;106126;108256;88353;88928.55535722409;90290.09709902816;93161.5341923286;96012.51993739986;9106.590203440728;9308.208802251613;9480.85778713306;9527.159240086086;9660.613575457184;40652.39021414622;44717.10565788731;52886;54308;54888.17667735067;46313;46522.53477465318;50794.492055078976;65323.020154698665;68676.96984545136;12534.122611417113;12758.48966041348;12832.29422381778;12971.740565188833;13235.933820330836;14622.926885365505;14751.704965900408;14952.925235373754;15076.396944122112;15084.170370629721;13448.193108413527;13458.66353341135;13569.1858488491;13575.728485430434;13948;13046.54337098197;13467.663308417368;13562.254076025913;13860.099093558887;13901.690475952488;12648.367581620698;12672.936635316764;12742.936285318514;12815.102942793916;13136.211827290394;10456.16350691958;11459.828102578302;11701.824472633087;11722.179447438597;11725.296482211095;11144.60993865211;11798.233114847508;12037.819432708691;12101.636950891487;12133.817992729939 00:37:44 INFO - PROCESS | 5437 | __end_tp_report 00:37:44 INFO - PROCESS | 5437 | __start_cc_report 00:37:44 INFO - PROCESS | 5437 | _x_x_mozilla_cycle_collect,1122 00:37:44 INFO - PROCESS | 5437 | __end_cc_report 00:37:44 INFO - PROCESS | 5437 | __startTimestamp1476257863992__endTimestamp 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | ------- Summary: start ------- 00:37:44 INFO - PROCESS | 5437 | Number of tests: 6 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#0] dojo.html Cycles:165 Average:5266.53 Median:5440.24 stddev:590.31 (10.9%) stddev-sans-first:563.23 00:37:44 INFO - PROCESS | 5437 | Values: 2941.2 2979.6 2998.1 3019.3 3054.4 5205.3 5232.8 5263.9 5327.0 5348.8 5291.2 5307.4 5312.8 5316.7 5323.2 4815.4 4843.2 4860.4 4895.9 4914.7 4904.9 4912.6 4940.0 4942.4 4944.9 4821.8 4839.6 4874.9 4885.1 4928.7 4896.9 4923.5 4929.1 4943.8 4998.4 4691.9 4740.8 4772.9 4832.3 4884.7 5242.3 5256.8 5257.3 5274.8 5349.9 5606.7 5675.2 5682.5 5682.6 5683.9 5402.8 5461.7 5630.9 5729.1 5782.4 5312.6 5333.2 5334.9 5377.5 5395.1 5793.6 5799.8 5802.5 5803.9 5804.7 5353.2 5457.4 5568.5 5571.0 5573.7 5566.6 5577.4 5610.2 5630.0 5703.5 5583.2 5625.5 5629.3 5634.3 5638.5 5523.8 5637.8 5639.0 5641.1 5646.4 4320.1 4351.1 4377.4 4382.4 4388.5 3861.1 3873.9 3880.3 3917.2 3923.8 5375.5 5387.2 5388.9 5390.3 5443.9 5386.3 5403.2 5663.4 5689.1 5711.3 5391.8 5392.6 5398.4 5438.6 5456.6 4902.5 4910.9 4912.1 4913.1 4927.1 5633.4 5635.6 5813.6 5870.0 5880.3 5706.6 5722.8 5728.6 5775.5 5791.9 5864.7 5866.3 5885.8 5895.7 5897.8 5488.2 5536.6 5635.4 5649.2 5650.5 5641.8 5664.0 5683.9 5687.1 5758.0 5497.6 5542.5 5565.2 5566.2 5573.0 5440.2 5485.1 5520.3 5543.3 5605.7 5419.3 5439.6 5458.8 5484.8 5573.5 5553.8 5584.9 5593.9 5598.4 5601.9 5344.3 5384.2 5384.7 5466.9 5479.5 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#1] ext.html Cycles:180 Average:54225.65 Median:172924.17 stddev:103406.61 (59.8%) stddev-sans-first:103618.18 00:37:44 INFO - PROCESS | 5437 | Values: 555.8 583.1 590.2 591.9 609.0 31109.0 43205.1 43523.6 43691.0 43750.3 44928.8 45181.1 45297.3 45298.1 45359.5 7873.2 8055.0 8847.8 9005.5 9005.6 10293.7 10544.2 10551.1 10909.9 10917.8 10715.0 10808.6 10815.6 10815.6 10821.2 10647.3 10699.4 10711.6 10738.2 10738.3 10504.3 10560.5 10569.7 10570.6 10574.4 41392.8 41665.2 41825.2 41825.4 41867.2 3327.2 3429.3 3448.8 3454.9 3477.4 31152.5 31712.0 31936.0 33193.0 33237.2 4239.4 4288.2 4315.9 4343.8 4455.2 337025.0 340216.7 341841.0 342179.0 342234.0 34722.7 58098.7 58371.7 58611.0 58636.1 35340.5 35380.3 35386.5 35414.8 35431.0 14940.0 15066.8 15079.7 15121.8 15136.8 9656.8 9748.9 11556.1 12157.6 12238.7 8452.5 8501.4 8503.0 8575.4 8585.8 3324.6 3337.1 3344.3 3365.6 3424.1 1005.9 1016.7 1050.8 1069.1 1076.8 30752.4 30804.7 30935.8 31138.5 31462.8 1013.5 1091.7 1100.3 1140.8 1160.1 16134.5 16484.7 16657.0 16721.7 16737.7 473595.0 475007.0 476019.0 477885.0 478965.0 56312.0 56736.7 56774.0 56817.1 56846.1 1145.8 1208.6 1211.8 1295.7 1312.5 26293.3 29615.4 31162.5 33586.8 33614.5 54112.5 54797.5 54812.2 54812.5 54843.5 337572.0 339465.0 341385.8 342165.0 342419.0 24503.4 25011.6 26441.6 28096.6 28280.7 40801.8 45555.8 45653.3 45669.5 47509.0 37475.1 39156.0 39333.6 40166.8 41401.0 39637.8 39763.2 40025.8 41079.0 41800.6 38218.8 39600.8 40248.2 40249.2 40297.8 33245.5 35924.5 36203.6 36520.6 37093.6 27198.3 27270.0 27450.3 27515.0 27714.9 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#2] jquery.html Cycles:180 Average:24071.43 Median:382.93 stddev:59728.30 (15597.7%) stddev-sans-first:59869.36 00:37:44 INFO - PROCESS | 5437 | Values: 380.7 385.2 387.5 397.5 407.3 17256.0 19428.5 19861.8 20075.6 20082.1 18589.6 18979.0 19214.0 19423.5 19460.5 5600.7 5603.0 5790.9 5859.3 5860.7 5727.1 5732.4 5779.0 5780.4 5783.3 5485.9 5612.5 5687.2 5741.8 5747.4 5687.0 5731.9 5735.4 5740.7 5747.0 5098.6 5153.3 5382.6 5430.4 5465.7 13948.7 14226.7 14226.9 20784.4 21379.8 2095.6 2098.8 2106.1 2293.0 2495.9 10157.0 10636.4 10684.9 10767.3 11068.7 1886.8 1896.1 1930.8 1938.7 1965.7 60318.4 63538.0 63680.7 83954.0 85481.0 9677.8 10419.7 10428.5 10525.9 10688.5 15592.2 15638.7 15639.0 15650.6 15654.5 7833.9 7888.5 8022.0 8158.8 8303.5 7747.9 7771.2 7919.2 7974.6 7986.5 4710.2 4722.8 4839.3 4850.9 4987.9 2014.6 2045.7 2052.9 2053.3 2058.2 826.5 906.9 949.8 1026.7 1068.4 17525.4 17895.3 18592.3 18794.7 18828.5 902.7 913.4 937.5 953.7 981.3 9759.5 10364.2 10502.3 10598.7 10611.8 303719.0 309678.0 309704.0 426999.0 427352.0 57414.7 57669.4 72014.6 79376.0 89707.0 949.1 1003.9 1016.3 1024.3 1041.2 12878.4 15714.8 15743.8 16543.4 17104.0 38684.0 39089.4 39171.8 40216.4 41738.2 56897.4 58004.1 58156.0 58234.0 59467.0 8662.1 8663.2 8704.5 8797.7 8896.6 9917.6 13202.6 13205.5 13241.2 13605.6 11288.4 11399.4 11549.6 11862.8 12295.0 10969.7 11253.8 11283.4 11518.7 11586.5 11709.6 11900.9 11986.1 12107.6 12267.7 8572.6 8655.8 8662.8 8849.1 8966.0 8664.8 10464.1 11039.0 11379.7 11766.9 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#3] mootools.html Cycles:180 Average:5774.49 Median:5228.70 stddev:3257.61 (62.3%) stddev-sans-first:3250.42 00:37:44 INFO - PROCESS | 5437 | Values: 1435.1 1481.3 1599.5 1700.8 1740.2 7553.5 7857.0 8236.9 9257.9 9275.5 8302.4 8585.6 8600.4 9122.1 9159.0 2311.5 2338.4 2340.4 2340.4 2341.3 2026.9 2315.4 2333.5 2339.4 2357.6 2038.3 2244.6 2321.0 2327.3 2336.6 2261.2 2273.6 2279.1 2281.5 2295.0 2259.5 2266.1 2276.0 2278.5 2289.8 8786.0 8837.1 8851.6 8857.9 8868.4 5151.7 5193.4 5232.2 5246.7 5273.1 3307.2 3327.7 3373.3 3382.6 3391.3 1062.4 1072.9 1073.2 1079.5 1090.1 11637.7 11733.1 11738.2 11771.6 11772.9 4423.7 4483.9 4661.6 4675.3 4710.4 9920.0 9946.7 9950.9 9954.4 9959.1 5234.6 5259.8 5275.9 5318.1 5318.3 4742.1 4822.0 4827.9 4848.4 4852.3 3806.4 3870.5 3889.5 3895.1 3933.2 1122.2 1160.9 1161.1 1261.1 1268.9 869.1 925.3 970.5 973.0 977.8 5829.5 5991.7 6129.9 6183.4 6267.7 937.8 938.1 944.3 960.9 974.7 4110.4 4162.1 4181.3 4199.5 4227.4 10522.2 11015.6 11018.3 11021.3 11033.7 10564.2 10881.0 10982.0 11033.4 11047.9 8175.0 8196.8 8268.6 8279.1 8329.9 5836.1 5836.3 5857.6 6003.0 6044.9 9715.8 9882.4 9934.3 9992.0 10030.5 9782.9 10010.5 10146.6 10225.5 10324.8 7574.5 7752.0 7856.2 7902.0 8100.0 8667.7 8749.4 8762.6 8762.8 8770.2 7662.5 7736.3 7892.0 8028.4 8045.9 7494.7 7500.8 7618.7 7763.3 7769.1 6909.1 7006.7 7011.6 7012.5 7030.4 5130.8 5143.6 5150.2 5250.5 5457.5 5225.2 5245.0 5263.7 5296.7 5472.7 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#4] prototype.html Cycles:180 Average:4432.83 Median:4917.12 stddev:1260.09 (25.6%) stddev-sans-first:1225.45 00:37:44 INFO - PROCESS | 5437 | Values: 331.7 332.7 339.4 342.2 343.0 5158.4 5303.9 5335.2 5374.1 5420.7 5076.6 5214.7 5231.9 5239.8 5240.0 4142.5 4166.3 4187.9 4189.1 4211.7 3980.5 4137.3 4154.8 4173.7 4200.8 4130.8 4135.1 4138.7 4144.3 4145.1 4112.5 4123.3 4126.3 4128.2 4135.7 3646.3 3649.5 3652.5 3655.2 3665.3 5146.6 5167.3 5196.0 5219.5 5224.1 4760.3 4779.5 4783.2 4790.4 4796.6 5424.6 5582.7 5601.3 5627.4 5628.8 3997.2 4000.8 4019.8 4031.4 4050.7 5717.7 5754.9 5755.1 5757.0 5766.1 4069.7 4099.3 4111.0 4122.5 4136.8 4017.3 4151.2 4160.0 4160.3 4179.4 4728.6 4754.1 4763.1 4790.8 4791.8 5564.7 5569.2 5575.9 5589.2 5625.2 1327.8 1338.8 1413.2 1417.8 1425.3 883.9 907.7 918.6 923.0 923.8 4676.6 4728.2 4753.4 4755.6 4759.2 5050.3 5058.9 5069.6 5080.4 5088.5 4446.0 4779.7 4793.9 4794.9 4809.2 2640.7 2658.8 2671.6 2685.3 2694.2 5136.5 5162.5 5163.3 5170.7 5180.5 4759.0 5084.8 5102.4 5160.9 5169.4 5079.2 5117.4 5131.9 5142.8 5180.4 4962.0 4965.9 4973.2 4986.5 5054.9 4726.7 4932.6 4944.2 4974.7 5000.0 5080.6 5081.9 5100.6 5161.2 5175.7 3689.5 3728.2 3731.2 3734.8 3746.2 4704.4 4977.9 5042.7 5070.5 5085.2 4888.8 4898.5 4910.0 4938.5 4952.0 4857.3 4895.8 4896.5 4929.9 4950.7 4841.4 4852.5 4924.3 5135.4 5491.5 5625.2 5629.8 5630.9 5647.0 5650.5 5460.6 5483.8 5516.2 5539.6 5557.5 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - PROCESS | 5437 | [#5] yui.html Cycles:180 Average:20156.58 Median:24550.64 stddev:29007.35 (118.2%) stddev-sans-first:29051.88 00:37:44 INFO - PROCESS | 5437 | Values: 685.7 695.9 754.7 773.3 773.6 15287.4 16634.7 16651.5 16737.0 16848.3 14920.6 15055.2 15079.9 15081.2 15104.9 642.3 654.3 777.0 783.4 802.5 795.1 798.0 799.1 799.8 800.0 851.2 856.6 857.8 858.4 858.4 694.3 701.3 823.9 840.2 853.7 611.4 613.9 614.3 614.3 614.5 14605.8 14634.3 14689.6 14714.8 14749.9 14004.9 14119.5 14426.4 14546.6 14605.9 12842.6 12929.6 13138.9 13235.9 13401.6 4255.9 4321.3 4329.5 4332.8 4384.2 78596.6 79049.0 80419.0 80481.6 80536.0 10418.4 11161.3 11239.3 11319.7 11456.7 19867.5 21233.8 21238.5 21244.3 21364.7 7970.2 7973.4 7977.4 7979.1 8350.4 4522.5 4612.6 4678.0 4756.7 4773.8 3461.4 3576.6 3582.8 3690.7 3736.2 610.9 618.0 622.7 643.6 669.9 623.6 729.7 739.5 750.9 782.5 9913.8 9923.4 10028.1 10158.6 10533.8 690.5 690.5 699.6 723.9 734.8 4681.4 4830.2 4843.6 4911.3 4942.7 65969.3 111467.4 119484.4 122555.4 126392.0 65717.3 75278.6 104435.2 106126.0 108256.0 88353.0 88928.6 90290.1 93161.5 96012.5 9106.6 9308.2 9480.9 9527.2 9660.6 40652.4 44717.1 52886.0 54308.0 54888.2 46313.0 46522.5 50794.5 65323.0 68677.0 12534.1 12758.5 12832.3 12971.7 13235.9 14622.9 14751.7 14952.9 15076.4 15084.2 13448.2 13458.7 13569.2 13575.7 13948.0 13046.5 13467.7 13562.3 13860.1 13901.7 12648.4 12672.9 12742.9 12815.1 13136.2 10456.2 11459.8 11701.8 11722.2 11725.3 11144.6 11798.2 12037.8 12101.6 12133.8 00:37:44 INFO - PROCESS | 5437 | -------- Summary: end -------- 00:37:44 INFO - PROCESS | 5437 | 00:37:44 INFO - TEST-INFO | 5437: exit 0 00:37:44 INFO - TEST-OK | dromaeo_css | took 1116943ms 00:37:44 INFO - TEST-START | kraken 00:37:44 INFO - operating with platform_type : linux_ 00:37:44 INFO - Initialising browser for kraken test... 00:37:44 INFO - TEST-INFO | started process 5744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHI_0Iy/profile http://localhost:58393/getInfo.html) 00:37:49 INFO - PROCESS | 5744 | __metrics Screen width/height:1600/1200 00:37:49 INFO - PROCESS | 5744 | colorDepth:24 00:37:49 INFO - PROCESS | 5744 | Browser inner width/height: 1024/697 00:37:49 INFO - PROCESS | 5744 | __metrics 00:37:49 INFO - PROCESS | 5744 | 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" 00:37:49 INFO - PROCESS | 5744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:37:50 INFO - PROCESS | 5744 | console.error: PushService: 00:37:50 INFO - PROCESS | 5744 | stateChangeProcessEnqueue: Error transitioning state 00:37:50 INFO - PROCESS | 5744 | UnknownError 00:37:50 INFO - TEST-INFO | 5744: exit 0 00:37:50 INFO - Browser initialized. 00:37:50 INFO - Running cycle 1/1 for kraken test... 00:37:50 INFO - TEST-INFO | started process 5825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHI_0Iy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:02 INFO - PROCESS | 5825 | RSS: Main: 172728320 00:38:02 INFO - PROCESS | 5825 | 00:38:05 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-beat-detection) 00:38:06 INFO - PROCESS | 5825 | RSS: Main: 231022592 00:38:06 INFO - PROCESS | 5825 | 00:38:08 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-dft) 00:38:09 INFO - PROCESS | 5825 | RSS: Main: 216227840 00:38:09 INFO - PROCESS | 5825 | 00:38:12 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-fft) 00:38:13 INFO - PROCESS | 5825 | RSS: Main: 298008576 00:38:13 INFO - PROCESS | 5825 | 00:38:15 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-oscillator) 00:38:15 INFO - PROCESS | 5825 | RSS: Main: 206753792 00:38:15 INFO - PROCESS | 5825 | 00:38:18 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:38:18 INFO - PROCESS | 5825 | RSS: Main: 212299776 00:38:18 INFO - PROCESS | 5825 | 00:38:21 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-darkroom) 00:38:22 INFO - PROCESS | 5825 | RSS: Main: 248606720 00:38:22 INFO - PROCESS | 5825 | 00:38:25 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-desaturate) 00:38:26 INFO - PROCESS | 5825 | RSS: Main: 247848960 00:38:26 INFO - PROCESS | 5825 | 00:38:29 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58393/tests/kraken/driver.html?testName=json-parse-financial) 00:38:29 INFO - PROCESS | 5825 | RSS: Main: 247541760 00:38:29 INFO - PROCESS | 5825 | 00:38:31 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:38:31 INFO - PROCESS | 5825 | RSS: Main: 209362944 00:38:31 INFO - PROCESS | 5825 | 00:38:33 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:38:34 INFO - PROCESS | 5825 | RSS: Main: 217096192 00:38:34 INFO - PROCESS | 5825 | 00:38:36 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:38:36 INFO - PROCESS | 5825 | RSS: Main: 226545664 00:38:36 INFO - PROCESS | 5825 | 00:38:39 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:38:40 INFO - PROCESS | 5825 | RSS: Main: 235159552 00:38:40 INFO - PROCESS | 5825 | 00:38:42 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:38:43 INFO - PROCESS | 5825 | RSS: Main: 231907328 00:38:43 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58393/tests/kraken/driver.html?testName=ai-astar) 00:38:45 INFO - PROCESS | 5825 | RSS: Main: 283193344 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | __start_tp_report 00:38:45 INFO - PROCESS | 5825 | _x_x_mozilla_page_load 00:38:45 INFO - PROCESS | 5825 | _x_x_mozilla_page_load_details 00:38:45 INFO - PROCESS | 5825 | |i|pagename|runs| 00:38:45 INFO - PROCESS | 5825 | |0;ai-astar;109;110;110;110;112;109;111;109;109;109 00:38:45 INFO - PROCESS | 5825 | |1;audio-beat-detection;145;128;122;164;123;122;127;127;154;129 00:38:45 INFO - PROCESS | 5825 | |2;audio-dft;160;160;161;161;162;162;160;159;160;162 00:38:45 INFO - PROCESS | 5825 | |3;audio-fft;75;74;76;111;77;75;76;76;126;76 00:38:45 INFO - PROCESS | 5825 | |4;audio-oscillator;83;82;111;83;82;81;100;82;81;115 00:38:45 INFO - PROCESS | 5825 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;118;117 00:38:45 INFO - PROCESS | 5825 | |6;imaging-darkroom;146;146;146;146;146;145;147;147;146;145 00:38:45 INFO - PROCESS | 5825 | |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 00:38:45 INFO - PROCESS | 5825 | |8;json-parse-financial;53;51;50;50;50;51;51;51;51;52 00:38:45 INFO - PROCESS | 5825 | |9;json-stringify-tinderbox;61;62;62;62;62;61;62;61;64;62 00:38:45 INFO - PROCESS | 5825 | |10;stanford-crypto-aes;79;79;81;79;78;78;79;78;78;78 00:38:45 INFO - PROCESS | 5825 | |11;stanford-crypto-ccm;141;130;138;129;133;130;130;131;173;129 00:38:45 INFO - PROCESS | 5825 | |12;stanford-crypto-pbkdf2;166;166;164;167;163;166;164;171;163;168 00:38:45 INFO - PROCESS | 5825 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;65;66;66;67;63 00:38:45 INFO - PROCESS | 5825 | __end_tp_report 00:38:45 INFO - PROCESS | 5825 | __start_cc_report 00:38:45 INFO - PROCESS | 5825 | _x_x_mozilla_cycle_collect,1662 00:38:45 INFO - PROCESS | 5825 | __end_cc_report 00:38:45 INFO - PROCESS | 5825 | __startTimestamp1476257925367__endTimestamp 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | ------- Summary: start ------- 00:38:45 INFO - PROCESS | 5825 | Number of tests: 14 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 00:38:45 INFO - PROCESS | 5825 | Values: 109.0 110.0 110.0 110.0 112.0 109.0 111.0 109.0 109.0 109.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:128.50 stddev:14.87 (11.6%) stddev-sans-first:15.24 00:38:45 INFO - PROCESS | 5825 | Values: 145.0 128.0 122.0 164.0 123.0 122.0 127.0 127.0 154.0 129.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 00:38:45 INFO - PROCESS | 5825 | Values: 160.0 160.0 161.0 161.0 162.0 162.0 160.0 159.0 160.0 162.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:18.44 (24.3%) stddev-sans-first:19.25 00:38:45 INFO - PROCESS | 5825 | Values: 75.0 74.0 76.0 111.0 77.0 75.0 76.0 76.0 126.0 76.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:13.41 (16.4%) stddev-sans-first:13.98 00:38:45 INFO - PROCESS | 5825 | Values: 83.0 82.0 111.0 83.0 82.0 81.0 100.0 82.0 81.0 115.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:38:45 INFO - PROCESS | 5825 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 00:38:45 INFO - PROCESS | 5825 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 147.0 147.0 146.0 145.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:38:45 INFO - PROCESS | 5825 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:0.67 00:38:45 INFO - PROCESS | 5825 | Values: 53.0 51.0 50.0 50.0 50.0 51.0 51.0 51.0 51.0 52.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 00:38:45 INFO - PROCESS | 5825 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 62.0 61.0 64.0 62.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 00:38:45 INFO - PROCESS | 5825 | Values: 79.0 79.0 81.0 79.0 78.0 78.0 79.0 78.0 78.0 78.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:132.00 stddev:13.48 (10.2%) stddev-sans-first:14.20 00:38:45 INFO - PROCESS | 5825 | Values: 141.0 130.0 138.0 129.0 133.0 130.0 130.0 131.0 173.0 129.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:2.49 (1.5%) stddev-sans-first:2.64 00:38:45 INFO - PROCESS | 5825 | Values: 166.0 166.0 164.0 167.0 163.0 166.0 164.0 171.0 163.0 168.0 00:38:45 INFO - PROCESS | 5825 | 00:38:45 INFO - PROCESS | 5825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.27 00:38:45 INFO - PROCESS | 5825 | Values: 68.0 66.0 67.0 67.0 66.0 65.0 66.0 66.0 67.0 63.0 00:38:45 INFO - PROCESS | 5825 | -------- Summary: end -------- 00:38:45 INFO - PROCESS | 5825 | 00:38:46 INFO - TEST-INFO | 5825: exit 0 00:38:46 INFO - TEST-OK | kraken | took 61711ms 00:38:46 INFO - SUITE-END | took 1178s 00:38:47 INFO - Completed test suite (00:19:39) 00:38:47 INFO - javascript benchmark 00:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2941.176470588236, 2979.6126503554533, 2998.1155559110075, 3019.305559721264, 3054.358584697214, 5205.3233079699585, 5232.790688372465, 5263.86840328992, 5326.9733651331735, 5348.759305831237, 5291.206319052144, 5307.442718514559, 5312.787488500456, 5316.680999140054, 5323.228131920879, 4815.398075240586, 4843.200871856139, 4860.368152140217, 4895.898422854865, 4914.680545764514, 4904.901901961958, 4912.557869791718, 4939.950600494003, 4942.382202224722, 4944.87637809054, 4821.831235906744, 4839.5644392004715, 4874.878128046809, 4885.145099607572, 4928.728919909404, 4896.853094407174, 4923.48303428142, 4929.137400954819, 4943.826966056171, 4998.40019197695, 4691.906161876777, 4740.810367585293, 4772.928406073912, 4832.347633069526, 4884.7069175849565, 5242.292290540767, 5256.763445644955, 5257.263983042377, 5274.841754747364, 5349.946500534984, 5606.719664016783, 5675.2054712340305, 5682.516986056149, 5682.573806964494, 5683.857903552403, 5402.837914862521, 5461.69960652164, 5630.887382252332, 5729.1119876419225, 5782.392848750863, 5312.601554883399, 5333.226682131147, 5334.91997620036, 5377.489138531794, 5395.109806881821, 5793.623414478046, 5799.826005219766, 5802.535797136219, 5803.912941305884, 5804.651720896675, 5353.223782551586, 5457.426970168154, 5568.498835104779, 5570.997220500268, 5573.693446860461, 5566.6381685191145, 5577.358603760538, 5610.158476228598, 5630.0, 5703.486686198262, 5583.162525621108, 5625.46558076982, 5629.296337957755, 5634.267545219095, 5638.520725738276, 5523.7790488380815, 5637.830865074055, 5638.97180514103, 5641.069223578145, 5646.435356464321, 4320.1143765527995, 4351.086271882877, 4377.409049778303, 4382.408374869416, 4388.495323037828, 3861.131245469803, 3873.8837834865, 3880.3015457217407, 3917.1578110705764, 3923.7841918694744, 5375.5162035416215, 5387.218853266255, 5388.91916621251, 5390.299261096111, 5443.918341224885, 5386.299781028441, 5403.162509810907, 5663.405342438985, 5689.061304884648, 5711.343195532484, 5391.81128660495, 5392.595555333366, 5398.433164517748, 5438.564914806885, 5456.563474921997, 4902.509749025069, 4910.852674419773, 4912.066707325596, 4913.06651736169, 4927.1131196384995, 5633.436656334334, 5635.605507614428, 5813.6221145625395, 5870.0, 5880.323762767251, 5706.600537962303, 5722.799702010409, 5728.570357223141, 5775.537956963517, 5791.942080579309, 5864.736086876186, 5866.325372582208, 5885.823425297248, 5895.67573783446, 5897.764089436375, 5488.231647569263, 5536.557075434036, 5635.380108188014, 5649.20911072442, 5650.547956163579, 5641.802536911188, 5664.0, 5683.857903552444, 5687.146927960839, 5758.0499217630295, 5497.642653227527, 5542.528885044816, 5565.193047008081, 5566.165075238747, 5573.0, 5440.238366628596, 5485.067538518541, 5520.282363292747, 5543.279373681396, 5605.691686957093, 5419.268398766116, 5439.646422982493, 5458.836234912959, 5484.753186106715, 5573.498385145356, 5553.8333849984565, 5584.916226256691, 5593.916091258716, 5598.440155984369, 5601.915971260516, 5344.331958505187, 5384.219288203267, 5384.6769193848495, 5466.8906621866545, 5479.479449452296], "value": 5226.4889449299, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7577486401149, 583.131134609432, 590.1884908251154, 591.9200907877437, 608.9543284253681, 31109.0, 43205.13589728204, 43523.56476435235, 43691.0, 43750.34374484381, 44928.77535612325, 45181.09637807242, 45297.320540191926, 45298.09403811922, 45359.54640453595, 7873.212678732139, 8055.0, 8847.823043539109, 9005.54972251388, 9005.639774409015, 10293.691189264335, 10544.15646748262, 10551.10315623173, 10909.890901090967, 10917.781644367107, 10715.035646791786, 10808.567657293699, 10815.621453249138, 10815.621453249138, 10821.188410869177, 10647.254692171551, 10699.411532365717, 10711.625093121782, 10738.248322617419, 10738.30201036934, 10504.317219380715, 10560.47197640115, 10569.682909512727, 10570.577176912915, 10574.365538067663, 41392.79303603493, 41665.1666966662, 41825.163496729896, 41825.37261941074, 41867.162656747, 3327.236564620755, 3429.3484237994703, 3448.827558622084, 3454.896353109411, 3477.3566890125153, 31152.53271200934, 31712.0, 31936.0, 33193.0, 33237.16907077318, 4239.385289133058, 4288.16380805743, 4315.870523884289, 4343.804528796211, 4455.22033644111, 337025.0, 340216.66858305654, 341841.0, 342179.0, 342234.0, 34722.652773472444, 58098.7095064522, 58371.70814145902, 58611.0, 58636.06819659, 35340.46989295162, 35380.29239415197, 35386.46920296198, 35414.82292588521, 35431.0, 14940.0, 15066.773998390034, 15079.698406032037, 15121.773173402407, 15136.848631513763, 9656.75858103539, 9748.853767193497, 11556.075513959031, 12157.574484892986, 12238.694032649077, 8452.450590711584, 8501.362397820189, 8503.0, 8575.399722019523, 8585.828283434297, 3324.5511855899144, 3337.0656216259486, 3344.2642618623863, 3365.6129545102135, 3424.092615456906, 1005.939643621385, 1016.7254841192837, 1050.810854046279, 1069.0989661733493, 1076.805510068379, 30752.38495230083, 30804.691953080182, 30935.845320773704, 31138.532922006187, 31462.842685786425, 1013.4527355228241, 1091.7270682329417, 1100.2573263047411, 1140.7604403075281, 1160.1356989043047, 16134.480656412772, 16484.6703065938, 16657.0, 16721.749173762404, 16737.748933766004, 473595.0, 475007.0, 476019.0, 477885.0, 478965.0, 56312.0, 56736.71631641898, 56774.0, 56817.14774278389, 56846.147307790416, 1145.7823013627385, 1208.6011616166468, 1211.7515909238762, 1295.6631275868153, 1312.5143696832042, 26293.342666432727, 29615.407691845612, 31162.532562011136, 33586.83206583952, 33614.49578256377, 54112.45887541074, 54797.45202548083, 54812.17781733357, 54812.451875480736, 54843.45156548543, 337572.0, 339465.0, 341385.8099223642, 342165.0, 342419.0, 24503.38741531476, 25011.624825627267, 26441.603375949762, 28096.64502002193, 28280.71719282863, 40801.795991019855, 45555.77222113868, 45653.315200272686, 45669.54330456786, 47509.0, 37475.06312342213, 39156.0, 39333.606663932995, 40166.799166003984, 41401.0, 39637.80181099076, 39763.204735905696, 40025.799871001625, 41079.0, 41800.58199418089, 38218.808905955295, 39600.80199598984, 40248.1950360997, 40249.19501609893, 40297.798511007255, 33245.50131747977, 35924.4611330825, 36203.63796362003, 36520.63479365279, 37093.62906370902, 27198.320041999108, 27270.0, 27450.313742156606, 27515.0, 27714.861425692743], "value": 18715.317207315464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6669164481078, 385.1930206217974, 387.4517557655917, 397.5190020075708, 407.33400889545624, 17256.0, 19428.514287142792, 19861.801381986177, 20075.59848803023, 20082.096305666244, 18589.60577956652, 18979.0, 19214.0, 19423.514412139702, 19460.51348716283, 5600.663960162403, 5602.971985140069, 5790.942090579104, 5859.296884373881, 5860.706964651772, 5727.112297593859, 5732.369439361667, 5778.971105144468, 5780.393058728836, 5783.334916484616, 5485.890282194354, 5612.466815652527, 5687.17535957286, 5741.770329186827, 5747.42525747424, 5687.0, 5731.914021289684, 5735.397783232784, 5740.712964351807, 5747.0, 5098.643094983316, 5153.304303918998, 5382.6232163748555, 5430.3755068167275, 5465.699386533739, 13948.651283717887, 14226.715465690628, 14226.92886535571, 20784.376468705963, 21379.786202137933, 2095.5808838232415, 2098.8320934325216, 2106.104905415192, 2293.048384920256, 2495.8752062396807, 10157.0, 10636.414997175152, 10684.893151068467, 10767.300125491818, 11068.667939961813, 1886.7735871695347, 1896.0709252466331, 1930.7779605345424, 1938.709193620954, 1965.7346258255238, 60318.39681603215, 63538.0, 63680.68159659265, 83954.0, 85481.0, 9677.758056048515, 10419.687409377731, 10428.478576071166, 10525.947370263253, 10688.51901664427, 15592.220388980733, 15638.687226255412, 15639.0, 15650.608734781494, 15654.45209417665, 7833.897371320667, 7888.48724832884, 8022.0, 8158.83682326362, 8303.501789892505, 7747.883781743279, 7771.222877712296, 7919.20807919215, 7974.60126993648, 7986.480878742979, 4710.152172608895, 4722.787474563653, 4839.322494850724, 4850.927236091461, 4987.905079866465, 2014.617222727677, 2045.6829191475344, 2052.9486762831048, 2053.2813515269536, 2058.217877206652, 826.4834478450969, 906.9252935271724, 949.7720547068653, 1026.7298653787561, 1068.3589846092439, 17525.38661146879, 17895.284188632308, 18592.349267775564, 18794.718079228824, 18828.52928676794, 902.6930843513237, 913.3878704087291, 937.5234006439885, 953.7186529973675, 981.3326937682444, 9759.463229522444, 10364.170866330676, 10502.317349372266, 10598.735031624272, 10611.84082238767, 303719.0, 309678.0, 309704.0, 426999.0, 427352.0, 57414.7129264351, 57669.423305767246, 72014.63992680107, 79376.0, 89707.0, 949.0699114867331, 1003.859459675646, 1016.2632091733434, 1024.2778840917135, 1041.1982773264544, 12878.356082195665, 15714.76427853606, 15743.842561574238, 16543.420980266113, 17103.973761574347, 38684.0, 39089.41365879457, 39171.80414098025, 40216.396754048124, 41738.165236695706, 56897.43102569087, 58004.12993805012, 58156.0, 58234.0, 59467.0, 8662.133786621287, 8663.220310172115, 8704.477731336141, 8797.692080777142, 8896.599653015759, 9917.553710082919, 13202.603921882359, 13205.537806176737, 13241.205527668371, 13605.591832244652, 11288.429359906162, 11399.373034483184, 11549.595764148215, 11862.82205766897, 12295.0, 10969.725756856142, 11253.7749245013, 11283.379414132301, 11518.712032198926, 11586.536538538365, 11709.590164344207, 11900.940495297467, 11986.101042422028, 12107.576234831738, 12267.69330766738, 8572.614232359434, 8655.826883462421, 8662.82674346497, 8849.115088491099, 8966.0, 8664.82670346577, 10464.058234758908, 11039.0, 11379.658610241706, 11766.941165294118], "value": 8839.303408452262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.11740279728, 1481.251967756283, 1599.4561848971348, 1700.7959044914612, 1740.208205266603, 7553.546787192772, 7856.9607151964165, 8236.91763082369, 9257.907420925789, 9275.53622318884, 8302.41883068184, 8585.613647385868, 8600.397972141953, 9122.087791220874, 9158.954205228982, 2311.4683622766775, 2338.3920180752957, 2340.356401989458, 2340.4031971847157, 2341.274204996448, 2026.9493262668404, 2315.3979965209082, 2333.474968132165, 2339.3800642829665, 2357.634566642173, 2038.337540299401, 2244.5735310290993, 2321.025169428844, 2327.290176496168, 2336.649502574619, 2261.21987914171, 2273.5793878132517, 2279.122537822942, 2281.498070424504, 2294.9770502295096, 2259.45773014477, 2266.1275408967504, 2276.032686108414, 2278.498730279336, 2289.8053665438456, 8786.0, 8837.116288371175, 8851.64593416269, 8857.867131993025, 8868.423552469068, 5151.716655583941, 5193.350831146106, 5232.162853943389, 5246.658967167122, 5273.050850846846, 3307.206270495088, 3327.73378129749, 3373.325334932999, 3382.6109997350372, 3391.3217356528794, 1062.383817385922, 1072.903438690514, 1073.2272763610188, 1079.4602698650674, 1090.1224514266012, 11637.70905727355, 11733.12001599875, 11738.237014594024, 11771.646850594496, 11772.882271177265, 4423.6903416760515, 4483.892570491864, 4661.603763680125, 4675.3220782986955, 4710.364100846342, 9920.0, 9946.651867184759, 9950.900490995142, 9954.402735835729, 9959.103680668775, 5234.607404444682, 5259.76331065103, 5275.947240527622, 5318.122509785842, 5318.282031925641, 4742.146413645577, 4821.975890120527, 4827.903441931142, 4848.369711937426, 4852.272159176152, 3806.410006449005, 3870.4968354113785, 3889.4943657324366, 3895.1235971906663, 3933.2330195612153, 1122.1583812140893, 1160.9245399049034, 1161.1349544589334, 1261.1172179474404, 1268.8604253532103, 869.096140014378, 925.2921515040999, 970.5292932927524, 972.9902700973041, 977.8044391121804, 5829.533637309005, 5991.670458124845, 6129.877402452015, 6183.412575805291, 6267.709959335397, 937.8311903857372, 938.0994245524237, 944.3342443577261, 960.8846938367441, 974.6637410093506, 4110.383442483651, 4162.105147393265, 4181.330987042059, 4199.475065616798, 4227.365895115758, 10522.158227341793, 11015.559377624966, 11018.338899666045, 11021.338719676845, 11033.668989930315, 10564.154867610572, 10881.0, 10982.0, 11033.448327583588, 11047.944760276147, 8174.959125204336, 8196.754097376968, 8268.586570671321, 8279.130691277449, 8329.916700833035, 5836.095405212199, 5836.299644042742, 5857.648541087548, 6002.969985150221, 6044.90932636002, 9715.805683886141, 9882.357646752938, 9934.254930880357, 9992.0, 10030.548625311732, 9782.85325720129, 10010.549525271526, 10146.594136234764, 10225.48872556384, 10324.793504130026, 7574.545527268381, 7752.0, 7856.214378562098, 7902.0, 8100.0, 8667.696630617898, 8749.387542872193, 8762.561871906251, 8762.824743504967, 8770.166834150745, 7662.501937374052, 7736.2650548197835, 7892.0, 8028.43800933929, 8045.919540804751, 7494.662740176596, 7500.849983000418, 7618.733344332922, 7763.340116090196, 7769.106552746506, 6909.136357955255, 7006.719731210695, 7011.579305241702, 7012.474064445289, 7030.367266945999, 5130.846074617767, 5143.588512918883, 5150.175971844487, 5250.474952504872, 5457.508824205841, 5225.242339860622, 5245.003449344612, 5263.6578622389425, 5296.655717378358, 5472.671639701631], "value": 4614.8547444024825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.7495291055254, 332.71903172784783, 339.4263694356537, 342.18047775577475, 343.0001545494882, 5158.380994280692, 5303.946960530394, 5335.173048177529, 5374.071131233477, 5420.701861397626, 5076.603933918174, 5214.687118772877, 5231.947680523193, 5239.842804715865, 5240.0, 4142.461480007595, 4166.270902592049, 4187.874363769077, 4189.120284740208, 4211.705180637349, 3980.5024371953505, 4137.338025915854, 4154.8130334134885, 4173.749575025508, 4200.810963506634, 4130.760771768458, 4135.0978549867095, 4138.668906487489, 4144.254034273829, 4145.129522800215, 4112.465379500661, 4123.299039163349, 4126.319157339036, 4128.236276288896, 4135.66914646829, 3646.2889736501393, 3649.543807024122, 3652.4886515887797, 3655.1958569114754, 3665.259001974068, 5146.639735218536, 5167.328247327823, 5195.974020129913, 5219.530242278213, 5224.085784987612, 4760.309755085528, 4779.545943135397, 4783.162946484351, 4790.449098353664, 4796.56830885222, 5424.562490939904, 5582.665040097567, 5601.29983752031, 5627.437256274381, 5628.774849006035, 3997.1805779815068, 4000.8199631016673, 4019.799010049486, 4031.4154447604933, 4050.696197785178, 5717.656940583578, 5754.935336962633, 5755.107958266475, 5756.971215143939, 5766.135079738073, 4069.694772892045, 4099.262132816122, 4110.979445102756, 4122.525909520384, 4136.793160341971, 4017.31705610047, 4151.232022075926, 4160.0, 4160.3343465046055, 4179.373094035919, 4728.645351598644, 4754.096721622881, 4763.118823017753, 4790.8323208687525, 4791.808327666924, 5564.66612003273, 5569.164625306155, 5575.8884822304135, 5589.245451863946, 5625.156226565966, 1327.81824176483, 1338.8259526261718, 1413.1662319231702, 1417.7944198091218, 1425.3181246129666, 883.9204471597587, 907.6823111910778, 918.6233644205844, 922.9769255768659, 923.831353338028, 4676.573645038228, 4728.243481043085, 4753.358296629911, 4755.643326750507, 4759.16714574948, 5050.292958985745, 5058.949410505921, 5069.645124841226, 5080.441151473335, 5088.465711100355, 4445.977080428397, 4779.689320194177, 4793.856184314476, 4794.9280760788615, 4809.196551293265, 2640.735926407344, 2658.800589955761, 2671.572548392248, 2685.328667833042, 2694.205209463213, 5136.512031357015, 5162.483751624807, 5163.251328557338, 5170.715610641376, 5180.507851754077, 4759.001219487824, 5084.822031228963, 5102.413222479388, 5160.92258616121, 5169.405518365361, 5079.187330027252, 5117.360329958829, 5131.948680513147, 5142.768575414116, 5180.404253510895, 4961.950380496149, 4965.857852693973, 4973.234501751826, 4986.47641997585, 5054.924176137434, 4726.740029298421, 4932.630052745986, 4944.233643785219, 4974.651774375759, 5000.024995125916, 5080.618953578571, 5081.898362032813, 5100.62283183531, 5161.225816127611, 5175.741212939262, 3689.520362352877, 3728.179800443898, 3731.235096805203, 3734.831932562987, 3746.1758413149064, 4704.435467743892, 4977.875553111201, 5042.747862606929, 5070.467600901852, 5085.203138274009, 4888.802243450377, 4898.485659005753, 4909.95090049095, 4938.530839570235, 4951.9752401237765, 4857.255650557424, 4895.755212239445, 4896.461389247252, 4929.926051109308, 4950.727709975986, 4841.419029716457, 4852.514748525119, 4924.291639598135, 5135.409427915688, 5491.450854914637, 5625.212470254086, 5629.802956896489, 5630.943690563042, 5646.971765141148, 5650.463205995424, 5460.5904557159165, 5483.8080667176455, 5516.172574113915, 5539.559714474346, 5557.527610153183], "value": 4036.8909540771942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.6537448588462, 695.8608278344333, 754.7358424551404, 773.3156156801231, 773.570668279105, 15287.388504459823, 16634.66730665389, 16651.50045498634, 16737.0, 16848.32606695732, 14920.626984325398, 15055.171965541891, 15079.92460037701, 15081.245937703126, 15104.924475377607, 642.3159335307905, 654.3031671270082, 776.9883451748228, 783.3811289081633, 802.506458528004, 795.129333379948, 798.0144521515953, 799.1489064146695, 799.8320352725934, 800.0039950261933, 851.2338894994492, 856.6230858422274, 857.8370109679172, 858.3948316436897, 858.4291446188278, 694.260612447744, 701.2531653788699, 823.892893923792, 840.2269911681268, 853.6884037326362, 611.4344231585766, 613.932467428587, 614.3027663601799, 614.3457218062749, 614.5237440983274, 14605.78091328631, 14634.268286585628, 14689.559313220621, 14714.779278310834, 14749.852501475063, 14004.92997535016, 14119.505817296447, 14426.422943082263, 14546.636334091732, 14605.853941460555, 12842.550510732079, 12929.612111636667, 13138.86861131386, 13235.938059790564, 13401.597952061455, 4255.851045213433, 4321.286987647034, 4329.5453977332245, 4332.826686932519, 4384.167008268419, 78596.60701696512, 79049.0, 80419.0, 80481.59759201224, 80536.0, 10418.426986515815, 11161.274517156358, 11239.325640461599, 11319.717007074889, 11456.713582160346, 19867.503312417306, 21233.78766212349, 21238.46903827417, 21244.25645102414, 21364.679529807065, 7970.2029797021, 7973.401994850409, 7977.441579089408, 7979.122296547375, 8350.4154709171, 4522.4573051234065, 4612.561806628365, 4677.953220467752, 4756.667033307635, 4773.76131193439, 3461.44616861301, 3576.624454432299, 3582.7671201371827, 3690.741648084662, 3736.1593641431004, 610.9419605137593, 618.0451202891543, 622.7166639179162, 643.6106155775782, 669.9497537684693, 623.6102435977514, 729.7044696897765, 739.5451797144717, 750.8873668949701, 782.4695015858118, 9913.75215619601, 9923.40459572428, 10028.144793213132, 10158.593656253815, 10533.788614309453, 690.4683393786756, 690.5131882023162, 699.5697645947705, 723.8588475247382, 734.8309888725623, 4681.391419115494, 4830.154722923475, 4843.636727245471, 4911.287863259808, 4942.703437793743, 65969.34030659728, 111467.44266278617, 119484.40257798655, 122555.38722306331, 126392.0, 65717.34282657207, 75278.61246243822, 104435.21171124004, 106126.0, 108256.0, 88353.0, 88928.55535722409, 90290.09709902816, 93161.5341923286, 96012.51993739986, 9106.590203440728, 9308.208802251613, 9480.85778713306, 9527.159240086086, 9660.613575457184, 40652.39021414622, 44717.10565788731, 52886.0, 54308.0, 54888.17667735067, 46313.0, 46522.53477465318, 50794.492055078976, 65323.020154698665, 68676.96984545136, 12534.122611417113, 12758.48966041348, 12832.29422381778, 12971.740565188833, 13235.933820330836, 14622.926885365505, 14751.704965900408, 14952.925235373754, 15076.396944122112, 15084.170370629721, 13448.193108413527, 13458.66353341135, 13569.1858488491, 13575.728485430434, 13948.0, 13046.54337098197, 13467.663308417368, 13562.254076025913, 13860.099093558887, 13901.690475952488, 12648.367581620698, 12672.936635316764, 12742.936285318514, 12815.102942793916, 13136.211827290394, 10456.16350691958, 11459.828102578302, 11701.824472633087, 11722.179447438597, 11725.296482211095, 11144.60993865211, 11798.233114847508, 12037.819432708691, 12101.636950891487, 12133.817992729939], "value": 7493.660206238658, "unit": "score"}], "name": "dromaeo_css", "value": 7030.099217187463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 110.0, 112.0, 109.0, 111.0, 109.0, 109.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 128.0, 122.0, 164.0, 123.0, 122.0, 127.0, 127.0, 154.0, 129.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 160.0, 159.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 111.0, 77.0, 75.0, 76.0, 76.0, 126.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 83.0, 82.0, 81.0, 100.0, 82.0, 81.0, 115.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 50.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 64.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 79.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 130.0, 138.0, 129.0, 133.0, 130.0, 130.0, 131.0, 173.0, 129.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 167.0, 163.0, 166.0, 164.0, 171.0, 163.0, 168.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 65.0, 66.0, 66.0, 67.0, 63.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1497.5, "alertThreshold": 2.0}]} 00:38:47 INFO - Return code: 0 00:38:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:38:47 INFO - # TBPL SUCCESS # 00:38:47 INFO - Running post-action listener: _resource_record_post_action 00:38:47 INFO - [mozharness: 2016-10-12 07:38:47.193344Z] Finished run-tests step (success) 00:38:47 INFO - Running post-run listener: _resource_record_post_run 00:38:47 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394092544; Read time: 8; Write time: 281380 00:38:47 INFO - TinderboxPrint: CPU usage
13.1% 00:38:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 00:38:47 INFO - TinderboxPrint: I/O write bytes / time
394,092,544 / 281,380 00:38:47 INFO - TinderboxPrint: CPU idle
8,289.6 (86.9%) 00:38:47 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 00:38:47 INFO - TinderboxPrint: Swap in / out
0 / 0 00:38:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103788544; Read time: 0; Write time: 96704 00:38:47 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 290304000; Read time: 0; Write time: 184676 00:38:47 INFO - Running post-run listener: _upload_blobber_files 00:38:47 INFO - Blob upload gear active. 00:38:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:38:47 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 00:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:38:48 INFO - (blobuploader) - INFO - Open directory for files ... 00:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:51 INFO - (blobuploader) - INFO - Done attempting. 00:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:52 INFO - (blobuploader) - INFO - Done attempting. 00:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:52 INFO - (blobuploader) - INFO - Done attempting. 00:38:52 INFO - (blobuploader) - INFO - Iteration through files over. 00:38:52 INFO - Return code: 0 00:38:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:38:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:38:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6e4057fee54ba6c10a2f8fb62babdc9042d6ec1fb59b7ea3a069c5facf064a8ea0cf86e4505f80b76e42642e96e7a8b45fed1bc19ba59be7165c94f64a4a2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd188ed0cadf825b14af199f8850162344d7c69833651fd48ad8515ede5766060fd45bcd56a3d91072f6465e4b6a326e7f74d5f5564e31b52a8ccbe2780a85e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46e0131ae5efb691d90d8d959ec6d172100fdd25effd25bfec3fdbb463c62888c253225b719a9709dbaa329e956a8b367a2f506cae4bcc31f1c7c0e87b2c60f6"} 00:38:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:38:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:38:52 INFO - Contents: 00:38:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6e4057fee54ba6c10a2f8fb62babdc9042d6ec1fb59b7ea3a069c5facf064a8ea0cf86e4505f80b76e42642e96e7a8b45fed1bc19ba59be7165c94f64a4a2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd188ed0cadf825b14af199f8850162344d7c69833651fd48ad8515ede5766060fd45bcd56a3d91072f6465e4b6a326e7f74d5f5564e31b52a8ccbe2780a85e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46e0131ae5efb691d90d8d959ec6d172100fdd25effd25bfec3fdbb463c62888c253225b719a9709dbaa329e956a8b367a2f506cae4bcc31f1c7c0e87b2c60f6"} 00:38:52 INFO - Running post-run listener: copy_logs_to_upload_dir 00:38:52 INFO - Copying logs to upload dir... 00:38:52 INFO - mkdir: /builds/slave/test/build/upload/logs 00:38:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.683889 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-10-12 00:38:52.541812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 00:38:52.545969) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6e4057fee54ba6c10a2f8fb62babdc9042d6ec1fb59b7ea3a069c5facf064a8ea0cf86e4505f80b76e42642e96e7a8b45fed1bc19ba59be7165c94f64a4a2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd188ed0cadf825b14af199f8850162344d7c69833651fd48ad8515ede5766060fd45bcd56a3d91072f6465e4b6a326e7f74d5f5564e31b52a8ccbe2780a85e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46e0131ae5efb691d90d8d959ec6d172100fdd25effd25bfec3fdbb463c62888c253225b719a9709dbaa329e956a8b367a2f506cae4bcc31f1c7c0e87b2c60f6"} build_url:https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/NCb9ffV-QIiGCysEDQLtlw/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/Mozilla-Inbound/sha512/d6e4057fee54ba6c10a2f8fb62babdc9042d6ec1fb59b7ea3a069c5facf064a8ea0cf86e4505f80b76e42642e96e7a8b45fed1bc19ba59be7165c94f64a4a2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd188ed0cadf825b14af199f8850162344d7c69833651fd48ad8515ede5766060fd45bcd56a3d91072f6465e4b6a326e7f74d5f5564e31b52a8ccbe2780a85e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46e0131ae5efb691d90d8d959ec6d172100fdd25effd25bfec3fdbb463c62888c253225b719a9709dbaa329e956a8b367a2f506cae4bcc31f1c7c0e87b2c60f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 00:38:52.575545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:38:52.575861) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476249825.981619-400796657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 00:38:52.657135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 00:38:52.657466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 00:38:52.657784) ========= ========= Total master_lag: 0.18 =========