builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1478208177.04 results: success (0) buildid: 20161103134109 builduid: 392210f75dea4cb38f15113104caf556 revision: 8a36d67577d84f9d1833fa35c7c13e8aed02b209 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.039683) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.040187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.040467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.055167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.055515) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-03 14:22:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-11-03 14:22:57 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.214318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.215012) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:57.267090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 14:22:57.267449) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8a36d67577d84f9d1833fa35c7c13e8aed02b209 --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 8a36d67577d84f9d1833fa35c7c13e8aed02b209 --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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-03 14:22:57,317 truncating revision to first 12 chars 2016-11-03 14:22:57,317 Setting DEBUG logging. 2016-11-03 14:22:57,317 attempt 1/10 2016-11-03 14:22:57,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8a36d67577d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 14:22:58,206 unpacking tar archive at: mozilla-inbound-8a36d67577d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.218447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 14:22:58.500402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:58.500895) ========= script_repo_revision: 8a36d67577d84f9d1833fa35c7c13e8aed02b209 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:58.501364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:58.501818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 14:22:58.513031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-03 14:22:58.513513) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:22:58 INFO - MultiFileLogger online at 20161103 14:22:58 in /builds/slave/test 14:22: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 14:22:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:58 INFO - {'append_to_log': False, 14:22:58 INFO - 'base_work_dir': '/builds/slave/test', 14:22:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:22:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:58 INFO - 'branch': 'Mozilla-Inbound', 14:22:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:58 INFO - 'config_files': ('talos/linux_config.py',), 14:22:58 INFO - 'default_actions': ('clobber', 14:22:58 INFO - 'read-buildbot-config', 14:22:58 INFO - 'download-and-extract', 14:22:58 INFO - 'populate-webroot', 14:22:58 INFO - 'create-virtualenv', 14:22:58 INFO - 'install', 14:22:58 INFO - 'run-tests'), 14:22:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:58 INFO - 'download_minidump_stackwalk': True, 14:22:58 INFO - 'download_symbols': 'ondemand', 14:22:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:58 INFO - 'installer_path': 'installer.exe', 14:22:58 INFO - 'log_level': 'info', 14:22:58 INFO - 'log_name': 'talos', 14:22:58 INFO - 'log_to_console': True, 14:22:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:22:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:22:58 INFO - 'opt_config_files': (), 14:22:58 INFO - 'pip_index': False, 14:22:58 INFO - 'sps_profile': False, 14:22:58 INFO - 'sps_profile_interval': 0, 14:22:58 INFO - 'suite': 'dromaeojs', 14:22:58 INFO - 'system_bits': '32', 14:22:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:58 INFO - 'title': 'talos-linux64-ix-057', 14:22:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:58 INFO - 'use_talos_json': True, 14:22:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:58 INFO - 'work_dir': 'build'} 14:22:58 INFO - [mozharness: 2016-11-03 21:22:58.657763Z] Running clobber step. 14:22:58 INFO - Running pre-action listener: _resource_record_pre_action 14:22:58 INFO - Running main action method: clobber 14:22:58 INFO - rmtree: /builds/slave/test/build 14:22:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:59 INFO - Running post-action listener: _resource_record_post_action 14:22:59 INFO - [mozharness: 2016-11-03 21:22:59.638546Z] Finished clobber step (success) 14:22:59 INFO - [mozharness: 2016-11-03 21:22:59.638647Z] Running read-buildbot-config step. 14:22:59 INFO - Running pre-action listener: _resource_record_pre_action 14:22:59 INFO - Running main action method: read_buildbot_config 14:22:59 INFO - Using buildbot properties: 14:22:59 INFO - { 14:22:59 INFO - "project": "", 14:22:59 INFO - "product": "firefox", 14:22:59 INFO - "script_repo_revision": "production", 14:22:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:22:59 INFO - "repository": "", 14:22:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:22:59 INFO - "buildid": "20161103134109", 14:22:59 INFO - "stage_platform": "linux64-pgo", 14:22:59 INFO - "basedir": "/builds/slave/test", 14:22:59 INFO - "buildnumber": 2013, 14:22:59 INFO - "platform": "ubuntu64_hw", 14:22:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:22:59 INFO - "slavebuilddir": "test", 14:22:59 INFO - "branch": "mozilla-inbound", 14:22:59 INFO - "revision": "8a36d67577d84f9d1833fa35c7c13e8aed02b209", 14:22:59 INFO - "slavename": "talos-linux64-ix-057", 14:22:59 INFO - "builduid": "392210f75dea4cb38f15113104caf556", 14:22:59 INFO - "repo_path": "integration/mozilla-inbound" 14:22:59 INFO - } 14:22:59 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:22:59 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 14:22:59 INFO - Running post-action listener: _resource_record_post_action 14:22:59 INFO - [mozharness: 2016-11-03 21:22:59.641018Z] Finished read-buildbot-config step (success) 14:22:59 INFO - [mozharness: 2016-11-03 21:22:59.641106Z] Running download-and-extract step. 14:22:59 INFO - Running pre-action listener: _resource_record_pre_action 14:22:59 INFO - Running main action method: download_and_extract 14:22:59 INFO - mkdir: /builds/slave/test/build/tests 14:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:59 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:22:59 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/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 14:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/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 14:22:59 INFO - Downloaded 1361 bytes. 14:22:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:22:59 INFO - Using the following test package requirements: 14:22:59 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:22:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:22:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'jsshell-linux-x86_64.zip'], 14:22:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:22:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:22:59 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:22:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:22:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:22:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:22:59 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:22:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:59 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:22:59 INFO - Http code: 200 14:22:59 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 14:22:59 INFO - x-amz-cf-id: ianexCQPHPNm3s862KKtn9g8AxFpdE91tIE5MQagOttOnfYr_-k5rA== 14:22:59 INFO - x-amz-replication-status: COMPLETED 14:22:59 INFO - x-amz-version-id: gboZnomCQ.1LVzg_HfBfzRspc4zkG.cV 14:23:00 INFO - Expected file size: 22010092 14:23:00 INFO - Obtained file size: 22010092 14:23:04 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 14:23:04 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:23:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:04 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:23:04 INFO - Http code: 200 14:23:04 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 14:23:04 INFO - x-amz-cf-id: 7IbrjlKOBDV1Tma6URG5xxBUdqVcaujEoM1HKbjiPfjz2xrAC7YmMg== 14:23:04 INFO - x-amz-replication-status: COMPLETED 14:23:04 INFO - x-amz-version-id: gboZnomCQ.1LVzg_HfBfzRspc4zkG.cV 14:23:04 INFO - Expected file size: 22010092 14:23:04 INFO - Obtained file size: 22010092 14:23:09 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:23:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:23:09 INFO - Http code: 200 14:23:09 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 14:23:09 INFO - x-amz-cf-id: owK7IFScrbhRHKOCKtOEYQCPbGeT4o2B4xJw2QJlZjZPzHWg6dQXcA== 14:23:09 INFO - x-amz-replication-status: COMPLETED 14:23:09 INFO - x-amz-version-id: JWgq4c5JTlABj1EiUa197hkGVSAQ.t67 14:23:09 INFO - Expected file size: 14409038 14:23:09 INFO - Obtained file size: 14409038 14:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:09 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:23:09 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/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 14:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/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 14:23:10 INFO - Downloaded 59634205 bytes. 14:23:10 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:23:10 INFO - mkdir: /builds/slave/test/properties 14:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:10 INFO - Contents: 14:23:10 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:23:10 INFO - Running post-action listener: _resource_record_post_action 14:23:10 INFO - Running post-action listener: set_extra_try_arguments 14:23:10 INFO - [mozharness: 2016-11-03 21:23:10.450798Z] Finished download-and-extract step (success) 14:23:10 INFO - [mozharness: 2016-11-03 21:23:10.451026Z] Running populate-webroot step. 14:23:10 INFO - Running pre-action listener: _resource_record_pre_action 14:23:10 INFO - Running main action method: populate_webroot 14:23:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:10 INFO - '--tppagecycles', 14:23:10 INFO - '7'], 14:23:10 INFO - 'tests': ['tsvgm']}}, 14:23:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['damp', 'tps']}, 14:23:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'tests': ['damp', 'tps']}, 14:23:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['dromaeo_dom']}, 14:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['basic_compositor_video']}, 14:23:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:23:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['a11yr', 14:23:10 INFO - 'ts_paint', 14:23:10 INFO - 'tpaint', 14:23:10 INFO - 'sessionrestore', 14:23:10 INFO - 'sessionrestore_no_auto_restore', 14:23:10 INFO - 'tabpaint']}, 14:23:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['tsvgx', 14:23:10 INFO - 'tsvgr_opacity', 14:23:10 INFO - 'tart', 14:23:10 INFO - 'tscrollx', 14:23:10 INFO - 'cart']}, 14:23:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:10 INFO - 'tsvgr_opacity', 14:23:10 INFO - 'tart', 14:23:10 INFO - 'tscrollx', 14:23:10 INFO - 'cart']}, 14:23:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'talos_options': ['--disable-e10s'], 14:23:10 INFO - 'tests': ['tp5o']}, 14:23:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'tests': ['tp5o']}, 14:23:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'talos_options': ['--disable-e10s', 14:23:10 INFO - '--xperf_path', 14:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:10 INFO - 'tests': ['tp5n']}, 14:23:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:10 INFO - 'talos_options': ['--xperf_path', 14:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:10 INFO - 'tests': ['tp5n']}}, 14:23:10 INFO - 'talos.zip': {'path': '', 14:23:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:10 INFO - Running post-action listener: _resource_record_post_action 14:23:10 INFO - [mozharness: 2016-11-03 21:23:10.470862Z] Finished populate-webroot step (success) 14:23:10 INFO - [mozharness: 2016-11-03 21:23:10.470951Z] Running create-virtualenv step. 14:23:10 INFO - Running pre-action listener: _resource_record_pre_action 14:23:10 INFO - Running main action method: create_virtualenv 14:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:10 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 14:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:10 INFO - Using real prefix '/usr' 14:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:13 INFO - Installing pip.................done. 14:23:13 INFO - Return code: 0 14:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:23:13 INFO - Reading from file tmpfile_stdout 14:23:13 INFO - Output received: 14:23:13 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) 14:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:13 INFO - Using env: {'DISPLAY': ':0', 14:23:13 INFO - 'HOME': '/home/cltbld', 14:23:13 INFO - 'LANG': 'en_US.UTF-8', 14:23:13 INFO - 'LANGUAGE': 'en_US:en', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MAIL': '/var/mail/cltbld', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SHLVL': '1', 14:23:13 INFO - 'TERM': 'linux', 14:23:13 INFO - 'TMOUT': '86400', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - '_': '/tools/buildbot/bin/python'} 14:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:13 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 14:23:13 INFO - Cleaning up... 14:23:13 INFO - Return code: 0 14:23:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:23:13 INFO - Using env: {'DISPLAY': ':0', 14:23:13 INFO - 'HOME': '/home/cltbld', 14:23:13 INFO - 'LANG': 'en_US.UTF-8', 14:23:13 INFO - 'LANGUAGE': 'en_US:en', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MAIL': '/var/mail/cltbld', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SHLVL': '1', 14:23:13 INFO - 'TERM': 'linux', 14:23:13 INFO - 'TMOUT': '86400', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - '_': '/tools/buildbot/bin/python'} 14:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:13 INFO - Downloading/unpacking psutil>=3.1.1 14:23:13 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 14:23:13 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 14:23:13 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 14:23:13 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 14:23:13 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 14:23:13 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 14:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:15 INFO - Installing collected packages: psutil 14:23:15 INFO - Running setup.py install for psutil 14:23:15 INFO - building 'psutil._psutil_linux' extension 14:23:15 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 14:23:15 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 14:23:15 INFO - building 'psutil._psutil_posix' extension 14:23:15 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 14:23:16 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 14:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:16 INFO - Successfully installed psutil 14:23:16 INFO - Cleaning up... 14:23:16 INFO - Return code: 0 14:23:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:16 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')]} 14:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:16 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')]} 14:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:16 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:16 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 14:23:16 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 14:23:16 INFO - Using env: {'DISPLAY': ':0', 14:23:16 INFO - 'HOME': '/home/cltbld', 14:23:16 INFO - 'LANG': 'en_US.UTF-8', 14:23:16 INFO - 'LANGUAGE': 'en_US:en', 14:23:16 INFO - 'LOGNAME': 'cltbld', 14:23:16 INFO - 'MAIL': '/var/mail/cltbld', 14:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:16 INFO - 'MOZ_NO_REMOTE': '1', 14:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:16 INFO - 'NO_EM_RESTART': '1', 14:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:16 INFO - 'PWD': '/builds/slave/test', 14:23:16 INFO - 'SHELL': '/bin/bash', 14:23:16 INFO - 'SHLVL': '1', 14:23:16 INFO - 'TERM': 'linux', 14:23:16 INFO - 'TMOUT': '86400', 14:23:16 INFO - 'USER': 'cltbld', 14:23:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:16 INFO - '_': '/tools/buildbot/bin/python'} 14:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:18 INFO - Installing collected packages: mozsystemmonitor 14:23:18 INFO - Running setup.py install for mozsystemmonitor 14:23:18 INFO - Successfully installed mozsystemmonitor 14:23:18 INFO - Cleaning up... 14:23:18 INFO - Return code: 0 14:23:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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', '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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:23: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 jsonschema==2.5.1 14:23:18 INFO - Using env: {'DISPLAY': ':0', 14:23:18 INFO - 'HOME': '/home/cltbld', 14:23:18 INFO - 'LANG': 'en_US.UTF-8', 14:23:18 INFO - 'LANGUAGE': 'en_US:en', 14:23:18 INFO - 'LOGNAME': 'cltbld', 14:23:18 INFO - 'MAIL': '/var/mail/cltbld', 14:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:18 INFO - 'MOZ_NO_REMOTE': '1', 14:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:18 INFO - 'NO_EM_RESTART': '1', 14:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:18 INFO - 'PWD': '/builds/slave/test', 14:23:18 INFO - 'SHELL': '/bin/bash', 14:23:18 INFO - 'SHLVL': '1', 14:23:18 INFO - 'TERM': 'linux', 14:23:18 INFO - 'TMOUT': '86400', 14:23:18 INFO - 'USER': 'cltbld', 14:23:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:18 INFO - '_': '/tools/buildbot/bin/python'} 14:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:18 INFO - Downloading/unpacking jsonschema==2.5.1 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:20 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 14:23:20 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 14:23:20 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 14:23:20 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 14:23:20 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 14:23:20 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 14:23:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:21 INFO - warning: no files found matching '*.txt' 14:23:21 INFO - no previously-included directories found matching 'build' 14:23:21 INFO - no previously-included directories found matching 'dist' 14:23:21 INFO - no previously-included directories found matching '.git*' 14:23:21 INFO - Installing collected packages: jsonschema, functools32 14:23:21 INFO - Running setup.py install for functools32 14:23:21 INFO - warning: no files found matching '*.txt' 14:23:21 INFO - no previously-included directories found matching 'build' 14:23:21 INFO - no previously-included directories found matching 'dist' 14:23:21 INFO - no previously-included directories found matching '.git*' 14:23:21 INFO - Successfully installed jsonschema functools32 14:23:21 INFO - Cleaning up... 14:23:21 INFO - Return code: 0 14:23:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:21 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')]} 14:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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')]} 14:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:21 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 14:23:21 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 14:23:21 INFO - Using env: {'DISPLAY': ':0', 14:23:21 INFO - 'HOME': '/home/cltbld', 14:23:21 INFO - 'LANG': 'en_US.UTF-8', 14:23:21 INFO - 'LANGUAGE': 'en_US:en', 14:23:21 INFO - 'LOGNAME': 'cltbld', 14:23:21 INFO - 'MAIL': '/var/mail/cltbld', 14:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:21 INFO - 'MOZ_NO_REMOTE': '1', 14:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:21 INFO - 'NO_EM_RESTART': '1', 14:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:21 INFO - 'PWD': '/builds/slave/test', 14:23:21 INFO - 'SHELL': '/bin/bash', 14:23:21 INFO - 'SHLVL': '1', 14:23:21 INFO - 'TERM': 'linux', 14:23:21 INFO - 'TMOUT': '86400', 14:23:21 INFO - 'USER': 'cltbld', 14:23:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:21 INFO - '_': '/tools/buildbot/bin/python'} 14:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:21 INFO - Cleaning up... 14:23:21 INFO - Return code: 0 14:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:21 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')]} 14:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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')]} 14:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:21 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 14:23:21 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 14:23:21 INFO - Using env: {'DISPLAY': ':0', 14:23:21 INFO - 'HOME': '/home/cltbld', 14:23:21 INFO - 'LANG': 'en_US.UTF-8', 14:23:21 INFO - 'LANGUAGE': 'en_US:en', 14:23:21 INFO - 'LOGNAME': 'cltbld', 14:23:21 INFO - 'MAIL': '/var/mail/cltbld', 14:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:21 INFO - 'MOZ_NO_REMOTE': '1', 14:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:21 INFO - 'NO_EM_RESTART': '1', 14:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:21 INFO - 'PWD': '/builds/slave/test', 14:23:21 INFO - 'SHELL': '/bin/bash', 14:23:21 INFO - 'SHLVL': '1', 14:23:21 INFO - 'TERM': 'linux', 14:23:21 INFO - 'TMOUT': '86400', 14:23:21 INFO - 'USER': 'cltbld', 14:23:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:21 INFO - '_': '/tools/buildbot/bin/python'} 14:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:21 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:23 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 14:23:23 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 14:23:23 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 14:23:23 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 14:23:23 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 14:23:23 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 14:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:24 INFO - Downloading docopt-0.6.1.tar.gz 14:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:24 INFO - Running setup.py install for blobuploader 14:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:24 INFO - Running setup.py install for requests 14:23:24 INFO - Running setup.py install for docopt 14:23:24 INFO - Successfully installed blobuploader requests docopt 14:23:24 INFO - Cleaning up... 14:23:25 INFO - Return code: 0 14:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:25 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')]} 14:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:25 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')]} 14:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:25 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:25 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 14:23:25 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 14:23:25 INFO - Using env: {'DISPLAY': ':0', 14:23:25 INFO - 'HOME': '/home/cltbld', 14:23:25 INFO - 'LANG': 'en_US.UTF-8', 14:23:25 INFO - 'LANGUAGE': 'en_US:en', 14:23:25 INFO - 'LOGNAME': 'cltbld', 14:23:25 INFO - 'MAIL': '/var/mail/cltbld', 14:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:25 INFO - 'MOZ_NO_REMOTE': '1', 14:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:25 INFO - 'NO_EM_RESTART': '1', 14:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:25 INFO - 'PWD': '/builds/slave/test', 14:23:25 INFO - 'SHELL': '/bin/bash', 14:23:25 INFO - 'SHLVL': '1', 14:23:25 INFO - 'TERM': 'linux', 14:23:25 INFO - 'TMOUT': '86400', 14:23:25 INFO - 'USER': 'cltbld', 14:23:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:25 INFO - '_': '/tools/buildbot/bin/python'} 14:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:25 INFO - Running setup.py (path:/tmp/pip-1bKXZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:25 INFO - Running setup.py (path:/tmp/pip-l5zKkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:25 INFO - Running setup.py (path:/tmp/pip-Qzfyer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:25 INFO - Running setup.py (path:/tmp/pip-iBi64d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:25 INFO - Running setup.py (path:/tmp/pip-8hzk8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:25 INFO - Running setup.py (path:/tmp/pip-hz8aLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:25 INFO - Running setup.py (path:/tmp/pip-MWGHfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:25 INFO - Running setup.py (path:/tmp/pip-HLUgt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:25 INFO - Running setup.py (path:/tmp/pip-43f6wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:25 INFO - Running setup.py (path:/tmp/pip-TKcj2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:25 INFO - Running setup.py (path:/tmp/pip-sQa09S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:26 INFO - Running setup.py (path:/tmp/pip-6Cdkpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:26 INFO - Running setup.py (path:/tmp/pip-7H_Zxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:26 INFO - Running setup.py (path:/tmp/pip-1qxCsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:26 INFO - Running setup.py (path:/tmp/pip-vuEkZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:26 INFO - Running setup.py (path:/tmp/pip-37Dmu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:26 INFO - Running setup.py (path:/tmp/pip-58HeeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:26 INFO - Running setup.py install for manifestparser 14:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:26 INFO - Running setup.py install for mozcrash 14:23:26 INFO - Running setup.py install for mozdebug 14:23:26 INFO - Running setup.py install for mozdevice 14:23:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:26 INFO - Running setup.py install for mozfile 14:23:27 INFO - Running setup.py install for mozhttpd 14:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozinfo 14:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozInstall 14:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozleak 14:23:27 INFO - Running setup.py install for mozlog 14:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for moznetwork 14:23:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozprocess 14:23:27 INFO - Running setup.py install for mozprofile 14:23:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozrunner 14:23:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:27 INFO - Running setup.py install for mozscreenshot 14:23:28 INFO - Running setup.py install for moztest 14:23:28 INFO - Running setup.py install for mozversion 14:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:28 INFO - Cleaning up... 14:23:28 INFO - Return code: 0 14:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:28 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')]} 14:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:28 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')]} 14:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:28 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:28 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 14:23:28 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 14:23:28 INFO - Using env: {'DISPLAY': ':0', 14:23:28 INFO - 'HOME': '/home/cltbld', 14:23:28 INFO - 'LANG': 'en_US.UTF-8', 14:23:28 INFO - 'LANGUAGE': 'en_US:en', 14:23:28 INFO - 'LOGNAME': 'cltbld', 14:23:28 INFO - 'MAIL': '/var/mail/cltbld', 14:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:28 INFO - 'MOZ_NO_REMOTE': '1', 14:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:28 INFO - 'NO_EM_RESTART': '1', 14:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:28 INFO - 'PWD': '/builds/slave/test', 14:23:28 INFO - 'SHELL': '/bin/bash', 14:23:28 INFO - 'SHLVL': '1', 14:23:28 INFO - 'TERM': 'linux', 14:23:28 INFO - 'TMOUT': '86400', 14:23:28 INFO - 'USER': 'cltbld', 14:23:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:28 INFO - '_': '/tools/buildbot/bin/python'} 14:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:28 INFO - Running setup.py (path:/tmp/pip-CUaT3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:28 INFO - Running setup.py (path:/tmp/pip-fkCcDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:28 INFO - Running setup.py (path:/tmp/pip-4sNeGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:28 INFO - Running setup.py (path:/tmp/pip-C9WYoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:28 INFO - Running setup.py (path:/tmp/pip-JmiwvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:28 INFO - Running setup.py (path:/tmp/pip-GZ72l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:28 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)) 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:28 INFO - Running setup.py (path:/tmp/pip-R1oB9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:29 INFO - Running setup.py (path:/tmp/pip-P5wMwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:29 INFO - Running setup.py (path:/tmp/pip-6wKpku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:29 INFO - Running setup.py (path:/tmp/pip-7uou_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:29 INFO - Running setup.py (path:/tmp/pip-i_1ct8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:29 INFO - Running setup.py (path:/tmp/pip-1Xqb5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:29 INFO - Running setup.py (path:/tmp/pip-905YGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:29 INFO - Running setup.py (path:/tmp/pip-iVKLh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:29 INFO - Running setup.py (path:/tmp/pip-x76xW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:29 INFO - Running setup.py (path:/tmp/pip-kuUeTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:29 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)) 14:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:29 INFO - Running setup.py (path:/tmp/pip-xSS6Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:29 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)) 14:23:29 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)) 14:23:29 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)) 14:23:29 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)) 14:23:29 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)) 14:23:29 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)) 14:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:31 INFO - Downloading blessings-1.6.tar.gz 14:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:31 INFO - Installing collected packages: blessings 14:23:31 INFO - Running setup.py install for blessings 14:23:31 INFO - Successfully installed blessings 14:23:31 INFO - Cleaning up... 14:23:31 INFO - Return code: 0 14:23:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:32 INFO - Reading from file tmpfile_stdout 14:23:32 INFO - Current package versions: 14:23:32 INFO - argparse == 1.2.1 14:23:32 INFO - blessings == 1.6 14:23:32 INFO - blobuploader == 1.2.4 14:23:32 INFO - docopt == 0.6.1 14:23:32 INFO - functools32 == 3.2.3-2 14:23:32 INFO - jsonschema == 2.5.1 14:23:32 INFO - manifestparser == 1.1 14:23:32 INFO - mozInstall == 1.12 14:23:32 INFO - mozcrash == 0.17 14:23:32 INFO - mozdebug == 0.1 14:23:32 INFO - mozdevice == 0.48 14:23:32 INFO - mozfile == 1.2 14:23:32 INFO - mozhttpd == 0.7 14:23:32 INFO - mozinfo == 0.9 14:23:32 INFO - mozleak == 0.1 14:23:32 INFO - mozlog == 3.4 14:23:32 INFO - moznetwork == 0.27 14:23:32 INFO - mozprocess == 0.23 14:23:32 INFO - mozprofile == 0.28 14:23:32 INFO - mozrunner == 6.12 14:23:32 INFO - mozscreenshot == 0.1 14:23:32 INFO - mozsystemmonitor == 0.3 14:23:32 INFO - moztest == 0.7 14:23:32 INFO - mozversion == 1.4 14:23:32 INFO - psutil == 3.1.1 14:23:32 INFO - requests == 1.2.3 14:23:32 INFO - wsgiref == 0.1.2 14:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:32 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')]} 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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')]} 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:32 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 14:23:32 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 14:23:32 INFO - Using env: {'DISPLAY': ':0', 14:23:32 INFO - 'HOME': '/home/cltbld', 14:23:32 INFO - 'LANG': 'en_US.UTF-8', 14:23:32 INFO - 'LANGUAGE': 'en_US:en', 14:23:32 INFO - 'LOGNAME': 'cltbld', 14:23:32 INFO - 'MAIL': '/var/mail/cltbld', 14:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:32 INFO - 'MOZ_NO_REMOTE': '1', 14:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:32 INFO - 'NO_EM_RESTART': '1', 14:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:32 INFO - 'PWD': '/builds/slave/test', 14:23:32 INFO - 'SHELL': '/bin/bash', 14:23:32 INFO - 'SHLVL': '1', 14:23:32 INFO - 'TERM': 'linux', 14:23:32 INFO - 'TMOUT': '86400', 14:23:32 INFO - 'USER': 'cltbld', 14:23:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:32 INFO - '_': '/tools/buildbot/bin/python'} 14:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 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)) 14:23:32 INFO - Cleaning up... 14:23:32 INFO - Return code: 0 14:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:32 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')]} 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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')]} 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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 0x7f80b7a26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', '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 14:23:32 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 14:23:32 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 14:23:32 INFO - Using env: {'DISPLAY': ':0', 14:23:32 INFO - 'HOME': '/home/cltbld', 14:23:32 INFO - 'LANG': 'en_US.UTF-8', 14:23:32 INFO - 'LANGUAGE': 'en_US:en', 14:23:32 INFO - 'LOGNAME': 'cltbld', 14:23:32 INFO - 'MAIL': '/var/mail/cltbld', 14:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:32 INFO - 'MOZ_NO_REMOTE': '1', 14:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:32 INFO - 'NO_EM_RESTART': '1', 14:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:32 INFO - 'PWD': '/builds/slave/test', 14:23:32 INFO - 'SHELL': '/bin/bash', 14:23:32 INFO - 'SHLVL': '1', 14:23:32 INFO - 'TERM': 'linux', 14:23:32 INFO - 'TMOUT': '86400', 14:23:32 INFO - 'USER': 'cltbld', 14:23:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:32 INFO - '_': '/tools/buildbot/bin/python'} 14:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:32 INFO - Cleaning up... 14:23:32 INFO - Return code: 0 14:23:32 INFO - Running post-action listener: _resource_record_post_action 14:23:32 INFO - Running post-action listener: _start_resource_monitoring 14:23:32 INFO - Starting resource monitoring. 14:23:32 INFO - [mozharness: 2016-11-03 21:23:32.650680Z] Finished create-virtualenv step (success) 14:23:32 INFO - [mozharness: 2016-11-03 21:23:32.651194Z] Running install step. 14:23:32 INFO - Running pre-action listener: _resource_record_pre_action 14:23:32 INFO - Running main action method: install 14:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:32 INFO - Reading from file tmpfile_stdout 14:23:32 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:32 INFO - Reading from file tmpfile_stdout 14:23:32 INFO - Output received: 14:23:32 INFO - Usage: mozinstall [options] installer 14:23:32 INFO - Options: 14:23:32 INFO - -h, --help show this help message and exit 14:23:32 INFO - -d DEST, --destination=DEST 14:23:32 INFO - Directory to install application into. [default: 14:23:32 INFO - "/builds/slave/test"] 14:23:32 INFO - --app=APP Application being installed. [default: firefox] 14:23:32 INFO - mkdir: /builds/slave/test/build/application 14:23:32 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'] 14:23:32 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 14:23:49 INFO - Reading from file tmpfile_stdout 14:23:49 INFO - Output received: 14:23:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - [mozharness: 2016-11-03 21:23:49.922731Z] Finished install step (success) 14:23:49 INFO - [mozharness: 2016-11-03 21:23:49.923071Z] Running run-tests step. 14:23:49 INFO - Running pre-action listener: _resource_record_pre_action 14:23:49 INFO - Running main action method: run_tests 14:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:49 INFO - Python 2.7.3 14:23:49 INFO - Return code: 0 14:23:49 INFO - grabbing minidump binary from tooltool 14:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:49 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 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:49 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 14:23:49 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 14:23:49 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 14:23:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:50 INFO - Return code: 0 14:23:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:50 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 14:23:50 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 14:23:50 INFO - Using env: {'DISPLAY': ':0', 14:23:50 INFO - 'HOME': '/home/cltbld', 14:23:50 INFO - 'LANG': 'en_US.UTF-8', 14:23:50 INFO - 'LANGUAGE': 'en_US:en', 14:23:50 INFO - 'LOGNAME': 'cltbld', 14:23:50 INFO - 'MAIL': '/var/mail/cltbld', 14:23:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:50 INFO - 'MOZ_NO_REMOTE': '1', 14:23:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:50 INFO - 'NO_EM_RESTART': '1', 14:23:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:50 INFO - 'PWD': '/builds/slave/test', 14:23:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:50 INFO - 'SHELL': '/bin/bash', 14:23:50 INFO - 'SHLVL': '1', 14:23:50 INFO - 'TERM': 'linux', 14:23:50 INFO - 'TMOUT': '86400', 14:23:50 INFO - 'USER': 'cltbld', 14:23:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635', 14:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:50 INFO - '_': '/tools/buildbot/bin/python'} 14:23:50 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/1478190879/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 14:23:50 INFO - mozversion application_buildid: 20161103093439 14:23:50 INFO - mozversion application_changeset: 8a36d67577d84f9d1833fa35c7c13e8aed02b209 14:23:50 INFO - mozversion application_display_name: Nightly 14:23:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:50 INFO - mozversion application_name: Firefox 14:23:50 INFO - mozversion application_remotingname: firefox 14:23:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:23:50 INFO - mozversion application_vendor: Mozilla 14:23:50 INFO - mozversion application_version: 52.0a1 14:23:50 INFO - mozversion platform_buildid: 20161103093439 14:23:50 INFO - mozversion platform_changeset: 8a36d67577d84f9d1833fa35c7c13e8aed02b209 14:23:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:23:50 INFO - mozversion platform_version: 52.0a1 14:23:50 INFO - using testdate: 1478208230 14:23:50 INFO - actual date: 1478208230 14:23:50 INFO - starting webserver on 'localhost:43190' 14:23:50 INFO - SUITE-START | Running 2 tests 14:23:50 INFO - TEST-START | dromaeo_css 14:23:50 INFO - operating with platform_type : linux_ 14:23:50 INFO - Initialising browser for dromaeo_css test... 14:23:50 INFO - TEST-INFO | started process 3863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpURdT8e/profile http://localhost:43190/getInfo.html) 14:23:54 INFO - PROCESS | 3863 | __metrics Screen width/height:1600/1200 14:23:54 INFO - PROCESS | 3863 | colorDepth:24 14:23:54 INFO - PROCESS | 3863 | Browser inner width/height: 1024/697 14:23:54 INFO - PROCESS | 3863 | __metrics 14:23:55 INFO - PROCESS | 3863 | 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" 14:23:55 INFO - PROCESS | 3863 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:55 INFO - PROCESS | 3863 | console.error: PushService: 14:23:55 INFO - PROCESS | 3863 | stateChangeProcessEnqueue: Error transitioning state 14:23:55 INFO - PROCESS | 3863 | UnknownError 14:23:56 INFO - TEST-INFO | 3863: exit 0 14:23:56 INFO - Browser initialized. 14:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:56 INFO - TEST-INFO | started process 3948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpURdT8e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:08 INFO - PROCESS | 3948 | RSS: Main: 172269568 14:24:08 INFO - PROCESS | 3948 | 14:25:00 INFO - PROCESS | 3948 | 1478208300187 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] 14:27:10 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43190/tests/dromaeo/cssquery-ext.html) 14:27:12 INFO - PROCESS | 3948 | RSS: Main: 407261184 14:27:12 INFO - PROCESS | 3948 | 14:30:15 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-ext.html (next: http://localhost:43190/tests/dromaeo/cssquery-jquery.html) 14:30:16 INFO - PROCESS | 3948 | RSS: Main: 287588352 14:30:16 INFO - PROCESS | 3948 | 14:33:18 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43190/tests/dromaeo/cssquery-mootools.html) 14:33:18 INFO - PROCESS | 3948 | RSS: Main: 224509952 14:33:18 INFO - PROCESS | 3948 | 14:36:20 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43190/tests/dromaeo/cssquery-prototype.html) 14:36:21 INFO - PROCESS | 3948 | RSS: Main: 256733184 14:36:21 INFO - PROCESS | 3948 | 14:39:23 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43190/tests/dromaeo/cssquery-yui.html) 14:39:24 INFO - PROCESS | 3948 | RSS: Main: 221122560 14:39:24 INFO - PROCESS | 3948 | 14:42:27 INFO - PROCESS | 3948 | Cycle 1(1): loaded http://localhost:43190/tests/dromaeo/cssquery-yui.html (next: http://localhost:43190/tests/dromaeo/cssquery-dojo.html) 14:42:28 INFO - PROCESS | 3948 | RSS: Main: 314961920 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | __start_tp_report 14:42:28 INFO - PROCESS | 3948 | _x_x_mozilla_page_load 14:42:28 INFO - PROCESS | 3948 | _x_x_mozilla_page_load_details 14:42:28 INFO - PROCESS | 3948 | |i|pagename|runs| 14:42:28 INFO - PROCESS | 3948 | |0;dojo.html;2951.0556621881005;3005.1585556044315;3012.3975204959;3041.604591403118;3057.0981560439677;5288.497592728694;5379.112446446332;5392.433794451585;5429.918551221735;5491.148871924853;5305.071612467812;5373.543248823855;5377.220303056055;5379.112446446332;5496.697681627509;4866.805327786902;4896.755162241891;4928.507149285061;4953.554180123788;4954.405471343443;4956.405231372222;4973.850784476472;5025.246213068032;5029.622778291625;5064.746762661871;5025.271335656346;5065.246311677583;5074.391073071218;5083.923741143886;5143.048536020848;4836.516348365135;4862.3922009748785;4880;4954.43024052235;4957.206846904478;4906.852794416173;4922.064807686528;4922.975385123087;4923.556879880792;4925.729084900329;5232.3459567554055;5344.118220493614;5382.381026181961;5411.891762164774;5417.485338892799;5712.485876271114;5725.77096916127;5732.254806875079;5777.133429985493;5795.043817770063;5772.942270577282;5775.913361299584;5780.942190578125;5788.88422231553;5794.072948328248;5329.333833270841;5372.91940620891;5375.381831089475;5377.7311134443125;5413.675179489243;5899.970500147472;5924.052151655715;5947.732352044169;5968.432998865101;5972.552058595623;5704.401037891044;5718.1708652246025;5731.742071606787;5737.827865164052;5739.110437882135;5837.737301821428;5841.773227622162;5848.444397782204;5851.473367396955;5853.151293062568;5656.43435656431;5709.115087161414;5720.370759216483;5737.311522617312;5786.768529258867;5740.052891272977;5740.712964351766;5744.712764361765;5748.540116790647;5811.767529298865;4461.442319710036;4465.419495465569;4467.553244675506;4472.195004899149;4522.3668686383935;3843.2313537292653;3877.41838724188;3907.5897030811925;3918.1575961168487;3951.565327813938;5412.485813847678;5447.346318441733;5447.509724124848;5449.209864569694;5510.9448905511235;5702.087665973424;5753.539716822645;5760.51035661965;5760.855978600484;5764.74058667361;5393.083175860113;5442.510174084351;5444.727763611803;5450.411822188537;5498.367687715884;4905.852824415273;4933.45731969483;4956.479569645207;4979.402471703346;5034.295198672189;6112.572119951561;6116.4189402008515;6116.571839971249;6121.663308517986;6124.295705993868;5715.399883012224;5865.120231965239;5902.881942361215;5904.439078287728;5906.438888305604;5962.314333851489;6000.5799594028;6047.425494578008;6078.483328917092;6079.604825686316;5699.316082070178;5731.598788084794;5733.627314224562;5737.91393129095;5753.884922301614;5856.326522449973;5859.56053296013;5864.208331875142;5868.23712917318;5874.471297583238;5702.486776190163;5703.429657034263;5703.771849125988;5708.743106560298;5727.713614319351;5658.40586738403;5681.346645135863;5683.488486036276;5688.11834165705;5688.886222275449;5704.258446401941;5704.372519022987;5707.229524014205;5709.029464990878;5711.114777209539;5624.156376543551;5634.74643641029;5646.830595082154;5699.316082070012;5703.372629010889;5593.1889875966945;5601.579881508822;5602.411746766694;5602.663840169603;5603.299587551556 14:42:28 INFO - PROCESS | 3948 | |1;ext.html;591.2225423568009;598.7694737526053;607.8723468071705;615.3661728419729;618.953578481614;31372.68627313726;34392.656073439255;34406;34442.483362749546;40756.18487630245;39131.80434097833;42403.363949540784;42766.78616606913;42943.14113717724;43013;8529.573521323924;8692.913070869274;8697.95651021744;8699.652013919436;8705.477671339708;8056.8388632227325;8239.217274358927;8583.356248281403;8721.60752766127;8815.823683526325;8232.670693172266;8299.336053115736;10452.947735261314;10608.78782424351;10661.626843060494;10613.57545698171;10674.039336459717;10692.625758098508;10697.197710171768;10699.465026748632;10465.162786977024;10551.472426378727;10561.78876422475;10573.947130264376;10574.206934479946;41072;41400.792996035125;41461.58538414608;41486;41540;3388.136025313554;3467.133216695826;3863.2466668999277;4016.859409920639;4109.486314210723;29808.40383192324;30002;30475.695243047507;30509.542356864666;30518.84740576283;4099.118689481746;4201.390798334224;4208.85269015583;4258.297380932143;4391.121775644884;323233.9999999977;324303;326965;327423;329021;56206;56800.715996419756;56820.59076455426;56841.71579142078;56928.146077808866;58608.41391586115;58650.70674646685;58789.41210587925;58936.821263574486;59149.70425147933;16367.754483682755;16640.918340307842;16642.66714665724;16644.83355166457;16661.33354665824;12563.937180314222;12668.556600518938;12692.682682933;12704.872951270369;12747.298898560482;14713.190774507291;15306.770398444032;15412.383504659689;15661.216939152997;15697.764533532007;4889.532597713501;5567.749451274703;5636.943630563642;5883.646981181143;5891.381404952418;960.5533426956499;1016.3952448293254;1040.4485622619873;1106.0709004436312;1129.7799823347161;31666;31954.68045319517;32028.679713203037;32089.679103209135;32352.514712279335;1107.0755918807886;1108.539955918301;1134.385242017142;1146.2606618730872;1178.5698220149584;16123.355065797472;17396.739048914278;17670.91164544169;17933.150314986862;17938.446894582157;478019;481916;485595;485944;486680;56568.43431565714;56682;56746.43253567412;56838;56850.43149568451;1242.45332053896;1289.0654275650454;1340.4571148684797;1368.8015237790464;1399.734050530396;28757.85621071881;31338.373232535676;31620.841895790374;32913.506297406035;33234.335313293115;51826.48173518216;52483.47516524786;52525.7373713129;52533;52569.21146182887;443666;453998;454374;455418;456506;26931.730682692923;27005.59491607667;27384.315392115357;27393.72606273912;27743.86128069347;34737.47893781646;45364;46386;46619.30071048869;46791;36520.81739591392;40174.59825401709;40257.59742402656;40381.798091009354;42037.57962420337;40082.799586001885;40152.176500932175;40397.59602403938;40410.39384409295;41314.58685413108;38511.80744096261;39378;39382.60617393904;39436.40845387264;40238;33175.66824331726;35937.640623594474;36335.81832090823;36578.8171059143;36664.63335366612;27164.592531112445;27544.449111018068;27651;27655.446891062467;27773 14:42:28 INFO - PROCESS | 3948 | |2;jquery.html;374.8406927056001;389.7583498231097;401.8472980267498;404.3086322388715;412.6922714443734;13130.212187268771;15148.924255378735;16497.917510412448;18722.81277187231;19129.61740765184;18909;19323.516912077204;19391.612167756637;19459.805401945978;19466.318678846244;5435.239066530688;5554.222408862763;5793.507551858097;5795.159701843251;5801.100829371433;5451.318585176853;5726.885462290752;5760.510356619692;5767.9423205768035;5768.307803063638;5635.267415236013;5722.456366645162;5722.771089156428;5727.34135574408;6016.368281330463;6261.530385221126;6414.230292364946;6428.774992875227;6432.45324147448;6440.903386449207;5550.611457197998;5635.746391412396;5661.122526008476;5665.518430933375;5758.165066065439;12292.385380731017;12428.75712428759;12436.502539898484;13641.454341826315;22645.433864153365;2038.6330460517102;2107.378323394587;2144.0994782191515;2146.796054374832;2575.84544927305;9868.309218354718;9878.60485580576;9905.158061564776;10358.22313326496;10601.628942987036;1764.1796564597396;1823.3253696132383;1841.4659748672868;1866.2908094923978;1982.3953694123286;74154.62922685406;79263;81907;82889.58555207185;82913.58543207306;9868;10060.798784024279;10250.487475626189;11166.106711463064;11459.598914037968;15676.529704108894;15677.529674109795;15684;15712.21438928049;15775.29011194499;7512.2487751225535;7796;7831.686732530635;7871.409644276702;7997.5601341925585;7356.1172659280155;7387.556746595222;7481.9251807482315;7532.359749421361;7798.688052477951;4752.7861246244;4762.59517940972;4801.231802911518;4858.902821943612;4909;1901.91441385138;1926.6050459655737;1937.409090227494;1942.2813558983266;1976.5849171673822;861.190480947907;986.2750878104588;1010.4190090697731;1018.9606601266667;1033.2302434686208;18778.906105469385;19321.4203573893;19324.227030918606;19411.223551058083;19521.414357569294;988.9752756181009;1004.9397036177706;1008.3344992305043;1031.7317497450717;1045.8065257927308;9913.702588922344;10553.894461055292;10817.83773243402;10885.401302928414;10924.453777311102;427673;436464;436607;437473;455115;49611;60696.696516518015;84593;85714.57142714372;85918;982.4252812104855;982.823091843475;1007.0584003956178;1011.8279892418307;1018.9439580822977;15802.920985395;16133.354665813236;16135.826263188426;16855;17209.483715488554;40291.99270018156;41127.35490580343;41281;41501.792491037355;42188.36717449302;52189;55011.72494137504;55081;56590.7170464145;56758.432415675314;8435.831283374175;8455.408121431441;8574.142585741376;8714.433561818714;8738.69414570487;8011.599420028859;11331.603393881174;12432.502699891904;12809.423575939292;12938.935305323414;10547.103496202908;11093.5562577496;11387.487563059516;11618.244814087057;11643.359615221245;5406.21609866575;10413.219008574235;10647.467626618483;10812.39128387857;11366.602168924048;11128.554857805597;11272.9436352821;11556.364399958084;11637.127215459044;11848.170628055954;8257.298129659046;8329;8386.874196886929;8406.579671016547;8565.743027709179;10338.844917326396;11351.772964540829;11485.19603627738;11526.366049867338;11581.131415144066 14:42:28 INFO - PROCESS | 3948 | |3;mootools.html;1367.18652401821;1449.2463918762246;1494.7458931981562;1593.2989484626764;1778.9377371791982;7234.276572342763;8216.58917054148;8384.874226886586;8386.412951093425;8606.741797746077;8449.112843151457;8517.616707248173;8521.44610600312;8532.274756645676;8534.1039190885;2319.82601304902;2352.6706261123454;2357.2221167014845;2357.669926210332;2359.1742889988536;2313.90744370225;2356.434455730621;2360.280114565057;2369.7037870266217;2387.403149212697;2325.197806756666;2339.543788961153;2369.9170529031403;2379.690640216778;2383.4637206628545;2229.063793206857;2229.855059421149;2254.199759085526;2259.762724913877;2324.1749179041367;2294.162630639821;2330.8718020508863;2367.928962131122;2371.0515793682493;2371.1463873005705;8561.828763424759;8634.568271586459;8671.39858042591;8704.390692651517;8704.912950870474;5216;5418.8916221675345;5424.864378390533;5427.891442171174;5433.429489903543;3288.358770039843;3420.26464310172;3471.8784842530645;3474.808885511296;3482.8432720527635;1116.564539829467;1134.2513940799115;1158.25871442277;1171.2328424881716;1178.4873579992645;12195.39023048844;12343.444544995496;12364.752704945851;12373.814392784116;12377.443015064253;4160.2303573838935;4524.88687782808;4658.3711198988385;4748.4539277982785;4756.286557016406;9542.666006689733;9557.092076252746;9557.187639050619;9562.187214086742;9564.139227469423;5142.408623008327;5157.510036546522;5159.2003239497935;5159.458256883048;5166.070107380632;4379.255526560492;4422.380866678667;4840.903181936412;4908.141075311806;4931.408231012229;3652.2878038782183;3739.383001804672;3765.134019175605;3835.6164383561977;3849.2301539692176;1187;1203.9518419263306;1213.9393030348447;1216.6775804411839;1226.6381417481864;737.3806002957434;785.8781888807245;882.9955850220837;919.6183583812776;943.099340130174;5406.107992181246;5433.864153396196;5564.054110801174;5641.605087643826;5661.207430959669;494.37461611062037;501.14054396709815;588.1648059755072;825.475822852493;971.6696323250129;3789.2610940866816;3792.981035094807;4031.3348297531165;4036.354183330653;4112.629863312316;10117.848232276521;10833.458327083614;10855.348679079123;10872.782544349227;10875.238733288752;10753.51609177589;10779.353238805697;10791.892081079246;10829.783404332027;10881.347119172875;7728.420368472387;8118.35053195743;8225.547594882219;8228.42401031934;8243.25810677042;5371.758270877898;5429.782808687608;5708.628939118944;5755.395683453345;5805.158252053513;9290.16388525036;9350.906490935004;9373;9387.953060234928;9493.810123797624;9291;9571.37786043905;9678;9678.419294842332;9686.51567421612;7297.963510182415;7409.66656500448;7437.888431673638;7443.851122977402;7447.92552074494;7659.578723170279;7805.921940780519;7874.606269686378;7888.211178882066;7891.368690504861;6900.896486552605;6932.445404367538;6946.583205007716;6972.163340399185;7133.5719856808755;6961.582305061713;7048.682809273492;7067.151941767021;7125.75059872902;7169.820754481179;6492.772752953624;6599.4720422365135;6607.636579988147;6609.173853268341;6613.074169616161;4583.679142459996;4667.83662571822;4762.76186190696;5112.488751124858;5167.974160129175;4993.251012348177;5043.2687260347775;5065.214891691794;5155.381354237516;5283.39240987276 14:42:28 INFO - PROCESS | 3948 | |4;prototype.html;327.5753521680962;341.2645748412172;346.546024707633;351.2763706764065;353.9380608393534;5199.714015729133;5307.920381194281;5322.201669749539;5349.866253343668;5367.543758780504;5092.159793634046;5203.271541984125;5249.790008399669;5252;5273.762680679369;4183.8326466941435;4186.937195942063;4187.267228235047;4189.664826813862;4195.2029114468305;3993.282888358005;4101.646456669292;4188.6649068074485;4204.516480604739;4208.221479026374;4079.77561234132;4087.89780255493;4089.652379547742;4099.298791001731;4102.3026085565525;4076.816543255531;4081;4082.6733861291027;4093;4094.529129150141;3615.475756015363;3618.4029635110173;3627.038834708804;3640.7087433005295;3641.18073433478;4977.178765503688;5049.141645920203;5073.575336647748;5086.694798312076;5092.439831618519;4632.976835115836;4676.316526050619;4685.2269375553;4686.882827929295;4699;5459.454054594548;5460.399356070829;5461.290032295816;5463.262459567947;5475.260839786618;3782.1679230569507;3934.1934903344745;3957.327254366736;3961;3972.7616343019513;5699.68651724155;5728.536729206439;5732.369439361667;5732.484076433099;5749.9937510935415;4095.85664501747;4098.303288440972;4102.856400025985;4106.938395924063;4114.567970363129;4033.253848038122;4165.500139983222;4168.520620128724;4177.4778152730905;4200.4959404871615;4707.270373092176;4707.6233901287815;4708.882277943078;4709.1994360958715;4733.715977041388;5523.944760552343;5527;5548.140038294071;5574.1917421973585;5608.915866262009;1337.4716986790163;1361.224102261721;1371.8750624488023;1409.9929500352637;1424.6082327359852;889.9866502002475;908.5055084386148;922.6078916460477;926.7590426489162;930.9022552631876;4687.695299805502;4691.554302341272;4719.787609557578;4723.244280915106;4740.241561350236;4872.4640289568115;4924.630652701062;4935.432425271139;4943.307936888838;4978.755311172207;4582.399241533953;4655.650826188049;4667.323238130452;4675.50383877156;4710.552497512731;2533.4299782549147;2622.7246139155495;2644.471105778852;2644.9237348681577;2647.007372235412;5049.31834202378;5053.054573988968;5076.2131869559535;5083.949160508421;5107.668001579886;4950.554450099508;4989.501049894981;5008.398992120969;5028.522290382408;5360.65155764874;5895.675737834375;5956.940430595812;5963.403659634002;5967.224260846149;5967.582269241198;5742.971285143548;5754.309482861916;5763.164341170423;5767.155589305004;5779.422057794187;5468.507834294933;5631.6902570359025;5658.293817549512;5670.659760414388;5675.971620141873;5828.912566311424;5858.531317494505;5878.500327472213;5934.258217722785;5938.732757025858;4112.568180341021;4117;4121.732087414309;4124.752514849119;4155.480564929384;5466.34403871538;5548.944510555004;5756.30924289088;5783.334916484658;5791.247137872049;5430.321209848769;5456.536194423518;5546.473085056913;5571.7771289149605;5592.832215033555;5553.972230138824;5570.944290557042;5578.470045345685;5581.832545023656;5585.497305242548;5368.194770784414;5526.392096869261;5553.972230138824;5602.607817452739;5603.971980140073;5575.581831362745;5580.381689310055;5584.944150558605;5586.581006424453;5598.681252809765;5500.532454741392;5503.587230957774;5505.752241149078;5512.4211957743855;5512.889742205053 14:42:28 INFO - PROCESS | 3948 | |5;yui.html;710.7228181009403;718.4115343857429;733.3143510817386;773.7214602743015;813.1177672225635;11981.640550783479;12498;12501.187422817511;12510.937445312773;12556.497740090397;12361.752764944718;12495.375231238448;12518.18631788933;12520.499180032788;12550.811737823917;648.1929997153551;655.403582739707;757.3903008078495;775.0234704272629;786.7836345005127;774.3688893551737;785.0265670568511;786.2648423723837;786.3669745854585;789.2383849585178;838.6645341863273;842.0190478093015;842.6966292134827;843.2621456225802;843.3295530053622;673.5655502201078;682.8873235916068;811.6672164412621;837.1210229259284;838.0739283092187;611.3855575146949;613.0283500651473;613.3314686991156;613.4264462727364;613.8373331067271;12317.938410307981;12368.690782730504;12377.690557736129;12430.937845310806;12449.066320025944;12884.355782210852;13423.32883355838;13585.864141358657;13680.179189248578;13705;9712.417254964725;10296.794064118676;10435.895641043568;10573;10700.625478108306;3636.1636823530735;3734.3838266685966;4120.052387950788;4124.1957818225455;4221.894452638678;62053.6897315515;62119;62372.37627623711;62437.68781156065;64055.359446405404;9971.15533626267;10040.748981275527;10099.091081802526;10290.434026128485;10651.520681569347;18435.078246087643;19441.902790485958;20394.592108157754;20461.590768184553;20786.896065519577;7571.697132114764;7885.093214280317;8018.759437216893;8124.55314957683;8189.79525511867;4088.9182216356103;4114.588541145861;4137.710360274812;4181.832726690959;4256.404103425523;3226.741860651189;3291.127851119455;3318.8340582970754;3321.2029113013186;3329.8335083246225;552.3785741041329;563.1215304125577;565.045073825234;570.7831024210774;580.1877371679598;716.2658275267892;726.1358982810544;740.988885166723;758.1319389299222;774.8450309938034;7904.604769761489;7947.642356093989;7973.521588704696;8336.166383361615;8489.83020339602;593.2673148661399;640.4204195203348;685.3557655803628;725.3580581185689;733.7321877514669;3727.9811472082483;3969.92060158801;4002.779847108437;4026.295398305285;4170.937435938464;85977.57011214904;86013.13986860176;87346;87674;90643.54678226699;49451.50548494469;56059;74094.25905740874;78057.60971195108;78329.60835195788;43974;44390.556094438645;45209.54790452119;46791.766041169576;47313.5268647316;7670.194629563815;7770.261825126604;7942.682292708458;7983.2415920487465;8205.466644668077;46160;46163.229596300465;46742.53257467518;47888.760556197;48574.514254857;50974.74512627413;53162.93674126573;54219.45780542144;62705.372946269956;63334.366656332844;10976.725581860517;11204.271722338022;11302.943485282522;11590.13074019435;11595.942020289845;13422.798658020332;13521.459141634617;13546.187228766306;13570.389332479865;14187.361568729226;11183.88816111861;11478.253913495597;11506.884931150582;11686.532538698357;12789.424475898793;11738.41307934617;11746.941265293619;11852.762944740884;12365.629031129081;12448;11272.492737826653;11429.314241145557;11687.941560292144;11707.941460292644;12076.939615301868;10225.795484090128;10527.210459215436;10708.73228169302;10737.228357321266;10915.181361398085;9819.85270220933;10261.692149235534;10408.323458975143;10484.580616775549;10540.840507544317 14:42:28 INFO - PROCESS | 3948 | __end_tp_report 14:42:28 INFO - PROCESS | 3948 | __start_cc_report 14:42:28 INFO - PROCESS | 3948 | _x_x_mozilla_cycle_collect,2411 14:42:28 INFO - PROCESS | 3948 | __end_cc_report 14:42:28 INFO - PROCESS | 3948 | __startTimestamp1478209348131__endTimestamp 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | ------- Summary: start ------- 14:42:28 INFO - PROCESS | 3948 | Number of tests: 6 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#0] dojo.html Cycles:165 Average:5388.85 Median:5646.83 stddev:630.86 (11.2%) stddev-sans-first:603.11 14:42:28 INFO - PROCESS | 3948 | Values: 2951.1 3005.2 3012.4 3041.6 3057.1 5288.5 5379.1 5392.4 5429.9 5491.1 5305.1 5373.5 5377.2 5379.1 5496.7 4866.8 4896.8 4928.5 4953.6 4954.4 4956.4 4973.9 5025.2 5029.6 5064.7 5025.3 5065.2 5074.4 5083.9 5143.0 4836.5 4862.4 4880.0 4954.4 4957.2 4906.9 4922.1 4923.0 4923.6 4925.7 5232.3 5344.1 5382.4 5411.9 5417.5 5712.5 5725.8 5732.3 5777.1 5795.0 5772.9 5775.9 5780.9 5788.9 5794.1 5329.3 5372.9 5375.4 5377.7 5413.7 5900.0 5924.1 5947.7 5968.4 5972.6 5704.4 5718.2 5731.7 5737.8 5739.1 5837.7 5841.8 5848.4 5851.5 5853.2 5656.4 5709.1 5720.4 5737.3 5786.8 5740.1 5740.7 5744.7 5748.5 5811.8 4461.4 4465.4 4467.6 4472.2 4522.4 3843.2 3877.4 3907.6 3918.2 3951.6 5412.5 5447.3 5447.5 5449.2 5510.9 5702.1 5753.5 5760.5 5760.9 5764.7 5393.1 5442.5 5444.7 5450.4 5498.4 4905.9 4933.5 4956.5 4979.4 5034.3 6112.6 6116.4 6116.6 6121.7 6124.3 5715.4 5865.1 5902.9 5904.4 5906.4 5962.3 6000.6 6047.4 6078.5 6079.6 5699.3 5731.6 5733.6 5737.9 5753.9 5856.3 5859.6 5864.2 5868.2 5874.5 5702.5 5703.4 5703.8 5708.7 5727.7 5658.4 5681.3 5683.5 5688.1 5688.9 5704.3 5704.4 5707.2 5709.0 5711.1 5624.2 5634.7 5646.8 5699.3 5703.4 5593.2 5601.6 5602.4 5602.7 5603.3 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#1] ext.html Cycles:180 Average:57825.31 Median:21187.53 stddev:112899.61 (532.9%) stddev-sans-first:113134.54 14:42:28 INFO - PROCESS | 3948 | Values: 591.2 598.8 607.9 615.4 619.0 31372.7 34392.7 34406.0 34442.5 40756.2 39131.8 42403.4 42766.8 42943.1 43013.0 8529.6 8692.9 8698.0 8699.7 8705.5 8056.8 8239.2 8583.4 8721.6 8815.8 8232.7 8299.3 10452.9 10608.8 10661.6 10613.6 10674.0 10692.6 10697.2 10699.5 10465.2 10551.5 10561.8 10573.9 10574.2 41072.0 41400.8 41461.6 41486.0 41540.0 3388.1 3467.1 3863.2 4016.9 4109.5 29808.4 30002.0 30475.7 30509.5 30518.8 4099.1 4201.4 4208.9 4258.3 4391.1 323234.0 324303.0 326965.0 327423.0 329021.0 56206.0 56800.7 56820.6 56841.7 56928.1 58608.4 58650.7 58789.4 58936.8 59149.7 16367.8 16640.9 16642.7 16644.8 16661.3 12563.9 12668.6 12692.7 12704.9 12747.3 14713.2 15306.8 15412.4 15661.2 15697.8 4889.5 5567.7 5636.9 5883.6 5891.4 960.6 1016.4 1040.4 1106.1 1129.8 31666.0 31954.7 32028.7 32089.7 32352.5 1107.1 1108.5 1134.4 1146.3 1178.6 16123.4 17396.7 17670.9 17933.2 17938.4 478019.0 481916.0 485595.0 485944.0 486680.0 56568.4 56682.0 56746.4 56838.0 56850.4 1242.5 1289.1 1340.5 1368.8 1399.7 28757.9 31338.4 31620.8 32913.5 33234.3 51826.5 52483.5 52525.7 52533.0 52569.2 443666.0 453998.0 454374.0 455418.0 456506.0 26931.7 27005.6 27384.3 27393.7 27743.9 34737.5 45364.0 46386.0 46619.3 46791.0 36520.8 40174.6 40257.6 40381.8 42037.6 40082.8 40152.2 40397.6 40410.4 41314.6 38511.8 39378.0 39382.6 39436.4 40238.0 33175.7 35937.6 36335.8 36578.8 36664.6 27164.6 27544.4 27651.0 27655.4 27773.0 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#2] jquery.html Cycles:180 Average:26465.28 Median:20346.92 stddev:72328.21 (355.5%) stddev-sans-first:72504.58 14:42:28 INFO - PROCESS | 3948 | Values: 374.8 389.8 401.8 404.3 412.7 13130.2 15148.9 16497.9 18722.8 19129.6 18909.0 19323.5 19391.6 19459.8 19466.3 5435.2 5554.2 5793.5 5795.2 5801.1 5451.3 5726.9 5760.5 5767.9 5768.3 5635.3 5722.5 5722.8 5727.3 6016.4 6261.5 6414.2 6428.8 6432.5 6440.9 5550.6 5635.7 5661.1 5665.5 5758.2 12292.4 12428.8 12436.5 13641.5 22645.4 2038.6 2107.4 2144.1 2146.8 2575.8 9868.3 9878.6 9905.2 10358.2 10601.6 1764.2 1823.3 1841.5 1866.3 1982.4 74154.6 79263.0 81907.0 82889.6 82913.6 9868.0 10060.8 10250.5 11166.1 11459.6 15676.5 15677.5 15684.0 15712.2 15775.3 7512.2 7796.0 7831.7 7871.4 7997.6 7356.1 7387.6 7481.9 7532.4 7798.7 4752.8 4762.6 4801.2 4858.9 4909.0 1901.9 1926.6 1937.4 1942.3 1976.6 861.2 986.3 1010.4 1019.0 1033.2 18778.9 19321.4 19324.2 19411.2 19521.4 989.0 1004.9 1008.3 1031.7 1045.8 9913.7 10553.9 10817.8 10885.4 10924.5 427673.0 436464.0 436607.0 437473.0 455115.0 49611.0 60696.7 84593.0 85714.6 85918.0 982.4 982.8 1007.1 1011.8 1018.9 15802.9 16133.4 16135.8 16855.0 17209.5 40292.0 41127.4 41281.0 41501.8 42188.4 52189.0 55011.7 55081.0 56590.7 56758.4 8435.8 8455.4 8574.1 8714.4 8738.7 8011.6 11331.6 12432.5 12809.4 12938.9 10547.1 11093.6 11387.5 11618.2 11643.4 5406.2 10413.2 10647.5 10812.4 11366.6 11128.6 11272.9 11556.4 11637.1 11848.2 8257.3 8329.0 8386.9 8406.6 8565.7 10338.8 11351.8 11485.2 11526.4 11581.1 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#3] mootools.html Cycles:180 Average:5579.27 Median:5156.45 stddev:3163.88 (61.4%) stddev-sans-first:3156.92 14:42:28 INFO - PROCESS | 3948 | Values: 1367.2 1449.2 1494.7 1593.3 1778.9 7234.3 8216.6 8384.9 8386.4 8606.7 8449.1 8517.6 8521.4 8532.3 8534.1 2319.8 2352.7 2357.2 2357.7 2359.2 2313.9 2356.4 2360.3 2369.7 2387.4 2325.2 2339.5 2369.9 2379.7 2383.5 2229.1 2229.9 2254.2 2259.8 2324.2 2294.2 2330.9 2367.9 2371.1 2371.1 8561.8 8634.6 8671.4 8704.4 8704.9 5216.0 5418.9 5424.9 5427.9 5433.4 3288.4 3420.3 3471.9 3474.8 3482.8 1116.6 1134.3 1158.3 1171.2 1178.5 12195.4 12343.4 12364.8 12373.8 12377.4 4160.2 4524.9 4658.4 4748.5 4756.3 9542.7 9557.1 9557.2 9562.2 9564.1 5142.4 5157.5 5159.2 5159.5 5166.1 4379.3 4422.4 4840.9 4908.1 4931.4 3652.3 3739.4 3765.1 3835.6 3849.2 1187.0 1204.0 1213.9 1216.7 1226.6 737.4 785.9 883.0 919.6 943.1 5406.1 5433.9 5564.1 5641.6 5661.2 494.4 501.1 588.2 825.5 971.7 3789.3 3793.0 4031.3 4036.4 4112.6 10117.8 10833.5 10855.3 10872.8 10875.2 10753.5 10779.4 10791.9 10829.8 10881.3 7728.4 8118.4 8225.5 8228.4 8243.3 5371.8 5429.8 5708.6 5755.4 5805.2 9290.2 9350.9 9373.0 9388.0 9493.8 9291.0 9571.4 9678.0 9678.4 9686.5 7298.0 7409.7 7437.9 7443.9 7447.9 7659.6 7805.9 7874.6 7888.2 7891.4 6900.9 6932.4 6946.6 6972.2 7133.6 6961.6 7048.7 7067.2 7125.8 7169.8 6492.8 6599.5 6607.6 6609.2 6613.1 4583.7 4667.8 4762.8 5112.5 5168.0 4993.3 5043.3 5065.2 5155.4 5283.4 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#4] prototype.html Cycles:180 Average:4568.38 Median:5049.23 stddev:1348.47 (26.7%) stddev-sans-first:1314.15 14:42:28 INFO - PROCESS | 3948 | Values: 327.6 341.3 346.5 351.3 353.9 5199.7 5307.9 5322.2 5349.9 5367.5 5092.2 5203.3 5249.8 5252.0 5273.8 4183.8 4186.9 4187.3 4189.7 4195.2 3993.3 4101.6 4188.7 4204.5 4208.2 4079.8 4087.9 4089.7 4099.3 4102.3 4076.8 4081.0 4082.7 4093.0 4094.5 3615.5 3618.4 3627.0 3640.7 3641.2 4977.2 5049.1 5073.6 5086.7 5092.4 4633.0 4676.3 4685.2 4686.9 4699.0 5459.5 5460.4 5461.3 5463.3 5475.3 3782.2 3934.2 3957.3 3961.0 3972.8 5699.7 5728.5 5732.4 5732.5 5750.0 4095.9 4098.3 4102.9 4106.9 4114.6 4033.3 4165.5 4168.5 4177.5 4200.5 4707.3 4707.6 4708.9 4709.2 4733.7 5523.9 5527.0 5548.1 5574.2 5608.9 1337.5 1361.2 1371.9 1410.0 1424.6 890.0 908.5 922.6 926.8 930.9 4687.7 4691.6 4719.8 4723.2 4740.2 4872.5 4924.6 4935.4 4943.3 4978.8 4582.4 4655.7 4667.3 4675.5 4710.6 2533.4 2622.7 2644.5 2644.9 2647.0 5049.3 5053.1 5076.2 5083.9 5107.7 4950.6 4989.5 5008.4 5028.5 5360.7 5895.7 5956.9 5963.4 5967.2 5967.6 5743.0 5754.3 5763.2 5767.2 5779.4 5468.5 5631.7 5658.3 5670.7 5676.0 5828.9 5858.5 5878.5 5934.3 5938.7 4112.6 4117.0 4121.7 4124.8 4155.5 5466.3 5548.9 5756.3 5783.3 5791.2 5430.3 5456.5 5546.5 5571.8 5592.8 5554.0 5570.9 5578.5 5581.8 5585.5 5368.2 5526.4 5554.0 5602.6 5604.0 5575.6 5580.4 5584.9 5586.6 5598.7 5500.5 5503.6 5505.8 5512.4 5512.9 14:42:28 INFO - PROCESS | 3948 | 14:42:28 INFO - PROCESS | 3948 | [#5] yui.html Cycles:180 Average:16256.51 Median:46161.61 stddev:21631.00 (46.9%) stddev-sans-first:21660.18 14:42:28 INFO - PROCESS | 3948 | Values: 710.7 718.4 733.3 773.7 813.1 11981.6 12498.0 12501.2 12510.9 12556.5 12361.8 12495.4 12518.2 12520.5 12550.8 648.2 655.4 757.4 775.0 786.8 774.4 785.0 786.3 786.4 789.2 838.7 842.0 842.7 843.3 843.3 673.6 682.9 811.7 837.1 838.1 611.4 613.0 613.3 613.4 613.8 12317.9 12368.7 12377.7 12430.9 12449.1 12884.4 13423.3 13585.9 13680.2 13705.0 9712.4 10296.8 10435.9 10573.0 10700.6 3636.2 3734.4 4120.1 4124.2 4221.9 62053.7 62119.0 62372.4 62437.7 64055.4 9971.2 10040.7 10099.1 10290.4 10651.5 18435.1 19441.9 20394.6 20461.6 20786.9 7571.7 7885.1 8018.8 8124.6 8189.8 4088.9 4114.6 4137.7 4181.8 4256.4 3226.7 3291.1 3318.8 3321.2 3329.8 552.4 563.1 565.0 570.8 580.2 716.3 726.1 741.0 758.1 774.8 7904.6 7947.6 7973.5 8336.2 8489.8 593.3 640.4 685.4 725.4 733.7 3728.0 3969.9 4002.8 4026.3 4170.9 85977.6 86013.1 87346.0 87674.0 90643.5 49451.5 56059.0 74094.3 78057.6 78329.6 43974.0 44390.6 45209.5 46791.8 47313.5 7670.2 7770.3 7942.7 7983.2 8205.5 46160.0 46163.2 46742.5 47888.8 48574.5 50974.7 53162.9 54219.5 62705.4 63334.4 10976.7 11204.3 11302.9 11590.1 11595.9 13422.8 13521.5 13546.2 13570.4 14187.4 11183.9 11478.3 11506.9 11686.5 12789.4 11738.4 11746.9 11852.8 12365.6 12448.0 11272.5 11429.3 11687.9 11707.9 12076.9 10225.8 10527.2 10708.7 10737.2 10915.2 9819.9 10261.7 10408.3 10484.6 10540.8 14:42:28 INFO - PROCESS | 3948 | -------- Summary: end -------- 14:42:28 INFO - PROCESS | 3948 | 14:42:29 INFO - TEST-INFO | 3948: exit 0 14:42:29 INFO - TEST-OK | dromaeo_css | took 1118860ms 14:42:29 INFO - TEST-START | kraken 14:42:29 INFO - operating with platform_type : linux_ 14:42:29 INFO - Initialising browser for kraken test... 14:42:29 INFO - TEST-INFO | started process 4248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCw6J6H/profile http://localhost:43190/getInfo.html) 14:42:33 INFO - PROCESS | 4248 | __metrics Screen width/height:1600/1200 14:42:33 INFO - PROCESS | 4248 | colorDepth:24 14:42:33 INFO - PROCESS | 4248 | Browser inner width/height: 1024/697 14:42:33 INFO - PROCESS | 4248 | __metrics 14:42:33 INFO - PROCESS | 4248 | 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" 14:42:33 INFO - PROCESS | 4248 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:34 INFO - PROCESS | 4248 | console.error: PushService: 14:42:34 INFO - PROCESS | 4248 | stateChangeProcessEnqueue: Error transitioning state 14:42:34 INFO - PROCESS | 4248 | UnknownError 14:42:35 INFO - TEST-INFO | 4248: exit 0 14:42:35 INFO - Browser initialized. 14:42:35 INFO - Running cycle 1/1 for kraken test... 14:42:35 INFO - TEST-INFO | started process 4330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCw6J6H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:47 INFO - PROCESS | 4330 | RSS: Main: 172498944 14:42:47 INFO - PROCESS | 4330 | 14:42:49 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43190/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:50 INFO - PROCESS | 4330 | RSS: Main: 233943040 14:42:50 INFO - PROCESS | 4330 | 14:42:53 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43190/tests/kraken/driver.html?testName=audio-dft) 14:42:53 INFO - PROCESS | 4330 | RSS: Main: 217001984 14:42:53 INFO - PROCESS | 4330 | 14:42:57 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43190/tests/kraken/driver.html?testName=audio-fft) 14:42:57 INFO - PROCESS | 4330 | RSS: Main: 298504192 14:42:57 INFO - PROCESS | 4330 | 14:42:59 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43190/tests/kraken/driver.html?testName=audio-oscillator) 14:43:00 INFO - PROCESS | 4330 | RSS: Main: 207527936 14:43:00 INFO - PROCESS | 4330 | 14:43:02 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:03 INFO - PROCESS | 4330 | RSS: Main: 212983808 14:43:03 INFO - PROCESS | 4330 | 14:43:06 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43190/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:06 INFO - PROCESS | 4330 | RSS: Main: 248557568 14:43:06 INFO - PROCESS | 4330 | 14:43:09 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43190/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:10 INFO - PROCESS | 4330 | RSS: Main: 247345152 14:43:10 INFO - PROCESS | 4330 | 14:43:13 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43190/tests/kraken/driver.html?testName=json-parse-financial) 14:43:13 INFO - PROCESS | 4330 | RSS: Main: 247754752 14:43:13 INFO - PROCESS | 4330 | 14:43:15 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:15 INFO - PROCESS | 4330 | RSS: Main: 209805312 14:43:15 INFO - PROCESS | 4330 | 14:43:17 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:18 INFO - PROCESS | 4330 | RSS: Main: 218034176 14:43:18 INFO - PROCESS | 4330 | 14:43:20 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:20 INFO - PROCESS | 4330 | RSS: Main: 226672640 14:43:20 INFO - PROCESS | 4330 | 14:43:23 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:24 INFO - PROCESS | 4330 | RSS: Main: 234782720 14:43:24 INFO - PROCESS | 4330 | 14:43:27 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:27 INFO - PROCESS | 4330 | RSS: Main: 232083456 14:43:27 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:43190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43190/tests/kraken/driver.html?testName=ai-astar) 14:43:29 INFO - PROCESS | 4330 | RSS: Main: 282222592 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | __start_tp_report 14:43:29 INFO - PROCESS | 4330 | _x_x_mozilla_page_load 14:43:29 INFO - PROCESS | 4330 | _x_x_mozilla_page_load_details 14:43:29 INFO - PROCESS | 4330 | |i|pagename|runs| 14:43:29 INFO - PROCESS | 4330 | |0;ai-astar;106;114;113;114;111;112;113;113;112;112 14:43:29 INFO - PROCESS | 4330 | |1;audio-beat-detection;153;123;123;157;123;124;124;129;153;135 14:43:29 INFO - PROCESS | 4330 | |2;audio-dft;161;162;162;160;161;163;161;162;163;161 14:43:29 INFO - PROCESS | 4330 | |3;audio-fft;75;74;76;110;77;77;76;75;104;76 14:43:29 INFO - PROCESS | 4330 | |4;audio-oscillator;82;81;115;83;83;84;100;84;83;106 14:43:29 INFO - PROCESS | 4330 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;117;117;116 14:43:29 INFO - PROCESS | 4330 | |6;imaging-darkroom;145;146;146;146;145;146;146;145;145;146 14:43:29 INFO - PROCESS | 4330 | |7;imaging-desaturate;84;85;84;85;84;85;84;86;85;86 14:43:29 INFO - PROCESS | 4330 | |8;json-parse-financial;54;52;53;52;53;53;54;53;58;53 14:43:29 INFO - PROCESS | 4330 | |9;json-stringify-tinderbox;60;61;59;61;61;61;61;60;61;63 14:43:29 INFO - PROCESS | 4330 | |10;stanford-crypto-aes;80;79;79;86;82;83;80;81;81;89 14:43:29 INFO - PROCESS | 4330 | |11;stanford-crypto-ccm;134;153;130;132;138;135;141;132;180;137 14:43:29 INFO - PROCESS | 4330 | |12;stanford-crypto-pbkdf2;171;172;166;170;168;168;165;172;170;167 14:43:29 INFO - PROCESS | 4330 | |13;stanford-crypto-sha256-iterative;69;64;65;65;67;64;64;68;63;64 14:43:29 INFO - PROCESS | 4330 | __end_tp_report 14:43:29 INFO - PROCESS | 4330 | __start_cc_report 14:43:29 INFO - PROCESS | 4330 | _x_x_mozilla_cycle_collect,1726 14:43:29 INFO - PROCESS | 4330 | __end_cc_report 14:43:29 INFO - PROCESS | 4330 | __startTimestamp1478209409706__endTimestamp 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | ------- Summary: start ------- 14:43:29 INFO - PROCESS | 4330 | Number of tests: 14 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.31 (2.0%) stddev-sans-first:1.00 14:43:29 INFO - PROCESS | 4330 | Values: 106.0 114.0 113.0 114.0 111.0 112.0 113.0 113.0 112.0 112.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:132.00 stddev:14.29 (10.8%) stddev-sans-first:13.48 14:43:29 INFO - PROCESS | 4330 | Values: 153.0 123.0 123.0 157.0 123.0 124.0 124.0 129.0 153.0 135.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 14:43:29 INFO - PROCESS | 4330 | Values: 161.0 162.0 162.0 160.0 161.0 163.0 161.0 162.0 163.0 161.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.28 (17.5%) stddev-sans-first:13.85 14:43:29 INFO - PROCESS | 4330 | Values: 75.0 74.0 76.0 110.0 77.0 77.0 76.0 75.0 104.0 76.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:12.22 (14.7%) stddev-sans-first:12.61 14:43:29 INFO - PROCESS | 4330 | Values: 82.0 81.0 115.0 83.0 83.0 84.0 100.0 84.0 83.0 106.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 14:43:29 INFO - PROCESS | 4330 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:43:29 INFO - PROCESS | 4330 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 14:43:29 INFO - PROCESS | 4330 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 84.0 86.0 85.0 86.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:1.72 (3.2%) stddev-sans-first:1.81 14:43:29 INFO - PROCESS | 4330 | Values: 54.0 52.0 53.0 52.0 53.0 53.0 54.0 53.0 58.0 53.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 14:43:29 INFO - PROCESS | 4330 | Values: 60.0 61.0 59.0 61.0 61.0 61.0 61.0 60.0 61.0 63.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.23 (4.0%) stddev-sans-first:3.35 14:43:29 INFO - PROCESS | 4330 | Values: 80.0 79.0 79.0 86.0 82.0 83.0 80.0 81.0 81.0 89.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.50 stddev:15.12 (11.0%) stddev-sans-first:15.81 14:43:29 INFO - PROCESS | 4330 | Values: 134.0 153.0 130.0 132.0 138.0 135.0 141.0 132.0 180.0 137.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:170.00 stddev:2.47 (1.5%) stddev-sans-first:2.50 14:43:29 INFO - PROCESS | 4330 | Values: 171.0 172.0 166.0 170.0 168.0 168.0 165.0 172.0 170.0 167.0 14:43:29 INFO - PROCESS | 4330 | 14:43:29 INFO - PROCESS | 4330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.00 (3.1%) stddev-sans-first:1.62 14:43:29 INFO - PROCESS | 4330 | Values: 69.0 64.0 65.0 65.0 67.0 64.0 64.0 68.0 63.0 64.0 14:43:29 INFO - PROCESS | 4330 | -------- Summary: end -------- 14:43:29 INFO - PROCESS | 4330 | 14:43:30 INFO - TEST-INFO | 4330: exit 0 14:43:30 INFO - TEST-OK | kraken | took 61870ms 14:43:30 INFO - SUITE-END | took 1180s 14:43:31 INFO - Completed test suite (00:19:41) 14:43:31 INFO - javascript benchmark 14:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2951.0556621881005, 3005.1585556044315, 3012.3975204959, 3041.604591403118, 3057.0981560439677, 5288.497592728694, 5379.112446446332, 5392.433794451585, 5429.918551221735, 5491.148871924853, 5305.071612467812, 5373.543248823855, 5377.220303056055, 5379.112446446332, 5496.697681627509, 4866.805327786902, 4896.755162241891, 4928.507149285061, 4953.554180123788, 4954.405471343443, 4956.405231372222, 4973.850784476472, 5025.246213068032, 5029.622778291625, 5064.746762661871, 5025.271335656346, 5065.246311677583, 5074.391073071218, 5083.923741143886, 5143.048536020848, 4836.516348365135, 4862.3922009748785, 4880.0, 4954.43024052235, 4957.206846904478, 4906.852794416173, 4922.064807686528, 4922.975385123087, 4923.556879880792, 4925.729084900329, 5232.3459567554055, 5344.118220493614, 5382.381026181961, 5411.891762164774, 5417.485338892799, 5712.485876271114, 5725.77096916127, 5732.254806875079, 5777.133429985493, 5795.043817770063, 5772.942270577282, 5775.913361299584, 5780.942190578125, 5788.88422231553, 5794.072948328248, 5329.333833270841, 5372.91940620891, 5375.381831089475, 5377.7311134443125, 5413.675179489243, 5899.970500147472, 5924.052151655715, 5947.732352044169, 5968.432998865101, 5972.552058595623, 5704.401037891044, 5718.1708652246025, 5731.742071606787, 5737.827865164052, 5739.110437882135, 5837.737301821428, 5841.773227622162, 5848.444397782204, 5851.473367396955, 5853.151293062568, 5656.43435656431, 5709.115087161414, 5720.370759216483, 5737.311522617312, 5786.768529258867, 5740.052891272977, 5740.712964351766, 5744.712764361765, 5748.540116790647, 5811.767529298865, 4461.442319710036, 4465.419495465569, 4467.553244675506, 4472.195004899149, 4522.3668686383935, 3843.2313537292653, 3877.41838724188, 3907.5897030811925, 3918.1575961168487, 3951.565327813938, 5412.485813847678, 5447.346318441733, 5447.509724124848, 5449.209864569694, 5510.9448905511235, 5702.087665973424, 5753.539716822645, 5760.51035661965, 5760.855978600484, 5764.74058667361, 5393.083175860113, 5442.510174084351, 5444.727763611803, 5450.411822188537, 5498.367687715884, 4905.852824415273, 4933.45731969483, 4956.479569645207, 4979.402471703346, 5034.295198672189, 6112.572119951561, 6116.4189402008515, 6116.571839971249, 6121.663308517986, 6124.295705993868, 5715.399883012224, 5865.120231965239, 5902.881942361215, 5904.439078287728, 5906.438888305604, 5962.314333851489, 6000.5799594028, 6047.425494578008, 6078.483328917092, 6079.604825686316, 5699.316082070178, 5731.598788084794, 5733.627314224562, 5737.91393129095, 5753.884922301614, 5856.326522449973, 5859.56053296013, 5864.208331875142, 5868.23712917318, 5874.471297583238, 5702.486776190163, 5703.429657034263, 5703.771849125988, 5708.743106560298, 5727.713614319351, 5658.40586738403, 5681.346645135863, 5683.488486036276, 5688.11834165705, 5688.886222275449, 5704.258446401941, 5704.372519022987, 5707.229524014205, 5709.029464990878, 5711.114777209539, 5624.156376543551, 5634.74643641029, 5646.830595082154, 5699.316082070012, 5703.372629010889, 5593.1889875966945, 5601.579881508822, 5602.411746766694, 5602.663840169603, 5603.299587551556], "value": 5343.967938778169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2225423568009, 598.7694737526053, 607.8723468071705, 615.3661728419729, 618.953578481614, 31372.68627313726, 34392.656073439255, 34406.0, 34442.483362749546, 40756.18487630245, 39131.80434097833, 42403.363949540784, 42766.78616606913, 42943.14113717724, 43013.0, 8529.573521323924, 8692.913070869274, 8697.95651021744, 8699.652013919436, 8705.477671339708, 8056.8388632227325, 8239.217274358927, 8583.356248281403, 8721.60752766127, 8815.823683526325, 8232.670693172266, 8299.336053115736, 10452.947735261314, 10608.78782424351, 10661.626843060494, 10613.57545698171, 10674.039336459717, 10692.625758098508, 10697.197710171768, 10699.465026748632, 10465.162786977024, 10551.472426378727, 10561.78876422475, 10573.947130264376, 10574.206934479946, 41072.0, 41400.792996035125, 41461.58538414608, 41486.0, 41540.0, 3388.136025313554, 3467.133216695826, 3863.2466668999277, 4016.859409920639, 4109.486314210723, 29808.40383192324, 30002.0, 30475.695243047507, 30509.542356864666, 30518.84740576283, 4099.118689481746, 4201.390798334224, 4208.85269015583, 4258.297380932143, 4391.121775644884, 323233.9999999977, 324303.0, 326965.0, 327423.0, 329021.0, 56206.0, 56800.715996419756, 56820.59076455426, 56841.71579142078, 56928.146077808866, 58608.41391586115, 58650.70674646685, 58789.41210587925, 58936.821263574486, 59149.70425147933, 16367.754483682755, 16640.918340307842, 16642.66714665724, 16644.83355166457, 16661.33354665824, 12563.937180314222, 12668.556600518938, 12692.682682933, 12704.872951270369, 12747.298898560482, 14713.190774507291, 15306.770398444032, 15412.383504659689, 15661.216939152997, 15697.764533532007, 4889.532597713501, 5567.749451274703, 5636.943630563642, 5883.646981181143, 5891.381404952418, 960.5533426956499, 1016.3952448293254, 1040.4485622619873, 1106.0709004436312, 1129.7799823347161, 31666.0, 31954.68045319517, 32028.679713203037, 32089.679103209135, 32352.514712279335, 1107.0755918807886, 1108.539955918301, 1134.385242017142, 1146.2606618730872, 1178.5698220149584, 16123.355065797472, 17396.739048914278, 17670.91164544169, 17933.150314986862, 17938.446894582157, 478019.0, 481916.0, 485595.0, 485944.0, 486680.0, 56568.43431565714, 56682.0, 56746.43253567412, 56838.0, 56850.43149568451, 1242.45332053896, 1289.0654275650454, 1340.4571148684797, 1368.8015237790464, 1399.734050530396, 28757.85621071881, 31338.373232535676, 31620.841895790374, 32913.506297406035, 33234.335313293115, 51826.48173518216, 52483.47516524786, 52525.7373713129, 52533.0, 52569.21146182887, 443666.0, 453998.0, 454374.0, 455418.0, 456506.0, 26931.730682692923, 27005.59491607667, 27384.315392115357, 27393.72606273912, 27743.86128069347, 34737.47893781646, 45364.0, 46386.0, 46619.30071048869, 46791.0, 36520.81739591392, 40174.59825401709, 40257.59742402656, 40381.798091009354, 42037.57962420337, 40082.799586001885, 40152.176500932175, 40397.59602403938, 40410.39384409295, 41314.58685413108, 38511.80744096261, 39378.0, 39382.60617393904, 39436.40845387264, 40238.0, 33175.66824331726, 35937.640623594474, 36335.81832090823, 36578.8171059143, 36664.63335366612, 27164.592531112445, 27544.449111018068, 27651.0, 27655.446891062467, 27773.0], "value": 19677.769218706442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8406927056001, 389.7583498231097, 401.8472980267498, 404.3086322388715, 412.6922714443734, 13130.212187268771, 15148.924255378735, 16497.917510412448, 18722.81277187231, 19129.61740765184, 18909.0, 19323.516912077204, 19391.612167756637, 19459.805401945978, 19466.318678846244, 5435.239066530688, 5554.222408862763, 5793.507551858097, 5795.159701843251, 5801.100829371433, 5451.318585176853, 5726.885462290752, 5760.510356619692, 5767.9423205768035, 5768.307803063638, 5635.267415236013, 5722.456366645162, 5722.771089156428, 5727.34135574408, 6016.368281330463, 6261.530385221126, 6414.230292364946, 6428.774992875227, 6432.45324147448, 6440.903386449207, 5550.611457197998, 5635.746391412396, 5661.122526008476, 5665.518430933375, 5758.165066065439, 12292.385380731017, 12428.75712428759, 12436.502539898484, 13641.454341826315, 22645.433864153365, 2038.6330460517102, 2107.378323394587, 2144.0994782191515, 2146.796054374832, 2575.84544927305, 9868.309218354718, 9878.60485580576, 9905.158061564776, 10358.22313326496, 10601.628942987036, 1764.1796564597396, 1823.3253696132383, 1841.4659748672868, 1866.2908094923978, 1982.3953694123286, 74154.62922685406, 79263.0, 81907.0, 82889.58555207185, 82913.58543207306, 9868.0, 10060.798784024279, 10250.487475626189, 11166.106711463064, 11459.598914037968, 15676.529704108894, 15677.529674109795, 15684.0, 15712.21438928049, 15775.29011194499, 7512.2487751225535, 7796.0, 7831.686732530635, 7871.409644276702, 7997.5601341925585, 7356.1172659280155, 7387.556746595222, 7481.9251807482315, 7532.359749421361, 7798.688052477951, 4752.7861246244, 4762.59517940972, 4801.231802911518, 4858.902821943612, 4909.0, 1901.91441385138, 1926.6050459655737, 1937.409090227494, 1942.2813558983266, 1976.5849171673822, 861.190480947907, 986.2750878104588, 1010.4190090697731, 1018.9606601266667, 1033.2302434686208, 18778.906105469385, 19321.4203573893, 19324.227030918606, 19411.223551058083, 19521.414357569294, 988.9752756181009, 1004.9397036177706, 1008.3344992305043, 1031.7317497450717, 1045.8065257927308, 9913.702588922344, 10553.894461055292, 10817.83773243402, 10885.401302928414, 10924.453777311102, 427673.0, 436464.0, 436607.0, 437473.0, 455115.0, 49611.0, 60696.696516518015, 84593.0, 85714.57142714372, 85918.0, 982.4252812104855, 982.823091843475, 1007.0584003956178, 1011.8279892418307, 1018.9439580822977, 15802.920985395, 16133.354665813236, 16135.826263188426, 16855.0, 17209.483715488554, 40291.99270018156, 41127.35490580343, 41281.0, 41501.792491037355, 42188.36717449302, 52189.0, 55011.72494137504, 55081.0, 56590.7170464145, 56758.432415675314, 8435.831283374175, 8455.408121431441, 8574.142585741376, 8714.433561818714, 8738.69414570487, 8011.599420028859, 11331.603393881174, 12432.502699891904, 12809.423575939292, 12938.935305323414, 10547.103496202908, 11093.5562577496, 11387.487563059516, 11618.244814087057, 11643.359615221245, 5406.21609866575, 10413.219008574235, 10647.467626618483, 10812.39128387857, 11366.602168924048, 11128.554857805597, 11272.9436352821, 11556.364399958084, 11637.127215459044, 11848.170628055954, 8257.298129659046, 8329.0, 8386.874196886929, 8406.579671016547, 8565.743027709179, 10338.844917326396, 11351.772964540829, 11485.19603627738, 11526.366049867338, 11581.131415144066], "value": 8820.987966804292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.18652401821, 1449.2463918762246, 1494.7458931981562, 1593.2989484626764, 1778.9377371791982, 7234.276572342763, 8216.58917054148, 8384.874226886586, 8386.412951093425, 8606.741797746077, 8449.112843151457, 8517.616707248173, 8521.44610600312, 8532.274756645676, 8534.1039190885, 2319.82601304902, 2352.6706261123454, 2357.2221167014845, 2357.669926210332, 2359.1742889988536, 2313.90744370225, 2356.434455730621, 2360.280114565057, 2369.7037870266217, 2387.403149212697, 2325.197806756666, 2339.543788961153, 2369.9170529031403, 2379.690640216778, 2383.4637206628545, 2229.063793206857, 2229.855059421149, 2254.199759085526, 2259.762724913877, 2324.1749179041367, 2294.162630639821, 2330.8718020508863, 2367.928962131122, 2371.0515793682493, 2371.1463873005705, 8561.828763424759, 8634.568271586459, 8671.39858042591, 8704.390692651517, 8704.912950870474, 5216.0, 5418.8916221675345, 5424.864378390533, 5427.891442171174, 5433.429489903543, 3288.358770039843, 3420.26464310172, 3471.8784842530645, 3474.808885511296, 3482.8432720527635, 1116.564539829467, 1134.2513940799115, 1158.25871442277, 1171.2328424881716, 1178.4873579992645, 12195.39023048844, 12343.444544995496, 12364.752704945851, 12373.814392784116, 12377.443015064253, 4160.2303573838935, 4524.88687782808, 4658.3711198988385, 4748.4539277982785, 4756.286557016406, 9542.666006689733, 9557.092076252746, 9557.187639050619, 9562.187214086742, 9564.139227469423, 5142.408623008327, 5157.510036546522, 5159.2003239497935, 5159.458256883048, 5166.070107380632, 4379.255526560492, 4422.380866678667, 4840.903181936412, 4908.141075311806, 4931.408231012229, 3652.2878038782183, 3739.383001804672, 3765.134019175605, 3835.6164383561977, 3849.2301539692176, 1187.0, 1203.9518419263306, 1213.9393030348447, 1216.6775804411839, 1226.6381417481864, 737.3806002957434, 785.8781888807245, 882.9955850220837, 919.6183583812776, 943.099340130174, 5406.107992181246, 5433.864153396196, 5564.054110801174, 5641.605087643826, 5661.207430959669, 494.37461611062037, 501.14054396709815, 588.1648059755072, 825.475822852493, 971.6696323250129, 3789.2610940866816, 3792.981035094807, 4031.3348297531165, 4036.354183330653, 4112.629863312316, 10117.848232276521, 10833.458327083614, 10855.348679079123, 10872.782544349227, 10875.238733288752, 10753.51609177589, 10779.353238805697, 10791.892081079246, 10829.783404332027, 10881.347119172875, 7728.420368472387, 8118.35053195743, 8225.547594882219, 8228.42401031934, 8243.25810677042, 5371.758270877898, 5429.782808687608, 5708.628939118944, 5755.395683453345, 5805.158252053513, 9290.16388525036, 9350.906490935004, 9373.0, 9387.953060234928, 9493.810123797624, 9291.0, 9571.37786043905, 9678.0, 9678.419294842332, 9686.51567421612, 7297.963510182415, 7409.66656500448, 7437.888431673638, 7443.851122977402, 7447.92552074494, 7659.578723170279, 7805.921940780519, 7874.606269686378, 7888.211178882066, 7891.368690504861, 6900.896486552605, 6932.445404367538, 6946.583205007716, 6972.163340399185, 7133.5719856808755, 6961.582305061713, 7048.682809273492, 7067.151941767021, 7125.75059872902, 7169.820754481179, 6492.772752953624, 6599.4720422365135, 6607.636579988147, 6609.173853268341, 6613.074169616161, 4583.679142459996, 4667.83662571822, 4762.76186190696, 5112.488751124858, 5167.974160129175, 4993.251012348177, 5043.2687260347775, 5065.214891691794, 5155.381354237516, 5283.39240987276], "value": 4454.469415221406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5753521680962, 341.2645748412172, 346.546024707633, 351.2763706764065, 353.9380608393534, 5199.714015729133, 5307.920381194281, 5322.201669749539, 5349.866253343668, 5367.543758780504, 5092.159793634046, 5203.271541984125, 5249.790008399669, 5252.0, 5273.762680679369, 4183.8326466941435, 4186.937195942063, 4187.267228235047, 4189.664826813862, 4195.2029114468305, 3993.282888358005, 4101.646456669292, 4188.6649068074485, 4204.516480604739, 4208.221479026374, 4079.77561234132, 4087.89780255493, 4089.652379547742, 4099.298791001731, 4102.3026085565525, 4076.816543255531, 4081.0, 4082.6733861291027, 4093.0, 4094.529129150141, 3615.475756015363, 3618.4029635110173, 3627.038834708804, 3640.7087433005295, 3641.18073433478, 4977.178765503688, 5049.141645920203, 5073.575336647748, 5086.694798312076, 5092.439831618519, 4632.976835115836, 4676.316526050619, 4685.2269375553, 4686.882827929295, 4699.0, 5459.454054594548, 5460.399356070829, 5461.290032295816, 5463.262459567947, 5475.260839786618, 3782.1679230569507, 3934.1934903344745, 3957.327254366736, 3961.0, 3972.7616343019513, 5699.68651724155, 5728.536729206439, 5732.369439361667, 5732.484076433099, 5749.9937510935415, 4095.85664501747, 4098.303288440972, 4102.856400025985, 4106.938395924063, 4114.567970363129, 4033.253848038122, 4165.500139983222, 4168.520620128724, 4177.4778152730905, 4200.4959404871615, 4707.270373092176, 4707.6233901287815, 4708.882277943078, 4709.1994360958715, 4733.715977041388, 5523.944760552343, 5527.0, 5548.140038294071, 5574.1917421973585, 5608.915866262009, 1337.4716986790163, 1361.224102261721, 1371.8750624488023, 1409.9929500352637, 1424.6082327359852, 889.9866502002475, 908.5055084386148, 922.6078916460477, 926.7590426489162, 930.9022552631876, 4687.695299805502, 4691.554302341272, 4719.787609557578, 4723.244280915106, 4740.241561350236, 4872.4640289568115, 4924.630652701062, 4935.432425271139, 4943.307936888838, 4978.755311172207, 4582.399241533953, 4655.650826188049, 4667.323238130452, 4675.50383877156, 4710.552497512731, 2533.4299782549147, 2622.7246139155495, 2644.471105778852, 2644.9237348681577, 2647.007372235412, 5049.31834202378, 5053.054573988968, 5076.2131869559535, 5083.949160508421, 5107.668001579886, 4950.554450099508, 4989.501049894981, 5008.398992120969, 5028.522290382408, 5360.65155764874, 5895.675737834375, 5956.940430595812, 5963.403659634002, 5967.224260846149, 5967.582269241198, 5742.971285143548, 5754.309482861916, 5763.164341170423, 5767.155589305004, 5779.422057794187, 5468.507834294933, 5631.6902570359025, 5658.293817549512, 5670.659760414388, 5675.971620141873, 5828.912566311424, 5858.531317494505, 5878.500327472213, 5934.258217722785, 5938.732757025858, 4112.568180341021, 4117.0, 4121.732087414309, 4124.752514849119, 4155.480564929384, 5466.34403871538, 5548.944510555004, 5756.30924289088, 5783.334916484658, 5791.247137872049, 5430.321209848769, 5456.536194423518, 5546.473085056913, 5571.7771289149605, 5592.832215033555, 5553.972230138824, 5570.944290557042, 5578.470045345685, 5581.832545023656, 5585.497305242548, 5368.194770784414, 5526.392096869261, 5553.972230138824, 5602.607817452739, 5603.971980140073, 5575.581831362745, 5580.381689310055, 5584.944150558605, 5586.581006424453, 5598.681252809765, 5500.532454741392, 5503.587230957774, 5505.752241149078, 5512.4211957743855, 5512.889742205053], "value": 4142.489815308489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7228181009403, 718.4115343857429, 733.3143510817386, 773.7214602743015, 813.1177672225635, 11981.640550783479, 12498.0, 12501.187422817511, 12510.937445312773, 12556.497740090397, 12361.752764944718, 12495.375231238448, 12518.18631788933, 12520.499180032788, 12550.811737823917, 648.1929997153551, 655.403582739707, 757.3903008078495, 775.0234704272629, 786.7836345005127, 774.3688893551737, 785.0265670568511, 786.2648423723837, 786.3669745854585, 789.2383849585178, 838.6645341863273, 842.0190478093015, 842.6966292134827, 843.2621456225802, 843.3295530053622, 673.5655502201078, 682.8873235916068, 811.6672164412621, 837.1210229259284, 838.0739283092187, 611.3855575146949, 613.0283500651473, 613.3314686991156, 613.4264462727364, 613.8373331067271, 12317.938410307981, 12368.690782730504, 12377.690557736129, 12430.937845310806, 12449.066320025944, 12884.355782210852, 13423.32883355838, 13585.864141358657, 13680.179189248578, 13705.0, 9712.417254964725, 10296.794064118676, 10435.895641043568, 10573.0, 10700.625478108306, 3636.1636823530735, 3734.3838266685966, 4120.052387950788, 4124.1957818225455, 4221.894452638678, 62053.6897315515, 62119.0, 62372.37627623711, 62437.68781156065, 64055.359446405404, 9971.15533626267, 10040.748981275527, 10099.091081802526, 10290.434026128485, 10651.520681569347, 18435.078246087643, 19441.902790485958, 20394.592108157754, 20461.590768184553, 20786.896065519577, 7571.697132114764, 7885.093214280317, 8018.759437216893, 8124.55314957683, 8189.79525511867, 4088.9182216356103, 4114.588541145861, 4137.710360274812, 4181.832726690959, 4256.404103425523, 3226.741860651189, 3291.127851119455, 3318.8340582970754, 3321.2029113013186, 3329.8335083246225, 552.3785741041329, 563.1215304125577, 565.045073825234, 570.7831024210774, 580.1877371679598, 716.2658275267892, 726.1358982810544, 740.988885166723, 758.1319389299222, 774.8450309938034, 7904.604769761489, 7947.642356093989, 7973.521588704696, 8336.166383361615, 8489.83020339602, 593.2673148661399, 640.4204195203348, 685.3557655803628, 725.3580581185689, 733.7321877514669, 3727.9811472082483, 3969.92060158801, 4002.779847108437, 4026.295398305285, 4170.937435938464, 85977.57011214904, 86013.13986860176, 87346.0, 87674.0, 90643.54678226699, 49451.50548494469, 56059.0, 74094.25905740874, 78057.60971195108, 78329.60835195788, 43974.0, 44390.556094438645, 45209.54790452119, 46791.766041169576, 47313.5268647316, 7670.194629563815, 7770.261825126604, 7942.682292708458, 7983.2415920487465, 8205.466644668077, 46160.0, 46163.229596300465, 46742.53257467518, 47888.760556197, 48574.514254857, 50974.74512627413, 53162.93674126573, 54219.45780542144, 62705.372946269956, 63334.366656332844, 10976.725581860517, 11204.271722338022, 11302.943485282522, 11590.13074019435, 11595.942020289845, 13422.798658020332, 13521.459141634617, 13546.187228766306, 13570.389332479865, 14187.361568729226, 11183.88816111861, 11478.253913495597, 11506.884931150582, 11686.532538698357, 12789.424475898793, 11738.41307934617, 11746.941265293619, 11852.762944740884, 12365.629031129081, 12448.0, 11272.492737826653, 11429.314241145557, 11687.941560292144, 11707.941460292644, 12076.939615301868, 10225.795484090128, 10527.210459215436, 10708.73228169302, 10737.228357321266, 10915.181361398085, 9819.85270220933, 10261.692149235534, 10408.323458975143, 10484.580616775549, 10540.840507544317], "value": 6624.79710848331, "unit": "score"}], "name": "dromaeo_css", "value": 6957.26923705163, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 114.0, 111.0, 112.0, 113.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 123.0, 157.0, 123.0, 124.0, 124.0, 129.0, 153.0, 135.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 161.0, 163.0, 161.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 110.0, 77.0, 77.0, 76.0, 75.0, 104.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 115.0, 83.0, 83.0, 84.0, 100.0, 84.0, 83.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 86.0, 85.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 53.0, 53.0, 54.0, 53.0, 58.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 63.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 86.0, 82.0, 83.0, 80.0, 81.0, 81.0, 89.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 153.0, 130.0, 132.0, 138.0, 135.0, 141.0, 132.0, 180.0, 137.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 166.0, 170.0, 168.0, 168.0, 165.0, 172.0, 170.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 65.0, 65.0, 67.0, 64.0, 64.0, 68.0, 63.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1499.1000000000001, "alertThreshold": 2.0}]} 14:43:31 INFO - Return code: 0 14:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:43:31 INFO - # TBPL SUCCESS # 14:43:31 INFO - Running post-action listener: _resource_record_post_action 14:43:31 INFO - [mozharness: 2016-11-03 21:43:31.527949Z] Finished run-tests step (success) 14:43:31 INFO - Running post-run listener: _resource_record_post_run 14:43:31 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409985024; Read time: 12; Write time: 273984 14:43:31 INFO - TinderboxPrint: CPU usage
13.1% 14:43:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:43:31 INFO - TinderboxPrint: I/O write bytes / time
409,985,024 / 273,984 14:43:31 INFO - TinderboxPrint: CPU idle
8,303.8 (86.9%) 14:43:31 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 14:43:31 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120999936; Read time: 0; Write time: 108596 14:43:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288370688; Read time: 0; Write time: 165388 14:43:32 INFO - Running post-run listener: _upload_blobber_files 14:43:32 INFO - Blob upload gear active. 14:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:32 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 14:43:32 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'] 14:43:32 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 14:43:32 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:33 INFO - (blobuploader) - INFO - Done attempting. 14:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:36 INFO - (blobuploader) - INFO - Done attempting. 14:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:37 INFO - (blobuploader) - INFO - Done attempting. 14:43:37 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:37 INFO - Return code: 0 14:43:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f95d983b79df6540645607144072d153431a2bf224ceec415c613427f8c55a9fea3740f9481e7ca3f04e37de4e08faba21a410b63bf5588ef9d3c5d6eb7ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/befcd0452b5a018a2f9e85744e0161b144517d854d56f73a6cc219b274584d2a0dfb525c68cdd08bcb9b5d1ac868701fda1255e9462e414bf02e6f724123be95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89b1326830e2768faab64f157d84f8df2936e6a82de25c13f95966a74996b0caf8f01006be4e6bf1c686e5101b22c5ab636d69949e4c8784b607b7f69fb19079"} 14:43:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:37 INFO - Contents: 14:43:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f95d983b79df6540645607144072d153431a2bf224ceec415c613427f8c55a9fea3740f9481e7ca3f04e37de4e08faba21a410b63bf5588ef9d3c5d6eb7ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/befcd0452b5a018a2f9e85744e0161b144517d854d56f73a6cc219b274584d2a0dfb525c68cdd08bcb9b5d1ac868701fda1255e9462e414bf02e6f724123be95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89b1326830e2768faab64f157d84f8df2936e6a82de25c13f95966a74996b0caf8f01006be4e6bf1c686e5101b22c5ab636d69949e4c8784b607b7f69fb19079"} 14:43:37 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:37 INFO - Copying logs to upload dir... 14:43:37 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.344230 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-03 14:43:37.872468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 14:43:37.876105) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 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/df6f95d983b79df6540645607144072d153431a2bf224ceec415c613427f8c55a9fea3740f9481e7ca3f04e37de4e08faba21a410b63bf5588ef9d3c5d6eb7ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/befcd0452b5a018a2f9e85744e0161b144517d854d56f73a6cc219b274584d2a0dfb525c68cdd08bcb9b5d1ac868701fda1255e9462e414bf02e6f724123be95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89b1326830e2768faab64f157d84f8df2936e6a82de25c13f95966a74996b0caf8f01006be4e6bf1c686e5101b22c5ab636d69949e4c8784b607b7f69fb19079"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478190879/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/df6f95d983b79df6540645607144072d153431a2bf224ceec415c613427f8c55a9fea3740f9481e7ca3f04e37de4e08faba21a410b63bf5588ef9d3c5d6eb7ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/befcd0452b5a018a2f9e85744e0161b144517d854d56f73a6cc219b274584d2a0dfb525c68cdd08bcb9b5d1ac868701fda1255e9462e414bf02e6f724123be95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89b1326830e2768faab64f157d84f8df2936e6a82de25c13f95966a74996b0caf8f01006be4e6bf1c686e5101b22c5ab636d69949e4c8784b607b7f69fb19079"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 14:43:37.901757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:43:37.902079) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1478208176.242004-772292635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 14:43:37.985947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 14:43:37.986263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 14:43:37.986564) ========= ========= Total master_lag: 0.17 =========