builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1477457156.82 results: success (0) buildid: 20161025213543 builduid: c16baad441b746c2be7945e4fd2553e1 revision: ac6306117c61a56f8446d99415a853becd7a21c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:56.815940) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:56.816385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:56.816682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:56.850605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:56.850993) ========= 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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 21:45:56-- 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% 215M=0s 2016-10-25 21:45:57 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.184182 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.064697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.065007) ========= 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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.060115 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.137483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.137837) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ac6306117c61a56f8446d99415a853becd7a21c0 --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 ac6306117c61a56f8446d99415a853becd7a21c0 --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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 21:45:57,185 truncating revision to first 12 chars 2016-10-25 21:45:57,185 Setting DEBUG logging. 2016-10-25 21:45:57,185 attempt 1/10 2016-10-25 21:45:57,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ac6306117c61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 21:45:57,503 unpacking tar archive at: mozilla-inbound-ac6306117c61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.806302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.806684) ========= script_repo_revision: ac6306117c61a56f8446d99415a853becd7a21c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.807110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.807462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 21:45:57.819232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-25 21:45:57.819763) ========= /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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:45:58 INFO - MultiFileLogger online at 20161025 21:45:58 in /builds/slave/test 21:45:58 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 21:45:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:45:58 INFO - {'append_to_log': False, 21:45:58 INFO - 'base_work_dir': '/builds/slave/test', 21:45:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:45:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:45:58 INFO - 'branch': 'Mozilla-Inbound', 21:45:58 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:58 INFO - 'config_files': ('talos/linux_config.py',), 21:45:58 INFO - 'default_actions': ('clobber', 21:45:58 INFO - 'read-buildbot-config', 21:45:58 INFO - 'download-and-extract', 21:45:58 INFO - 'populate-webroot', 21:45:58 INFO - 'create-virtualenv', 21:45:58 INFO - 'install', 21:45:58 INFO - 'run-tests'), 21:45:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:58 INFO - 'download_minidump_stackwalk': True, 21:45:58 INFO - 'download_symbols': 'ondemand', 21:45:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:58 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:58 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:58 INFO - 'installer_path': 'installer.exe', 21:45:58 INFO - 'log_level': 'info', 21:45:58 INFO - 'log_name': 'talos', 21:45:58 INFO - 'log_to_console': True, 21:45:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:45:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:45:58 INFO - 'opt_config_files': (), 21:45:58 INFO - 'pip_index': False, 21:45:58 INFO - 'sps_profile': False, 21:45:58 INFO - 'sps_profile_interval': 0, 21:45:58 INFO - 'suite': 'dromaeojs', 21:45:58 INFO - 'system_bits': '32', 21:45:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:58 INFO - 'title': 'talos-linux64-ix-028', 21:45:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:58 INFO - 'use_talos_json': True, 21:45:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:45:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:58 INFO - 'work_dir': 'build'} 21:45:58 INFO - [mozharness: 2016-10-26 04:45:58.074046Z] Running clobber step. 21:45:58 INFO - Running pre-action listener: _resource_record_pre_action 21:45:58 INFO - Running main action method: clobber 21:45:58 INFO - rmtree: /builds/slave/test/build 21:45:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:02 INFO - Running post-action listener: _resource_record_post_action 21:46:02 INFO - [mozharness: 2016-10-26 04:46:02.296595Z] Finished clobber step (success) 21:46:02 INFO - [mozharness: 2016-10-26 04:46:02.296773Z] Running read-buildbot-config step. 21:46:02 INFO - Running pre-action listener: _resource_record_pre_action 21:46:02 INFO - Running main action method: read_buildbot_config 21:46:02 INFO - Using buildbot properties: 21:46:02 INFO - { 21:46:02 INFO - "project": "", 21:46:02 INFO - "product": "firefox", 21:46:02 INFO - "script_repo_revision": "production", 21:46:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:46:02 INFO - "repository": "", 21:46:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:46:02 INFO - "buildid": "20161025213543", 21:46:02 INFO - "stage_platform": "linux64-pgo", 21:46:02 INFO - "basedir": "/builds/slave/test", 21:46:02 INFO - "buildnumber": 1904, 21:46:02 INFO - "platform": "ubuntu64_hw", 21:46:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:46:02 INFO - "slavebuilddir": "test", 21:46:02 INFO - "branch": "mozilla-inbound", 21:46:02 INFO - "revision": "ac6306117c61a56f8446d99415a853becd7a21c0", 21:46:02 INFO - "slavename": "talos-linux64-ix-028", 21:46:02 INFO - "builduid": "c16baad441b746c2be7945e4fd2553e1", 21:46:02 INFO - "repo_path": "integration/mozilla-inbound" 21:46:02 INFO - } 21:46:02 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:46:02 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:46:02 INFO - Running post-action listener: _resource_record_post_action 21:46:02 INFO - [mozharness: 2016-10-26 04:46:02.301162Z] Finished read-buildbot-config step (success) 21:46:02 INFO - [mozharness: 2016-10-26 04:46:02.301324Z] Running download-and-extract step. 21:46:02 INFO - Running pre-action listener: _resource_record_pre_action 21:46:02 INFO - Running main action method: download_and_extract 21:46:02 INFO - mkdir: /builds/slave/test/build/tests 21:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:02 INFO - Downloaded 1361 bytes. 21:46:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:02 INFO - Using the following test package requirements: 21:46:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:46:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:46:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'jsshell-linux-x86_64.zip'], 21:46:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:46:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:46:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:46:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:46:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:46:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:46:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:02 INFO - Http code: 200 21:46:02 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 21:46:02 INFO - x-amz-cf-id: vGRceXResDDwlnBN5yVjhgEvrZ2nAHcfU2D1HMw61EjRzywZl0Hpeg== 21:46:02 INFO - x-amz-replication-status: COMPLETED 21:46:02 INFO - x-amz-version-id: AR50MGmuK293f9oyb8hfv7s_iCAt2J08 21:46:02 INFO - Expected file size: 22058226 21:46:02 INFO - Obtained file size: 22058226 21:46:06 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 21:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:06 INFO - Http code: 200 21:46:06 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 21:46:06 INFO - x-amz-cf-id: uHBtM37i-AR_oQJzM3yuN2IU2iBZEWSDCUSgqJKwfAp4sQlmJuGkyw== 21:46:06 INFO - x-amz-replication-status: COMPLETED 21:46:06 INFO - x-amz-version-id: AR50MGmuK293f9oyb8hfv7s_iCAt2J08 21:46:07 INFO - Expected file size: 22058226 21:46:07 INFO - Obtained file size: 22058226 21:46:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:46:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:46:12 INFO - Http code: 200 21:46:12 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 21:46:12 INFO - x-amz-cf-id: H2PolUl3RBGIKsVuFbAOD2glhnr5BECEruW-MOSjFJElZFnZeZ0oAg== 21:46:12 INFO - x-amz-replication-status: COMPLETED 21:46:12 INFO - x-amz-version-id: Tfdzo9Bf.BfysQa9rbYxcExRpFFsrpwf 21:46:12 INFO - Expected file size: 14409028 21:46:12 INFO - Obtained file size: 14409028 21:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:14 INFO - Downloaded 59445965 bytes. 21:46:14 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:14 INFO - mkdir: /builds/slave/test/properties 21:46:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:14 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:14 INFO - Contents: 21:46:14 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:14 INFO - Running post-action listener: _resource_record_post_action 21:46:14 INFO - Running post-action listener: set_extra_try_arguments 21:46:14 INFO - [mozharness: 2016-10-26 04:46:14.768613Z] Finished download-and-extract step (success) 21:46:14 INFO - [mozharness: 2016-10-26 04:46:14.768767Z] Running populate-webroot step. 21:46:14 INFO - Running pre-action listener: _resource_record_pre_action 21:46:14 INFO - Running main action method: populate_webroot 21:46:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:14 INFO - '--tppagecycles', 21:46:14 INFO - '7'], 21:46:14 INFO - 'tests': ['tsvgm']}}, 21:46:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['damp', 'tps']}, 21:46:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'tests': ['damp', 'tps']}, 21:46:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['dromaeo_dom']}, 21:46:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['basic_compositor_video']}, 21:46:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:46:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['a11yr', 21:46:14 INFO - 'ts_paint', 21:46:14 INFO - 'tpaint', 21:46:14 INFO - 'sessionrestore', 21:46:14 INFO - 'sessionrestore_no_auto_restore', 21:46:14 INFO - 'tabpaint']}, 21:46:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['tsvgx', 21:46:14 INFO - 'tsvgr_opacity', 21:46:14 INFO - 'tart', 21:46:14 INFO - 'tscrollx', 21:46:14 INFO - 'cart']}, 21:46:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:14 INFO - 'tsvgr_opacity', 21:46:14 INFO - 'tart', 21:46:14 INFO - 'tscrollx', 21:46:14 INFO - 'cart']}, 21:46:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'talos_options': ['--disable-e10s'], 21:46:14 INFO - 'tests': ['tp5o']}, 21:46:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'tests': ['tp5o']}, 21:46:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'talos_options': ['--disable-e10s', 21:46:14 INFO - '--xperf_path', 21:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:14 INFO - 'tests': ['tp5n']}, 21:46:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:14 INFO - 'talos_options': ['--xperf_path', 21:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:14 INFO - 'tests': ['tp5n']}}, 21:46:14 INFO - 'talos.zip': {'path': '', 21:46:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:14 INFO - Running post-action listener: _resource_record_post_action 21:46:14 INFO - [mozharness: 2016-10-26 04:46:14.789108Z] Finished populate-webroot step (success) 21:46:14 INFO - [mozharness: 2016-10-26 04:46:14.789209Z] Running create-virtualenv step. 21:46:14 INFO - Running pre-action listener: _resource_record_pre_action 21:46:14 INFO - Running main action method: create_virtualenv 21:46:14 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:14 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 21:46:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:14 INFO - Using real prefix '/usr' 21:46:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:15 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:17 INFO - Installing pip.................done. 21:46:17 INFO - Return code: 0 21:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:46:17 INFO - Reading from file tmpfile_stdout 21:46:17 INFO - Output received: 21:46:17 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) 21:46:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:17 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')]} 21:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:17 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')]} 21:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:17 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:17 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 21:46:17 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 21:46:17 INFO - Using env: {'DISPLAY': ':0', 21:46:17 INFO - 'HOME': '/home/cltbld', 21:46:17 INFO - 'LANG': 'en_US.UTF-8', 21:46:17 INFO - 'LANGUAGE': 'en_US:en', 21:46:17 INFO - 'LOGNAME': 'cltbld', 21:46:17 INFO - 'MAIL': '/var/mail/cltbld', 21:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:17 INFO - 'MOZ_NO_REMOTE': '1', 21:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:17 INFO - 'NO_EM_RESTART': '1', 21:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:17 INFO - 'PWD': '/builds/slave/test', 21:46:17 INFO - 'SHELL': '/bin/bash', 21:46:17 INFO - 'SHLVL': '1', 21:46:17 INFO - 'TERM': 'linux', 21:46:17 INFO - 'TMOUT': '86400', 21:46:17 INFO - 'USER': 'cltbld', 21:46:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:17 INFO - '_': '/tools/buildbot/bin/python'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 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 21:46:18 INFO - Cleaning up... 21:46:18 INFO - Return code: 0 21:46:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:46:18 INFO - Using env: {'DISPLAY': ':0', 21:46:18 INFO - 'HOME': '/home/cltbld', 21:46:18 INFO - 'LANG': 'en_US.UTF-8', 21:46:18 INFO - 'LANGUAGE': 'en_US:en', 21:46:18 INFO - 'LOGNAME': 'cltbld', 21:46:18 INFO - 'MAIL': '/var/mail/cltbld', 21:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:18 INFO - 'MOZ_NO_REMOTE': '1', 21:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:18 INFO - 'NO_EM_RESTART': '1', 21:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:18 INFO - 'PWD': '/builds/slave/test', 21:46:18 INFO - 'SHELL': '/bin/bash', 21:46:18 INFO - 'SHLVL': '1', 21:46:18 INFO - 'TERM': 'linux', 21:46:18 INFO - 'TMOUT': '86400', 21:46:18 INFO - 'USER': 'cltbld', 21:46:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:18 INFO - '_': '/tools/buildbot/bin/python'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 INFO - Downloading/unpacking psutil>=3.1.1 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:20 INFO - Installing collected packages: psutil 21:46:20 INFO - Running setup.py install for psutil 21:46:20 INFO - building 'psutil._psutil_linux' extension 21:46:20 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 21:46:21 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 21:46:21 INFO - building 'psutil._psutil_posix' extension 21:46:21 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 21:46:21 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 21:46:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:22 INFO - Successfully installed psutil 21:46:22 INFO - Cleaning up... 21:46:22 INFO - Return code: 0 21:46:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46:22 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')]} 21:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:22 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')]} 21:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:22 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:22 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 21:46:22 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 21:46:22 INFO - Using env: {'DISPLAY': ':0', 21:46:22 INFO - 'HOME': '/home/cltbld', 21:46:22 INFO - 'LANG': 'en_US.UTF-8', 21:46:22 INFO - 'LANGUAGE': 'en_US:en', 21:46:22 INFO - 'LOGNAME': 'cltbld', 21:46:22 INFO - 'MAIL': '/var/mail/cltbld', 21:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:22 INFO - 'MOZ_NO_REMOTE': '1', 21:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:22 INFO - 'NO_EM_RESTART': '1', 21:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:22 INFO - 'PWD': '/builds/slave/test', 21:46:22 INFO - 'SHELL': '/bin/bash', 21:46:22 INFO - 'SHLVL': '1', 21:46:22 INFO - 'TERM': 'linux', 21:46:22 INFO - 'TMOUT': '86400', 21:46:22 INFO - 'USER': 'cltbld', 21:46:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:22 INFO - '_': '/tools/buildbot/bin/python'} 21:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:24 INFO - Installing collected packages: mozsystemmonitor 21:46:24 INFO - Running setup.py install for mozsystemmonitor 21:46:24 INFO - Successfully installed mozsystemmonitor 21:46:24 INFO - Cleaning up... 21:46:24 INFO - Return code: 0 21:46:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:46:24 INFO - Using env: {'DISPLAY': ':0', 21:46:24 INFO - 'HOME': '/home/cltbld', 21:46:24 INFO - 'LANG': 'en_US.UTF-8', 21:46:24 INFO - 'LANGUAGE': 'en_US:en', 21:46:24 INFO - 'LOGNAME': 'cltbld', 21:46:24 INFO - 'MAIL': '/var/mail/cltbld', 21:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:24 INFO - 'MOZ_NO_REMOTE': '1', 21:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:24 INFO - 'NO_EM_RESTART': '1', 21:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:24 INFO - 'PWD': '/builds/slave/test', 21:46:24 INFO - 'SHELL': '/bin/bash', 21:46:24 INFO - 'SHLVL': '1', 21:46:24 INFO - 'TERM': 'linux', 21:46:24 INFO - 'TMOUT': '86400', 21:46:24 INFO - 'USER': 'cltbld', 21:46:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:24 INFO - '_': '/tools/buildbot/bin/python'} 21:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:26 INFO - warning: no files found matching '*.txt' 21:46:26 INFO - no previously-included directories found matching 'build' 21:46:26 INFO - no previously-included directories found matching 'dist' 21:46:26 INFO - no previously-included directories found matching '.git*' 21:46:26 INFO - Installing collected packages: jsonschema, functools32 21:46:26 INFO - Running setup.py install for functools32 21:46:27 INFO - warning: no files found matching '*.txt' 21:46:27 INFO - no previously-included directories found matching 'build' 21:46:27 INFO - no previously-included directories found matching 'dist' 21:46:27 INFO - no previously-included directories found matching '.git*' 21:46:27 INFO - Successfully installed jsonschema functools32 21:46:27 INFO - Cleaning up... 21:46:27 INFO - Return code: 0 21:46:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:27 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 21:46:27 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 21:46:27 INFO - Using env: {'DISPLAY': ':0', 21:46:27 INFO - 'HOME': '/home/cltbld', 21:46:27 INFO - 'LANG': 'en_US.UTF-8', 21:46:27 INFO - 'LANGUAGE': 'en_US:en', 21:46:27 INFO - 'LOGNAME': 'cltbld', 21:46:27 INFO - 'MAIL': '/var/mail/cltbld', 21:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:27 INFO - 'MOZ_NO_REMOTE': '1', 21:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:27 INFO - 'NO_EM_RESTART': '1', 21:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:27 INFO - 'PWD': '/builds/slave/test', 21:46:27 INFO - 'SHELL': '/bin/bash', 21:46:27 INFO - 'SHLVL': '1', 21:46:27 INFO - 'TERM': 'linux', 21:46:27 INFO - 'TMOUT': '86400', 21:46:27 INFO - 'USER': 'cltbld', 21:46:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:27 INFO - '_': '/tools/buildbot/bin/python'} 21:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:46:27 INFO - Cleaning up... 21:46:27 INFO - Return code: 0 21:46:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:27 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 21:46:27 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 21:46:27 INFO - Using env: {'DISPLAY': ':0', 21:46:27 INFO - 'HOME': '/home/cltbld', 21:46:27 INFO - 'LANG': 'en_US.UTF-8', 21:46:27 INFO - 'LANGUAGE': 'en_US:en', 21:46:27 INFO - 'LOGNAME': 'cltbld', 21:46:27 INFO - 'MAIL': '/var/mail/cltbld', 21:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:27 INFO - 'MOZ_NO_REMOTE': '1', 21:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:27 INFO - 'NO_EM_RESTART': '1', 21:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:27 INFO - 'PWD': '/builds/slave/test', 21:46:27 INFO - 'SHELL': '/bin/bash', 21:46:27 INFO - 'SHLVL': '1', 21:46:27 INFO - 'TERM': 'linux', 21:46:27 INFO - 'TMOUT': '86400', 21:46:27 INFO - 'USER': 'cltbld', 21:46:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:27 INFO - '_': '/tools/buildbot/bin/python'} 21:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:29 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 21:46:30 INFO - Downloading docopt-0.6.1.tar.gz 21:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:30 INFO - Running setup.py install for blobuploader 21:46:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:30 INFO - Running setup.py install for requests 21:46:30 INFO - Running setup.py install for docopt 21:46:30 INFO - Successfully installed blobuploader requests docopt 21:46:30 INFO - Cleaning up... 21:46:30 INFO - Return code: 0 21:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:30 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:30 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 21:46:30 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 21:46:30 INFO - Using env: {'DISPLAY': ':0', 21:46:30 INFO - 'HOME': '/home/cltbld', 21:46:30 INFO - 'LANG': 'en_US.UTF-8', 21:46:30 INFO - 'LANGUAGE': 'en_US:en', 21:46:30 INFO - 'LOGNAME': 'cltbld', 21:46:30 INFO - 'MAIL': '/var/mail/cltbld', 21:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:30 INFO - 'MOZ_NO_REMOTE': '1', 21:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:30 INFO - 'NO_EM_RESTART': '1', 21:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:30 INFO - 'PWD': '/builds/slave/test', 21:46:30 INFO - 'SHELL': '/bin/bash', 21:46:30 INFO - 'SHLVL': '1', 21:46:30 INFO - 'TERM': 'linux', 21:46:30 INFO - 'TMOUT': '86400', 21:46:30 INFO - 'USER': 'cltbld', 21:46:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:30 INFO - '_': '/tools/buildbot/bin/python'} 21:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:31 INFO - Running setup.py (path:/tmp/pip-lRKHqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:31 INFO - Running setup.py (path:/tmp/pip-8nyObL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:31 INFO - Running setup.py (path:/tmp/pip-ex15a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:31 INFO - Running setup.py (path:/tmp/pip-PGDSC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:31 INFO - Running setup.py (path:/tmp/pip-eJAxgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:31 INFO - Running setup.py (path:/tmp/pip-UauDFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:31 INFO - Running setup.py (path:/tmp/pip-OaLPvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:31 INFO - Running setup.py (path:/tmp/pip-BZt3sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:31 INFO - Running setup.py (path:/tmp/pip-4mKj3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:31 INFO - Running setup.py (path:/tmp/pip-syPBdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:31 INFO - Running setup.py (path:/tmp/pip-bSkidb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:31 INFO - Running setup.py (path:/tmp/pip-PpGRTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:31 INFO - Running setup.py (path:/tmp/pip-6G3znM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:32 INFO - Running setup.py (path:/tmp/pip-EFYP8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:32 INFO - Running setup.py (path:/tmp/pip-HUZfxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:32 INFO - Running setup.py (path:/tmp/pip-nFYxTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:32 INFO - Running setup.py (path:/tmp/pip-jPZcWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:32 INFO - Running setup.py install for manifestparser 21:46:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:32 INFO - Running setup.py install for mozcrash 21:46:32 INFO - Running setup.py install for mozdebug 21:46:32 INFO - Running setup.py install for mozdevice 21:46:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:32 INFO - Running setup.py install for mozfile 21:46:32 INFO - Running setup.py install for mozhttpd 21:46:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:32 INFO - Running setup.py install for mozinfo 21:46:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:32 INFO - Running setup.py install for mozInstall 21:46:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Running setup.py install for mozleak 21:46:33 INFO - Running setup.py install for mozlog 21:46:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Running setup.py install for moznetwork 21:46:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Running setup.py install for mozprocess 21:46:33 INFO - Running setup.py install for mozprofile 21:46:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Running setup.py install for mozrunner 21:46:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:33 INFO - Running setup.py install for mozscreenshot 21:46:33 INFO - Running setup.py install for moztest 21:46:33 INFO - Running setup.py install for mozversion 21:46:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:34 INFO - Cleaning up... 21:46:34 INFO - Return code: 0 21:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:34 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:34 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 21:46:34 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 21:46:34 INFO - Using env: {'DISPLAY': ':0', 21:46:34 INFO - 'HOME': '/home/cltbld', 21:46:34 INFO - 'LANG': 'en_US.UTF-8', 21:46:34 INFO - 'LANGUAGE': 'en_US:en', 21:46:34 INFO - 'LOGNAME': 'cltbld', 21:46:34 INFO - 'MAIL': '/var/mail/cltbld', 21:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:34 INFO - 'MOZ_NO_REMOTE': '1', 21:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:34 INFO - 'NO_EM_RESTART': '1', 21:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:34 INFO - 'PWD': '/builds/slave/test', 21:46:34 INFO - 'SHELL': '/bin/bash', 21:46:34 INFO - 'SHLVL': '1', 21:46:34 INFO - 'TERM': 'linux', 21:46:34 INFO - 'TMOUT': '86400', 21:46:34 INFO - 'USER': 'cltbld', 21:46:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:34 INFO - '_': '/tools/buildbot/bin/python'} 21:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:34 INFO - Running setup.py (path:/tmp/pip-P_5RWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:34 INFO - Running setup.py (path:/tmp/pip-FK2Qvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:34 INFO - Running setup.py (path:/tmp/pip-UstZ1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:34 INFO - Running setup.py (path:/tmp/pip-N1Axj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:34 INFO - Running setup.py (path:/tmp/pip-Wu_qMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:34 INFO - Running setup.py (path:/tmp/pip-obBkaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:34 INFO - Running setup.py (path:/tmp/pip-e9Y2pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:34 INFO - Running setup.py (path:/tmp/pip-yHZcge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:34 INFO - Running setup.py (path:/tmp/pip-BlXJxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:34 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)) 21:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:34 INFO - Running setup.py (path:/tmp/pip-Ix9vsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:35 INFO - Running setup.py (path:/tmp/pip-mAwOnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:35 INFO - Running setup.py (path:/tmp/pip-8uNn1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:35 INFO - Running setup.py (path:/tmp/pip-LHFEXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:35 INFO - Running setup.py (path:/tmp/pip-zECEPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:35 INFO - Running setup.py (path:/tmp/pip-F_2j3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:35 INFO - Running setup.py (path:/tmp/pip-PBwCks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:35 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)) 21:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:35 INFO - Running setup.py (path:/tmp/pip-f8Dmvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:35 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)) 21:46:35 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)) 21:46:35 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)) 21:46:35 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)) 21:46:35 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)) 21:46:35 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)) 21:46:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:37 INFO - Downloading blessings-1.6.tar.gz 21:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:37 INFO - Installing collected packages: blessings 21:46:37 INFO - Running setup.py install for blessings 21:46:37 INFO - Successfully installed blessings 21:46:37 INFO - Cleaning up... 21:46:37 INFO - Return code: 0 21:46:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:37 INFO - Reading from file tmpfile_stdout 21:46:37 INFO - Current package versions: 21:46:37 INFO - argparse == 1.2.1 21:46:37 INFO - blessings == 1.6 21:46:37 INFO - blobuploader == 1.2.4 21:46:37 INFO - docopt == 0.6.1 21:46:37 INFO - functools32 == 3.2.3-2 21:46:37 INFO - jsonschema == 2.5.1 21:46:37 INFO - manifestparser == 1.1 21:46:37 INFO - mozInstall == 1.12 21:46:37 INFO - mozcrash == 0.17 21:46:37 INFO - mozdebug == 0.1 21:46:37 INFO - mozdevice == 0.48 21:46:37 INFO - mozfile == 1.2 21:46:37 INFO - mozhttpd == 0.7 21:46:37 INFO - mozinfo == 0.9 21:46:37 INFO - mozleak == 0.1 21:46:37 INFO - mozlog == 3.4 21:46:37 INFO - moznetwork == 0.27 21:46:37 INFO - mozprocess == 0.23 21:46:37 INFO - mozprofile == 0.28 21:46:37 INFO - mozrunner == 6.12 21:46:37 INFO - mozscreenshot == 0.1 21:46:37 INFO - mozsystemmonitor == 0.3 21:46:37 INFO - moztest == 0.7 21:46:37 INFO - mozversion == 1.4 21:46:37 INFO - psutil == 3.1.1 21:46:37 INFO - requests == 1.2.3 21:46:37 INFO - wsgiref == 0.1.2 21:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:37 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 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:37 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 21:46:37 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 21:46:37 INFO - Using env: {'DISPLAY': ':0', 21:46:37 INFO - 'HOME': '/home/cltbld', 21:46:37 INFO - 'LANG': 'en_US.UTF-8', 21:46:37 INFO - 'LANGUAGE': 'en_US:en', 21:46:37 INFO - 'LOGNAME': 'cltbld', 21:46:37 INFO - 'MAIL': '/var/mail/cltbld', 21:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:38 INFO - 'MOZ_NO_REMOTE': '1', 21:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:38 INFO - 'NO_EM_RESTART': '1', 21:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:38 INFO - 'PWD': '/builds/slave/test', 21:46:38 INFO - 'SHELL': '/bin/bash', 21:46:38 INFO - 'SHLVL': '1', 21:46:38 INFO - 'TERM': 'linux', 21:46:38 INFO - 'TMOUT': '86400', 21:46:38 INFO - 'USER': 'cltbld', 21:46:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:38 INFO - '_': '/tools/buildbot/bin/python'} 21:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 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)) 21:46:38 INFO - Cleaning up... 21:46:38 INFO - Return code: 0 21:46:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8018778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', '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 21:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:46:38 INFO - Using env: {'DISPLAY': ':0', 21:46:38 INFO - 'HOME': '/home/cltbld', 21:46:38 INFO - 'LANG': 'en_US.UTF-8', 21:46:38 INFO - 'LANGUAGE': 'en_US:en', 21:46:38 INFO - 'LOGNAME': 'cltbld', 21:46:38 INFO - 'MAIL': '/var/mail/cltbld', 21:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:38 INFO - 'MOZ_NO_REMOTE': '1', 21:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:38 INFO - 'NO_EM_RESTART': '1', 21:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:38 INFO - 'PWD': '/builds/slave/test', 21:46:38 INFO - 'SHELL': '/bin/bash', 21:46:38 INFO - 'SHLVL': '1', 21:46:38 INFO - 'TERM': 'linux', 21:46:38 INFO - 'TMOUT': '86400', 21:46:38 INFO - 'USER': 'cltbld', 21:46:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:38 INFO - '_': '/tools/buildbot/bin/python'} 21:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:46:38 INFO - Cleaning up... 21:46:38 INFO - Return code: 0 21:46:38 INFO - Running post-action listener: _resource_record_post_action 21:46:38 INFO - Running post-action listener: _start_resource_monitoring 21:46:38 INFO - Starting resource monitoring. 21:46:38 INFO - [mozharness: 2016-10-26 04:46:38.481939Z] Finished create-virtualenv step (success) 21:46:38 INFO - [mozharness: 2016-10-26 04:46:38.482388Z] Running install step. 21:46:38 INFO - Running pre-action listener: _resource_record_pre_action 21:46:38 INFO - Running main action method: install 21:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:38 INFO - Reading from file tmpfile_stdout 21:46:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:38 INFO - Reading from file tmpfile_stdout 21:46:38 INFO - Output received: 21:46:38 INFO - Usage: mozinstall [options] installer 21:46:38 INFO - Options: 21:46:38 INFO - -h, --help show this help message and exit 21:46:38 INFO - -d DEST, --destination=DEST 21:46:38 INFO - Directory to install application into. [default: 21:46:38 INFO - "/builds/slave/test"] 21:46:38 INFO - --app=APP Application being installed. [default: firefox] 21:46:38 INFO - mkdir: /builds/slave/test/build/application 21:46:38 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'] 21:46:38 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 21:46:55 INFO - Reading from file tmpfile_stdout 21:46:55 INFO - Output received: 21:46:55 INFO - /builds/slave/test/build/application/firefox/firefox 21:46:55 INFO - Running post-action listener: _resource_record_post_action 21:46:55 INFO - [mozharness: 2016-10-26 04:46:55.713058Z] Finished install step (success) 21:46:55 INFO - [mozharness: 2016-10-26 04:46:55.713337Z] Running run-tests step. 21:46:55 INFO - Running pre-action listener: _resource_record_pre_action 21:46:55 INFO - Running main action method: run_tests 21:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:46:55 INFO - Python 2.7.3 21:46:55 INFO - Return code: 0 21:46:55 INFO - grabbing minidump binary from tooltool 21:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:55 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 0x126bf60>, '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 0x126cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:46:55 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 21:46:55 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 21:46:55 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 21:46:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:55 INFO - Return code: 0 21:46:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:46:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:46:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:46:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:46:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:46:55 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:46:55 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 21:46:55 INFO - Using env: {'DISPLAY': ':0', 21:46:55 INFO - 'HOME': '/home/cltbld', 21:46:55 INFO - 'LANG': 'en_US.UTF-8', 21:46:55 INFO - 'LANGUAGE': 'en_US:en', 21:46:55 INFO - 'LOGNAME': 'cltbld', 21:46:55 INFO - 'MAIL': '/var/mail/cltbld', 21:46:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:46:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:55 INFO - 'MOZ_NO_REMOTE': '1', 21:46:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:55 INFO - 'NO_EM_RESTART': '1', 21:46:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:55 INFO - 'PWD': '/builds/slave/test', 21:46:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:46:55 INFO - 'SHELL': '/bin/bash', 21:46:55 INFO - 'SHLVL': '1', 21:46:55 INFO - 'TERM': 'linux', 21:46:55 INFO - 'TMOUT': '86400', 21:46:55 INFO - 'USER': 'cltbld', 21:46:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835', 21:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:55 INFO - '_': '/tools/buildbot/bin/python'} 21:46:55 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:46:56 INFO - mozversion application_buildid: 20161025183007 21:46:56 INFO - mozversion application_changeset: ac6306117c61a56f8446d99415a853becd7a21c0 21:46:56 INFO - mozversion application_display_name: Nightly 21:46:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:56 INFO - mozversion application_name: Firefox 21:46:56 INFO - mozversion application_remotingname: firefox 21:46:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:46:56 INFO - mozversion application_vendor: Mozilla 21:46:56 INFO - mozversion application_version: 52.0a1 21:46:56 INFO - mozversion platform_buildid: 20161025183007 21:46:56 INFO - mozversion platform_changeset: ac6306117c61a56f8446d99415a853becd7a21c0 21:46:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:46:56 INFO - mozversion platform_version: 52.0a1 21:46:56 INFO - using testdate: 1477457216 21:46:56 INFO - actual date: 1477457216 21:46:56 INFO - starting webserver on 'localhost:49753' 21:46:56 INFO - SUITE-START | Running 2 tests 21:46:56 INFO - TEST-START | dromaeo_css 21:46:56 INFO - operating with platform_type : linux_ 21:46:56 INFO - Initialising browser for dromaeo_css test... 21:46:56 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVjA0XO/profile http://localhost:49753/getInfo.html) 21:47:01 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 21:47:01 INFO - PROCESS | 3306 | colorDepth:24 21:47:01 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 21:47:01 INFO - PROCESS | 3306 | __metrics 21:47:03 INFO - PROCESS | 3306 | 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" 21:47:03 INFO - PROCESS | 3306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:04 INFO - PROCESS | 3306 | console.error: PushService: 21:47:04 INFO - PROCESS | 3306 | stateChangeProcessEnqueue: Error transitioning state 21:47:04 INFO - PROCESS | 3306 | UnknownError 21:47:04 INFO - TEST-INFO | 3306: exit 0 21:47:04 INFO - Browser initialized. 21:47:04 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:04 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVjA0XO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:16 INFO - PROCESS | 3391 | RSS: Main: 171651072 21:47:16 INFO - PROCESS | 3391 | 21:48:08 INFO - PROCESS | 3391 | 1477457288865 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] 21:50:19 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49753/tests/dromaeo/cssquery-ext.html) 21:50:21 INFO - PROCESS | 3391 | RSS: Main: 250028032 21:50:21 INFO - PROCESS | 3391 | 21:53:23 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-ext.html (next: http://localhost:49753/tests/dromaeo/cssquery-jquery.html) 21:53:24 INFO - PROCESS | 3391 | RSS: Main: 272408576 21:53:24 INFO - PROCESS | 3391 | 21:56:26 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49753/tests/dromaeo/cssquery-mootools.html) 21:56:26 INFO - PROCESS | 3391 | RSS: Main: 217325568 21:56:26 INFO - PROCESS | 3391 | 21:59:28 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49753/tests/dromaeo/cssquery-prototype.html) 21:59:29 INFO - PROCESS | 3391 | RSS: Main: 276312064 21:59:29 INFO - PROCESS | 3391 | 22:02:32 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49753/tests/dromaeo/cssquery-yui.html) 22:02:32 INFO - PROCESS | 3391 | RSS: Main: 217227264 22:02:32 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:49753/tests/dromaeo/cssquery-yui.html (next: http://localhost:49753/tests/dromaeo/cssquery-dojo.html) 22:05:35 INFO - PROCESS | 3391 | RSS: Main: 300957696 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | __start_tp_report 22:05:35 INFO - PROCESS | 3391 | _x_x_mozilla_page_load 22:05:35 INFO - PROCESS | 3391 | _x_x_mozilla_page_load_details 22:05:35 INFO - PROCESS | 3391 | |i|pagename|runs| 22:05:35 INFO - PROCESS | 3391 | |0;dojo.html;3044.7107524785147;3056.8777248910046;3088.6911308869117;3095.2880837407397;3101.1471845242554;5271.920921186185;5364.356277246736;5394.433584473628;5473.534749546288;5481.671099734014;5371.973140134294;5390.78436862525;5454.781808727646;5455.618106732521;5472.589555783312;4829.106615276185;4848.127337079324;4899.559039686427;4979.427365852919;4985.750712464381;4965.801367945278;5038.29463875056;5047.041062198189;5053.570446512051;5115.155999260118;4824.517548245182;4913.803447862081;4922.827701030446;4939.28380384844;5029.220470827027;4818.542238487338;4849.587785038276;4859.441164266119;4874.195757699975;4928.975355123202;4805.879853003668;4821.132196204681;4850.102730994778;4856.368672072608;4925.039617274633;5327.200919862013;5345.839624811262;5347.54545863602;5358.624896257264;5370.248165256867;5615.1857980592995;5679.943200567983;5704.172894930211;5794.768209271624;5825.300963884319;5862.853428664275;5884.588078834483;5898.911516327215;5934.465898069195;5950;5461.781528738886;5471.917921231185;5477.589180811416;5478.260434841325;5482.780688772405;5721.485066343966;5721.685307308055;5789.884202316014;5966.31387390447;5977.043673012297;5501.862453438696;5681.062624666966;5696.686682232434;5757.272818154537;5774.509166720792;5697.544196464273;5781.88436231273;5794.507466865363;5798.797042103506;5802.65184088956;5619.100943849046;5740.3685594585395;5746.655200687972;5747.48272655463;5759.913601295984;5595.07681232592;5726.169705392695;5795.1017592273265;5799.536037117105;5868.178455016301;4447.777611119431;4464.218761716752;4482.7758612069265;4490.101979604092;4514.6614003949835;3948.190620922704;3962.7027972902147;3964.72246942717;4001.4397984282223;4014.0566966762785;5316.946830531645;5351.277577527062;5548.472895074961;5562.888742225214;5562.972185139049;5692.516136128475;5731.083026715705;5734.62724922887;5746.080627099644;5816.011278082736;5364.91952620711;5413.079776438015;5423.159410291411;5424.349078110573;5429.294191755047;4895.583875370562;4955.752212389366;4960.826371077067;4970.751462426864;5026.246063090565;5873.20711703923;5899.8906317885985;5970.731317090828;6025.126356678345;6077.513798896166;5883.970580147072;5889.293284805851;5889.882202356014;5929.703514824155;5954.10688396744;6051.818445446644;6056.454919057306;6069.998450255658;6073.696315184135;6079.574429789872;5539.14143307788;5631.605787594993;5683.8010669626365;5740.454656807597;5780.7398667060925;5788.247527821356;5809.9419005809405;5810.970945145247;5825.417458254141;5883.61756485827;5647.576431767552;5650.915236271377;5654.321481422256;5663.292088488939;5665.830025099253;5546.58400619947;5590.329160500766;5594.86012849682;5640;5647.463490968352;5561.277033985556;5585.553155747449;5612.747426365741;5640.746166422438;5703.315602127771;5575.637583557056;5608.859778505407;5615.634983726045;5616.719164041863;5634.887302254014;5398.622096453368;5411.188321751769;5442.891142177214;5525.060739674184;5620.775168993195 22:05:35 INFO - PROCESS | 3391 | |1;ext.html;557.5121768452605;590.2179612014081;592.5881512348916;594.9077892926596;603.8882806680762;31872.840635796816;34976.650233497654;35002.12494687634;35007.99999999997;41224.79387603058;41586.58413415865;45550;45584.772076139656;45602.315965260466;45674.54325456744;8840.999999999984;9005.189532942033;9011.774705632346;9017.909820901805;9018.549072546346;8050.4364694471415;8208.138145494726;8847.02682704902;8940.910590894073;8941.552922353889;10446.9477652612;10715.35707857531;10722.35665860047;11078.113750899949;11081.667549973474;10701.571937122506;10758.462076896201;10781.676549703521;10788.406637634927;10791.082757965582;10692.305000174963;10779.838302425469;10787.083097936686;10790.352578845295;10795.676129716043;41584.1683166335;41617.79191104056;41639.583604163876;41896.1620767586;41907.79046104781;3275.5905511811025;3309.3050459403553;3326.234965957843;3382.6786455286956;3464.5496085508976;30592.54111188334;31184.150022991118;31704.682953170402;31794.682053179404;31909.202269943205;4028.7784171870535;4060.2285565742413;4123.670106391512;4133.772642504661;4299.419578356913;231849;233093;233180;233194;233611;55364;55630.44369556253;55639;56003;56259.43740562624;59045.40954590485;59637.70181149067;59726;59753.42712301643;59822.70088649616;12592.181508201938;12764.744705106032;12777.23336599807;12786;12789;10188.134008609202;10209.132223760915;10290.331128476626;10307;10308;15080.396784128512;15326.770098448533;16585.668286634198;16873.325066997182;17123.914380428017;6192.473639740582;6294.181756371734;6318.747250109944;6332;6357.332480089524;906.9954650226839;927.4388994658269;930.0559931669361;991.7718924647371;1040.9115225205942;29835.850820745756;31287.843560782505;31495.527567086512;31515.527267091013;31922.521162182587;1016.1667432705111;1036.6216331039268;1049.968500944973;1063.5798859450474;1108.2906939558688;15630;16192.19039048043;16228.188590570424;16410.17949102564;16848.494545163663;686780;709366;710221;710453;711698;49708.751456242484;50252;50605.24092138621;54652;56641.716791415776;1288.935553222354;1322.9669258268427;1330.361426515278;1348.2045593100117;1350.5678182981549;30424.695753042186;31319.530207046457;32626;32937.17657058497;33103.50344744782;53953.190702138716;54514;54621.18068229059;54634;54638.453615464925;436040;439485.21029579866;440472;626118;647764;26762;26785.598216027163;26845.328866778487;27071.323216919736;27118.593221102095;45800.77099614614;46659.30011049905;48082.51917480781;48308.516914830405;48528.75735621299;39332;39500.40749388704;39503.60496394999;41471.58528414798;41996;39649.80175099106;40305.395419069326;40449.79775101106;41446.58553414427;41970.790146049076;39152.21695566016;39954.80022599868;40196.1960760789;40263.1947361057;40492.1901561973;33213;35707.46438803368;36104.45388911952;36490.8175459121;36775.816120919226;27057.86471067632;27374.17877463679;27439.176824695292;27675.308117297227;27725.168244952685 22:05:35 INFO - PROCESS | 3391 | |2;jquery.html;352.95411596492454;364.9014766013175;374.2029477213535;378.90337963819223;387.4459522882277;13993.860061399395;18275.177617007233;18593.442196734104;19214.807851921476;20420.795792042074;17425.73861392077;17462.738058929095;18008.4597462076;18009.18958646861;18157.273709051624;5290.365156181254;5565.1374037024325;5569.66582005079;5569.777208911659;5572.5263352615075;3975.423563583279;4181.979090104561;5441.047816632094;5535.6955367454775;5535.916961245564;4283.3146696528565;6166.568340216187;6199.070139479069;6311.558190926637;6316.368363163693;6144.78493252734;6157.138000679908;6207.131001659771;6276.340984196662;6282.151909492229;5455;5466;5466.453354664542;5470.8085217017615;5472.179173124024;22014.669779953314;22483.21308754186;22710.54578908429;22807.54384912309;23043.654345184837;2262.536180083079;2356.7996720278798;2362.976370236293;2412.9396765081015;2866.813657112302;13663.248521331323;14152.858471415257;14226.928865355607;14538.491152809602;14806.925965370212;1796.7484552162707;1823.4347352320824;1905.8189472000138;1957.6574099532668;1961.2743284984504;81037.59481202615;81692.59153704254;81768;82335;82394;9797.706068817946;9861.161801246832;9986.20110391167;10047.799044019224;10170.389776613427;14076.71846563063;14100.435982560788;14102.717945641234;14116.435342586181;14135.646608834655;6682.9331706682315;6860.3139686032;6887.070245516891;6962.756303529352;7078.646067696697;6324.35160157284;6423.967880160662;6583.44040756541;6629.801105966829;6643.800685979429;6061.54538409621;6220.160278362454;6305.936940630627;6306.905396419057;6454.870902581922;1758.806531281558;1763.6296377760557;1822.82683145101;1847.7505536752635;1892.0539730134933;876.4259410086404;914.4056363363734;920.7652048727532;963.2919803944095;1031.3502493429091;18420.447386578424;19627.214911403385;19692.212311507665;19703.049959770226;20029.499262518555;946.252460556153;964.7491652170346;974.2449601558849;981.4798156976814;1037.419045334615;10207.489625518694;10280.663513743166;10980.121590272758;11032.944835275772;11104.222704410613;451810;454131;457902;463541.77603783703;465866;93504.53247733854;96384.51807740917;96485;97398.82514685665;97837.51081244549;985.3447457440722;1004.4124187350336;1029.1663752360612;1031.030831018825;1031.664708969588;17398.73901891498;17428.372955387164;18189.817661851936;18196.90901545484;18378.264869405073;42669.35995960125;43174;44989.87525311762;45102.77448612736;45662;61653;61736.69131654313;62022.68988655028;63488.36511634824;64915.157635813004;6929.1684997800585;7179.497435179696;8067.507511110463;8209.05595856484;8254;10775;11879.643610691694;11941.343226122646;11959.282443053444;12158.331291779037;10122.746931326776;10385.63650272237;10504.159667226451;10582.682519524427;10950.616728414467;10439.530221139916;10472.895271047191;10615;10646.361218326925;10752.731181720519;10785.406802625617;10840.728981775519;10857.565697372016;11268.267562608404;11343.432828358384;7206.531575447579;7211.567305961659;7396.112466504054;7451.3666338361845;7477.177510473734;10297.691069267934;10625.734356641145;10713.303635263683;11044.944775276072;11072.501737421997 22:05:35 INFO - PROCESS | 3391 | |3;mootools.html;1315.7960516120004;1425.4298280687724;1462.4004158295097;1568.623530352715;1753.2811547265633;7338.082739657543;8329.750967238842;8517.105703901087;8517.95741021294;8642.870356944652;8393.70622028229;8492.660293588264;8496.362772792034;8498.702545410912;8506.744797656065;2251.5609456156058;2261.739899911515;2268.750437451879;2276.1009401286483;2276.3398614401885;2236.8769717665523;2279.2022792022826;2292.8509646872985;2307.2962746362355;2318.200220923787;2225.10995601759;2225.710657614508;2257.4243567890167;2257.446925503254;2260.9886950565224;2081.250749730096;2113.86259893108;2121.2893680616935;2125.9893700531475;2126.8404869634837;2227.287268074217;2244.7194100737406;2245.7080579524722;2245.9438514037115;2249.741279752833;8454.28138608219;8610.741677749678;8617.439866408664;8622;8625.784355391166;5018.322526458918;5192.61055420845;5206.271122042917;5265.210218467222;5268.710220937847;3203.2472368993267;3495.056334789618;3525.665061819123;3560.7151427885706;3575.3921833288405;1025.600015993763;1031.1647565471917;1063.1707268330715;1064.3294724323705;1101.2456467319832;11515.36665483398;11701.590444334408;11715;11740.941295293555;11793.056555475627;4245.172191422643;4329.437173167531;4349.760763158057;4420.756858372756;4523.276275795857;9384.343095983351;9398.107179817905;9406.43561386319;9412.95293523528;9414;5087.8982420351385;5092.083424983464;5094.541491265803;5097.745112744348;5097.847064588068;4113.177364527107;4229.259879521133;4536.61438777701;4621.95378046222;4641.419822522184;3498.8950331490096;3621.311950729353;3668.6514781095752;3675;3691.1141326082084;1109.7336639206533;1116.6873275482878;1130.0451118804597;1131.9773604527863;1138.6754774889116;743.5798773692846;865.3812524045338;876.2420506262165;877.6313948141795;890.9242714369351;5259.39516955555;5568.860778480571;5637.881788596862;5640.971795140998;5770.076787713946;410.671462829735;430.5264209369668;436.80343845269755;437.1431993293181;442.5640743867288;3754.0990162360836;3874.2251549690177;3912.9021774455296;3952.975973380366;4002.899927501836;10210.336328138646;10681.572737090584;10704.678859634223;10708.250422470352;10713.303635263683;9963.950180249052;10364.274500784873;10385.532651030722;10619.30974486656;10657.733556661145;7954.681812727542;8134.389920755849;8138.87791683137;8155.918440815516;8165.510069395856;5525.309336332958;5722;5738.053221218619;5746.339170995222;5972.984592619178;9543.618255269712;9723;9737.951310243403;9800.11798938099;9891;9976.950115249378;9977.900220997697;9983.550740216562;9988.800223995624;9998.500074996076;6712.194536655633;6853.17761868579;7108;7592.772216833504;7709.113451953097;7898.68405263783;8264.421490495608;8266.256036956704;8277.503349799032;8290.170982901904;7368.963155184189;7396.408287337108;7498.550086994798;7701.422393320636;7709.151993280622;7256.7822965311125;7340.302671246223;7362.337389634744;7379.225181356095;7403.074615673041;6422.454091402096;6546;6548.967255163694;6555.4427873631275;6558.704858281293;4669.463011753692;4760.214564596803;4836.105320515716;4901.044296362175;4944.381952255968;4656.161890859677;4709.646776491845;4798.328234047306;4933;5017.749112544431 22:05:35 INFO - PROCESS | 3391 | |4;prototype.html;308.56338281331904;316.3546365414554;323.6763236763237;327.15430611868317;332.6457322951057;4696.154692155411;5047.974760126203;5251.3698356197265;5268.262443257942;5279.260903473512;5116.1814109742445;5160.2517634942915;5218.791248350061;5238.030964271612;5238.240455134013;4074.1851629674034;4089.1821635672836;4097.528784189826;4103.8919491737215;4108.0551473161195;3876;4076.5923407659143;4088.8568900088353;4096.446979657738;4097.467329247209;3770.7737535747942;4014.598540145991;4038.717289789716;4052.0882801369753;4056.9594304056877;4022.658074063708;4028.395740638913;4038.3740520219267;4039.6162364575316;4052.878413647595;3594.6045934947133;3607.2965771674535;3614.6566076222716;3623.3659109655705;3640.1445660269815;4940.1601727706375;5020.874478138076;5021.246812978046;5024.196128619404;5146.614003949681;4593.908121837578;4600.35595016698;4601.263797792337;4616.215243408628;4647.60495357895;5354.785808567653;5356.785728570852;5360.159115668702;5377.919331210035;5378.300820893259;3826.9617303826885;3921.745086569364;3925.980370098131;3944.5858184890462;3956.5647778744315;5294.841154765363;5459.508644222039;5625.971870140664;5626.156076588503;5626.874625075001;3884.8446062157195;3982.0841206522664;3985.6847240410593;3994.8601798936897;3996.3406038003404;4015.8795236142964;4025.9597404025585;4031.596840315945;4037.6567991720444;4047.6357127858632;4486.170058539181;4589.655775816827;4609.400777898919;4628.120657075145;4640.303954406799;5369.167778994262;5386.8383948481605;5394.083005889008;5414.458554144633;5419;1387.4172847404116;1413.6253892718437;1420.5241244183107;1426.1229343953394;1434.9713005739827;872.358816270041;924.8531820542479;937.1565590968183;938.4885237545554;939.5537119868007;4598.977005114953;4624.468186158635;4624.653151013687;4682.197354018659;4694.2723877799;4870.561649451495;4881.707097574157;4909.26361045846;4915.336429581961;4933.876653083702;4348.543402942709;4644.558766917137;4657.231556793159;4666.743329116931;4668.323093151474;2601.9089331873292;2609.9478010439684;2612.4905643399356;2616.607508873646;2618.711941686413;4999.3000979862845;5040.23591742887;5040.647154699136;5053.140966035783;5120.948790512121;4747.694384044346;4954.835613630794;4965.453800081988;4972.72650004246;5027.3464449621315;4969.329140566049;5021.372328459016;5047.772850221749;5053.671511351824;5062.316587260672;4923.842896919149;4931.137051015986;4933.950660493493;4935.777889995031;4954.430240522386;4502.3471596618965;4791;4852.660313778002;4864.781084851119;4866.416030076413;5034.345535080416;5044.218146187347;5419.539339156216;5583.413741557078;5644.008675402043;4029.4560234367987;4042.4946881639794;4068.7355321903983;4082.918341633091;4099.262132816122;5577;5577.386487486292;5595.832125036255;5605.663660180402;5625.8593535161945;5312.353170516997;5411.78352865881;5430.402655707948;5439.48324909133;5445.40100588927;5396.21754845553;5406.080841301438;5421.295231619864;5421.945780542144;5441.129419293053;5417.322834645669;5422.048062697505;5428.891422171613;5433.9456605435025;5442.12925931849;5232.529072383504;5517.5585953124455;5540.501354878081;5545.306836645419;5547.528460080938;5373;5376.086065368975;5404.945950540444;5422.593305502024;5425.240466334795 22:05:35 INFO - PROCESS | 3391 | |5;yui.html;676.4419354032918;688.5902887781774;693.712109474568;698.3470455124458;744.7840126363355;13366.532171374003;14927.402903883845;15422.845771542296;15426.537203883874;16198.919005404987;14708.485203017897;14792.926035369808;14821.481248156317;14843.703125937474;14872;662.9701663425134;798.4410912361355;818.46799580273;819.8237378963522;820.0610301205116;659.324192702479;794.1621589223367;800.4636893281515;815.3843847894831;816.2164322250617;847.2332539052168;848.0332421040019;850.4174640371366;850.8978922529274;851.2764150472111;698.657657747705;851.3742399336483;851.5188918261224;851.7061613743249;853.2363534636496;516.0195628306211;603.4418163199024;604.29901314475;609.6738245038928;612.4763327355092;13480.460781568725;13498.59504214875;13523.459061637523;13533.255670938095;13555;12696.619101426879;12946.87053129466;13096.214227146307;13224.206547607175;13353;11451.423429728327;11635.360055196961;11648.825267620992;11667.533298668042;12168.695782605417;4290.742555446652;4323.200207961506;4366.279563871957;4415.558444155591;4514.413126293561;60703;60935;62844.685776571285;62954.370456295306;64167.35832641661;9525.666601669047;9682;9744.902550974399;9804.411735295906;10123.088921997056;18497.16762745653;18595.163217655238;18616.255349786126;18630.16164272611;18993.145308461153;6996;7056.047433596399;7167.569945803269;7287.6356182190675;7496.550206987598;3996.2606917720314;4073.796310184538;4104.91790164195;4145.709800314009;4145.958540414617;3248.9350212996083;3336.366090442808;3337.349216902681;3337.8497967591516;3344.3812894614575;560.8906263278703;562.7383266780967;568.3747877334898;569.1803802524435;636.522608043967;550.6640949021094;600.5975996082635;633.7813454358239;647.5952529668957;670.3865962644126;8255.628496717542;9004.054574269738;9077.546122693839;9288.256939444827;9291.814163716688;615.0067640760141;648.847520832604;655.8950567909112;662.9337066293429;680.884249677556;4202.810873510699;4438.733675979452;4559.475660299108;4577.153226653079;4593.104344652761;53149.7342513285;54499;89635;94294.0570594299;94929;65262;65480;68924.6553767238;72632.27367726361;79732.60133699294;52341.21488177757;65407.67296163489;65628;66619.66690166519;66802;9245.768855778659;9496.525173741147;9822.803543928938;9964.153046991087;9997.850032249376;39645.60354396419;45919.77040114778;46310.768446157555;47187.76406117948;49243;52422;52785.47214527806;56210.71894640501;62346.688266558376;63408.68295658492;12157.513699451923;12175.391230438265;12203.14577979533;12421.254724716546;12601.810972835232;13617.25105119228;13658.248796316298;13877.852905753343;14168.220747858966;14836.62908427298;10162.644307449204;13254.403551839998;13407.396667149807;13479.854212392056;13490;12778.808317875426;13247.20516768997;13359.933200333937;13419.463221471031;13527.93236033853;12930.547430839875;13126.34368281563;13220.471181152647;13474.326283685581;13493.462392575078;10454.215933805148;10653.467326633483;10792.784144316913;10903.454827258447;11115.166362523005;9771.657991970247;10240.846387304346;11118.825580291756;11229.775404492028;11373.20387572862 22:05:35 INFO - PROCESS | 3391 | __end_tp_report 22:05:35 INFO - PROCESS | 3391 | __start_cc_report 22:05:35 INFO - PROCESS | 3391 | _x_x_mozilla_cycle_collect,1492 22:05:35 INFO - PROCESS | 3391 | __end_cc_report 22:05:35 INFO - PROCESS | 3391 | __startTimestamp1477458335930__endTimestamp 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | ------- Summary: start ------- 22:05:35 INFO - PROCESS | 3391 | Number of tests: 6 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#0] dojo.html Cycles:165 Average:5369.23 Median:5562.97 stddev:613.21 (11.0%) stddev-sans-first:587.35 22:05:35 INFO - PROCESS | 3391 | Values: 3044.7 3056.9 3088.7 3095.3 3101.1 5271.9 5364.4 5394.4 5473.5 5481.7 5372.0 5390.8 5454.8 5455.6 5472.6 4829.1 4848.1 4899.6 4979.4 4985.8 4965.8 5038.3 5047.0 5053.6 5115.2 4824.5 4913.8 4922.8 4939.3 5029.2 4818.5 4849.6 4859.4 4874.2 4929.0 4805.9 4821.1 4850.1 4856.4 4925.0 5327.2 5345.8 5347.5 5358.6 5370.2 5615.2 5679.9 5704.2 5794.8 5825.3 5862.9 5884.6 5898.9 5934.5 5950.0 5461.8 5471.9 5477.6 5478.3 5482.8 5721.5 5721.7 5789.9 5966.3 5977.0 5501.9 5681.1 5696.7 5757.3 5774.5 5697.5 5781.9 5794.5 5798.8 5802.7 5619.1 5740.4 5746.7 5747.5 5759.9 5595.1 5726.2 5795.1 5799.5 5868.2 4447.8 4464.2 4482.8 4490.1 4514.7 3948.2 3962.7 3964.7 4001.4 4014.1 5316.9 5351.3 5548.5 5562.9 5563.0 5692.5 5731.1 5734.6 5746.1 5816.0 5364.9 5413.1 5423.2 5424.3 5429.3 4895.6 4955.8 4960.8 4970.8 5026.2 5873.2 5899.9 5970.7 6025.1 6077.5 5884.0 5889.3 5889.9 5929.7 5954.1 6051.8 6056.5 6070.0 6073.7 6079.6 5539.1 5631.6 5683.8 5740.5 5780.7 5788.2 5809.9 5811.0 5825.4 5883.6 5647.6 5650.9 5654.3 5663.3 5665.8 5546.6 5590.3 5594.9 5640.0 5647.5 5561.3 5585.6 5612.7 5640.7 5703.3 5575.6 5608.9 5615.6 5616.7 5634.9 5398.6 5411.2 5442.9 5525.1 5620.8 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#1] ext.html Cycles:180 Average:63263.74 Median:39242.11 stddev:141595.58 (360.8%) stddev-sans-first:141914.52 22:05:35 INFO - PROCESS | 3391 | Values: 557.5 590.2 592.6 594.9 603.9 31872.8 34976.7 35002.1 35008.0 41224.8 41586.6 45550.0 45584.8 45602.3 45674.5 8841.0 9005.2 9011.8 9017.9 9018.5 8050.4 8208.1 8847.0 8940.9 8941.6 10446.9 10715.4 10722.4 11078.1 11081.7 10701.6 10758.5 10781.7 10788.4 10791.1 10692.3 10779.8 10787.1 10790.4 10795.7 41584.2 41617.8 41639.6 41896.2 41907.8 3275.6 3309.3 3326.2 3382.7 3464.5 30592.5 31184.2 31704.7 31794.7 31909.2 4028.8 4060.2 4123.7 4133.8 4299.4 231849.0 233093.0 233180.0 233194.0 233611.0 55364.0 55630.4 55639.0 56003.0 56259.4 59045.4 59637.7 59726.0 59753.4 59822.7 12592.2 12764.7 12777.2 12786.0 12789.0 10188.1 10209.1 10290.3 10307.0 10308.0 15080.4 15326.8 16585.7 16873.3 17123.9 6192.5 6294.2 6318.7 6332.0 6357.3 907.0 927.4 930.1 991.8 1040.9 29835.9 31287.8 31495.5 31515.5 31922.5 1016.2 1036.6 1050.0 1063.6 1108.3 15630.0 16192.2 16228.2 16410.2 16848.5 686780.0 709366.0 710221.0 710453.0 711698.0 49708.8 50252.0 50605.2 54652.0 56641.7 1288.9 1323.0 1330.4 1348.2 1350.6 30424.7 31319.5 32626.0 32937.2 33103.5 53953.2 54514.0 54621.2 54634.0 54638.5 436040.0 439485.2 440472.0 626118.0 647764.0 26762.0 26785.6 26845.3 27071.3 27118.6 45800.8 46659.3 48082.5 48308.5 48528.8 39332.0 39500.4 39503.6 41471.6 41996.0 39649.8 40305.4 40449.8 41446.6 41970.8 39152.2 39954.8 40196.2 40263.2 40492.2 33213.0 35707.5 36104.5 36490.8 36775.8 27057.9 27374.2 27439.2 27675.3 27725.2 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#2] jquery.html Cycles:180 Average:28214.87 Median:376.55 stddev:76060.78 (20199.2%) stddev-sans-first:76245.38 22:05:35 INFO - PROCESS | 3391 | Values: 353.0 364.9 374.2 378.9 387.4 13993.9 18275.2 18593.4 19214.8 20420.8 17425.7 17462.7 18008.5 18009.2 18157.3 5290.4 5565.1 5569.7 5569.8 5572.5 3975.4 4182.0 5441.0 5535.7 5535.9 4283.3 6166.6 6199.1 6311.6 6316.4 6144.8 6157.1 6207.1 6276.3 6282.2 5455.0 5466.0 5466.5 5470.8 5472.2 22014.7 22483.2 22710.5 22807.5 23043.7 2262.5 2356.8 2363.0 2412.9 2866.8 13663.2 14152.9 14226.9 14538.5 14806.9 1796.7 1823.4 1905.8 1957.7 1961.3 81037.6 81692.6 81768.0 82335.0 82394.0 9797.7 9861.2 9986.2 10047.8 10170.4 14076.7 14100.4 14102.7 14116.4 14135.6 6682.9 6860.3 6887.1 6962.8 7078.6 6324.4 6424.0 6583.4 6629.8 6643.8 6061.5 6220.2 6305.9 6306.9 6454.9 1758.8 1763.6 1822.8 1847.8 1892.1 876.4 914.4 920.8 963.3 1031.4 18420.4 19627.2 19692.2 19703.0 20029.5 946.3 964.7 974.2 981.5 1037.4 10207.5 10280.7 10980.1 11032.9 11104.2 451810.0 454131.0 457902.0 463541.8 465866.0 93504.5 96384.5 96485.0 97398.8 97837.5 985.3 1004.4 1029.2 1031.0 1031.7 17398.7 17428.4 18189.8 18196.9 18378.3 42669.4 43174.0 44989.9 45102.8 45662.0 61653.0 61736.7 62022.7 63488.4 64915.2 6929.2 7179.5 8067.5 8209.1 8254.0 10775.0 11879.6 11941.3 11959.3 12158.3 10122.7 10385.6 10504.2 10582.7 10950.6 10439.5 10472.9 10615.0 10646.4 10752.7 10785.4 10840.7 10857.6 11268.3 11343.4 7206.5 7211.6 7396.1 7451.4 7477.2 10297.7 10625.7 10713.3 11044.9 11072.5 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#3] mootools.html Cycles:180 Average:5534.59 Median:4917.02 stddev:3186.44 (64.8%) stddev-sans-first:3179.61 22:05:35 INFO - PROCESS | 3391 | Values: 1315.8 1425.4 1462.4 1568.6 1753.3 7338.1 8329.8 8517.1 8518.0 8642.9 8393.7 8492.7 8496.4 8498.7 8506.7 2251.6 2261.7 2268.8 2276.1 2276.3 2236.9 2279.2 2292.9 2307.3 2318.2 2225.1 2225.7 2257.4 2257.4 2261.0 2081.3 2113.9 2121.3 2126.0 2126.8 2227.3 2244.7 2245.7 2245.9 2249.7 8454.3 8610.7 8617.4 8622.0 8625.8 5018.3 5192.6 5206.3 5265.2 5268.7 3203.2 3495.1 3525.7 3560.7 3575.4 1025.6 1031.2 1063.2 1064.3 1101.2 11515.4 11701.6 11715.0 11740.9 11793.1 4245.2 4329.4 4349.8 4420.8 4523.3 9384.3 9398.1 9406.4 9413.0 9414.0 5087.9 5092.1 5094.5 5097.7 5097.8 4113.2 4229.3 4536.6 4622.0 4641.4 3498.9 3621.3 3668.7 3675.0 3691.1 1109.7 1116.7 1130.0 1132.0 1138.7 743.6 865.4 876.2 877.6 890.9 5259.4 5568.9 5637.9 5641.0 5770.1 410.7 430.5 436.8 437.1 442.6 3754.1 3874.2 3912.9 3953.0 4002.9 10210.3 10681.6 10704.7 10708.3 10713.3 9964.0 10364.3 10385.5 10619.3 10657.7 7954.7 8134.4 8138.9 8155.9 8165.5 5525.3 5722.0 5738.1 5746.3 5973.0 9543.6 9723.0 9738.0 9800.1 9891.0 9977.0 9977.9 9983.6 9988.8 9998.5 6712.2 6853.2 7108.0 7592.8 7709.1 7898.7 8264.4 8266.3 8277.5 8290.2 7369.0 7396.4 7498.6 7701.4 7709.2 7256.8 7340.3 7362.3 7379.2 7403.1 6422.5 6546.0 6549.0 6555.4 6558.7 4669.5 4760.2 4836.1 4901.0 4944.4 4656.2 4709.6 4798.3 4933.0 5017.7 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#4] prototype.html Cycles:180 Average:4411.17 Median:4919.59 stddev:1263.47 (25.7%) stddev-sans-first:1228.91 22:05:35 INFO - PROCESS | 3391 | Values: 308.6 316.4 323.7 327.2 332.6 4696.2 5048.0 5251.4 5268.3 5279.3 5116.2 5160.3 5218.8 5238.0 5238.2 4074.2 4089.2 4097.5 4103.9 4108.1 3876.0 4076.6 4088.9 4096.4 4097.5 3770.8 4014.6 4038.7 4052.1 4057.0 4022.7 4028.4 4038.4 4039.6 4052.9 3594.6 3607.3 3614.7 3623.4 3640.1 4940.2 5020.9 5021.2 5024.2 5146.6 4593.9 4600.4 4601.3 4616.2 4647.6 5354.8 5356.8 5360.2 5377.9 5378.3 3827.0 3921.7 3926.0 3944.6 3956.6 5294.8 5459.5 5626.0 5626.2 5626.9 3884.8 3982.1 3985.7 3994.9 3996.3 4015.9 4026.0 4031.6 4037.7 4047.6 4486.2 4589.7 4609.4 4628.1 4640.3 5369.2 5386.8 5394.1 5414.5 5419.0 1387.4 1413.6 1420.5 1426.1 1435.0 872.4 924.9 937.2 938.5 939.6 4599.0 4624.5 4624.7 4682.2 4694.3 4870.6 4881.7 4909.3 4915.3 4933.9 4348.5 4644.6 4657.2 4666.7 4668.3 2601.9 2609.9 2612.5 2616.6 2618.7 4999.3 5040.2 5040.6 5053.1 5120.9 4747.7 4954.8 4965.5 4972.7 5027.3 4969.3 5021.4 5047.8 5053.7 5062.3 4923.8 4931.1 4934.0 4935.8 4954.4 4502.3 4791.0 4852.7 4864.8 4866.4 5034.3 5044.2 5419.5 5583.4 5644.0 4029.5 4042.5 4068.7 4082.9 4099.3 5577.0 5577.4 5595.8 5605.7 5625.9 5312.4 5411.8 5430.4 5439.5 5445.4 5396.2 5406.1 5421.3 5421.9 5441.1 5417.3 5422.0 5428.9 5433.9 5442.1 5232.5 5517.6 5540.5 5545.3 5547.5 5373.0 5376.1 5404.9 5422.6 5425.2 22:05:35 INFO - PROCESS | 3391 | 22:05:35 INFO - PROCESS | 3391 | [#5] yui.html Cycles:180 Average:16910.61 Median:26428.62 stddev:21894.72 (82.8%) stddev-sans-first:21922.20 22:05:35 INFO - PROCESS | 3391 | Values: 676.4 688.6 693.7 698.3 744.8 13366.5 14927.4 15422.8 15426.5 16198.9 14708.5 14792.9 14821.5 14843.7 14872.0 663.0 798.4 818.5 819.8 820.1 659.3 794.2 800.5 815.4 816.2 847.2 848.0 850.4 850.9 851.3 698.7 851.4 851.5 851.7 853.2 516.0 603.4 604.3 609.7 612.5 13480.5 13498.6 13523.5 13533.3 13555.0 12696.6 12946.9 13096.2 13224.2 13353.0 11451.4 11635.4 11648.8 11667.5 12168.7 4290.7 4323.2 4366.3 4415.6 4514.4 60703.0 60935.0 62844.7 62954.4 64167.4 9525.7 9682.0 9744.9 9804.4 10123.1 18497.2 18595.2 18616.3 18630.2 18993.1 6996.0 7056.0 7167.6 7287.6 7496.6 3996.3 4073.8 4104.9 4145.7 4146.0 3248.9 3336.4 3337.3 3337.8 3344.4 560.9 562.7 568.4 569.2 636.5 550.7 600.6 633.8 647.6 670.4 8255.6 9004.1 9077.5 9288.3 9291.8 615.0 648.8 655.9 662.9 680.9 4202.8 4438.7 4559.5 4577.2 4593.1 53149.7 54499.0 89635.0 94294.1 94929.0 65262.0 65480.0 68924.7 72632.3 79732.6 52341.2 65407.7 65628.0 66619.7 66802.0 9245.8 9496.5 9822.8 9964.2 9997.9 39645.6 45919.8 46310.8 47187.8 49243.0 52422.0 52785.5 56210.7 62346.7 63408.7 12157.5 12175.4 12203.1 12421.3 12601.8 13617.3 13658.2 13877.9 14168.2 14836.6 10162.6 13254.4 13407.4 13479.9 13490.0 12778.8 13247.2 13359.9 13419.5 13527.9 12930.5 13126.3 13220.5 13474.3 13493.5 10454.2 10653.5 10792.8 10903.5 11115.2 9771.7 10240.8 11118.8 11229.8 11373.2 22:05:35 INFO - PROCESS | 3391 | -------- Summary: end -------- 22:05:35 INFO - PROCESS | 3391 | 22:05:36 INFO - TEST-INFO | 3391: exit 0 22:05:36 INFO - TEST-OK | dromaeo_css | took 1120673ms 22:05:36 INFO - TEST-START | kraken 22:05:36 INFO - operating with platform_type : linux_ 22:05:36 INFO - Initialising browser for kraken test... 22:05:36 INFO - TEST-INFO | started process 3695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVCxeE/profile http://localhost:49753/getInfo.html) 22:05:40 INFO - PROCESS | 3695 | __metrics Screen width/height:1600/1200 22:05:40 INFO - PROCESS | 3695 | colorDepth:24 22:05:40 INFO - PROCESS | 3695 | Browser inner width/height: 1024/697 22:05:40 INFO - PROCESS | 3695 | __metrics 22:05:41 INFO - PROCESS | 3695 | 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" 22:05:41 INFO - PROCESS | 3695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:42 INFO - PROCESS | 3695 | console.error: PushService: 22:05:42 INFO - PROCESS | 3695 | stateChangeProcessEnqueue: Error transitioning state 22:05:42 INFO - PROCESS | 3695 | UnknownError 22:05:42 INFO - TEST-INFO | 3695: exit 0 22:05:42 INFO - Browser initialized. 22:05:42 INFO - Running cycle 1/1 for kraken test... 22:05:42 INFO - TEST-INFO | started process 3780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVCxeE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:54 INFO - PROCESS | 3780 | RSS: Main: 171991040 22:05:54 INFO - PROCESS | 3780 | 22:05:57 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49753/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:58 INFO - PROCESS | 3780 | RSS: Main: 228704256 22:05:58 INFO - PROCESS | 3780 | 22:06:00 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49753/tests/kraken/driver.html?testName=audio-dft) 22:06:01 INFO - PROCESS | 3780 | RSS: Main: 215597056 22:06:01 INFO - PROCESS | 3780 | 22:06:04 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49753/tests/kraken/driver.html?testName=audio-fft) 22:06:05 INFO - PROCESS | 3780 | RSS: Main: 297332736 22:06:05 INFO - PROCESS | 3780 | 22:06:07 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49753/tests/kraken/driver.html?testName=audio-oscillator) 22:06:07 INFO - PROCESS | 3780 | RSS: Main: 205828096 22:06:07 INFO - PROCESS | 3780 | 22:06:09 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:10 INFO - PROCESS | 3780 | RSS: Main: 211111936 22:06:10 INFO - PROCESS | 3780 | 22:06:13 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49753/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:14 INFO - PROCESS | 3780 | RSS: Main: 247455744 22:06:14 INFO - PROCESS | 3780 | 22:06:17 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49753/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:17 INFO - PROCESS | 3780 | RSS: Main: 246136832 22:06:17 INFO - PROCESS | 3780 | 22:06:20 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49753/tests/kraken/driver.html?testName=json-parse-financial) 22:06:21 INFO - PROCESS | 3780 | RSS: Main: 246001664 22:06:21 INFO - PROCESS | 3780 | 22:06:22 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:23 INFO - PROCESS | 3780 | RSS: Main: 207978496 22:06:23 INFO - PROCESS | 3780 | 22:06:25 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:25 INFO - PROCESS | 3780 | RSS: Main: 216711168 22:06:25 INFO - PROCESS | 3780 | 22:06:27 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:28 INFO - PROCESS | 3780 | RSS: Main: 224952320 22:06:28 INFO - PROCESS | 3780 | 22:06:31 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:31 INFO - PROCESS | 3780 | RSS: Main: 233885696 22:06:31 INFO - PROCESS | 3780 | 22:06:34 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:35 INFO - PROCESS | 3780 | RSS: Main: 230965248 22:06:35 INFO - PROCESS | 3780 | 22:06:36 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:49753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49753/tests/kraken/driver.html?testName=ai-astar) 22:06:37 INFO - PROCESS | 3780 | RSS: Main: 281559040 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | __start_tp_report 22:06:37 INFO - PROCESS | 3780 | _x_x_mozilla_page_load 22:06:37 INFO - PROCESS | 3780 | _x_x_mozilla_page_load_details 22:06:37 INFO - PROCESS | 3780 | |i|pagename|runs| 22:06:37 INFO - PROCESS | 3780 | |0;ai-astar;104;111;110;110;111;110;111;113;110;111 22:06:37 INFO - PROCESS | 3780 | |1;audio-beat-detection;160;123;128;159;122;123;126;121;150;121 22:06:37 INFO - PROCESS | 3780 | |2;audio-dft;160;162;160;163;158;162;162;161;161;161 22:06:37 INFO - PROCESS | 3780 | |3;audio-fft;75;75;75;107;75;75;74;75;105;75 22:06:37 INFO - PROCESS | 3780 | |4;audio-oscillator;82;82;112;81;81;81;104;82;82;118 22:06:37 INFO - PROCESS | 3780 | |5;imaging-gaussian-blur;116;116;116;116;117;117;116;117;117;116 22:06:37 INFO - PROCESS | 3780 | |6;imaging-darkroom;146;146;146;145;146;147;146;145;145;145 22:06:37 INFO - PROCESS | 3780 | |7;imaging-desaturate;84;84;84;84;84;84;84;85;85;84 22:06:37 INFO - PROCESS | 3780 | |8;json-parse-financial;54;53;53;52;54;54;54;54;54;53 22:06:37 INFO - PROCESS | 3780 | |9;json-stringify-tinderbox;64;65;64;65;65;65;66;65;65;75 22:06:37 INFO - PROCESS | 3780 | |10;stanford-crypto-aes;80;80;79;79;80;83;79;86;82;87 22:06:37 INFO - PROCESS | 3780 | |11;stanford-crypto-ccm;133;131;128;133;135;139;132;129;168;139 22:06:37 INFO - PROCESS | 3780 | |12;stanford-crypto-pbkdf2;167;170;169;173;166;166;168;170;176;174 22:06:37 INFO - PROCESS | 3780 | |13;stanford-crypto-sha256-iterative;66;69;67;67;65;72;67;67;65;65 22:06:37 INFO - PROCESS | 3780 | __end_tp_report 22:06:37 INFO - PROCESS | 3780 | __start_cc_report 22:06:37 INFO - PROCESS | 3780 | _x_x_mozilla_cycle_collect,1731 22:06:37 INFO - PROCESS | 3780 | __end_cc_report 22:06:37 INFO - PROCESS | 3780 | __startTimestamp1477458397164__endTimestamp 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | ------- Summary: start ------- 22:06:37 INFO - PROCESS | 3780 | Number of tests: 14 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:0.97 22:06:37 INFO - PROCESS | 3780 | Values: 104.0 111.0 110.0 110.0 111.0 110.0 111.0 113.0 110.0 111.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:127.00 stddev:16.25 (12.8%) stddev-sans-first:14.07 22:06:37 INFO - PROCESS | 3780 | Values: 160.0 123.0 128.0 159.0 122.0 123.0 126.0 121.0 150.0 121.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 22:06:37 INFO - PROCESS | 3780 | Values: 160.0 162.0 160.0 163.0 158.0 162.0 162.0 161.0 161.0 161.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.14 (17.5%) stddev-sans-first:13.75 22:06:37 INFO - PROCESS | 3780 | Values: 75.0 75.0 75.0 107.0 75.0 75.0 74.0 75.0 105.0 75.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.50 stddev:14.76 (18.1%) stddev-sans-first:15.33 22:06:37 INFO - PROCESS | 3780 | Values: 82.0 82.0 112.0 81.0 81.0 81.0 104.0 82.0 82.0 118.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:06:37 INFO - PROCESS | 3780 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:06:37 INFO - PROCESS | 3780 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 145.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 22:06:37 INFO - PROCESS | 3780 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 85.0 84.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.71 (1.3%) stddev-sans-first:0.73 22:06:37 INFO - PROCESS | 3780 | Values: 54.0 53.0 53.0 52.0 54.0 54.0 54.0 54.0 54.0 53.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:3.25 (5.0%) stddev-sans-first:3.37 22:06:37 INFO - PROCESS | 3780 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 75.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.95 (3.6%) stddev-sans-first:3.08 22:06:37 INFO - PROCESS | 3780 | Values: 80.0 80.0 79.0 79.0 80.0 83.0 79.0 86.0 82.0 87.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:134.00 stddev:11.60 (8.7%) stddev-sans-first:12.22 22:06:37 INFO - PROCESS | 3780 | Values: 133.0 131.0 128.0 133.0 135.0 139.0 132.0 129.0 168.0 139.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.00 stddev:3.45 (2.0%) stddev-sans-first:3.49 22:06:37 INFO - PROCESS | 3780 | Values: 167.0 170.0 169.0 173.0 166.0 166.0 168.0 170.0 176.0 174.0 22:06:37 INFO - PROCESS | 3780 | 22:06:37 INFO - PROCESS | 3780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:2.26 22:06:37 INFO - PROCESS | 3780 | Values: 66.0 69.0 67.0 67.0 65.0 72.0 67.0 67.0 65.0 65.0 22:06:37 INFO - PROCESS | 3780 | -------- Summary: end -------- 22:06:37 INFO - PROCESS | 3780 | 22:06:38 INFO - TEST-INFO | 3780: exit 0 22:06:38 INFO - TEST-OK | kraken | took 61602ms 22:06:38 INFO - SUITE-END | took 1182s 22:06:38 INFO - Completed test suite (00:19:42) 22:06:38 INFO - javascript benchmark 22:06:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.7107524785147, 3056.8777248910046, 3088.6911308869117, 3095.2880837407397, 3101.1471845242554, 5271.920921186185, 5364.356277246736, 5394.433584473628, 5473.534749546288, 5481.671099734014, 5371.973140134294, 5390.78436862525, 5454.781808727646, 5455.618106732521, 5472.589555783312, 4829.106615276185, 4848.127337079324, 4899.559039686427, 4979.427365852919, 4985.750712464381, 4965.801367945278, 5038.29463875056, 5047.041062198189, 5053.570446512051, 5115.155999260118, 4824.517548245182, 4913.803447862081, 4922.827701030446, 4939.28380384844, 5029.220470827027, 4818.542238487338, 4849.587785038276, 4859.441164266119, 4874.195757699975, 4928.975355123202, 4805.879853003668, 4821.132196204681, 4850.102730994778, 4856.368672072608, 4925.039617274633, 5327.200919862013, 5345.839624811262, 5347.54545863602, 5358.624896257264, 5370.248165256867, 5615.1857980592995, 5679.943200567983, 5704.172894930211, 5794.768209271624, 5825.300963884319, 5862.853428664275, 5884.588078834483, 5898.911516327215, 5934.465898069195, 5950.0, 5461.781528738886, 5471.917921231185, 5477.589180811416, 5478.260434841325, 5482.780688772405, 5721.485066343966, 5721.685307308055, 5789.884202316014, 5966.31387390447, 5977.043673012297, 5501.862453438696, 5681.062624666966, 5696.686682232434, 5757.272818154537, 5774.509166720792, 5697.544196464273, 5781.88436231273, 5794.507466865363, 5798.797042103506, 5802.65184088956, 5619.100943849046, 5740.3685594585395, 5746.655200687972, 5747.48272655463, 5759.913601295984, 5595.07681232592, 5726.169705392695, 5795.1017592273265, 5799.536037117105, 5868.178455016301, 4447.777611119431, 4464.218761716752, 4482.7758612069265, 4490.101979604092, 4514.6614003949835, 3948.190620922704, 3962.7027972902147, 3964.72246942717, 4001.4397984282223, 4014.0566966762785, 5316.946830531645, 5351.277577527062, 5548.472895074961, 5562.888742225214, 5562.972185139049, 5692.516136128475, 5731.083026715705, 5734.62724922887, 5746.080627099644, 5816.011278082736, 5364.91952620711, 5413.079776438015, 5423.159410291411, 5424.349078110573, 5429.294191755047, 4895.583875370562, 4955.752212389366, 4960.826371077067, 4970.751462426864, 5026.246063090565, 5873.20711703923, 5899.8906317885985, 5970.731317090828, 6025.126356678345, 6077.513798896166, 5883.970580147072, 5889.293284805851, 5889.882202356014, 5929.703514824155, 5954.10688396744, 6051.818445446644, 6056.454919057306, 6069.998450255658, 6073.696315184135, 6079.574429789872, 5539.14143307788, 5631.605787594993, 5683.8010669626365, 5740.454656807597, 5780.7398667060925, 5788.247527821356, 5809.9419005809405, 5810.970945145247, 5825.417458254141, 5883.61756485827, 5647.576431767552, 5650.915236271377, 5654.321481422256, 5663.292088488939, 5665.830025099253, 5546.58400619947, 5590.329160500766, 5594.86012849682, 5640.0, 5647.463490968352, 5561.277033985556, 5585.553155747449, 5612.747426365741, 5640.746166422438, 5703.315602127771, 5575.637583557056, 5608.859778505407, 5615.634983726045, 5616.719164041863, 5634.887302254014, 5398.622096453368, 5411.188321751769, 5442.891142177214, 5525.060739674184, 5620.775168993195], "value": 5327.427505893576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.5121768452605, 590.2179612014081, 592.5881512348916, 594.9077892926596, 603.8882806680762, 31872.840635796816, 34976.650233497654, 35002.12494687634, 35007.99999999997, 41224.79387603058, 41586.58413415865, 45550.0, 45584.772076139656, 45602.315965260466, 45674.54325456744, 8840.999999999984, 9005.189532942033, 9011.774705632346, 9017.909820901805, 9018.549072546346, 8050.4364694471415, 8208.138145494726, 8847.02682704902, 8940.910590894073, 8941.552922353889, 10446.9477652612, 10715.35707857531, 10722.35665860047, 11078.113750899949, 11081.667549973474, 10701.571937122506, 10758.462076896201, 10781.676549703521, 10788.406637634927, 10791.082757965582, 10692.305000174963, 10779.838302425469, 10787.083097936686, 10790.352578845295, 10795.676129716043, 41584.1683166335, 41617.79191104056, 41639.583604163876, 41896.1620767586, 41907.79046104781, 3275.5905511811025, 3309.3050459403553, 3326.234965957843, 3382.6786455286956, 3464.5496085508976, 30592.54111188334, 31184.150022991118, 31704.682953170402, 31794.682053179404, 31909.202269943205, 4028.7784171870535, 4060.2285565742413, 4123.670106391512, 4133.772642504661, 4299.419578356913, 231849.0, 233093.0, 233180.0, 233194.0, 233611.0, 55364.0, 55630.44369556253, 55639.0, 56003.0, 56259.43740562624, 59045.40954590485, 59637.70181149067, 59726.0, 59753.42712301643, 59822.70088649616, 12592.181508201938, 12764.744705106032, 12777.23336599807, 12786.0, 12789.0, 10188.134008609202, 10209.132223760915, 10290.331128476626, 10307.0, 10308.0, 15080.396784128512, 15326.770098448533, 16585.668286634198, 16873.325066997182, 17123.914380428017, 6192.473639740582, 6294.181756371734, 6318.747250109944, 6332.0, 6357.332480089524, 906.9954650226839, 927.4388994658269, 930.0559931669361, 991.7718924647371, 1040.9115225205942, 29835.850820745756, 31287.843560782505, 31495.527567086512, 31515.527267091013, 31922.521162182587, 1016.1667432705111, 1036.6216331039268, 1049.968500944973, 1063.5798859450474, 1108.2906939558688, 15630.0, 16192.19039048043, 16228.188590570424, 16410.17949102564, 16848.494545163663, 686780.0, 709366.0, 710221.0, 710453.0, 711698.0, 49708.751456242484, 50252.0, 50605.24092138621, 54652.0, 56641.716791415776, 1288.935553222354, 1322.9669258268427, 1330.361426515278, 1348.2045593100117, 1350.5678182981549, 30424.695753042186, 31319.530207046457, 32626.0, 32937.17657058497, 33103.50344744782, 53953.190702138716, 54514.0, 54621.18068229059, 54634.0, 54638.453615464925, 436040.0, 439485.21029579866, 440472.0, 626118.0, 647764.0, 26762.0, 26785.598216027163, 26845.328866778487, 27071.323216919736, 27118.593221102095, 45800.77099614614, 46659.30011049905, 48082.51917480781, 48308.516914830405, 48528.75735621299, 39332.0, 39500.40749388704, 39503.60496394999, 41471.58528414798, 41996.0, 39649.80175099106, 40305.395419069326, 40449.79775101106, 41446.58553414427, 41970.790146049076, 39152.21695566016, 39954.80022599868, 40196.1960760789, 40263.1947361057, 40492.1901561973, 33213.0, 35707.46438803368, 36104.45388911952, 36490.8175459121, 36775.816120919226, 27057.86471067632, 27374.17877463679, 27439.176824695292, 27675.308117297227, 27725.168244952685], "value": 19582.192051631184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.95411596492454, 364.9014766013175, 374.2029477213535, 378.90337963819223, 387.4459522882277, 13993.860061399395, 18275.177617007233, 18593.442196734104, 19214.807851921476, 20420.795792042074, 17425.73861392077, 17462.738058929095, 18008.4597462076, 18009.18958646861, 18157.273709051624, 5290.365156181254, 5565.1374037024325, 5569.66582005079, 5569.777208911659, 5572.5263352615075, 3975.423563583279, 4181.979090104561, 5441.047816632094, 5535.6955367454775, 5535.916961245564, 4283.3146696528565, 6166.568340216187, 6199.070139479069, 6311.558190926637, 6316.368363163693, 6144.78493252734, 6157.138000679908, 6207.131001659771, 6276.340984196662, 6282.151909492229, 5455.0, 5466.0, 5466.453354664542, 5470.8085217017615, 5472.179173124024, 22014.669779953314, 22483.21308754186, 22710.54578908429, 22807.54384912309, 23043.654345184837, 2262.536180083079, 2356.7996720278798, 2362.976370236293, 2412.9396765081015, 2866.813657112302, 13663.248521331323, 14152.858471415257, 14226.928865355607, 14538.491152809602, 14806.925965370212, 1796.7484552162707, 1823.4347352320824, 1905.8189472000138, 1957.6574099532668, 1961.2743284984504, 81037.59481202615, 81692.59153704254, 81768.0, 82335.0, 82394.0, 9797.706068817946, 9861.161801246832, 9986.20110391167, 10047.799044019224, 10170.389776613427, 14076.71846563063, 14100.435982560788, 14102.717945641234, 14116.435342586181, 14135.646608834655, 6682.9331706682315, 6860.3139686032, 6887.070245516891, 6962.756303529352, 7078.646067696697, 6324.35160157284, 6423.967880160662, 6583.44040756541, 6629.801105966829, 6643.800685979429, 6061.54538409621, 6220.160278362454, 6305.936940630627, 6306.905396419057, 6454.870902581922, 1758.806531281558, 1763.6296377760557, 1822.82683145101, 1847.7505536752635, 1892.0539730134933, 876.4259410086404, 914.4056363363734, 920.7652048727532, 963.2919803944095, 1031.3502493429091, 18420.447386578424, 19627.214911403385, 19692.212311507665, 19703.049959770226, 20029.499262518555, 946.252460556153, 964.7491652170346, 974.2449601558849, 981.4798156976814, 1037.419045334615, 10207.489625518694, 10280.663513743166, 10980.121590272758, 11032.944835275772, 11104.222704410613, 451810.0, 454131.0, 457902.0, 463541.77603783703, 465866.0, 93504.53247733854, 96384.51807740917, 96485.0, 97398.82514685665, 97837.51081244549, 985.3447457440722, 1004.4124187350336, 1029.1663752360612, 1031.030831018825, 1031.664708969588, 17398.73901891498, 17428.372955387164, 18189.817661851936, 18196.90901545484, 18378.264869405073, 42669.35995960125, 43174.0, 44989.87525311762, 45102.77448612736, 45662.0, 61653.0, 61736.69131654313, 62022.68988655028, 63488.36511634824, 64915.157635813004, 6929.1684997800585, 7179.497435179696, 8067.507511110463, 8209.05595856484, 8254.0, 10775.0, 11879.643610691694, 11941.343226122646, 11959.282443053444, 12158.331291779037, 10122.746931326776, 10385.63650272237, 10504.159667226451, 10582.682519524427, 10950.616728414467, 10439.530221139916, 10472.895271047191, 10615.0, 10646.361218326925, 10752.731181720519, 10785.406802625617, 10840.728981775519, 10857.565697372016, 11268.267562608404, 11343.432828358384, 7206.531575447579, 7211.567305961659, 7396.112466504054, 7451.3666338361845, 7477.177510473734, 10297.691069267934, 10625.734356641145, 10713.303635263683, 11044.944775276072, 11072.501737421997], "value": 8992.102723051084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.7960516120004, 1425.4298280687724, 1462.4004158295097, 1568.623530352715, 1753.2811547265633, 7338.082739657543, 8329.750967238842, 8517.105703901087, 8517.95741021294, 8642.870356944652, 8393.70622028229, 8492.660293588264, 8496.362772792034, 8498.702545410912, 8506.744797656065, 2251.5609456156058, 2261.739899911515, 2268.750437451879, 2276.1009401286483, 2276.3398614401885, 2236.8769717665523, 2279.2022792022826, 2292.8509646872985, 2307.2962746362355, 2318.200220923787, 2225.10995601759, 2225.710657614508, 2257.4243567890167, 2257.446925503254, 2260.9886950565224, 2081.250749730096, 2113.86259893108, 2121.2893680616935, 2125.9893700531475, 2126.8404869634837, 2227.287268074217, 2244.7194100737406, 2245.7080579524722, 2245.9438514037115, 2249.741279752833, 8454.28138608219, 8610.741677749678, 8617.439866408664, 8622.0, 8625.784355391166, 5018.322526458918, 5192.61055420845, 5206.271122042917, 5265.210218467222, 5268.710220937847, 3203.2472368993267, 3495.056334789618, 3525.665061819123, 3560.7151427885706, 3575.3921833288405, 1025.600015993763, 1031.1647565471917, 1063.1707268330715, 1064.3294724323705, 1101.2456467319832, 11515.36665483398, 11701.590444334408, 11715.0, 11740.941295293555, 11793.056555475627, 4245.172191422643, 4329.437173167531, 4349.760763158057, 4420.756858372756, 4523.276275795857, 9384.343095983351, 9398.107179817905, 9406.43561386319, 9412.95293523528, 9414.0, 5087.8982420351385, 5092.083424983464, 5094.541491265803, 5097.745112744348, 5097.847064588068, 4113.177364527107, 4229.259879521133, 4536.61438777701, 4621.95378046222, 4641.419822522184, 3498.8950331490096, 3621.311950729353, 3668.6514781095752, 3675.0, 3691.1141326082084, 1109.7336639206533, 1116.6873275482878, 1130.0451118804597, 1131.9773604527863, 1138.6754774889116, 743.5798773692846, 865.3812524045338, 876.2420506262165, 877.6313948141795, 890.9242714369351, 5259.39516955555, 5568.860778480571, 5637.881788596862, 5640.971795140998, 5770.076787713946, 410.671462829735, 430.5264209369668, 436.80343845269755, 437.1431993293181, 442.5640743867288, 3754.0990162360836, 3874.2251549690177, 3912.9021774455296, 3952.975973380366, 4002.899927501836, 10210.336328138646, 10681.572737090584, 10704.678859634223, 10708.250422470352, 10713.303635263683, 9963.950180249052, 10364.274500784873, 10385.532651030722, 10619.30974486656, 10657.733556661145, 7954.681812727542, 8134.389920755849, 8138.87791683137, 8155.918440815516, 8165.510069395856, 5525.309336332958, 5722.0, 5738.053221218619, 5746.339170995222, 5972.984592619178, 9543.618255269712, 9723.0, 9737.951310243403, 9800.11798938099, 9891.0, 9976.950115249378, 9977.900220997697, 9983.550740216562, 9988.800223995624, 9998.500074996076, 6712.194536655633, 6853.17761868579, 7108.0, 7592.772216833504, 7709.113451953097, 7898.68405263783, 8264.421490495608, 8266.256036956704, 8277.503349799032, 8290.170982901904, 7368.963155184189, 7396.408287337108, 7498.550086994798, 7701.422393320636, 7709.151993280622, 7256.7822965311125, 7340.302671246223, 7362.337389634744, 7379.225181356095, 7403.074615673041, 6422.454091402096, 6546.0, 6548.967255163694, 6555.4427873631275, 6558.704858281293, 4669.463011753692, 4760.214564596803, 4836.105320515716, 4901.044296362175, 4944.381952255968, 4656.161890859677, 4709.646776491845, 4798.328234047306, 4933.0, 5017.749112544431], "value": 4332.607021613081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.56338281331904, 316.3546365414554, 323.6763236763237, 327.15430611868317, 332.6457322951057, 4696.154692155411, 5047.974760126203, 5251.3698356197265, 5268.262443257942, 5279.260903473512, 5116.1814109742445, 5160.2517634942915, 5218.791248350061, 5238.030964271612, 5238.240455134013, 4074.1851629674034, 4089.1821635672836, 4097.528784189826, 4103.8919491737215, 4108.0551473161195, 3876.0, 4076.5923407659143, 4088.8568900088353, 4096.446979657738, 4097.467329247209, 3770.7737535747942, 4014.598540145991, 4038.717289789716, 4052.0882801369753, 4056.9594304056877, 4022.658074063708, 4028.395740638913, 4038.3740520219267, 4039.6162364575316, 4052.878413647595, 3594.6045934947133, 3607.2965771674535, 3614.6566076222716, 3623.3659109655705, 3640.1445660269815, 4940.1601727706375, 5020.874478138076, 5021.246812978046, 5024.196128619404, 5146.614003949681, 4593.908121837578, 4600.35595016698, 4601.263797792337, 4616.215243408628, 4647.60495357895, 5354.785808567653, 5356.785728570852, 5360.159115668702, 5377.919331210035, 5378.300820893259, 3826.9617303826885, 3921.745086569364, 3925.980370098131, 3944.5858184890462, 3956.5647778744315, 5294.841154765363, 5459.508644222039, 5625.971870140664, 5626.156076588503, 5626.874625075001, 3884.8446062157195, 3982.0841206522664, 3985.6847240410593, 3994.8601798936897, 3996.3406038003404, 4015.8795236142964, 4025.9597404025585, 4031.596840315945, 4037.6567991720444, 4047.6357127858632, 4486.170058539181, 4589.655775816827, 4609.400777898919, 4628.120657075145, 4640.303954406799, 5369.167778994262, 5386.8383948481605, 5394.083005889008, 5414.458554144633, 5419.0, 1387.4172847404116, 1413.6253892718437, 1420.5241244183107, 1426.1229343953394, 1434.9713005739827, 872.358816270041, 924.8531820542479, 937.1565590968183, 938.4885237545554, 939.5537119868007, 4598.977005114953, 4624.468186158635, 4624.653151013687, 4682.197354018659, 4694.2723877799, 4870.561649451495, 4881.707097574157, 4909.26361045846, 4915.336429581961, 4933.876653083702, 4348.543402942709, 4644.558766917137, 4657.231556793159, 4666.743329116931, 4668.323093151474, 2601.9089331873292, 2609.9478010439684, 2612.4905643399356, 2616.607508873646, 2618.711941686413, 4999.3000979862845, 5040.23591742887, 5040.647154699136, 5053.140966035783, 5120.948790512121, 4747.694384044346, 4954.835613630794, 4965.453800081988, 4972.72650004246, 5027.3464449621315, 4969.329140566049, 5021.372328459016, 5047.772850221749, 5053.671511351824, 5062.316587260672, 4923.842896919149, 4931.137051015986, 4933.950660493493, 4935.777889995031, 4954.430240522386, 4502.3471596618965, 4791.0, 4852.660313778002, 4864.781084851119, 4866.416030076413, 5034.345535080416, 5044.218146187347, 5419.539339156216, 5583.413741557078, 5644.008675402043, 4029.4560234367987, 4042.4946881639794, 4068.7355321903983, 4082.918341633091, 4099.262132816122, 5577.0, 5577.386487486292, 5595.832125036255, 5605.663660180402, 5625.8593535161945, 5312.353170516997, 5411.78352865881, 5430.402655707948, 5439.48324909133, 5445.40100588927, 5396.21754845553, 5406.080841301438, 5421.295231619864, 5421.945780542144, 5441.129419293053, 5417.322834645669, 5422.048062697505, 5428.891422171613, 5433.9456605435025, 5442.12925931849, 5232.529072383504, 5517.5585953124455, 5540.501354878081, 5545.306836645419, 5547.528460080938, 5373.0, 5376.086065368975, 5404.945950540444, 5422.593305502024, 5425.240466334795], "value": 4013.3204458636674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.4419354032918, 688.5902887781774, 693.712109474568, 698.3470455124458, 744.7840126363355, 13366.532171374003, 14927.402903883845, 15422.845771542296, 15426.537203883874, 16198.919005404987, 14708.485203017897, 14792.926035369808, 14821.481248156317, 14843.703125937474, 14872.0, 662.9701663425134, 798.4410912361355, 818.46799580273, 819.8237378963522, 820.0610301205116, 659.324192702479, 794.1621589223367, 800.4636893281515, 815.3843847894831, 816.2164322250617, 847.2332539052168, 848.0332421040019, 850.4174640371366, 850.8978922529274, 851.2764150472111, 698.657657747705, 851.3742399336483, 851.5188918261224, 851.7061613743249, 853.2363534636496, 516.0195628306211, 603.4418163199024, 604.29901314475, 609.6738245038928, 612.4763327355092, 13480.460781568725, 13498.59504214875, 13523.459061637523, 13533.255670938095, 13555.0, 12696.619101426879, 12946.87053129466, 13096.214227146307, 13224.206547607175, 13353.0, 11451.423429728327, 11635.360055196961, 11648.825267620992, 11667.533298668042, 12168.695782605417, 4290.742555446652, 4323.200207961506, 4366.279563871957, 4415.558444155591, 4514.413126293561, 60703.0, 60935.0, 62844.685776571285, 62954.370456295306, 64167.35832641661, 9525.666601669047, 9682.0, 9744.902550974399, 9804.411735295906, 10123.088921997056, 18497.16762745653, 18595.163217655238, 18616.255349786126, 18630.16164272611, 18993.145308461153, 6996.0, 7056.047433596399, 7167.569945803269, 7287.6356182190675, 7496.550206987598, 3996.2606917720314, 4073.796310184538, 4104.91790164195, 4145.709800314009, 4145.958540414617, 3248.9350212996083, 3336.366090442808, 3337.349216902681, 3337.8497967591516, 3344.3812894614575, 560.8906263278703, 562.7383266780967, 568.3747877334898, 569.1803802524435, 636.522608043967, 550.6640949021094, 600.5975996082635, 633.7813454358239, 647.5952529668957, 670.3865962644126, 8255.628496717542, 9004.054574269738, 9077.546122693839, 9288.256939444827, 9291.814163716688, 615.0067640760141, 648.847520832604, 655.8950567909112, 662.9337066293429, 680.884249677556, 4202.810873510699, 4438.733675979452, 4559.475660299108, 4577.153226653079, 4593.104344652761, 53149.7342513285, 54499.0, 89635.0, 94294.0570594299, 94929.0, 65262.0, 65480.0, 68924.6553767238, 72632.27367726361, 79732.60133699294, 52341.21488177757, 65407.67296163489, 65628.0, 66619.66690166519, 66802.0, 9245.768855778659, 9496.525173741147, 9822.803543928938, 9964.153046991087, 9997.850032249376, 39645.60354396419, 45919.77040114778, 46310.768446157555, 47187.76406117948, 49243.0, 52422.0, 52785.47214527806, 56210.71894640501, 62346.688266558376, 63408.68295658492, 12157.513699451923, 12175.391230438265, 12203.14577979533, 12421.254724716546, 12601.810972835232, 13617.25105119228, 13658.248796316298, 13877.852905753343, 14168.220747858966, 14836.62908427298, 10162.644307449204, 13254.403551839998, 13407.396667149807, 13479.854212392056, 13490.0, 12778.808317875426, 13247.20516768997, 13359.933200333937, 13419.463221471031, 13527.93236033853, 12930.547430839875, 13126.34368281563, 13220.471181152647, 13474.326283685581, 13493.462392575078, 10454.215933805148, 10653.467326633483, 10792.784144316913, 10903.454827258447, 11115.166362523005, 9771.657991970247, 10240.846387304346, 11118.825580291756, 11229.775404492028, 11373.20387572862], "value": 6888.0157334249725, "unit": "score"}], "name": "dromaeo_css", "value": 6946.605332429456, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0, 113.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 128.0, 159.0, 122.0, 123.0, 126.0, 121.0, 150.0, 121.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 163.0, 158.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 107.0, 75.0, 75.0, 74.0, 75.0, 105.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 81.0, 81.0, 81.0, 104.0, 82.0, 82.0, 118.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 75.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 80.0, 83.0, 79.0, 86.0, 82.0, 87.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 128.0, 133.0, 135.0, 139.0, 132.0, 129.0, 168.0, 139.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 169.0, 173.0, 166.0, 166.0, 168.0, 170.0, 176.0, 174.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 67.0, 65.0, 72.0, 67.0, 67.0, 65.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1496.8000000000002, "alertThreshold": 2.0}]} 22:06:38 INFO - Return code: 0 22:06:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:06:38 INFO - # TBPL SUCCESS # 22:06:38 INFO - Running post-action listener: _resource_record_post_action 22:06:38 INFO - [mozharness: 2016-10-26 05:06:38.965445Z] Finished run-tests step (success) 22:06:38 INFO - Running post-run listener: _resource_record_post_run 22:06:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7741440; Write bytes: 425336832; Read time: 1236; Write time: 368416 22:06:39 INFO - TinderboxPrint: CPU usage
13.1% 22:06:39 INFO - TinderboxPrint: I/O read bytes / time
7,741,440 / 1,236 22:06:39 INFO - TinderboxPrint: I/O write bytes / time
425,336,832 / 368,416 22:06:39 INFO - TinderboxPrint: CPU idle
8,317.1 (86.9%) 22:06:39 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 22:06:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:06:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4653056; Read time: 0; Write time: 436 22:06:39 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5517312; Write bytes: 399712256; Read time: 1060; Write time: 364660 22:06:39 INFO - Running post-run listener: _upload_blobber_files 22:06:39 INFO - Blob upload gear active. 22:06:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:39 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 22:06:39 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'] 22:06:39 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 22:06:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:41 INFO - (blobuploader) - INFO - Done attempting. 22:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:45 INFO - (blobuploader) - INFO - Done attempting. 22:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:45 INFO - (blobuploader) - INFO - Done attempting. 22:06:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:45 INFO - Return code: 0 22:06:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:06:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b69fbf65d8cf5318abaf425f529c59088a57b38748958a8b8aff051312d877f2f08d29dcf970b864055ee40ccb23dd2fd7c75d844f41cb292f709a5db822025c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02f62bf5fdf93a9c3f7adc10a230df1e52a1989944e94a8c22fdad99ae23ae8674f3cd798a1fe2284eabee0103f5d82b5bdcf775c5408022416891ee21ec0706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec73bec6df2efa467cf5d876721782e844e6e204cba21568a61bea474ca53c52836e4619438aaa81b65ea70adf8d57be8a5f34f9f54504d8db047dd742c6982"} 22:06:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:06:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:06:45 INFO - Contents: 22:06:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b69fbf65d8cf5318abaf425f529c59088a57b38748958a8b8aff051312d877f2f08d29dcf970b864055ee40ccb23dd2fd7c75d844f41cb292f709a5db822025c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02f62bf5fdf93a9c3f7adc10a230df1e52a1989944e94a8c22fdad99ae23ae8674f3cd798a1fe2284eabee0103f5d82b5bdcf775c5408022416891ee21ec0706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec73bec6df2efa467cf5d876721782e844e6e204cba21568a61bea474ca53c52836e4619438aaa81b65ea70adf8d57be8a5f34f9f54504d8db047dd742c6982"} 22:06:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:06:45 INFO - Copying logs to upload dir... 22:06:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:06:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.967478 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-25 22:06:45.797132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:06:45.801014) ========= 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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 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/b69fbf65d8cf5318abaf425f529c59088a57b38748958a8b8aff051312d877f2f08d29dcf970b864055ee40ccb23dd2fd7c75d844f41cb292f709a5db822025c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02f62bf5fdf93a9c3f7adc10a230df1e52a1989944e94a8c22fdad99ae23ae8674f3cd798a1fe2284eabee0103f5d82b5bdcf775c5408022416891ee21ec0706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec73bec6df2efa467cf5d876721782e844e6e204cba21568a61bea474ca53c52836e4619438aaa81b65ea70adf8d57be8a5f34f9f54504d8db047dd742c6982"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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/b69fbf65d8cf5318abaf425f529c59088a57b38748958a8b8aff051312d877f2f08d29dcf970b864055ee40ccb23dd2fd7c75d844f41cb292f709a5db822025c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02f62bf5fdf93a9c3f7adc10a230df1e52a1989944e94a8c22fdad99ae23ae8674f3cd798a1fe2284eabee0103f5d82b5bdcf775c5408022416891ee21ec0706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec73bec6df2efa467cf5d876721782e844e6e204cba21568a61bea474ca53c52836e4619438aaa81b65ea70adf8d57be8a5f34f9f54504d8db047dd742c6982"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:06:45.827174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:06:45.827537) ========= 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=836cfdc75598d54cb747368e000001a9-1477457155.742563-140853835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:06:45.909504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:06:45.909815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:06:45.910133) ========= ========= Total master_lag: 0.16 =========