builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1479079789.99 results: success (0) buildid: 20161113152921 builduid: 47b7f96a7a66451da6860e914952eab5 revision: 71825cbd0e2549d813d8279dcdb19fb357f8ab3f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:49.991370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:49.991857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:49.992179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:50.436340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:50.436757) ========= 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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-13 15:29:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-11-13 15:29:53 (35.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080814 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:50.546314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:50.546713) ========= 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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:50.596341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 15:29:50.599751) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 71825cbd0e2549d813d8279dcdb19fb357f8ab3f --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 71825cbd0e2549d813d8279dcdb19fb357f8ab3f --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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-13 15:29:53,343 truncating revision to first 12 chars 2016-11-13 15:29:53,343 Setting DEBUG logging. 2016-11-13 15:29:53,343 attempt 1/10 2016-11-13 15:29:53,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/71825cbd0e25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 15:29:54,527 unpacking tar archive at: mozilla-inbound-71825cbd0e25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.494564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 15:29:52.111546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:52.112070) ========= script_repo_revision: 71825cbd0e2549d813d8279dcdb19fb357f8ab3f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:52.112516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:52.112834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 15:29:52.122880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-13 15:29:52.123182) ========= /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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:29:54 INFO - MultiFileLogger online at 20161113 15:29:54 in /builds/slave/test 15:29:54 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 15:29:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:29:54 INFO - {'append_to_log': False, 15:29:54 INFO - 'base_work_dir': '/builds/slave/test', 15:29:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:29:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:29:54 INFO - 'branch': 'Mozilla-Inbound', 15:29:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:29:54 INFO - 'config_files': ('talos/linux_config.py',), 15:29:54 INFO - 'default_actions': ('clobber', 15:29:54 INFO - 'read-buildbot-config', 15:29:54 INFO - 'download-and-extract', 15:29:54 INFO - 'populate-webroot', 15:29:54 INFO - 'create-virtualenv', 15:29:54 INFO - 'install', 15:29:54 INFO - 'run-tests'), 15:29:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:29:54 INFO - 'download_minidump_stackwalk': True, 15:29:54 INFO - 'download_symbols': 'ondemand', 15:29:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:29:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:29:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:29:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:29:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:29:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:29:54 INFO - 'installer_path': 'installer.exe', 15:29:54 INFO - 'log_level': 'info', 15:29:54 INFO - 'log_name': 'talos', 15:29:54 INFO - 'log_to_console': True, 15:29:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:29:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:29:54 INFO - 'opt_config_files': (), 15:29:54 INFO - 'pip_index': False, 15:29:54 INFO - 'sps_profile': False, 15:29:54 INFO - 'sps_profile_interval': 0, 15:29:54 INFO - 'suite': 'dromaeojs', 15:29:54 INFO - 'system_bits': '32', 15:29:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:29:54 INFO - 'title': 'talos-linux64-ix-025', 15:29:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:29:54 INFO - 'use_talos_json': True, 15:29:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:29:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:29:54 INFO - 'work_dir': 'build'} 15:29:54 INFO - [mozharness: 2016-11-13 23:29:54.968529Z] Running clobber step. 15:29:54 INFO - Running pre-action listener: _resource_record_pre_action 15:29:54 INFO - Running main action method: clobber 15:29:54 INFO - rmtree: /builds/slave/test/build 15:29:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:29:55 INFO - Running post-action listener: _resource_record_post_action 15:29:55 INFO - [mozharness: 2016-11-13 23:29:55.429793Z] Finished clobber step (success) 15:29:55 INFO - [mozharness: 2016-11-13 23:29:55.429892Z] Running read-buildbot-config step. 15:29:55 INFO - Running pre-action listener: _resource_record_pre_action 15:29:55 INFO - Running main action method: read_buildbot_config 15:29:55 INFO - Using buildbot properties: 15:29:55 INFO - { 15:29:55 INFO - "project": "", 15:29:55 INFO - "product": "firefox", 15:29:55 INFO - "script_repo_revision": "production", 15:29:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:29:55 INFO - "repository": "", 15:29:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:29:55 INFO - "buildid": "20161113152921", 15:29:55 INFO - "stage_platform": "linux64-pgo", 15:29:55 INFO - "basedir": "/builds/slave/test", 15:29:55 INFO - "buildnumber": 2866, 15:29:55 INFO - "platform": "ubuntu64_hw", 15:29:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:29:55 INFO - "slavebuilddir": "test", 15:29:55 INFO - "branch": "mozilla-inbound", 15:29:55 INFO - "revision": "71825cbd0e2549d813d8279dcdb19fb357f8ab3f", 15:29:55 INFO - "slavename": "talos-linux64-ix-025", 15:29:55 INFO - "builduid": "47b7f96a7a66451da6860e914952eab5", 15:29:55 INFO - "repo_path": "integration/mozilla-inbound" 15:29:55 INFO - } 15:29:55 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:29:55 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:29:55 INFO - Running post-action listener: _resource_record_post_action 15:29:55 INFO - [mozharness: 2016-11-13 23:29:55.432315Z] Finished read-buildbot-config step (success) 15:29:55 INFO - [mozharness: 2016-11-13 23:29:55.432402Z] Running download-and-extract step. 15:29:55 INFO - Running pre-action listener: _resource_record_pre_action 15:29:55 INFO - Running main action method: download_and_extract 15:29:55 INFO - mkdir: /builds/slave/test/build/tests 15:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:55 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:29:55 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/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 15:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/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 15:29:55 INFO - Downloaded 1361 bytes. 15:29:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:29:55 INFO - Using the following test package requirements: 15:29:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:29:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:29:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:29:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'jsshell-linux-x86_64.zip'], 15:29:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:29:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:29:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:29:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:29:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:29:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:29:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:29:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:29:55 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/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:29:55 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:29:55 INFO - Http code: 200 15:29:55 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:29:55 INFO - x-amz-cf-id: KeLwB-JydXe0fFvXWe8tGnNzXyUwGvgTwRboVcaBf9mudd_WREcPUQ== 15:29:55 INFO - x-amz-replication-status: COMPLETED 15:29:55 INFO - x-amz-version-id: s0kX3vB9zES1jguItA7ycnvUDru4zybz 15:29:58 INFO - Expected file size: 21983532 15:29:58 INFO - Obtained file size: 21983532 15:30:02 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 15:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:30:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:30:02 INFO - Http code: 200 15:30:02 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:30:02 INFO - x-amz-cf-id: RrnF4tqbRvuehXfoxQvBCXyqkzWxXCbss4YIsfRK7zGohU8GwS8VWw== 15:30:02 INFO - x-amz-replication-status: COMPLETED 15:30:02 INFO - x-amz-version-id: s0kX3vB9zES1jguItA7ycnvUDru4zybz 15:30:03 INFO - Expected file size: 21983532 15:30:03 INFO - Obtained file size: 21983532 15:30:07 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/1479069002/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:30:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:30:07 INFO - Http code: 200 15:30:07 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 15:30:07 INFO - x-amz-cf-id: _-eC6-PE8rQKXaycb5DECBluBEvG73TYvIDyT8_Rwr6ypZ9EosHGyg== 15:30:07 INFO - x-amz-replication-status: COMPLETED 15:30:07 INFO - x-amz-version-id: huqIgYhqQrtSzKTYTxEJg8TwqfFDII87 15:30:10 INFO - Expected file size: 14409038 15:30:10 INFO - Obtained file size: 14409038 15:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/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 15:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/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 15:30:14 INFO - Downloaded 59597781 bytes. 15:30:14 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:14 INFO - mkdir: /builds/slave/test/properties 15:30:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:14 INFO - Contents: 15:30:14 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:15 INFO - Running post-action listener: _resource_record_post_action 15:30:15 INFO - Running post-action listener: set_extra_try_arguments 15:30:15 INFO - [mozharness: 2016-11-13 23:30:15.331477Z] Finished download-and-extract step (success) 15:30:15 INFO - [mozharness: 2016-11-13 23:30:15.331704Z] Running populate-webroot step. 15:30:15 INFO - Running pre-action listener: _resource_record_pre_action 15:30:15 INFO - Running main action method: populate_webroot 15:30:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:15 INFO - '--tppagecycles', 15:30:15 INFO - '7'], 15:30:15 INFO - 'tests': ['tsvgm']}}, 15:30:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['damp', 'tps']}, 15:30:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'tests': ['damp', 'tps']}, 15:30:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['dromaeo_dom']}, 15:30:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['basic_compositor_video']}, 15:30:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:30:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['a11yr', 15:30:15 INFO - 'ts_paint', 15:30:15 INFO - 'tpaint', 15:30:15 INFO - 'sessionrestore', 15:30:15 INFO - 'sessionrestore_no_auto_restore', 15:30:15 INFO - 'tabpaint']}, 15:30:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['tsvgx', 15:30:15 INFO - 'tsvgr_opacity', 15:30:15 INFO - 'tart', 15:30:15 INFO - 'tscrollx', 15:30:15 INFO - 'cart']}, 15:30:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:15 INFO - 'tsvgr_opacity', 15:30:15 INFO - 'tart', 15:30:15 INFO - 'tscrollx', 15:30:15 INFO - 'cart']}, 15:30:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'talos_options': ['--disable-e10s'], 15:30:15 INFO - 'tests': ['tp5o']}, 15:30:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'tests': ['tp5o']}, 15:30:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'talos_options': ['--disable-e10s', 15:30:15 INFO - '--xperf_path', 15:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:15 INFO - 'tests': ['tp5n']}, 15:30:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:15 INFO - 'talos_options': ['--xperf_path', 15:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:15 INFO - 'tests': ['tp5n']}}, 15:30:15 INFO - 'talos.zip': {'path': '', 15:30:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:15 INFO - Running post-action listener: _resource_record_post_action 15:30:15 INFO - [mozharness: 2016-11-13 23:30:15.351113Z] Finished populate-webroot step (success) 15:30:15 INFO - [mozharness: 2016-11-13 23:30:15.351201Z] Running create-virtualenv step. 15:30:15 INFO - Running pre-action listener: _resource_record_pre_action 15:30:15 INFO - Running main action method: create_virtualenv 15:30:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:15 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 15:30:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:15 INFO - Using real prefix '/usr' 15:30:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:17 INFO - Installing pip.................done. 15:30:17 INFO - Return code: 0 15:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:30:18 INFO - Reading from file tmpfile_stdout 15:30:18 INFO - Output received: 15:30:18 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) 15:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30: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', 'pip>=1.5'] in /builds/slave/test/build 15:30: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 pip>=1.5 15:30:18 INFO - Using env: {'DISPLAY': ':0', 15:30:18 INFO - 'HOME': '/home/cltbld', 15:30:18 INFO - 'LANG': 'en_US.UTF-8', 15:30:18 INFO - 'LANGUAGE': 'en_US:en', 15:30:18 INFO - 'LOGNAME': 'cltbld', 15:30:18 INFO - 'MAIL': '/var/mail/cltbld', 15:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:18 INFO - 'MOZ_NO_REMOTE': '1', 15:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:18 INFO - 'NO_EM_RESTART': '1', 15:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:18 INFO - 'PWD': '/builds/slave/test', 15:30:18 INFO - 'SHELL': '/bin/bash', 15:30:18 INFO - 'SHLVL': '1', 15:30:18 INFO - 'TERM': 'linux', 15:30:18 INFO - 'TMOUT': '86400', 15:30:18 INFO - 'USER': 'cltbld', 15:30:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:18 INFO - '_': '/tools/buildbot/bin/python'} 15:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:30:18 INFO - Cleaning up... 15:30:18 INFO - Return code: 0 15:30:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:30:18 INFO - Using env: {'DISPLAY': ':0', 15:30:18 INFO - 'HOME': '/home/cltbld', 15:30:18 INFO - 'LANG': 'en_US.UTF-8', 15:30:18 INFO - 'LANGUAGE': 'en_US:en', 15:30:18 INFO - 'LOGNAME': 'cltbld', 15:30:18 INFO - 'MAIL': '/var/mail/cltbld', 15:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:18 INFO - 'MOZ_NO_REMOTE': '1', 15:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:18 INFO - 'NO_EM_RESTART': '1', 15:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:18 INFO - 'PWD': '/builds/slave/test', 15:30:18 INFO - 'SHELL': '/bin/bash', 15:30:18 INFO - 'SHLVL': '1', 15:30:18 INFO - 'TERM': 'linux', 15:30:18 INFO - 'TMOUT': '86400', 15:30:18 INFO - 'USER': 'cltbld', 15:30:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:18 INFO - '_': '/tools/buildbot/bin/python'} 15:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:18 INFO - Downloading/unpacking psutil>=3.1.1 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:20 INFO - Installing collected packages: psutil 15:30:20 INFO - Running setup.py install for psutil 15:30:20 INFO - building 'psutil._psutil_linux' extension 15:30:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:30:20 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 15:30:20 INFO - building 'psutil._psutil_posix' extension 15:30:20 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 15:30:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:21 INFO - Successfully installed psutil 15:30:21 INFO - Cleaning up... 15:30:21 INFO - Return code: 0 15:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:30: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 mozsystemmonitor==0.3 15:30:21 INFO - Using env: {'DISPLAY': ':0', 15:30:21 INFO - 'HOME': '/home/cltbld', 15:30:21 INFO - 'LANG': 'en_US.UTF-8', 15:30:21 INFO - 'LANGUAGE': 'en_US:en', 15:30:21 INFO - 'LOGNAME': 'cltbld', 15:30:21 INFO - 'MAIL': '/var/mail/cltbld', 15:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:21 INFO - 'MOZ_NO_REMOTE': '1', 15:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:21 INFO - 'NO_EM_RESTART': '1', 15:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:21 INFO - 'PWD': '/builds/slave/test', 15:30:21 INFO - 'SHELL': '/bin/bash', 15:30:21 INFO - 'SHLVL': '1', 15:30:21 INFO - 'TERM': 'linux', 15:30:21 INFO - 'TMOUT': '86400', 15:30:21 INFO - 'USER': 'cltbld', 15:30:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:21 INFO - '_': '/tools/buildbot/bin/python'} 15:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:30:23 INFO - Installing collected packages: mozsystemmonitor 15:30:23 INFO - Running setup.py install for mozsystemmonitor 15:30:23 INFO - Successfully installed mozsystemmonitor 15:30:23 INFO - Cleaning up... 15:30:23 INFO - Return code: 0 15:30:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:30:23 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')]} 15:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:23 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')]} 15:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:23 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:23 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 15:30:23 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 15:30:23 INFO - Using env: {'DISPLAY': ':0', 15:30:23 INFO - 'HOME': '/home/cltbld', 15:30:23 INFO - 'LANG': 'en_US.UTF-8', 15:30:23 INFO - 'LANGUAGE': 'en_US:en', 15:30:23 INFO - 'LOGNAME': 'cltbld', 15:30:23 INFO - 'MAIL': '/var/mail/cltbld', 15:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:23 INFO - 'MOZ_NO_REMOTE': '1', 15:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:23 INFO - 'NO_EM_RESTART': '1', 15:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:23 INFO - 'PWD': '/builds/slave/test', 15:30:23 INFO - 'SHELL': '/bin/bash', 15:30:23 INFO - 'SHLVL': '1', 15:30:23 INFO - 'TERM': 'linux', 15:30:23 INFO - 'TMOUT': '86400', 15:30:23 INFO - 'USER': 'cltbld', 15:30:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:23 INFO - '_': '/tools/buildbot/bin/python'} 15:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:30:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:30:25 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 15:30:25 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 15:30:25 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 15:30:25 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 15:30:25 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 15:30:25 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 15:30:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:30:25 INFO - warning: no files found matching '*.txt' 15:30:25 INFO - no previously-included directories found matching 'build' 15:30:25 INFO - no previously-included directories found matching 'dist' 15:30:25 INFO - no previously-included directories found matching '.git*' 15:30:25 INFO - Installing collected packages: jsonschema, functools32 15:30:26 INFO - Running setup.py install for functools32 15:30:26 INFO - warning: no files found matching '*.txt' 15:30:26 INFO - no previously-included directories found matching 'build' 15:30:26 INFO - no previously-included directories found matching 'dist' 15:30:26 INFO - no previously-included directories found matching '.git*' 15:30:26 INFO - Successfully installed jsonschema functools32 15:30:26 INFO - Cleaning up... 15:30:26 INFO - Return code: 0 15:30:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:30:26 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')]} 15:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:26 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')]} 15:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:26 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:26 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 15:30:26 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 15:30:26 INFO - Using env: {'DISPLAY': ':0', 15:30:26 INFO - 'HOME': '/home/cltbld', 15:30:26 INFO - 'LANG': 'en_US.UTF-8', 15:30:26 INFO - 'LANGUAGE': 'en_US:en', 15:30:26 INFO - 'LOGNAME': 'cltbld', 15:30:26 INFO - 'MAIL': '/var/mail/cltbld', 15:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:26 INFO - 'MOZ_NO_REMOTE': '1', 15:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:26 INFO - 'NO_EM_RESTART': '1', 15:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:26 INFO - 'PWD': '/builds/slave/test', 15:30:26 INFO - 'SHELL': '/bin/bash', 15:30:26 INFO - 'SHLVL': '1', 15:30:26 INFO - 'TERM': 'linux', 15:30:26 INFO - 'TMOUT': '86400', 15:30:26 INFO - 'USER': 'cltbld', 15:30:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:26 INFO - '_': '/tools/buildbot/bin/python'} 15:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:30:26 INFO - Cleaning up... 15:30:26 INFO - Return code: 0 15:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:30:26 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')]} 15:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:26 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')]} 15:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:26 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:26 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 15:30:26 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 15:30:26 INFO - Using env: {'DISPLAY': ':0', 15:30:26 INFO - 'HOME': '/home/cltbld', 15:30:26 INFO - 'LANG': 'en_US.UTF-8', 15:30:26 INFO - 'LANGUAGE': 'en_US:en', 15:30:26 INFO - 'LOGNAME': 'cltbld', 15:30:26 INFO - 'MAIL': '/var/mail/cltbld', 15:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:26 INFO - 'MOZ_NO_REMOTE': '1', 15:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:26 INFO - 'NO_EM_RESTART': '1', 15:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:26 INFO - 'PWD': '/builds/slave/test', 15:30:26 INFO - 'SHELL': '/bin/bash', 15:30:26 INFO - 'SHLVL': '1', 15:30:26 INFO - 'TERM': 'linux', 15:30:26 INFO - 'TMOUT': '86400', 15:30:26 INFO - 'USER': 'cltbld', 15:30:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:26 INFO - '_': '/tools/buildbot/bin/python'} 15:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:30:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:30:28 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 15:30:28 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 15:30:28 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 15:30:28 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 15:30:28 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 15:30:28 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 15:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:30:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:29 INFO - Downloading docopt-0.6.1.tar.gz 15:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:30:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:30:29 INFO - Running setup.py install for blobuploader 15:30:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:30:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:30:29 INFO - Running setup.py install for requests 15:30:29 INFO - Running setup.py install for docopt 15:30:29 INFO - Successfully installed blobuploader requests docopt 15:30:29 INFO - Cleaning up... 15:30:29 INFO - Return code: 0 15:30:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:29 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')]} 15:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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')]} 15:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:29 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 15:30:29 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 15:30:29 INFO - Using env: {'DISPLAY': ':0', 15:30:29 INFO - 'HOME': '/home/cltbld', 15:30:29 INFO - 'LANG': 'en_US.UTF-8', 15:30:29 INFO - 'LANGUAGE': 'en_US:en', 15:30:29 INFO - 'LOGNAME': 'cltbld', 15:30:29 INFO - 'MAIL': '/var/mail/cltbld', 15:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:29 INFO - 'MOZ_NO_REMOTE': '1', 15:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:29 INFO - 'NO_EM_RESTART': '1', 15:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:29 INFO - 'PWD': '/builds/slave/test', 15:30:29 INFO - 'SHELL': '/bin/bash', 15:30:29 INFO - 'SHLVL': '1', 15:30:29 INFO - 'TERM': 'linux', 15:30:29 INFO - 'TMOUT': '86400', 15:30:29 INFO - 'USER': 'cltbld', 15:30:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:29 INFO - '_': '/tools/buildbot/bin/python'} 15:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:30 INFO - Running setup.py (path:/tmp/pip-LNrLP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:30 INFO - Running setup.py (path:/tmp/pip-EAOe4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:30 INFO - Running setup.py (path:/tmp/pip-5NfiY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:30 INFO - Running setup.py (path:/tmp/pip-aH8jt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:30 INFO - Running setup.py (path:/tmp/pip-zNSWcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:30 INFO - Running setup.py (path:/tmp/pip-MtKLso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:30 INFO - Running setup.py (path:/tmp/pip-lsbXZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:30 INFO - Running setup.py (path:/tmp/pip-84K8vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:30 INFO - Running setup.py (path:/tmp/pip-0YsAuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:30 INFO - Running setup.py (path:/tmp/pip-A_cVir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:30 INFO - Running setup.py (path:/tmp/pip-JNghJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:30 INFO - Running setup.py (path:/tmp/pip-jEiuEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:31 INFO - Running setup.py (path:/tmp/pip-TrPkDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:31 INFO - Running setup.py (path:/tmp/pip-pX4ogh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:31 INFO - Running setup.py (path:/tmp/pip-rNJaT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:31 INFO - Running setup.py (path:/tmp/pip-kt_4Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:31 INFO - Running setup.py (path:/tmp/pip-Ht3T0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:30:31 INFO - Running setup.py install for manifestparser 15:30:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:30:31 INFO - Running setup.py install for mozcrash 15:30:31 INFO - Running setup.py install for mozdebug 15:30:31 INFO - Running setup.py install for mozdevice 15:30:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:30:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:30:31 INFO - Running setup.py install for mozfile 15:30:31 INFO - Running setup.py install for mozhttpd 15:30:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozinfo 15:30:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozInstall 15:30:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozleak 15:30:32 INFO - Running setup.py install for mozlog 15:30:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for moznetwork 15:30:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozprocess 15:30:32 INFO - Running setup.py install for mozprofile 15:30:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozrunner 15:30:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:30:32 INFO - Running setup.py install for mozscreenshot 15:30:33 INFO - Running setup.py install for moztest 15:30:33 INFO - Running setup.py install for mozversion 15:30:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:30:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:30:33 INFO - Cleaning up... 15:30:33 INFO - Return code: 0 15:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:33 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')]} 15:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:33 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')]} 15:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:33 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:33 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 15:30:33 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 15:30:33 INFO - Using env: {'DISPLAY': ':0', 15:30:33 INFO - 'HOME': '/home/cltbld', 15:30:33 INFO - 'LANG': 'en_US.UTF-8', 15:30:33 INFO - 'LANGUAGE': 'en_US:en', 15:30:33 INFO - 'LOGNAME': 'cltbld', 15:30:33 INFO - 'MAIL': '/var/mail/cltbld', 15:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:33 INFO - 'MOZ_NO_REMOTE': '1', 15:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:33 INFO - 'NO_EM_RESTART': '1', 15:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:33 INFO - 'PWD': '/builds/slave/test', 15:30:33 INFO - 'SHELL': '/bin/bash', 15:30:33 INFO - 'SHLVL': '1', 15:30:33 INFO - 'TERM': 'linux', 15:30:33 INFO - 'TMOUT': '86400', 15:30:33 INFO - 'USER': 'cltbld', 15:30:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:33 INFO - '_': '/tools/buildbot/bin/python'} 15:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:33 INFO - Running setup.py (path:/tmp/pip-GlF8gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:33 INFO - Running setup.py (path:/tmp/pip-LpLqCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:33 INFO - Running setup.py (path:/tmp/pip-O7LJ4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:33 INFO - Running setup.py (path:/tmp/pip-T_Iuh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:33 INFO - Running setup.py (path:/tmp/pip-XEtwDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:33 INFO - Running setup.py (path:/tmp/pip-droXjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:33 INFO - Running setup.py (path:/tmp/pip-rVk1FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:33 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)) 15:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:33 INFO - Running setup.py (path:/tmp/pip-8pjiUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:34 INFO - Running setup.py (path:/tmp/pip-pb_RvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:34 INFO - Running setup.py (path:/tmp/pip-DrPSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:34 INFO - Running setup.py (path:/tmp/pip-wELIVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:34 INFO - Running setup.py (path:/tmp/pip-osakSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:34 INFO - Running setup.py (path:/tmp/pip-xqoO1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:34 INFO - Running setup.py (path:/tmp/pip-ImqztP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:34 INFO - Running setup.py (path:/tmp/pip-C77VSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:34 INFO - Running setup.py (path:/tmp/pip-pJqmu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:34 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)) 15:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:34 INFO - Running setup.py (path:/tmp/pip-n65MPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:34 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)) 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:34 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)) 15:30:34 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)) 15:30:34 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)) 15:30:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:36 INFO - Downloading blessings-1.6.tar.gz 15:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:30:36 INFO - Installing collected packages: blessings 15:30:36 INFO - Running setup.py install for blessings 15:30:36 INFO - Successfully installed blessings 15:30:36 INFO - Cleaning up... 15:30:36 INFO - Return code: 0 15:30:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:37 INFO - Reading from file tmpfile_stdout 15:30:37 INFO - Current package versions: 15:30:37 INFO - argparse == 1.2.1 15:30:37 INFO - blessings == 1.6 15:30:37 INFO - blobuploader == 1.2.4 15:30:37 INFO - docopt == 0.6.1 15:30:37 INFO - functools32 == 3.2.3-2 15:30:37 INFO - jsonschema == 2.5.1 15:30:37 INFO - manifestparser == 1.1 15:30:37 INFO - mozInstall == 1.12 15:30:37 INFO - mozcrash == 1.0 15:30:37 INFO - mozdebug == 0.1 15:30:37 INFO - mozdevice == 0.48 15:30:37 INFO - mozfile == 1.2 15:30:37 INFO - mozhttpd == 0.7 15:30:37 INFO - mozinfo == 0.9 15:30:37 INFO - mozleak == 0.1 15:30:37 INFO - mozlog == 3.4 15:30:37 INFO - moznetwork == 0.27 15:30:37 INFO - mozprocess == 0.23 15:30:37 INFO - mozprofile == 0.28 15:30:37 INFO - mozrunner == 6.13 15:30:37 INFO - mozscreenshot == 0.1 15:30:37 INFO - mozsystemmonitor == 0.3 15:30:37 INFO - moztest == 0.7 15:30:37 INFO - mozversion == 1.4 15:30:37 INFO - psutil == 3.1.1 15:30:37 INFO - requests == 1.2.3 15:30:37 INFO - wsgiref == 0.1.2 15:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:30:37 INFO - Using env: {'DISPLAY': ':0', 15:30:37 INFO - 'HOME': '/home/cltbld', 15:30:37 INFO - 'LANG': 'en_US.UTF-8', 15:30:37 INFO - 'LANGUAGE': 'en_US:en', 15:30:37 INFO - 'LOGNAME': 'cltbld', 15:30:37 INFO - 'MAIL': '/var/mail/cltbld', 15:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:37 INFO - 'MOZ_NO_REMOTE': '1', 15:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:37 INFO - 'NO_EM_RESTART': '1', 15:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:37 INFO - 'PWD': '/builds/slave/test', 15:30:37 INFO - 'SHELL': '/bin/bash', 15:30:37 INFO - 'SHLVL': '1', 15:30:37 INFO - 'TERM': 'linux', 15:30:37 INFO - 'TMOUT': '86400', 15:30:37 INFO - 'USER': 'cltbld', 15:30:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:37 INFO - '_': '/tools/buildbot/bin/python'} 15:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 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)) 15:30:37 INFO - Cleaning up... 15:30:37 INFO - Return code: 0 15:30:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:37 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 0x7f51b3b8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, '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': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', '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 15:30:37 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 15:30:37 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 15:30:37 INFO - Using env: {'DISPLAY': ':0', 15:30:37 INFO - 'HOME': '/home/cltbld', 15:30:37 INFO - 'LANG': 'en_US.UTF-8', 15:30:37 INFO - 'LANGUAGE': 'en_US:en', 15:30:37 INFO - 'LOGNAME': 'cltbld', 15:30:37 INFO - 'MAIL': '/var/mail/cltbld', 15:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:37 INFO - 'MOZ_NO_REMOTE': '1', 15:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:37 INFO - 'NO_EM_RESTART': '1', 15:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:37 INFO - 'PWD': '/builds/slave/test', 15:30:37 INFO - 'SHELL': '/bin/bash', 15:30:37 INFO - 'SHLVL': '1', 15:30:37 INFO - 'TERM': 'linux', 15:30:37 INFO - 'TMOUT': '86400', 15:30:37 INFO - 'USER': 'cltbld', 15:30:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:37 INFO - '_': '/tools/buildbot/bin/python'} 15:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:30:37 INFO - Cleaning up... 15:30:37 INFO - Return code: 0 15:30:37 INFO - Running post-action listener: _resource_record_post_action 15:30:37 INFO - Running post-action listener: _start_resource_monitoring 15:30:37 INFO - Starting resource monitoring. 15:30:37 INFO - [mozharness: 2016-11-13 23:30:37.617708Z] Finished create-virtualenv step (success) 15:30:37 INFO - [mozharness: 2016-11-13 23:30:37.618212Z] Running install step. 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: install 15:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:37 INFO - Reading from file tmpfile_stdout 15:30:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:30:37 INFO - Reading from file tmpfile_stdout 15:30:37 INFO - Output received: 15:30:37 INFO - Usage: mozinstall [options] installer 15:30:37 INFO - Options: 15:30:37 INFO - -h, --help show this help message and exit 15:30:37 INFO - -d DEST, --destination=DEST 15:30:37 INFO - Directory to install application into. [default: 15:30:37 INFO - "/builds/slave/test"] 15:30:37 INFO - --app=APP Application being installed. [default: firefox] 15:30:37 INFO - mkdir: /builds/slave/test/build/application 15:30:37 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'] 15:30:37 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 15:30:54 INFO - Reading from file tmpfile_stdout 15:30:54 INFO - Output received: 15:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - [mozharness: 2016-11-13 23:30:54.822329Z] Finished install step (success) 15:30:54 INFO - [mozharness: 2016-11-13 23:30:54.822667Z] Running run-tests step. 15:30:54 INFO - Running pre-action listener: _resource_record_pre_action 15:30:54 INFO - Running main action method: run_tests 15:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:30:54 INFO - Python 2.7.3 15:30:54 INFO - Return code: 0 15:30:54 INFO - grabbing minidump binary from tooltool 15:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:54 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 0x2a1bf60>, '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 0x2a1cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:30:54 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 15:30:54 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 15:30:54 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 15:30:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:30:54 INFO - Return code: 0 15:30:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:30:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:30:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:30:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:30:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:30:54 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/1479069002/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:30:54 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/1479069002/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 15:30:54 INFO - Using env: {'DISPLAY': ':0', 15:30:54 INFO - 'HOME': '/home/cltbld', 15:30:54 INFO - 'LANG': 'en_US.UTF-8', 15:30:54 INFO - 'LANGUAGE': 'en_US:en', 15:30:54 INFO - 'LOGNAME': 'cltbld', 15:30:54 INFO - 'MAIL': '/var/mail/cltbld', 15:30:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:30:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:54 INFO - 'MOZ_NO_REMOTE': '1', 15:30:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:54 INFO - 'NO_EM_RESTART': '1', 15:30:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:54 INFO - 'PWD': '/builds/slave/test', 15:30:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:30:54 INFO - 'SHELL': '/bin/bash', 15:30:54 INFO - 'SHLVL': '1', 15:30:54 INFO - 'TERM': 'linux', 15:30:54 INFO - 'TMOUT': '86400', 15:30:54 INFO - 'USER': 'cltbld', 15:30:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479079681.255622-152282362', 15:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:54 INFO - '_': '/tools/buildbot/bin/python'} 15:30:54 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/1479069002/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:30:55 INFO - mozversion application_buildid: 20161113123002 15:30:55 INFO - mozversion application_changeset: 71825cbd0e2549d813d8279dcdb19fb357f8ab3f 15:30:55 INFO - mozversion application_display_name: Nightly 15:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:30:55 INFO - mozversion application_name: Firefox 15:30:55 INFO - mozversion application_remotingname: firefox 15:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:30:55 INFO - mozversion application_vendor: Mozilla 15:30:55 INFO - mozversion application_version: 52.0a1 15:30:55 INFO - mozversion platform_buildid: 20161113123002 15:30:55 INFO - mozversion platform_changeset: 71825cbd0e2549d813d8279dcdb19fb357f8ab3f 15:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:30:55 INFO - mozversion platform_version: 52.0a1 15:30:55 INFO - using testdate: 1479079855 15:30:55 INFO - actual date: 1479079855 15:30:55 INFO - starting webserver on 'localhost:58828' 15:30:55 INFO - SUITE-START | Running 2 tests 15:30:55 INFO - TEST-START | dromaeo_css 15:30:55 INFO - operating with platform_type : linux_ 15:30:55 INFO - Initialising browser for dromaeo_css test... 15:30:55 INFO - TEST-INFO | started process 3459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGbZmQ/profile http://localhost:58828/getInfo.html) 15:30:59 INFO - PROCESS | 3459 | __metrics Screen width/height:1600/1200 15:30:59 INFO - PROCESS | 3459 | colorDepth:24 15:30:59 INFO - PROCESS | 3459 | Browser inner width/height: 1024/697 15:30:59 INFO - PROCESS | 3459 | __metrics 15:30:59 INFO - PROCESS | 3459 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:30:59 INFO - PROCESS | 3459 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:31:00 INFO - PROCESS | 3459 | console.error: PushService: 15:31:00 INFO - PROCESS | 3459 | stateChangeProcessEnqueue: Error transitioning state 15:31:00 INFO - PROCESS | 3459 | UnknownError 15:31:01 INFO - TEST-INFO | 3459: exit 0 15:31:01 INFO - Browser initialized. 15:31:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:01 INFO - TEST-INFO | started process 3541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGbZmQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:13 INFO - PROCESS | 3541 | RSS: Main: 173060096 15:31:13 INFO - PROCESS | 3541 | 15:32:04 INFO - PROCESS | 3541 | 1479079924588 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] 15:34:16 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58828/tests/dromaeo/cssquery-ext.html) 15:34:18 INFO - PROCESS | 3541 | RSS: Main: 275619840 15:34:18 INFO - PROCESS | 3541 | 15:37:20 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-ext.html (next: http://localhost:58828/tests/dromaeo/cssquery-jquery.html) 15:37:21 INFO - PROCESS | 3541 | RSS: Main: 280895488 15:37:21 INFO - PROCESS | 3541 | 15:40:23 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58828/tests/dromaeo/cssquery-mootools.html) 15:40:23 INFO - PROCESS | 3541 | RSS: Main: 259117056 15:40:23 INFO - PROCESS | 3541 | 15:43:25 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58828/tests/dromaeo/cssquery-prototype.html) 15:43:26 INFO - PROCESS | 3541 | RSS: Main: 250540032 15:43:26 INFO - PROCESS | 3541 | 15:46:29 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58828/tests/dromaeo/cssquery-yui.html) 15:46:29 INFO - PROCESS | 3541 | RSS: Main: 218095616 15:46:29 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-yui.html (next: http://localhost:58828/tests/dromaeo/cssquery-dojo.html) 15:49:32 INFO - PROCESS | 3541 | RSS: Main: 309858304 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | __start_tp_report 15:49:32 INFO - PROCESS | 3541 | _x_x_mozilla_page_load 15:49:32 INFO - PROCESS | 3541 | _x_x_mozilla_page_load_details 15:49:32 INFO - PROCESS | 3541 | |i|pagename|runs| 15:49:32 INFO - PROCESS | 3541 | |0;dojo.html;3068.6010818593586;3095.613048368954;3117.1739489035403;3124.812511249324;3128.5150801625755;5323.201519772036;5366.195070739386;5387.568994480442;5408.756605952732;5428.918566221505;5423.918641220384;5429.67421954683;5465.398806131332;5483.396826349099;5543.805966791163;4891.461939186686;4906.509349065101;4934.407871055479;4964.056829202458;4987.900241995158;4930.852074437755;5073.619478539106;5081.974590127044;5091.821786237482;5115.872103197413;4875.7074575525585;4953.380827396575;4968.950310496921;4996.600271978251;5060.266261392096;4889.071076495455;4960.851174464772;4969.378827646544;4971.502849715;4972;4921.384826896638;4930.063287975273;4934.185859333205;4935.70385776851;4937.506249375069;5365.758540865631;5388.78444862205;5396.325459317585;5400.243965844785;5408.648437851527;5795.710214489301;5814.069748840166;5818.679972601505;5820.854478638025;5823.301203855522;5802.506786923117;5814.040683287252;5825.475707186331;5828.0966450200285;5841.591088623798;5395.919061214085;5418.241446197536;5437.592180586472;5441;5443.646162999393;5866.413358664099;5921.319048309413;5925.05199168131;6018.849528761816;6028.819135425944;5784.537237021028;5790.652560846363;5797.072468405035;5800.477956983807;5805.042168042226;5622.887542249132;5646.407127251661;5651.463111004448;5745.454181852718;5865.88268234633;5742.799002034909;5743.59794814359;5748.310202775694;5749.195112684228;5759.1937128802;5731.8567035824435;5754.021816291241;5758.424157584208;5759.107338362561;5773.191753154561;4408.404865343137;4414.426124603781;4442.022754993896;4451.821927122879;4458.866234012985;3871.748336358184;3911.06134527717;3911.3741801311653;4037.8990525237105;4047.6559492442884;5509.090999984957;5513.283273174462;5513.5037846594;5527.088030475007;5527.39198688144;5602.803901863415;5635.5773317001385;5820.30156381237;5820.650760954271;5824.94175058244;5461.617686761889;5477.917831232535;5535.806246781343;5544.611877168641;5570.303712035996;4920.852374428773;4930.852074437773;4934.259861020804;4939.851804445872;4980.12847751642;5862.912056319244;5896.027155519463;6073.18012068374;6081.665508397081;6082.543809214415;5773.364929857628;5794.710264486843;5798.478136967525;5819.621724588058;5911.231539899785;6046.334903160561;6051.273847138372;6063.151158837854;6101.328853826164;6106.69466526663;5735.684537350319;5736.799212027559;5740.942590574041;5742.483176514133;5742.885142297214;5642.802501912413;5655.208270842003;5684.8294551163535;5795.420457954171;5862.179294898803;5522.337319521683;5606.299212598426;5617.129344951539;5642.322921249476;5654.15187721845;5588.972055139699;5603.38362780102;5608.831735047955;5609.382967873612;5615.6630602164005;5389.595780316414;5466.2859303331725;5514.283143191359;5542.8337149883955;5634.098544232903;5480.753366098615;5627.127795191752;5636.464535869086;5641.548676105819;5758.913616295843;5534.612577119563;5570.61005729595;5574.303212098488;5576.721163941867;5630.549556035589 15:49:32 INFO - PROCESS | 3541 | |1;ext.html;558.6565366174401;584.4914924016106;599.7780821096193;604.8820480006395;621.530744288063;31178.376432471367;41082;41896.790516047455;41918;42016.78991605045;42028.579714202846;42414.36378454325;42555.36166957498;42617;42773.786131069304;8363;8445.1977062179;8518.361122915776;8521.914780852174;8524.318054555652;8563.143685631418;8645;8645.913540864605;8646.135386461336;8650.26472749817;8680.56597170142;8703.47779133254;8720.781980450476;8728;8757.299416046733;8641.870371944395;8664.176903194219;8673.522956237404;8682.565871706389;8685.261752751023;8578.914210857936;8625.956870215672;8639.913600864036;8642.265407440374;8647.913520864773;40610.796946015376;40644.18711625751;40847;40890.386644200364;40945.181096377906;3455.2571197192474;3634.545681789776;3678.1724112074835;3820.274147911916;4097.7541347518945;29949.251268718457;30896.38207235865;31202.687973120206;31343;31394.529082063786;4113.650339721127;4213.4522512073545;4240.257954857888;4294.527601963781;4428.114377124588;328575;332712;333752;335741;336653;57502.424975750546;57626;57697.13454298189;57752.42247577471;57815.42184578184;59803.40196598065;60386;60441;60492.69753651204;60504.69747651234;15479.380824767108;15896;15905.045697258201;15916.204189790464;15920;11321.207515474003;11507.539698412138;11513;11514.021308188898;11515.30908145514;17004.659906801793;17881.195346209453;17930.462086137435;17946;18018.90990545065;6248.562600617913;6351.460125889259;6360.872782544323;6463.6768161591735;6499.305715113441;980.5146452506056;993.1111655068673;1008.9192864570816;1009.2531526670211;1087.0542627913608;30941.226469337995;31107.533386999214;31204.843975779975;31239.219019524695;31815.045548633116;961.8845738511424;1122.3882983773863;1133.3030186435283;1133.393634405589;1167.4921409187032;15250.771238431433;16256.75614865778;16314.836851631331;16367.42714005004;16417.753733694004;520206;523620;525883;526018;526894;55946;55971.16043259354;55976.440235597125;56043;56097;1247.3700781105665;1291.0510774580675;1324.423875614111;1329.5745361484426;1373.6771858613217;29124.417511649226;31570;31780.841095794374;31864.203394915312;32302;47987;48602.27096593483;48604.51395486;48635.75682121567;48720.756396217796;383807;385254;385654;387461;387944;28932.42135157327;29737.553936691398;29884;29885.252868678457;40305.79847100746;45641.77179114083;45815.77092114518;45944.7702761484;46251.53748462607;46492.53507464882;38573.80713096529;39382.05075798003;39451.21097577975;40001.79999099986;41206.175876481706;38938;38975;39173.2165356697;40364;40564.79717601511;36564;36824.26351472902;37013.814930925175;37059;37614.811925940194;32757.34485310328;34626.134346641535;34717;35380.46929296011;35413.29173416569;26839.194824155307;27410.588841167;27475.79263816561;27668.72331276742;27907.302317442227 15:49:32 INFO - PROCESS | 3541 | |2;jquery.html;375.6543979538824;392.88802691233025;403.38081045595;407.23236698822717;416.31100528625115;13786.586402407931;18400;18505.7224141638;18598.163082661278;18685.719714204264;18440.53898652531;18510.722339164924;18921.810781892178;18940.71588926167;18968;5459.508644222019;5462.426445223254;5690.032694441955;5700.030994730885;5700.6864622445955;5458.563314934796;5592.7762889484375;5601.019821531216;5601.831945041656;5602.971985140069;5366.624336296461;5564.081926482126;5571.359293681238;5573.916391254134;5576.637518561281;5536.557075433976;5536.889262214753;5565;5579.218909352694;5579.69311687857;4834.58905992991;4985.875353116165;5038.118329292396;5046.621503387224;5048.5203905628905;21791.346259612237;21987.890060549755;22013;22102.778972210395;22222;2312.3756585721762;2319.7100362454694;2351.247600767755;2364.2670772060715;2447.1801946347996;13180.340982950815;13535.729285414334;13626.318684065756;14103.929480352635;14612.780808287884;1846.7414561961336;1903.2957805611875;1937.1282922684707;1945.9513512162168;1978.940631781049;77296.35360869717;80172.59913700452;80494.19505804984;81561.18438815595;83499.58250208771;8923.643054277885;9528.761780955532;9555.522223888778;9636.83171286469;10460.372377657364;12954;13015.609531714064;13023.153495022792;13037.47850085986;13041.347932603521;7043.154821421463;7186.640667966581;7351.595662238628;7376.815579610553;7691.538507689556;7038.507304488637;7083.539569927938;7203.279672032755;7300.196978332379;7535.13345965221;3883.0390652720193;3885.203533275672;3896.2207558488417;3960.940585891214;4021.91956160881;1878.3801345555935;1925.2272354552094;1931.671615825313;1956.1975350514454;2000.1699294792788;862.844687956174;943.4339396362128;960.4045491794992;976.5995941663883;979.2802290316612;17832.91083544574;19048;19055.52361190981;19165.233390664496;19460.805391945898;947.1570302430843;966.4974213408988;980.7989362180735;991.0881988570533;1010.9797804043878;10328.535215915303;10550.525226364678;10788.56845726178;10849.403282819521;10903.563857445613;463201;464168;475744.9954788198;478510;479269;87571.12428875756;88879;89106;89195.55402222948;90328;977.6627063663025;988.1255089245925;1020.7244044108049;1040.380973320873;1048.564845589072;16132.596685082966;16467.752983705013;16569.171541423122;16600.41898533594;17016.87289088864;39771.80114099411;40909.590904090575;40964.59035409727;41246;42900.57099428966;54011.45988540064;55434.44565554293;55913.44086559245;56847;56981.43018569927;7033;8080.555569443737;8230.300424463987;8388.161183881562;8707.825843483222;12198.451069702061;12791.168574042658;12892.35706680147;13069.477220911058;13436.19382837033;11247.88752112501;11262.549498020315;11336.886631133913;11526.538938442369;11716.41417929083;11000;11013.118950483782;11013.889861101607;11106.666799996014;11268.774624507629;11173.441327933733;11263.324200547993;11269.492872820907;11489.482973266391;11535.192536522363;7301.963490182515;7349.4855360124275;7569.47013709035;7627.618619069135;7680.308772210527;9721.319507634398;11693.239939403911;11745.29528228309;11810.586629467927;11944.880551194377 15:49:32 INFO - PROCESS | 3541 | |3;mootools.html;1264.1403845385137;1354.0859919554298;1368.5689007962494;1376;1730.3943619733095;7287.125544934609;8014.198580141983;8181.672733090677;8228.547429891354;8449.873251901226;8234.588270586462;8252.66989320428;8258.380621453385;8286.544240066794;8331.083580806106;2297.667352935298;2332.183735692511;2332.4518738096535;2337;2338.672585837984;2285.1202287119495;2325.988370058147;2348.2720356689397;2368.0409434179187;2368.2066507719933;2182.181681869299;2202.8678279303213;2236.955260894781;2284.7715228477186;2318.5015221727326;2251.043306594691;2261.5250797332496;2300.4478925057865;2301.9424514387106;2302.873341966191;2252.40311317501;2265.105283413043;2273.4430064634107;2273.8521996070367;2276.4536511237184;8282.627281772335;8326.375521835887;8333;8340.833183336299;8341.791455213608;5161.071007218699;5302.072137375943;5352.678839269656;5372.274742909735;5374.543163831079;3401.3367393358303;3457.3949558827103;3476.617572067071;3516.1385460562324;3586.318599466093;1153.4924633161465;1197.5748609243767;1201.53740809788;1223.4677915106956;1242.739024804783;11461;11469.31184128955;11523.827142592783;11541.480633371602;11601.477933492928;4178.707490475637;4456.106154884226;4528.252838281646;4578.931316030262;4579.5878370946775;8867.246284065797;8870.86693699595;8873.29013678904;8876.556172191365;8884.244839188612;5001.499850015042;5001.774920128603;5002.849914502571;5008.12357837377;5014.89970200594;4354.9564504355185;4491.236489796743;4649.395578574764;4718.3158442025715;4765.642576806753;3553.9466907996402;3663.285659296465;3702.185519185775;3713.2202237530423;3805;1149.2242736153064;1168.8597368315686;1171.1041053594008;1196.4137572589543;1199.5561642192445;919.3748251189122;932.4917919733625;933.7898972731217;945.163530275711;982.3418309732353;5481.75332110056;5568.387477377485;5645.774169033275;5745.339285982082;5871.94128058714;902.909709029105;908.0873721909438;912.4890061565544;928.6378312458147;932.342698397628;3781.1870447853294;3845.538535375773;3876.5154355705536;3881.3789793633446;3921.1569512554365;10226.28416010887;10477;10542.209334299958;10600.575976960989;10603;10187.54156062979;10478.895211047791;10487.056164945192;10510.211734119972;10535.947320263349;7739.496932699357;8029.03651561828;8029.678812847537;8036.4776289541;8037.995250593675;5519.69641669712;5531.474509921551;5624.943750562442;5672.262605861211;5786.739596718074;9613.279004074582;9644.75888102803;9803.117719405287;9832.803343933225;9835.704928852147;9618.470984095662;9819.55811988448;9911.405315681082;9937.254705896941;10026.147777438999;6498.187726534184;6638.933610663831;6796.96601517009;6833.69248383814;6933.0986971693355;7805.765827025199;8217.465864718773;8226.259636632733;8231.835363292581;8233.34133269325;7117.024601509196;7248.855022899618;7314.378277846443;7410.6665200065045;7504.849903002018;6840.623765692736;6883.27725588806;6933.2026816916705;7079.115110611174;7196.712131514681;6469.547131700924;6656;6662.034005069335;6662.933370666231;6665.766698165541;4873.439554451142;5034.219695947134;5045.2432135180015;5050.3182070420025;5089.211172268304;4909.140900342497;5014.5737612303365;5062.468440813809;5169.121249387688;5198.298229738937 15:49:32 INFO - PROCESS | 3541 | |4;prototype.html;324.80511692984214;335.69954890373117;337.52577628432044;340.94544872820353;341.2169071979806;5061.316722242496;5120.180771076629;5187.46969643955;5273.547800272872;5274.894502109955;5038.949610503894;5081.263216833557;5114.872128196797;5157.638965272423;5187.403448603412;4122.50529936408;4123.113530590922;4124.628783409493;4134.193832202722;4138.04130047017;3835.712321575879;3878.263130005304;4112.568180341066;4123.876283711478;4138.234426631067;4034.7579145251234;4051.918961620766;4053.918921621566;4059.3505039193733;4060.5127384713874;4040.717149799486;4047.8785636430953;4055.41196526502;4056.290149223889;4069.8982525436954;3615.3311637347174;3620;3621.112827357288;3628.2743451309843;3631.618680038611;4888.511148885119;5038.647294689373;5039.798408063673;5045.722485263309;5048.444671086178;4611.838585649486;4616.376789133491;4617.769111544443;4643.674942754009;4646.953530464686;5140.871478213037;5378.946210537883;5416.566674666017;5419.918701219485;5426.782928682848;3885.26180025797;3900.64894159527;3926.5680775114715;3936.7795983245287;3962.980185099085;5500.834974950758;5532.6680399176175;5539.14143307788;5546.77812887484;5565.858998905255;4023.637872591481;4029.3553031514816;4036.858709945138;4041.8787436376956;4054.7769872656695;3862.304785138702;4002.8598999035476;4023.637872591481;4105.952981989633;4129.8967525811495;4626.21354369758;4628.884277893079;4630.629549636088;4640.5823475886655;4652.720836749806;5469.781208751685;5472.781088756485;5473.452654734495;5479.726013699299;5480.698561579152;1328.8139660447353;1353.6480515066153;1360.9047366684435;1361.9931900340434;1378.5037386540837;931.753085432361;939.5490164720973;947.190152419685;950.9144177024101;951.4253909779188;5014.141939094754;5071.163258062378;5071.782772134735;5080.263361812516;5106.310648062538;5354.277172581652;5370.489803468664;5374.838754837361;5381.735292206328;5394.514493695508;4841.588464980516;5044.344235249394;5047.747612619354;5104.749336412603;5128.564072053917;2831.870782785034;2832.8017038807084;2849.6010558521825;2850.7861910356805;2850.9429811403656;5461.399246082928;5470.987867244572;5518.255035570227;5533.695646739468;5548.361938377057;5264.184051472028;5435.021696094662;5454.181872719124;5466.5900057495055;5482.506574408322;5461.781528738886;5505.944940550623;5508.81560464486;5514.283143191359;5517.613767036269;5361.222622719762;5362.570994320367;5364.30264065669;5388.191771234347;5395.973020134874;5151.304573882478;5300.496452836975;5301.390340110936;5316.468353164652;5339.839804805862;5501.5323697486165;5506.339239291311;5521.309836270466;5528.75120619565;5572.387037425961;3670.2659468105953;3768.7550309229814;3881.3207688653806;3886.4947556817433;3916.8249525141773;5487.890242195054;5510.283663123768;5514.476124768141;5516.503514683698;5524.640898341595;5339.332583427072;5362.839114826562;5384.488473595002;5405.675659460445;5428.104362780255;5208.713520756395;5301.459974326915;5315.910238401196;5372.247885295984;5397.649152805055;5279.709615971158;5286.920696189637;5296.549793267615;5296.808218151039;5324.840254792362;5380.596455265949;5414.404415514212;5437.40188579248;5439.374471935778;5461.563074954073;5183.585313174862;5264.578833693372;5276.894462110813;5290.497402746733;5300.2049692546425 15:49:32 INFO - PROCESS | 3541 | |5;yui.html;728.5956294256689;729.7154109897137;736.7936977646258;792.972245971391;804.0190967020241;13517.121387109843;14050.578482645536;14059.22674252917;14076.296185190726;14159.362828672709;13428.395722192501;13570.864291357084;13592.592222233325;13613.115147515404;13625.1143675661;652.6540933305356;663.8439966607867;742.0983505041373;747.0512449189526;762.6225018615766;754.6415452659998;764.7667461424263;765.1124695353391;765.1468612497081;766.2452484302958;812.2040400407604;814.4380377539509;817.3461231015194;817.6157206113118;818.3616778912428;691.3535843985838;709.5600727548901;804.0552350987566;808.8786681997718;815.0260438775665;596.153462083842;596.4780816785313;597.8953683105439;598.1655590451296;598.6348327520209;14000.719985600334;14003.579892603238;14040.36818343177;14054.156750594997;14064.08583442073;13302.534411295655;13367.799483007762;13511.546023146537;13522.797158042637;13575.389107490088;12141.817872731915;12155.93922030393;12246.571370002097;12280.815787763102;13009.479620815157;3553.2538166984964;3625.170998631989;3725.068732816796;3730.9813450932843;3827.311084004878;61108;62615;62714.372856271766;62737.37262627361;62813.68593157051;10117.241206909512;10253.641122560675;10426.165906727443;10592.576296948037;10708.678739637824;18642.34751783681;18679.90660046691;18788.81211187898;18801;18804.717929231072;7365.263473652699;7385.113786345565;7451.180370159278;7476.775696728998;7519.436042296849;4271.3592961055465;4370.890727731832;4408.448943882015;4461.553844615512;4465.24090904547;3178.968210317867;3284.7700660953983;3447.3450044491465;3585.982070089633;3670.045788095061;639.2009987515605;639.3638329861724;650.4438704907236;651.1600035953661;677.140032159165;629.8929182039064;676.3912478769147;743.985120297591;746.2574738135481;751.3538357012965;8756.211940925346;8911.465312081296;9251.306152038624;9326.95336523313;9580.56887440067;649.7693318871733;673.6934694713991;687.6046273392719;714.0966677153405;714.3285311806885;4222.303319952173;4518.593326600556;4536.500984891659;4588.426446694163;4639.257718765049;85613.57193214119;87475.56262218776;88853.55573222092;89294.55352723195;92200.53899730458;52547;75869.62065189639;76718;77125;77517;71071.2892871075;72474;72770.63614681893;73805.26194738092;74598.62700686461;8528.147185281423;8715.564221789013;8749.518776467356;8858.512781797062;9059.592318345558;47180.292295614905;47737;48410.75794621145;48505.5149448501;50570.74714626403;41111;45099.549004509536;49332.79336843094;54079;56052;12024;12114;12156.635300940987;12439.751204976032;12959.870401295866;13658.795118073038;13845.376958036712;14124.78812817829;14137.151770893779;14365.13809171453;13205.273709946045;13209.405576748877;13216.339183041002;13580.117292375964;13804.309784510533;12645.87354126447;12884.226946383247;13029.543965961146;13116.147450415692;13469.1843953965;12208.206466579644;12415.689607759517;13051.086423950612;13059.477620895437;13061.34693265352;10467;10605.840912386475;11037.503530355993;11260.605878794202;11436.771264574496;9577.329586928849;10070.798584028133;10897.564097436014;11135.220534562826;11253.437328133725 15:49:32 INFO - PROCESS | 3541 | __end_tp_report 15:49:32 INFO - PROCESS | 3541 | __start_cc_report 15:49:32 INFO - PROCESS | 3541 | _x_x_mozilla_cycle_collect,1358 15:49:32 INFO - PROCESS | 3541 | __end_cc_report 15:49:32 INFO - PROCESS | 3541 | __startTimestamp1479080972946__endTimestamp 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | ------- Summary: start ------- 15:49:32 INFO - PROCESS | 3541 | Number of tests: 6 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#0] dojo.html Cycles:165 Average:5382.52 Median:5570.61 stddev:609.59 (10.9%) stddev-sans-first:583.80 15:49:32 INFO - PROCESS | 3541 | Values: 3068.6 3095.6 3117.2 3124.8 3128.5 5323.2 5366.2 5387.6 5408.8 5428.9 5423.9 5429.7 5465.4 5483.4 5543.8 4891.5 4906.5 4934.4 4964.1 4987.9 4930.9 5073.6 5082.0 5091.8 5115.9 4875.7 4953.4 4969.0 4996.6 5060.3 4889.1 4960.9 4969.4 4971.5 4972.0 4921.4 4930.1 4934.2 4935.7 4937.5 5365.8 5388.8 5396.3 5400.2 5408.6 5795.7 5814.1 5818.7 5820.9 5823.3 5802.5 5814.0 5825.5 5828.1 5841.6 5395.9 5418.2 5437.6 5441.0 5443.6 5866.4 5921.3 5925.1 6018.8 6028.8 5784.5 5790.7 5797.1 5800.5 5805.0 5622.9 5646.4 5651.5 5745.5 5865.9 5742.8 5743.6 5748.3 5749.2 5759.2 5731.9 5754.0 5758.4 5759.1 5773.2 4408.4 4414.4 4442.0 4451.8 4458.9 3871.7 3911.1 3911.4 4037.9 4047.7 5509.1 5513.3 5513.5 5527.1 5527.4 5602.8 5635.6 5820.3 5820.7 5824.9 5461.6 5477.9 5535.8 5544.6 5570.3 4920.9 4930.9 4934.3 4939.9 4980.1 5862.9 5896.0 6073.2 6081.7 6082.5 5773.4 5794.7 5798.5 5819.6 5911.2 6046.3 6051.3 6063.2 6101.3 6106.7 5735.7 5736.8 5740.9 5742.5 5742.9 5642.8 5655.2 5684.8 5795.4 5862.2 5522.3 5606.3 5617.1 5642.3 5654.2 5589.0 5603.4 5608.8 5609.4 5615.7 5389.6 5466.3 5514.3 5542.8 5634.1 5480.8 5627.1 5636.5 5641.5 5758.9 5534.6 5570.6 5574.3 5576.7 5630.5 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#1] ext.html Cycles:180 Average:57273.51 Median:40587.80 stddev:111957.13 (275.8%) stddev-sans-first:112190.22 15:49:32 INFO - PROCESS | 3541 | Values: 558.7 584.5 599.8 604.9 621.5 31178.4 41082.0 41896.8 41918.0 42016.8 42028.6 42414.4 42555.4 42617.0 42773.8 8363.0 8445.2 8518.4 8521.9 8524.3 8563.1 8645.0 8645.9 8646.1 8650.3 8680.6 8703.5 8720.8 8728.0 8757.3 8641.9 8664.2 8673.5 8682.6 8685.3 8578.9 8626.0 8639.9 8642.3 8647.9 40610.8 40644.2 40847.0 40890.4 40945.2 3455.3 3634.5 3678.2 3820.3 4097.8 29949.3 30896.4 31202.7 31343.0 31394.5 4113.7 4213.5 4240.3 4294.5 4428.1 328575.0 332712.0 333752.0 335741.0 336653.0 57502.4 57626.0 57697.1 57752.4 57815.4 59803.4 60386.0 60441.0 60492.7 60504.7 15479.4 15896.0 15905.0 15916.2 15920.0 11321.2 11507.5 11513.0 11514.0 11515.3 17004.7 17881.2 17930.5 17946.0 18018.9 6248.6 6351.5 6360.9 6463.7 6499.3 980.5 993.1 1008.9 1009.3 1087.1 30941.2 31107.5 31204.8 31239.2 31815.0 961.9 1122.4 1133.3 1133.4 1167.5 15250.8 16256.8 16314.8 16367.4 16417.8 520206.0 523620.0 525883.0 526018.0 526894.0 55946.0 55971.2 55976.4 56043.0 56097.0 1247.4 1291.1 1324.4 1329.6 1373.7 29124.4 31570.0 31780.8 31864.2 32302.0 47987.0 48602.3 48604.5 48635.8 48720.8 383807.0 385254.0 385654.0 387461.0 387944.0 28932.4 29737.6 29884.0 29885.3 40305.8 45641.8 45815.8 45944.8 46251.5 46492.5 38573.8 39382.1 39451.2 40001.8 41206.2 38938.0 38975.0 39173.2 40364.0 40564.8 36564.0 36824.3 37013.8 37059.0 37614.8 32757.3 34626.1 34717.0 35380.5 35413.3 26839.2 27410.6 27475.8 27668.7 27907.3 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#2] jquery.html Cycles:180 Average:28021.52 Median:21896.86 stddev:77929.06 (355.9%) stddev-sans-first:78120.03 15:49:32 INFO - PROCESS | 3541 | Values: 375.7 392.9 403.4 407.2 416.3 13786.6 18400.0 18505.7 18598.2 18685.7 18440.5 18510.7 18921.8 18940.7 18968.0 5459.5 5462.4 5690.0 5700.0 5700.7 5458.6 5592.8 5601.0 5601.8 5603.0 5366.6 5564.1 5571.4 5573.9 5576.6 5536.6 5536.9 5565.0 5579.2 5579.7 4834.6 4985.9 5038.1 5046.6 5048.5 21791.3 21987.9 22013.0 22102.8 22222.0 2312.4 2319.7 2351.2 2364.3 2447.2 13180.3 13535.7 13626.3 14103.9 14612.8 1846.7 1903.3 1937.1 1946.0 1978.9 77296.4 80172.6 80494.2 81561.2 83499.6 8923.6 9528.8 9555.5 9636.8 10460.4 12954.0 13015.6 13023.2 13037.5 13041.3 7043.2 7186.6 7351.6 7376.8 7691.5 7038.5 7083.5 7203.3 7300.2 7535.1 3883.0 3885.2 3896.2 3960.9 4021.9 1878.4 1925.2 1931.7 1956.2 2000.2 862.8 943.4 960.4 976.6 979.3 17832.9 19048.0 19055.5 19165.2 19460.8 947.2 966.5 980.8 991.1 1011.0 10328.5 10550.5 10788.6 10849.4 10903.6 463201.0 464168.0 475745.0 478510.0 479269.0 87571.1 88879.0 89106.0 89195.6 90328.0 977.7 988.1 1020.7 1040.4 1048.6 16132.6 16467.8 16569.2 16600.4 17016.9 39771.8 40909.6 40964.6 41246.0 42900.6 54011.5 55434.4 55913.4 56847.0 56981.4 7033.0 8080.6 8230.3 8388.2 8707.8 12198.5 12791.2 12892.4 13069.5 13436.2 11247.9 11262.5 11336.9 11526.5 11716.4 11000.0 11013.1 11013.9 11106.7 11268.8 11173.4 11263.3 11269.5 11489.5 11535.2 7302.0 7349.5 7569.5 7627.6 7680.3 9721.3 11693.2 11745.3 11810.6 11944.9 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#3] mootools.html Cycles:180 Average:5507.36 Median:5047.78 stddev:3070.99 (60.8%) stddev-sans-first:3063.04 15:49:32 INFO - PROCESS | 3541 | Values: 1264.1 1354.1 1368.6 1376.0 1730.4 7287.1 8014.2 8181.7 8228.5 8449.9 8234.6 8252.7 8258.4 8286.5 8331.1 2297.7 2332.2 2332.5 2337.0 2338.7 2285.1 2326.0 2348.3 2368.0 2368.2 2182.2 2202.9 2237.0 2284.8 2318.5 2251.0 2261.5 2300.4 2301.9 2302.9 2252.4 2265.1 2273.4 2273.9 2276.5 8282.6 8326.4 8333.0 8340.8 8341.8 5161.1 5302.1 5352.7 5372.3 5374.5 3401.3 3457.4 3476.6 3516.1 3586.3 1153.5 1197.6 1201.5 1223.5 1242.7 11461.0 11469.3 11523.8 11541.5 11601.5 4178.7 4456.1 4528.3 4578.9 4579.6 8867.2 8870.9 8873.3 8876.6 8884.2 5001.5 5001.8 5002.8 5008.1 5014.9 4355.0 4491.2 4649.4 4718.3 4765.6 3553.9 3663.3 3702.2 3713.2 3805.0 1149.2 1168.9 1171.1 1196.4 1199.6 919.4 932.5 933.8 945.2 982.3 5481.8 5568.4 5645.8 5745.3 5871.9 902.9 908.1 912.5 928.6 932.3 3781.2 3845.5 3876.5 3881.4 3921.2 10226.3 10477.0 10542.2 10600.6 10603.0 10187.5 10478.9 10487.1 10510.2 10535.9 7739.5 8029.0 8029.7 8036.5 8038.0 5519.7 5531.5 5624.9 5672.3 5786.7 9613.3 9644.8 9803.1 9832.8 9835.7 9618.5 9819.6 9911.4 9937.3 10026.1 6498.2 6638.9 6797.0 6833.7 6933.1 7805.8 8217.5 8226.3 8231.8 8233.3 7117.0 7248.9 7314.4 7410.7 7504.8 6840.6 6883.3 6933.2 7079.1 7196.7 6469.5 6656.0 6662.0 6662.9 6665.8 4873.4 5034.2 5045.2 5050.3 5089.2 4909.1 5014.6 5062.5 5169.1 5198.3 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#4] prototype.html Cycles:180 Average:4511.06 Median:5146.09 stddev:1300.92 (25.3%) stddev-sans-first:1266.06 15:49:32 INFO - PROCESS | 3541 | Values: 324.8 335.7 337.5 340.9 341.2 5061.3 5120.2 5187.5 5273.5 5274.9 5038.9 5081.3 5114.9 5157.6 5187.4 4122.5 4123.1 4124.6 4134.2 4138.0 3835.7 3878.3 4112.6 4123.9 4138.2 4034.8 4051.9 4053.9 4059.4 4060.5 4040.7 4047.9 4055.4 4056.3 4069.9 3615.3 3620.0 3621.1 3628.3 3631.6 4888.5 5038.6 5039.8 5045.7 5048.4 4611.8 4616.4 4617.8 4643.7 4647.0 5140.9 5378.9 5416.6 5419.9 5426.8 3885.3 3900.6 3926.6 3936.8 3963.0 5500.8 5532.7 5539.1 5546.8 5565.9 4023.6 4029.4 4036.9 4041.9 4054.8 3862.3 4002.9 4023.6 4106.0 4129.9 4626.2 4628.9 4630.6 4640.6 4652.7 5469.8 5472.8 5473.5 5479.7 5480.7 1328.8 1353.6 1360.9 1362.0 1378.5 931.8 939.5 947.2 950.9 951.4 5014.1 5071.2 5071.8 5080.3 5106.3 5354.3 5370.5 5374.8 5381.7 5394.5 4841.6 5044.3 5047.7 5104.7 5128.6 2831.9 2832.8 2849.6 2850.8 2850.9 5461.4 5471.0 5518.3 5533.7 5548.4 5264.2 5435.0 5454.2 5466.6 5482.5 5461.8 5505.9 5508.8 5514.3 5517.6 5361.2 5362.6 5364.3 5388.2 5396.0 5151.3 5300.5 5301.4 5316.5 5339.8 5501.5 5506.3 5521.3 5528.8 5572.4 3670.3 3768.8 3881.3 3886.5 3916.8 5487.9 5510.3 5514.5 5516.5 5524.6 5339.3 5362.8 5384.5 5405.7 5428.1 5208.7 5301.5 5315.9 5372.2 5397.6 5279.7 5286.9 5296.5 5296.8 5324.8 5380.6 5414.4 5437.4 5439.4 5461.6 5183.6 5264.6 5276.9 5290.5 5300.2 15:49:32 INFO - PROCESS | 3541 | 15:49:32 INFO - PROCESS | 3541 | [#5] yui.html Cycles:180 Average:17364.86 Median:25909.78 stddev:23068.19 (89.0%) stddev-sans-first:23099.08 15:49:32 INFO - PROCESS | 3541 | Values: 728.6 729.7 736.8 793.0 804.0 13517.1 14050.6 14059.2 14076.3 14159.4 13428.4 13570.9 13592.6 13613.1 13625.1 652.7 663.8 742.1 747.1 762.6 754.6 764.8 765.1 765.1 766.2 812.2 814.4 817.3 817.6 818.4 691.4 709.6 804.1 808.9 815.0 596.2 596.5 597.9 598.2 598.6 14000.7 14003.6 14040.4 14054.2 14064.1 13302.5 13367.8 13511.5 13522.8 13575.4 12141.8 12155.9 12246.6 12280.8 13009.5 3553.3 3625.2 3725.1 3731.0 3827.3 61108.0 62615.0 62714.4 62737.4 62813.7 10117.2 10253.6 10426.2 10592.6 10708.7 18642.3 18679.9 18788.8 18801.0 18804.7 7365.3 7385.1 7451.2 7476.8 7519.4 4271.4 4370.9 4408.4 4461.6 4465.2 3179.0 3284.8 3447.3 3586.0 3670.0 639.2 639.4 650.4 651.2 677.1 629.9 676.4 744.0 746.3 751.4 8756.2 8911.5 9251.3 9327.0 9580.6 649.8 673.7 687.6 714.1 714.3 4222.3 4518.6 4536.5 4588.4 4639.3 85613.6 87475.6 88853.6 89294.6 92200.5 52547.0 75869.6 76718.0 77125.0 77517.0 71071.3 72474.0 72770.6 73805.3 74598.6 8528.1 8715.6 8749.5 8858.5 9059.6 47180.3 47737.0 48410.8 48505.5 50570.7 41111.0 45099.5 49332.8 54079.0 56052.0 12024.0 12114.0 12156.6 12439.8 12959.9 13658.8 13845.4 14124.8 14137.2 14365.1 13205.3 13209.4 13216.3 13580.1 13804.3 12645.9 12884.2 13029.5 13116.1 13469.2 12208.2 12415.7 13051.1 13059.5 13061.3 10467.0 10605.8 11037.5 11260.6 11436.8 9577.3 10070.8 10897.6 11135.2 11253.4 15:49:32 INFO - PROCESS | 3541 | -------- Summary: end -------- 15:49:32 INFO - PROCESS | 3541 | 15:49:33 INFO - TEST-INFO | 3541: exit 0 15:49:33 INFO - TEST-OK | dromaeo_css | took 1118737ms 15:49:33 INFO - TEST-START | kraken 15:49:33 INFO - operating with platform_type : linux_ 15:49:33 INFO - Initialising browser for kraken test... 15:49:33 INFO - TEST-INFO | started process 3844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpku3SrK/profile http://localhost:58828/getInfo.html) 15:49:37 INFO - PROCESS | 3844 | __metrics Screen width/height:1600/1200 15:49:37 INFO - PROCESS | 3844 | colorDepth:24 15:49:37 INFO - PROCESS | 3844 | Browser inner width/height: 1024/697 15:49:37 INFO - PROCESS | 3844 | __metrics 15:49:38 INFO - PROCESS | 3844 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:49:38 INFO - PROCESS | 3844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:39 INFO - PROCESS | 3844 | console.error: PushService: 15:49:39 INFO - PROCESS | 3844 | stateChangeProcessEnqueue: Error transitioning state 15:49:39 INFO - PROCESS | 3844 | UnknownError 15:49:39 INFO - TEST-INFO | 3844: exit 0 15:49:39 INFO - Browser initialized. 15:49:39 INFO - Running cycle 1/1 for kraken test... 15:49:39 INFO - TEST-INFO | started process 3927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpku3SrK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:51 INFO - PROCESS | 3927 | RSS: Main: 173101056 15:49:51 INFO - PROCESS | 3927 | 15:49:54 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-beat-detection) 15:49:55 INFO - PROCESS | 3927 | RSS: Main: 238325760 15:49:55 INFO - PROCESS | 3927 | 15:49:57 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-dft) 15:49:58 INFO - PROCESS | 3927 | RSS: Main: 216875008 15:49:58 INFO - PROCESS | 3927 | 15:50:01 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-fft) 15:50:02 INFO - PROCESS | 3927 | RSS: Main: 297734144 15:50:02 INFO - PROCESS | 3927 | 15:50:04 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-oscillator) 15:50:04 INFO - PROCESS | 3927 | RSS: Main: 209317888 15:50:04 INFO - PROCESS | 3927 | 15:50:07 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:07 INFO - PROCESS | 3927 | RSS: Main: 212631552 15:50:07 INFO - PROCESS | 3927 | 15:50:10 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:11 INFO - PROCESS | 3927 | RSS: Main: 252596224 15:50:11 INFO - PROCESS | 3927 | 15:50:14 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:15 INFO - PROCESS | 3927 | RSS: Main: 252600320 15:50:15 INFO - PROCESS | 3927 | 15:50:18 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58828/tests/kraken/driver.html?testName=json-parse-financial) 15:50:18 INFO - PROCESS | 3927 | RSS: Main: 251179008 15:50:18 INFO - PROCESS | 3927 | 15:50:20 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:20 INFO - PROCESS | 3927 | RSS: Main: 213295104 15:50:20 INFO - PROCESS | 3927 | 15:50:22 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:23 INFO - PROCESS | 3927 | RSS: Main: 219590656 15:50:23 INFO - PROCESS | 3927 | 15:50:25 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:25 INFO - PROCESS | 3927 | RSS: Main: 229040128 15:50:25 INFO - PROCESS | 3927 | 15:50:28 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:29 INFO - PROCESS | 3927 | RSS: Main: 238575616 15:50:29 INFO - PROCESS | 3927 | 15:50:32 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:50:32 INFO - PROCESS | 3927 | RSS: Main: 234868736 15:50:32 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58828/tests/kraken/driver.html?testName=ai-astar) 15:50:34 INFO - PROCESS | 3927 | RSS: Main: 285429760 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | __start_tp_report 15:50:34 INFO - PROCESS | 3927 | _x_x_mozilla_page_load 15:50:34 INFO - PROCESS | 3927 | _x_x_mozilla_page_load_details 15:50:34 INFO - PROCESS | 3927 | |i|pagename|runs| 15:50:34 INFO - PROCESS | 3927 | |0;ai-astar;111;112;113;112;111;116;112;112;112;112 15:50:34 INFO - PROCESS | 3927 | |1;audio-beat-detection;149;122;131;156;129;124;122;130;168;123 15:50:34 INFO - PROCESS | 3927 | |2;audio-dft;161;162;162;162;165;161;163;161;160;162 15:50:34 INFO - PROCESS | 3927 | |3;audio-fft;74;75;76;110;76;76;76;77;114;76 15:50:34 INFO - PROCESS | 3927 | |4;audio-oscillator;83;83;118;83;84;83;113;83;83;118 15:50:34 INFO - PROCESS | 3927 | |5;imaging-gaussian-blur;117;117;116;117;118;117;117;117;117;117 15:50:34 INFO - PROCESS | 3927 | |6;imaging-darkroom;146;147;146;147;148;147;147;147;148;147 15:50:34 INFO - PROCESS | 3927 | |7;imaging-desaturate;85;84;85;84;85;85;85;85;85;84 15:50:34 INFO - PROCESS | 3927 | |8;json-parse-financial;53;51;51;51;52;53;56;52;52;52 15:50:34 INFO - PROCESS | 3927 | |9;json-stringify-tinderbox;62;63;63;62;62;62;62;62;62;63 15:50:34 INFO - PROCESS | 3927 | |10;stanford-crypto-aes;79;81;79;80;80;87;83;80;79;79 15:50:34 INFO - PROCESS | 3927 | |11;stanford-crypto-ccm;134;132;133;138;136;150;132;145;172;139 15:50:34 INFO - PROCESS | 3927 | |12;stanford-crypto-pbkdf2;164;165;168;168;162;162;160;161;166;163 15:50:34 INFO - PROCESS | 3927 | |13;stanford-crypto-sha256-iterative;69;75;64;64;67;67;69;64;63;62 15:50:34 INFO - PROCESS | 3927 | __end_tp_report 15:50:34 INFO - PROCESS | 3927 | __start_cc_report 15:50:34 INFO - PROCESS | 3927 | _x_x_mozilla_cycle_collect,1680 15:50:34 INFO - PROCESS | 3927 | __end_cc_report 15:50:34 INFO - PROCESS | 3927 | __startTimestamp1479081034557__endTimestamp 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | ------- Summary: start ------- 15:50:34 INFO - PROCESS | 3927 | Number of tests: 14 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.42 15:50:34 INFO - PROCESS | 3927 | Values: 111.0 112.0 113.0 112.0 111.0 116.0 112.0 112.0 112.0 112.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:130.50 stddev:16.34 (12.5%) stddev-sans-first:16.58 15:50:34 INFO - PROCESS | 3927 | Values: 149.0 122.0 131.0 156.0 129.0 124.0 122.0 130.0 168.0 123.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 15:50:34 INFO - PROCESS | 3927 | Values: 161.0 162.0 162.0 162.0 165.0 161.0 163.0 161.0 160.0 162.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.33 (20.2%) stddev-sans-first:15.91 15:50:34 INFO - PROCESS | 3927 | Values: 74.0 75.0 76.0 110.0 76.0 76.0 76.0 77.0 114.0 76.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:83.00 stddev:16.09 (19.4%) stddev-sans-first:16.65 15:50:34 INFO - PROCESS | 3927 | Values: 83.0 83.0 118.0 83.0 84.0 83.0 113.0 83.0 83.0 118.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:50:34 INFO - PROCESS | 3927 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 15:50:34 INFO - PROCESS | 3927 | Values: 146.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 15:50:34 INFO - PROCESS | 3927 | Values: 85.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.49 (2.9%) stddev-sans-first:1.56 15:50:34 INFO - PROCESS | 3927 | Values: 53.0 51.0 51.0 51.0 52.0 53.0 56.0 52.0 52.0 52.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 15:50:34 INFO - PROCESS | 3927 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.54 (3.2%) stddev-sans-first:2.62 15:50:34 INFO - PROCESS | 3927 | Values: 79.0 81.0 79.0 80.0 80.0 87.0 83.0 80.0 79.0 79.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:138.50 stddev:12.34 (8.9%) stddev-sans-first:12.82 15:50:34 INFO - PROCESS | 3927 | Values: 134.0 132.0 133.0 138.0 136.0 150.0 132.0 145.0 172.0 139.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:2.81 (1.7%) stddev-sans-first:2.98 15:50:34 INFO - PROCESS | 3927 | Values: 164.0 165.0 168.0 168.0 162.0 162.0 160.0 161.0 166.0 163.0 15:50:34 INFO - PROCESS | 3927 | 15:50:34 INFO - PROCESS | 3927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:3.89 (5.8%) stddev-sans-first:4.01 15:50:34 INFO - PROCESS | 3927 | Values: 69.0 75.0 64.0 64.0 67.0 67.0 69.0 64.0 63.0 62.0 15:50:34 INFO - PROCESS | 3927 | -------- Summary: end -------- 15:50:34 INFO - PROCESS | 3927 | 15:50:35 INFO - TEST-INFO | 3927: exit 0 15:50:35 INFO - TEST-OK | kraken | took 61943ms 15:50:35 INFO - SUITE-END | took 1180s 15:50:36 INFO - Completed test suite (00:19:41) 15:50:36 INFO - javascript benchmark 15:50:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.6010818593586, 3095.613048368954, 3117.1739489035403, 3124.812511249324, 3128.5150801625755, 5323.201519772036, 5366.195070739386, 5387.568994480442, 5408.756605952732, 5428.918566221505, 5423.918641220384, 5429.67421954683, 5465.398806131332, 5483.396826349099, 5543.805966791163, 4891.461939186686, 4906.509349065101, 4934.407871055479, 4964.056829202458, 4987.900241995158, 4930.852074437755, 5073.619478539106, 5081.974590127044, 5091.821786237482, 5115.872103197413, 4875.7074575525585, 4953.380827396575, 4968.950310496921, 4996.600271978251, 5060.266261392096, 4889.071076495455, 4960.851174464772, 4969.378827646544, 4971.502849715, 4972.0, 4921.384826896638, 4930.063287975273, 4934.185859333205, 4935.70385776851, 4937.506249375069, 5365.758540865631, 5388.78444862205, 5396.325459317585, 5400.243965844785, 5408.648437851527, 5795.710214489301, 5814.069748840166, 5818.679972601505, 5820.854478638025, 5823.301203855522, 5802.506786923117, 5814.040683287252, 5825.475707186331, 5828.0966450200285, 5841.591088623798, 5395.919061214085, 5418.241446197536, 5437.592180586472, 5441.0, 5443.646162999393, 5866.413358664099, 5921.319048309413, 5925.05199168131, 6018.849528761816, 6028.819135425944, 5784.537237021028, 5790.652560846363, 5797.072468405035, 5800.477956983807, 5805.042168042226, 5622.887542249132, 5646.407127251661, 5651.463111004448, 5745.454181852718, 5865.88268234633, 5742.799002034909, 5743.59794814359, 5748.310202775694, 5749.195112684228, 5759.1937128802, 5731.8567035824435, 5754.021816291241, 5758.424157584208, 5759.107338362561, 5773.191753154561, 4408.404865343137, 4414.426124603781, 4442.022754993896, 4451.821927122879, 4458.866234012985, 3871.748336358184, 3911.06134527717, 3911.3741801311653, 4037.8990525237105, 4047.6559492442884, 5509.090999984957, 5513.283273174462, 5513.5037846594, 5527.088030475007, 5527.39198688144, 5602.803901863415, 5635.5773317001385, 5820.30156381237, 5820.650760954271, 5824.94175058244, 5461.617686761889, 5477.917831232535, 5535.806246781343, 5544.611877168641, 5570.303712035996, 4920.852374428773, 4930.852074437773, 4934.259861020804, 4939.851804445872, 4980.12847751642, 5862.912056319244, 5896.027155519463, 6073.18012068374, 6081.665508397081, 6082.543809214415, 5773.364929857628, 5794.710264486843, 5798.478136967525, 5819.621724588058, 5911.231539899785, 6046.334903160561, 6051.273847138372, 6063.151158837854, 6101.328853826164, 6106.69466526663, 5735.684537350319, 5736.799212027559, 5740.942590574041, 5742.483176514133, 5742.885142297214, 5642.802501912413, 5655.208270842003, 5684.8294551163535, 5795.420457954171, 5862.179294898803, 5522.337319521683, 5606.299212598426, 5617.129344951539, 5642.322921249476, 5654.15187721845, 5588.972055139699, 5603.38362780102, 5608.831735047955, 5609.382967873612, 5615.6630602164005, 5389.595780316414, 5466.2859303331725, 5514.283143191359, 5542.8337149883955, 5634.098544232903, 5480.753366098615, 5627.127795191752, 5636.464535869086, 5641.548676105819, 5758.913616295843, 5534.612577119563, 5570.61005729595, 5574.303212098488, 5576.721163941867, 5630.549556035589], "value": 5341.192365159491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6565366174401, 584.4914924016106, 599.7780821096193, 604.8820480006395, 621.530744288063, 31178.376432471367, 41082.0, 41896.790516047455, 41918.0, 42016.78991605045, 42028.579714202846, 42414.36378454325, 42555.36166957498, 42617.0, 42773.786131069304, 8363.0, 8445.1977062179, 8518.361122915776, 8521.914780852174, 8524.318054555652, 8563.143685631418, 8645.0, 8645.913540864605, 8646.135386461336, 8650.26472749817, 8680.56597170142, 8703.47779133254, 8720.781980450476, 8728.0, 8757.299416046733, 8641.870371944395, 8664.176903194219, 8673.522956237404, 8682.565871706389, 8685.261752751023, 8578.914210857936, 8625.956870215672, 8639.913600864036, 8642.265407440374, 8647.913520864773, 40610.796946015376, 40644.18711625751, 40847.0, 40890.386644200364, 40945.181096377906, 3455.2571197192474, 3634.545681789776, 3678.1724112074835, 3820.274147911916, 4097.7541347518945, 29949.251268718457, 30896.38207235865, 31202.687973120206, 31343.0, 31394.529082063786, 4113.650339721127, 4213.4522512073545, 4240.257954857888, 4294.527601963781, 4428.114377124588, 328575.0, 332712.0, 333752.0, 335741.0, 336653.0, 57502.424975750546, 57626.0, 57697.13454298189, 57752.42247577471, 57815.42184578184, 59803.40196598065, 60386.0, 60441.0, 60492.69753651204, 60504.69747651234, 15479.380824767108, 15896.0, 15905.045697258201, 15916.204189790464, 15920.0, 11321.207515474003, 11507.539698412138, 11513.0, 11514.021308188898, 11515.30908145514, 17004.659906801793, 17881.195346209453, 17930.462086137435, 17946.0, 18018.90990545065, 6248.562600617913, 6351.460125889259, 6360.872782544323, 6463.6768161591735, 6499.305715113441, 980.5146452506056, 993.1111655068673, 1008.9192864570816, 1009.2531526670211, 1087.0542627913608, 30941.226469337995, 31107.533386999214, 31204.843975779975, 31239.219019524695, 31815.045548633116, 961.8845738511424, 1122.3882983773863, 1133.3030186435283, 1133.393634405589, 1167.4921409187032, 15250.771238431433, 16256.75614865778, 16314.836851631331, 16367.42714005004, 16417.753733694004, 520206.0, 523620.0, 525883.0, 526018.0, 526894.0, 55946.0, 55971.16043259354, 55976.440235597125, 56043.0, 56097.0, 1247.3700781105665, 1291.0510774580675, 1324.423875614111, 1329.5745361484426, 1373.6771858613217, 29124.417511649226, 31570.0, 31780.841095794374, 31864.203394915312, 32302.0, 47987.0, 48602.27096593483, 48604.51395486, 48635.75682121567, 48720.756396217796, 383807.0, 385254.0, 385654.0, 387461.0, 387944.0, 28932.42135157327, 29737.553936691398, 29884.0, 29885.252868678457, 40305.79847100746, 45641.77179114083, 45815.77092114518, 45944.7702761484, 46251.53748462607, 46492.53507464882, 38573.80713096529, 39382.05075798003, 39451.21097577975, 40001.79999099986, 41206.175876481706, 38938.0, 38975.0, 39173.2165356697, 40364.0, 40564.79717601511, 36564.0, 36824.26351472902, 37013.814930925175, 37059.0, 37614.811925940194, 32757.34485310328, 34626.134346641535, 34717.0, 35380.46929296011, 35413.29173416569, 26839.194824155307, 27410.588841167, 27475.79263816561, 27668.72331276742, 27907.302317442227], "value": 19418.10494948424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.6543979538824, 392.88802691233025, 403.38081045595, 407.23236698822717, 416.31100528625115, 13786.586402407931, 18400.0, 18505.7224141638, 18598.163082661278, 18685.719714204264, 18440.53898652531, 18510.722339164924, 18921.810781892178, 18940.71588926167, 18968.0, 5459.508644222019, 5462.426445223254, 5690.032694441955, 5700.030994730885, 5700.6864622445955, 5458.563314934796, 5592.7762889484375, 5601.019821531216, 5601.831945041656, 5602.971985140069, 5366.624336296461, 5564.081926482126, 5571.359293681238, 5573.916391254134, 5576.637518561281, 5536.557075433976, 5536.889262214753, 5565.0, 5579.218909352694, 5579.69311687857, 4834.58905992991, 4985.875353116165, 5038.118329292396, 5046.621503387224, 5048.5203905628905, 21791.346259612237, 21987.890060549755, 22013.0, 22102.778972210395, 22222.0, 2312.3756585721762, 2319.7100362454694, 2351.247600767755, 2364.2670772060715, 2447.1801946347996, 13180.340982950815, 13535.729285414334, 13626.318684065756, 14103.929480352635, 14612.780808287884, 1846.7414561961336, 1903.2957805611875, 1937.1282922684707, 1945.9513512162168, 1978.940631781049, 77296.35360869717, 80172.59913700452, 80494.19505804984, 81561.18438815595, 83499.58250208771, 8923.643054277885, 9528.761780955532, 9555.522223888778, 9636.83171286469, 10460.372377657364, 12954.0, 13015.609531714064, 13023.153495022792, 13037.47850085986, 13041.347932603521, 7043.154821421463, 7186.640667966581, 7351.595662238628, 7376.815579610553, 7691.538507689556, 7038.507304488637, 7083.539569927938, 7203.279672032755, 7300.196978332379, 7535.13345965221, 3883.0390652720193, 3885.203533275672, 3896.2207558488417, 3960.940585891214, 4021.91956160881, 1878.3801345555935, 1925.2272354552094, 1931.671615825313, 1956.1975350514454, 2000.1699294792788, 862.844687956174, 943.4339396362128, 960.4045491794992, 976.5995941663883, 979.2802290316612, 17832.91083544574, 19048.0, 19055.52361190981, 19165.233390664496, 19460.805391945898, 947.1570302430843, 966.4974213408988, 980.7989362180735, 991.0881988570533, 1010.9797804043878, 10328.535215915303, 10550.525226364678, 10788.56845726178, 10849.403282819521, 10903.563857445613, 463201.0, 464168.0, 475744.9954788198, 478510.0, 479269.0, 87571.12428875756, 88879.0, 89106.0, 89195.55402222948, 90328.0, 977.6627063663025, 988.1255089245925, 1020.7244044108049, 1040.380973320873, 1048.564845589072, 16132.596685082966, 16467.752983705013, 16569.171541423122, 16600.41898533594, 17016.87289088864, 39771.80114099411, 40909.590904090575, 40964.59035409727, 41246.0, 42900.57099428966, 54011.45988540064, 55434.44565554293, 55913.44086559245, 56847.0, 56981.43018569927, 7033.0, 8080.555569443737, 8230.300424463987, 8388.161183881562, 8707.825843483222, 12198.451069702061, 12791.168574042658, 12892.35706680147, 13069.477220911058, 13436.19382837033, 11247.88752112501, 11262.549498020315, 11336.886631133913, 11526.538938442369, 11716.41417929083, 11000.0, 11013.118950483782, 11013.889861101607, 11106.666799996014, 11268.774624507629, 11173.441327933733, 11263.324200547993, 11269.492872820907, 11489.482973266391, 11535.192536522363, 7301.963490182515, 7349.4855360124275, 7569.47013709035, 7627.618619069135, 7680.308772210527, 9721.319507634398, 11693.239939403911, 11745.29528228309, 11810.586629467927, 11944.880551194377], "value": 8878.75824731524, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.1403845385137, 1354.0859919554298, 1368.5689007962494, 1376.0, 1730.3943619733095, 7287.125544934609, 8014.198580141983, 8181.672733090677, 8228.547429891354, 8449.873251901226, 8234.588270586462, 8252.66989320428, 8258.380621453385, 8286.544240066794, 8331.083580806106, 2297.667352935298, 2332.183735692511, 2332.4518738096535, 2337.0, 2338.672585837984, 2285.1202287119495, 2325.988370058147, 2348.2720356689397, 2368.0409434179187, 2368.2066507719933, 2182.181681869299, 2202.8678279303213, 2236.955260894781, 2284.7715228477186, 2318.5015221727326, 2251.043306594691, 2261.5250797332496, 2300.4478925057865, 2301.9424514387106, 2302.873341966191, 2252.40311317501, 2265.105283413043, 2273.4430064634107, 2273.8521996070367, 2276.4536511237184, 8282.627281772335, 8326.375521835887, 8333.0, 8340.833183336299, 8341.791455213608, 5161.071007218699, 5302.072137375943, 5352.678839269656, 5372.274742909735, 5374.543163831079, 3401.3367393358303, 3457.3949558827103, 3476.617572067071, 3516.1385460562324, 3586.318599466093, 1153.4924633161465, 1197.5748609243767, 1201.53740809788, 1223.4677915106956, 1242.739024804783, 11461.0, 11469.31184128955, 11523.827142592783, 11541.480633371602, 11601.477933492928, 4178.707490475637, 4456.106154884226, 4528.252838281646, 4578.931316030262, 4579.5878370946775, 8867.246284065797, 8870.86693699595, 8873.29013678904, 8876.556172191365, 8884.244839188612, 5001.499850015042, 5001.774920128603, 5002.849914502571, 5008.12357837377, 5014.89970200594, 4354.9564504355185, 4491.236489796743, 4649.395578574764, 4718.3158442025715, 4765.642576806753, 3553.9466907996402, 3663.285659296465, 3702.185519185775, 3713.2202237530423, 3805.0, 1149.2242736153064, 1168.8597368315686, 1171.1041053594008, 1196.4137572589543, 1199.5561642192445, 919.3748251189122, 932.4917919733625, 933.7898972731217, 945.163530275711, 982.3418309732353, 5481.75332110056, 5568.387477377485, 5645.774169033275, 5745.339285982082, 5871.94128058714, 902.909709029105, 908.0873721909438, 912.4890061565544, 928.6378312458147, 932.342698397628, 3781.1870447853294, 3845.538535375773, 3876.5154355705536, 3881.3789793633446, 3921.1569512554365, 10226.28416010887, 10477.0, 10542.209334299958, 10600.575976960989, 10603.0, 10187.54156062979, 10478.895211047791, 10487.056164945192, 10510.211734119972, 10535.947320263349, 7739.496932699357, 8029.03651561828, 8029.678812847537, 8036.4776289541, 8037.995250593675, 5519.69641669712, 5531.474509921551, 5624.943750562442, 5672.262605861211, 5786.739596718074, 9613.279004074582, 9644.75888102803, 9803.117719405287, 9832.803343933225, 9835.704928852147, 9618.470984095662, 9819.55811988448, 9911.405315681082, 9937.254705896941, 10026.147777438999, 6498.187726534184, 6638.933610663831, 6796.96601517009, 6833.69248383814, 6933.0986971693355, 7805.765827025199, 8217.465864718773, 8226.259636632733, 8231.835363292581, 8233.34133269325, 7117.024601509196, 7248.855022899618, 7314.378277846443, 7410.6665200065045, 7504.849903002018, 6840.623765692736, 6883.27725588806, 6933.2026816916705, 7079.115110611174, 7196.712131514681, 6469.547131700924, 6656.0, 6662.034005069335, 6662.933370666231, 6665.766698165541, 4873.439554451142, 5034.219695947134, 5045.2432135180015, 5050.3182070420025, 5089.211172268304, 4909.140900342497, 5014.5737612303365, 5062.468440813809, 5169.121249387688, 5198.298229738937], "value": 4446.898756019648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.80511692984214, 335.69954890373117, 337.52577628432044, 340.94544872820353, 341.2169071979806, 5061.316722242496, 5120.180771076629, 5187.46969643955, 5273.547800272872, 5274.894502109955, 5038.949610503894, 5081.263216833557, 5114.872128196797, 5157.638965272423, 5187.403448603412, 4122.50529936408, 4123.113530590922, 4124.628783409493, 4134.193832202722, 4138.04130047017, 3835.712321575879, 3878.263130005304, 4112.568180341066, 4123.876283711478, 4138.234426631067, 4034.7579145251234, 4051.918961620766, 4053.918921621566, 4059.3505039193733, 4060.5127384713874, 4040.717149799486, 4047.8785636430953, 4055.41196526502, 4056.290149223889, 4069.8982525436954, 3615.3311637347174, 3620.0, 3621.112827357288, 3628.2743451309843, 3631.618680038611, 4888.511148885119, 5038.647294689373, 5039.798408063673, 5045.722485263309, 5048.444671086178, 4611.838585649486, 4616.376789133491, 4617.769111544443, 4643.674942754009, 4646.953530464686, 5140.871478213037, 5378.946210537883, 5416.566674666017, 5419.918701219485, 5426.782928682848, 3885.26180025797, 3900.64894159527, 3926.5680775114715, 3936.7795983245287, 3962.980185099085, 5500.834974950758, 5532.6680399176175, 5539.14143307788, 5546.77812887484, 5565.858998905255, 4023.637872591481, 4029.3553031514816, 4036.858709945138, 4041.8787436376956, 4054.7769872656695, 3862.304785138702, 4002.8598999035476, 4023.637872591481, 4105.952981989633, 4129.8967525811495, 4626.21354369758, 4628.884277893079, 4630.629549636088, 4640.5823475886655, 4652.720836749806, 5469.781208751685, 5472.781088756485, 5473.452654734495, 5479.726013699299, 5480.698561579152, 1328.8139660447353, 1353.6480515066153, 1360.9047366684435, 1361.9931900340434, 1378.5037386540837, 931.753085432361, 939.5490164720973, 947.190152419685, 950.9144177024101, 951.4253909779188, 5014.141939094754, 5071.163258062378, 5071.782772134735, 5080.263361812516, 5106.310648062538, 5354.277172581652, 5370.489803468664, 5374.838754837361, 5381.735292206328, 5394.514493695508, 4841.588464980516, 5044.344235249394, 5047.747612619354, 5104.749336412603, 5128.564072053917, 2831.870782785034, 2832.8017038807084, 2849.6010558521825, 2850.7861910356805, 2850.9429811403656, 5461.399246082928, 5470.987867244572, 5518.255035570227, 5533.695646739468, 5548.361938377057, 5264.184051472028, 5435.021696094662, 5454.181872719124, 5466.5900057495055, 5482.506574408322, 5461.781528738886, 5505.944940550623, 5508.81560464486, 5514.283143191359, 5517.613767036269, 5361.222622719762, 5362.570994320367, 5364.30264065669, 5388.191771234347, 5395.973020134874, 5151.304573882478, 5300.496452836975, 5301.390340110936, 5316.468353164652, 5339.839804805862, 5501.5323697486165, 5506.339239291311, 5521.309836270466, 5528.75120619565, 5572.387037425961, 3670.2659468105953, 3768.7550309229814, 3881.3207688653806, 3886.4947556817433, 3916.8249525141773, 5487.890242195054, 5510.283663123768, 5514.476124768141, 5516.503514683698, 5524.640898341595, 5339.332583427072, 5362.839114826562, 5384.488473595002, 5405.675659460445, 5428.104362780255, 5208.713520756395, 5301.459974326915, 5315.910238401196, 5372.247885295984, 5397.649152805055, 5279.709615971158, 5286.920696189637, 5296.549793267615, 5296.808218151039, 5324.840254792362, 5380.596455265949, 5414.404415514212, 5437.40188579248, 5439.374471935778, 5461.563074954073, 5183.585313174862, 5264.578833693372, 5276.894462110813, 5290.497402746733, 5300.2049692546425], "value": 4100.51875278889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5956294256689, 729.7154109897137, 736.7936977646258, 792.972245971391, 804.0190967020241, 13517.121387109843, 14050.578482645536, 14059.22674252917, 14076.296185190726, 14159.362828672709, 13428.395722192501, 13570.864291357084, 13592.592222233325, 13613.115147515404, 13625.1143675661, 652.6540933305356, 663.8439966607867, 742.0983505041373, 747.0512449189526, 762.6225018615766, 754.6415452659998, 764.7667461424263, 765.1124695353391, 765.1468612497081, 766.2452484302958, 812.2040400407604, 814.4380377539509, 817.3461231015194, 817.6157206113118, 818.3616778912428, 691.3535843985838, 709.5600727548901, 804.0552350987566, 808.8786681997718, 815.0260438775665, 596.153462083842, 596.4780816785313, 597.8953683105439, 598.1655590451296, 598.6348327520209, 14000.719985600334, 14003.579892603238, 14040.36818343177, 14054.156750594997, 14064.08583442073, 13302.534411295655, 13367.799483007762, 13511.546023146537, 13522.797158042637, 13575.389107490088, 12141.817872731915, 12155.93922030393, 12246.571370002097, 12280.815787763102, 13009.479620815157, 3553.2538166984964, 3625.170998631989, 3725.068732816796, 3730.9813450932843, 3827.311084004878, 61108.0, 62615.0, 62714.372856271766, 62737.37262627361, 62813.68593157051, 10117.241206909512, 10253.641122560675, 10426.165906727443, 10592.576296948037, 10708.678739637824, 18642.34751783681, 18679.90660046691, 18788.81211187898, 18801.0, 18804.717929231072, 7365.263473652699, 7385.113786345565, 7451.180370159278, 7476.775696728998, 7519.436042296849, 4271.3592961055465, 4370.890727731832, 4408.448943882015, 4461.553844615512, 4465.24090904547, 3178.968210317867, 3284.7700660953983, 3447.3450044491465, 3585.982070089633, 3670.045788095061, 639.2009987515605, 639.3638329861724, 650.4438704907236, 651.1600035953661, 677.140032159165, 629.8929182039064, 676.3912478769147, 743.985120297591, 746.2574738135481, 751.3538357012965, 8756.211940925346, 8911.465312081296, 9251.306152038624, 9326.95336523313, 9580.56887440067, 649.7693318871733, 673.6934694713991, 687.6046273392719, 714.0966677153405, 714.3285311806885, 4222.303319952173, 4518.593326600556, 4536.500984891659, 4588.426446694163, 4639.257718765049, 85613.57193214119, 87475.56262218776, 88853.55573222092, 89294.55352723195, 92200.53899730458, 52547.0, 75869.62065189639, 76718.0, 77125.0, 77517.0, 71071.2892871075, 72474.0, 72770.63614681893, 73805.26194738092, 74598.62700686461, 8528.147185281423, 8715.564221789013, 8749.518776467356, 8858.512781797062, 9059.592318345558, 47180.292295614905, 47737.0, 48410.75794621145, 48505.5149448501, 50570.74714626403, 41111.0, 45099.549004509536, 49332.79336843094, 54079.0, 56052.0, 12024.0, 12114.0, 12156.635300940987, 12439.751204976032, 12959.870401295866, 13658.795118073038, 13845.376958036712, 14124.78812817829, 14137.151770893779, 14365.13809171453, 13205.273709946045, 13209.405576748877, 13216.339183041002, 13580.117292375964, 13804.309784510533, 12645.87354126447, 12884.226946383247, 13029.543965961146, 13116.147450415692, 13469.1843953965, 12208.206466579644, 12415.689607759517, 13051.086423950612, 13059.477620895437, 13061.34693265352, 10467.0, 10605.840912386475, 11037.503530355993, 11260.605878794202, 11436.771264574496, 9577.329586928849, 10070.798584028133, 10897.564097436014, 11135.220534562826, 11253.437328133725], "value": 6944.515115423479, "unit": "score"}], "name": "dromaeo_css", "value": 6989.780317695846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 112.0, 111.0, 116.0, 112.0, 112.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 131.0, 156.0, 129.0, 124.0, 122.0, 130.0, 168.0, 123.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 165.0, 161.0, 163.0, 161.0, 160.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 110.0, 76.0, 76.0, 76.0, 77.0, 114.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 83.0, 84.0, 83.0, 113.0, 83.0, 83.0, 118.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 52.0, 53.0, 56.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 80.0, 80.0, 87.0, 83.0, 80.0, 79.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 133.0, 138.0, 136.0, 150.0, 132.0, 145.0, 172.0, 139.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 168.0, 162.0, 162.0, 160.0, 161.0, 166.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 64.0, 64.0, 67.0, 67.0, 69.0, 64.0, 63.0, 62.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1501.1000000000001, "alertThreshold": 2.0}]} 15:50:36 INFO - Return code: 0 15:50:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:50:36 INFO - # TBPL SUCCESS # 15:50:36 INFO - Running post-action listener: _resource_record_post_action 15:50:36 INFO - [mozharness: 2016-11-13 23:50:36.373094Z] Finished run-tests step (success) 15:50:36 INFO - Running post-run listener: _resource_record_post_run 15:50:36 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 392216576; Read time: 0; Write time: 302384 15:50:36 INFO - TinderboxPrint: CPU usage
13.1% 15:50:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:50:36 INFO - TinderboxPrint: I/O write bytes / time
392,216,576 / 302,384 15:50:36 INFO - TinderboxPrint: CPU idle
8,302.5 (86.9%) 15:50:36 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 15:50:36 INFO - TinderboxPrint: Swap in / out
0 / 0 15:50:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103727104; Read time: 0; Write time: 87004 15:50:36 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288169984; Read time: 0; Write time: 215380 15:50:37 INFO - Running post-run listener: _upload_blobber_files 15:50:37 INFO - Blob upload gear active. 15:50:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:50:37 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 15:50:37 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'] 15:50:37 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 15:50:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:38 INFO - (blobuploader) - INFO - Done attempting. 15:50:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:50:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:41 INFO - (blobuploader) - INFO - Done attempting. 15:50:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:50:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:50:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:42 INFO - (blobuploader) - INFO - Done attempting. 15:50:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:50:42 INFO - Return code: 0 15:50:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:50:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:50:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d0c287349ed17d374812e0ff828fc13fc1ffbfe951a8d78253fec073fb7eae18910a3112dbcaacad6f66cdf19dd6ec3307341553a38497ca15add6159672e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c9a000f0cbc0dc7b0bd56db740495c1c6feb9dbb376156b5057543c8311a4a7b9ea0945c2c145c6b62f997b276aa994d127656569e7a19e373fdcb46d4384be5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e80bd031bf73cdbf4cfb3c831b0bb74cd76169050e7b9a0cee061bdef205dcbfb453dc42b31f0ee35d5ccbfb99db90061f58f1ac38eee2b92b5fae84bc9fef78"} 15:50:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:50:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:50:42 INFO - Contents: 15:50:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d0c287349ed17d374812e0ff828fc13fc1ffbfe951a8d78253fec073fb7eae18910a3112dbcaacad6f66cdf19dd6ec3307341553a38497ca15add6159672e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c9a000f0cbc0dc7b0bd56db740495c1c6feb9dbb376156b5057543c8311a4a7b9ea0945c2c145c6b62f997b276aa994d127656569e7a19e373fdcb46d4384be5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e80bd031bf73cdbf4cfb3c831b0bb74cd76169050e7b9a0cee061bdef205dcbfb453dc42b31f0ee35d5ccbfb99db90061f58f1ac38eee2b92b5fae84bc9fef78"} 15:50:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:50:42 INFO - Copying logs to upload dir... 15:50:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:50:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.472787 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-13 15:50:39.600086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 15:50:39.604053) ========= 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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 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/5d0c287349ed17d374812e0ff828fc13fc1ffbfe951a8d78253fec073fb7eae18910a3112dbcaacad6f66cdf19dd6ec3307341553a38497ca15add6159672e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c9a000f0cbc0dc7b0bd56db740495c1c6feb9dbb376156b5057543c8311a4a7b9ea0945c2c145c6b62f997b276aa994d127656569e7a19e373fdcb46d4384be5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e80bd031bf73cdbf4cfb3c831b0bb74cd76169050e7b9a0cee061bdef205dcbfb453dc42b31f0ee35d5ccbfb99db90061f58f1ac38eee2b92b5fae84bc9fef78"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479069002/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/5d0c287349ed17d374812e0ff828fc13fc1ffbfe951a8d78253fec073fb7eae18910a3112dbcaacad6f66cdf19dd6ec3307341553a38497ca15add6159672e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c9a000f0cbc0dc7b0bd56db740495c1c6feb9dbb376156b5057543c8311a4a7b9ea0945c2c145c6b62f997b276aa994d127656569e7a19e373fdcb46d4384be5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e80bd031bf73cdbf4cfb3c831b0bb74cd76169050e7b9a0cee061bdef205dcbfb453dc42b31f0ee35d5ccbfb99db90061f58f1ac38eee2b92b5fae84bc9fef78"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 15:50:39.629912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:50:39.630272) ========= 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=232498196343f89f466a4a9a000001c8-1479079681.255622-152282362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 15:50:39.718681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 15:50:39.719404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 15:50:39.719856) ========= ========= Total master_lag: 0.18 =========