builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1477772741.26 results: success (0) buildid: 20161029131548 builduid: 2e442c787ff84470bc271387edae7cf1 revision: c136ac92dcdc37dfd09f4868887f1ccf86522989 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.258681) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.259102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.259369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.273800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.274083) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 13:25:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-29 13:25:41 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.416531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.416839) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.466272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:41.466631) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c136ac92dcdc37dfd09f4868887f1ccf86522989 --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 c136ac92dcdc37dfd09f4868887f1ccf86522989 --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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 13:25:41,613 truncating revision to first 12 chars 2016-10-29 13:25:41,613 Setting DEBUG logging. 2016-10-29 13:25:41,613 attempt 1/10 2016-10-29 13:25:41,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c136ac92dcdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 13:25:42,058 unpacking tar archive at: mozilla-inbound-c136ac92dcdc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:42.255720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:42.256059) ========= script_repo_revision: c136ac92dcdc37dfd09f4868887f1ccf86522989 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:42.256464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:42.256749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 13:25:42.269767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-29 13:25:42.270129) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:42 INFO - MultiFileLogger online at 20161029 13:25:42 in /builds/slave/test 13:25:42 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 13:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:42 INFO - {'append_to_log': False, 13:25:42 INFO - 'base_work_dir': '/builds/slave/test', 13:25:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:42 INFO - 'branch': 'Mozilla-Inbound', 13:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:42 INFO - 'config_files': ('talos/linux_config.py',), 13:25:42 INFO - 'default_actions': ('clobber', 13:25:42 INFO - 'read-buildbot-config', 13:25:42 INFO - 'download-and-extract', 13:25:42 INFO - 'populate-webroot', 13:25:42 INFO - 'create-virtualenv', 13:25:42 INFO - 'install', 13:25:42 INFO - 'run-tests'), 13:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:42 INFO - 'download_minidump_stackwalk': True, 13:25:42 INFO - 'download_symbols': 'ondemand', 13:25:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:42 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:42 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:42 INFO - 'installer_path': 'installer.exe', 13:25:42 INFO - 'log_level': 'info', 13:25:42 INFO - 'log_name': 'talos', 13:25:42 INFO - 'log_to_console': True, 13:25:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:42 INFO - 'opt_config_files': (), 13:25:42 INFO - 'pip_index': False, 13:25:42 INFO - 'sps_profile': False, 13:25:42 INFO - 'sps_profile_interval': 0, 13:25:42 INFO - 'suite': 'dromaeojs', 13:25:42 INFO - 'system_bits': '32', 13:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:42 INFO - 'title': 'talos-linux64-ix-033', 13:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:42 INFO - 'use_talos_json': True, 13:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:42 INFO - 'work_dir': 'build'} 13:25:42 INFO - [mozharness: 2016-10-29 20:25:42.516831Z] Running clobber step. 13:25:42 INFO - Running pre-action listener: _resource_record_pre_action 13:25:42 INFO - Running main action method: clobber 13:25:42 INFO - rmtree: /builds/slave/test/build 13:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:43 INFO - Running post-action listener: _resource_record_post_action 13:25:43 INFO - [mozharness: 2016-10-29 20:25:43.508423Z] Finished clobber step (success) 13:25:43 INFO - [mozharness: 2016-10-29 20:25:43.508521Z] Running read-buildbot-config step. 13:25:43 INFO - Running pre-action listener: _resource_record_pre_action 13:25:43 INFO - Running main action method: read_buildbot_config 13:25:43 INFO - Using buildbot properties: 13:25:43 INFO - { 13:25:43 INFO - "project": "", 13:25:43 INFO - "product": "firefox", 13:25:43 INFO - "script_repo_revision": "production", 13:25:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:25:43 INFO - "repository": "", 13:25:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:25:43 INFO - "buildid": "20161029131548", 13:25:43 INFO - "stage_platform": "linux64-pgo", 13:25:43 INFO - "basedir": "/builds/slave/test", 13:25:43 INFO - "buildnumber": 1939, 13:25:43 INFO - "platform": "ubuntu64_hw", 13:25:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:25:43 INFO - "slavebuilddir": "test", 13:25:43 INFO - "branch": "mozilla-inbound", 13:25:43 INFO - "revision": "c136ac92dcdc37dfd09f4868887f1ccf86522989", 13:25:43 INFO - "slavename": "talos-linux64-ix-033", 13:25:43 INFO - "builduid": "2e442c787ff84470bc271387edae7cf1", 13:25:43 INFO - "repo_path": "integration/mozilla-inbound" 13:25:43 INFO - } 13:25:43 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:25:43 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:25:43 INFO - Running post-action listener: _resource_record_post_action 13:25:43 INFO - [mozharness: 2016-10-29 20:25:43.510956Z] Finished read-buildbot-config step (success) 13:25:43 INFO - [mozharness: 2016-10-29 20:25:43.511045Z] Running download-and-extract step. 13:25:43 INFO - Running pre-action listener: _resource_record_pre_action 13:25:43 INFO - Running main action method: download_and_extract 13:25:43 INFO - mkdir: /builds/slave/test/build/tests 13:25:43 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')]} 13:25:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:25:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/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 13:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/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 13:25:43 INFO - Downloaded 1361 bytes. 13:25:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:25:43 INFO - Using the following test package requirements: 13:25:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:25:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:25:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'jsshell-linux-x86_64.zip'], 13:25:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:25:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:25:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:25:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:25:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:25:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:25:43 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:25:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:25:43 INFO - Http code: 200 13:25:43 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 13:25:43 INFO - x-amz-cf-id: IGdzzfpDKnmFB63urOwAZTuF_WIWTHaJ8CzbkOY21UILIiSn0XCPXA== 13:25:43 INFO - x-amz-replication-status: PENDING 13:25:43 INFO - x-amz-version-id: eHezoz9gEXDFZj47siXxq8OzJRKdi811 13:25:43 INFO - Expected file size: 22005783 13:25:43 INFO - Obtained file size: 22005783 13:25:48 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 13:25:48 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:25:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:25:48 INFO - Http code: 200 13:25:48 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:25:48 INFO - x-amz-cf-id: BNPFm-jCJQV5_HmiAjFwsVEYtE800tIF2YtboKQ6ClHIO9SiZr2yYw== 13:25:48 INFO - x-amz-replication-status: PENDING 13:25:48 INFO - x-amz-version-id: eHezoz9gEXDFZj47siXxq8OzJRKdi811 13:25:48 INFO - Expected file size: 22005783 13:25:48 INFO - Obtained file size: 22005783 13:25:52 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:25:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:25:52 INFO - Http code: 200 13:25:52 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 13:25:52 INFO - x-amz-cf-id: W6a0evPqv78z0wkj9uAemk-Z_xR0RwowGVY3zZrzNYhRGD7T_UuEqg== 13:25:52 INFO - x-amz-replication-status: PENDING 13:25:52 INFO - x-amz-version-id: Y15D.u_CQQRjQH355FdZaaY99uk8JmKU 13:25:53 INFO - Expected file size: 14409030 13:25:53 INFO - Obtained file size: 14409030 13:25:53 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')]} 13:25:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/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 13:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/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 13:25:54 INFO - Downloaded 59406539 bytes. 13:25:54 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:54 INFO - mkdir: /builds/slave/test/properties 13:25:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:54 INFO - Contents: 13:25:54 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:54 INFO - Running post-action listener: _resource_record_post_action 13:25:54 INFO - Running post-action listener: set_extra_try_arguments 13:25:54 INFO - [mozharness: 2016-10-29 20:25:54.441635Z] Finished download-and-extract step (success) 13:25:54 INFO - [mozharness: 2016-10-29 20:25:54.441862Z] Running populate-webroot step. 13:25:54 INFO - Running pre-action listener: _resource_record_pre_action 13:25:54 INFO - Running main action method: populate_webroot 13:25:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:54 INFO - '--tppagecycles', 13:25:54 INFO - '7'], 13:25:54 INFO - 'tests': ['tsvgm']}}, 13:25:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['damp', 'tps']}, 13:25:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'tests': ['damp', 'tps']}, 13:25:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['dromaeo_dom']}, 13:25:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['basic_compositor_video']}, 13:25:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['a11yr', 13:25:54 INFO - 'ts_paint', 13:25:54 INFO - 'tpaint', 13:25:54 INFO - 'sessionrestore', 13:25:54 INFO - 'sessionrestore_no_auto_restore', 13:25:54 INFO - 'tabpaint']}, 13:25:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['tsvgx', 13:25:54 INFO - 'tsvgr_opacity', 13:25:54 INFO - 'tart', 13:25:54 INFO - 'tscrollx', 13:25:54 INFO - 'cart']}, 13:25:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:54 INFO - 'tsvgr_opacity', 13:25:54 INFO - 'tart', 13:25:54 INFO - 'tscrollx', 13:25:54 INFO - 'cart']}, 13:25:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'talos_options': ['--disable-e10s'], 13:25:54 INFO - 'tests': ['tp5o']}, 13:25:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'tests': ['tp5o']}, 13:25:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'talos_options': ['--disable-e10s', 13:25:54 INFO - '--xperf_path', 13:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:54 INFO - 'tests': ['tp5n']}, 13:25:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:54 INFO - 'talos_options': ['--xperf_path', 13:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:54 INFO - 'tests': ['tp5n']}}, 13:25:54 INFO - 'talos.zip': {'path': '', 13:25:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:54 INFO - Running post-action listener: _resource_record_post_action 13:25:54 INFO - [mozharness: 2016-10-29 20:25:54.462453Z] Finished populate-webroot step (success) 13:25:54 INFO - [mozharness: 2016-10-29 20:25:54.462541Z] Running create-virtualenv step. 13:25:54 INFO - Running pre-action listener: _resource_record_pre_action 13:25:54 INFO - Running main action method: create_virtualenv 13:25:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:54 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 13:25:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:54 INFO - Using real prefix '/usr' 13:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:55 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:57 INFO - Installing pip.................done. 13:25:57 INFO - Return code: 0 13:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:25:57 INFO - Reading from file tmpfile_stdout 13:25:57 INFO - Output received: 13:25:57 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) 13:25:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:57 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')]} 13:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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')]} 13:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:25:57 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 13:25:57 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 13:25:57 INFO - Using env: {'DISPLAY': ':0', 13:25:57 INFO - 'HOME': '/home/cltbld', 13:25:57 INFO - 'LANG': 'en_US.UTF-8', 13:25:57 INFO - 'LANGUAGE': 'en_US:en', 13:25:57 INFO - 'LOGNAME': 'cltbld', 13:25:57 INFO - 'MAIL': '/var/mail/cltbld', 13:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:57 INFO - 'MOZ_NO_REMOTE': '1', 13:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:57 INFO - 'NO_EM_RESTART': '1', 13:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:57 INFO - 'PWD': '/builds/slave/test', 13:25:57 INFO - 'SHELL': '/bin/bash', 13:25:57 INFO - 'SHLVL': '1', 13:25:57 INFO - 'TERM': 'linux', 13:25:57 INFO - 'TMOUT': '86400', 13:25:57 INFO - 'USER': 'cltbld', 13:25:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:57 INFO - '_': '/tools/buildbot/bin/python'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 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 13:25:57 INFO - Cleaning up... 13:25:57 INFO - Return code: 0 13:25:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25:57 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')]} 13:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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')]} 13:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:25:57 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 13:25:57 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 13:25:57 INFO - Using env: {'DISPLAY': ':0', 13:25:57 INFO - 'HOME': '/home/cltbld', 13:25:57 INFO - 'LANG': 'en_US.UTF-8', 13:25:57 INFO - 'LANGUAGE': 'en_US:en', 13:25:57 INFO - 'LOGNAME': 'cltbld', 13:25:57 INFO - 'MAIL': '/var/mail/cltbld', 13:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:57 INFO - 'MOZ_NO_REMOTE': '1', 13:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:57 INFO - 'NO_EM_RESTART': '1', 13:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:57 INFO - 'PWD': '/builds/slave/test', 13:25:57 INFO - 'SHELL': '/bin/bash', 13:25:57 INFO - 'SHLVL': '1', 13:25:57 INFO - 'TERM': 'linux', 13:25:57 INFO - 'TMOUT': '86400', 13:25:57 INFO - 'USER': 'cltbld', 13:25:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:57 INFO - '_': '/tools/buildbot/bin/python'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 INFO - Downloading/unpacking psutil>=3.1.1 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:59 INFO - Installing collected packages: psutil 13:25:59 INFO - Running setup.py install for psutil 13:25:59 INFO - building 'psutil._psutil_linux' extension 13:25:59 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 13:25:59 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 13:25:59 INFO - building 'psutil._psutil_posix' extension 13:25:59 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 13:26:00 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 13:26:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:00 INFO - Successfully installed psutil 13:26:00 INFO - Cleaning up... 13:26:00 INFO - Return code: 0 13:26:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:26:00 INFO - Using env: {'DISPLAY': ':0', 13:26:00 INFO - 'HOME': '/home/cltbld', 13:26:00 INFO - 'LANG': 'en_US.UTF-8', 13:26:00 INFO - 'LANGUAGE': 'en_US:en', 13:26:00 INFO - 'LOGNAME': 'cltbld', 13:26:00 INFO - 'MAIL': '/var/mail/cltbld', 13:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:00 INFO - 'MOZ_NO_REMOTE': '1', 13:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:00 INFO - 'NO_EM_RESTART': '1', 13:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:00 INFO - 'PWD': '/builds/slave/test', 13:26:00 INFO - 'SHELL': '/bin/bash', 13:26:00 INFO - 'SHLVL': '1', 13:26:00 INFO - 'TERM': 'linux', 13:26:00 INFO - 'TMOUT': '86400', 13:26:00 INFO - 'USER': 'cltbld', 13:26:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:00 INFO - '_': '/tools/buildbot/bin/python'} 13:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:02 INFO - Installing collected packages: mozsystemmonitor 13:26:02 INFO - Running setup.py install for mozsystemmonitor 13:26:02 INFO - Successfully installed mozsystemmonitor 13:26:02 INFO - Cleaning up... 13:26:02 INFO - Return code: 0 13:26:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:02 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:02 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 13:26:02 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 13:26:02 INFO - Using env: {'DISPLAY': ':0', 13:26:02 INFO - 'HOME': '/home/cltbld', 13:26:02 INFO - 'LANG': 'en_US.UTF-8', 13:26:02 INFO - 'LANGUAGE': 'en_US:en', 13:26:02 INFO - 'LOGNAME': 'cltbld', 13:26:02 INFO - 'MAIL': '/var/mail/cltbld', 13:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:02 INFO - 'MOZ_NO_REMOTE': '1', 13:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:02 INFO - 'NO_EM_RESTART': '1', 13:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:02 INFO - 'PWD': '/builds/slave/test', 13:26:02 INFO - 'SHELL': '/bin/bash', 13:26:02 INFO - 'SHLVL': '1', 13:26:02 INFO - 'TERM': 'linux', 13:26:02 INFO - 'TMOUT': '86400', 13:26:02 INFO - 'USER': 'cltbld', 13:26:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:02 INFO - '_': '/tools/buildbot/bin/python'} 13:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:02 INFO - Downloading/unpacking jsonschema==2.5.1 13:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:26:04 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 13:26:04 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 13:26:04 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 13:26:04 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 13:26:04 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 13:26:04 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 13:26:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:05 INFO - warning: no files found matching '*.txt' 13:26:05 INFO - no previously-included directories found matching 'build' 13:26:05 INFO - no previously-included directories found matching 'dist' 13:26:05 INFO - no previously-included directories found matching '.git*' 13:26:05 INFO - Installing collected packages: jsonschema, functools32 13:26:05 INFO - Running setup.py install for functools32 13:26:05 INFO - warning: no files found matching '*.txt' 13:26:05 INFO - no previously-included directories found matching 'build' 13:26:05 INFO - no previously-included directories found matching 'dist' 13:26:05 INFO - no previously-included directories found matching '.git*' 13:26:05 INFO - Successfully installed jsonschema functools32 13:26:05 INFO - Cleaning up... 13:26:05 INFO - Return code: 0 13:26:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:26:05 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')]} 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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')]} 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:05 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 13:26:05 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 13:26:05 INFO - Using env: {'DISPLAY': ':0', 13:26:05 INFO - 'HOME': '/home/cltbld', 13:26:05 INFO - 'LANG': 'en_US.UTF-8', 13:26:05 INFO - 'LANGUAGE': 'en_US:en', 13:26:05 INFO - 'LOGNAME': 'cltbld', 13:26:05 INFO - 'MAIL': '/var/mail/cltbld', 13:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:05 INFO - 'MOZ_NO_REMOTE': '1', 13:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:05 INFO - 'NO_EM_RESTART': '1', 13:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:05 INFO - 'PWD': '/builds/slave/test', 13:26:05 INFO - 'SHELL': '/bin/bash', 13:26:05 INFO - 'SHLVL': '1', 13:26:05 INFO - 'TERM': 'linux', 13:26:05 INFO - 'TMOUT': '86400', 13:26:05 INFO - 'USER': 'cltbld', 13:26:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:05 INFO - '_': '/tools/buildbot/bin/python'} 13:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:26:05 INFO - Cleaning up... 13:26:05 INFO - Return code: 0 13:26:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:05 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')]} 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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')]} 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:05 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 13:26:05 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 13:26:05 INFO - Using env: {'DISPLAY': ':0', 13:26:05 INFO - 'HOME': '/home/cltbld', 13:26:05 INFO - 'LANG': 'en_US.UTF-8', 13:26:05 INFO - 'LANGUAGE': 'en_US:en', 13:26:05 INFO - 'LOGNAME': 'cltbld', 13:26:05 INFO - 'MAIL': '/var/mail/cltbld', 13:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:05 INFO - 'MOZ_NO_REMOTE': '1', 13:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:05 INFO - 'NO_EM_RESTART': '1', 13:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:05 INFO - 'PWD': '/builds/slave/test', 13:26:05 INFO - 'SHELL': '/bin/bash', 13:26:05 INFO - 'SHLVL': '1', 13:26:05 INFO - 'TERM': 'linux', 13:26:05 INFO - 'TMOUT': '86400', 13:26:05 INFO - 'USER': 'cltbld', 13:26:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:05 INFO - '_': '/tools/buildbot/bin/python'} 13:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:07 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 13:26:07 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 13:26:07 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 13:26:07 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 13:26:07 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 13:26:07 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 13:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 INFO - Downloading docopt-0.6.1.tar.gz 13:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:08 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:08 INFO - Running setup.py install for blobuploader 13:26:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:08 INFO - Running setup.py install for requests 13:26:08 INFO - Running setup.py install for docopt 13:26:08 INFO - Successfully installed blobuploader requests docopt 13:26:08 INFO - Cleaning up... 13:26:09 INFO - Return code: 0 13:26:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:09 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:09 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 13:26:09 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 13:26:09 INFO - Using env: {'DISPLAY': ':0', 13:26:09 INFO - 'HOME': '/home/cltbld', 13:26:09 INFO - 'LANG': 'en_US.UTF-8', 13:26:09 INFO - 'LANGUAGE': 'en_US:en', 13:26:09 INFO - 'LOGNAME': 'cltbld', 13:26:09 INFO - 'MAIL': '/var/mail/cltbld', 13:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:09 INFO - 'MOZ_NO_REMOTE': '1', 13:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:09 INFO - 'NO_EM_RESTART': '1', 13:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:09 INFO - 'PWD': '/builds/slave/test', 13:26:09 INFO - 'SHELL': '/bin/bash', 13:26:09 INFO - 'SHLVL': '1', 13:26:09 INFO - 'TERM': 'linux', 13:26:09 INFO - 'TMOUT': '86400', 13:26:09 INFO - 'USER': 'cltbld', 13:26:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:09 INFO - '_': '/tools/buildbot/bin/python'} 13:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:09 INFO - Running setup.py (path:/tmp/pip-BmjIB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:09 INFO - Running setup.py (path:/tmp/pip-Po3_CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:09 INFO - Running setup.py (path:/tmp/pip-b6KnLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:09 INFO - Running setup.py (path:/tmp/pip-V9RBBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:09 INFO - Running setup.py (path:/tmp/pip-qPvlTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:09 INFO - Running setup.py (path:/tmp/pip-0nl8yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:09 INFO - Running setup.py (path:/tmp/pip-cSt8lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:09 INFO - Running setup.py (path:/tmp/pip-vMIPrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:09 INFO - Running setup.py (path:/tmp/pip-v6939t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:09 INFO - Running setup.py (path:/tmp/pip-Ds1_E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:09 INFO - Running setup.py (path:/tmp/pip-ROWMrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:10 INFO - Running setup.py (path:/tmp/pip-5sB9pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:10 INFO - Running setup.py (path:/tmp/pip-JlQAXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:10 INFO - Running setup.py (path:/tmp/pip-S8GZy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:10 INFO - Running setup.py (path:/tmp/pip-buRRzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:10 INFO - Running setup.py (path:/tmp/pip-LZQK5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:10 INFO - Running setup.py (path:/tmp/pip-VA0vlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:10 INFO - Running setup.py install for manifestparser 13:26:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozcrash 13:26:10 INFO - Running setup.py install for mozdebug 13:26:10 INFO - Running setup.py install for mozdevice 13:26:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozfile 13:26:11 INFO - Running setup.py install for mozhttpd 13:26:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozinfo 13:26:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozInstall 13:26:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozleak 13:26:11 INFO - Running setup.py install for mozlog 13:26:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for moznetwork 13:26:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozprocess 13:26:11 INFO - Running setup.py install for mozprofile 13:26:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozrunner 13:26:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Running setup.py install for mozscreenshot 13:26:12 INFO - Running setup.py install for moztest 13:26:12 INFO - Running setup.py install for mozversion 13:26:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:12 INFO - Cleaning up... 13:26:12 INFO - Return code: 0 13:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:12 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')]} 13:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 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')]} 13:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:12 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 13:26:12 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 13:26:12 INFO - Using env: {'DISPLAY': ':0', 13:26:12 INFO - 'HOME': '/home/cltbld', 13:26:12 INFO - 'LANG': 'en_US.UTF-8', 13:26:12 INFO - 'LANGUAGE': 'en_US:en', 13:26:12 INFO - 'LOGNAME': 'cltbld', 13:26:12 INFO - 'MAIL': '/var/mail/cltbld', 13:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:12 INFO - 'MOZ_NO_REMOTE': '1', 13:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:12 INFO - 'NO_EM_RESTART': '1', 13:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:12 INFO - 'PWD': '/builds/slave/test', 13:26:12 INFO - 'SHELL': '/bin/bash', 13:26:12 INFO - 'SHLVL': '1', 13:26:12 INFO - 'TERM': 'linux', 13:26:12 INFO - 'TMOUT': '86400', 13:26:12 INFO - 'USER': 'cltbld', 13:26:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:12 INFO - '_': '/tools/buildbot/bin/python'} 13:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:12 INFO - Running setup.py (path:/tmp/pip-i1VzAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:12 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)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:12 INFO - Running setup.py (path:/tmp/pip-FyGN0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:12 INFO - Running setup.py (path:/tmp/pip-JdrfY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:12 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)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:12 INFO - Running setup.py (path:/tmp/pip-3pslrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:12 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)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:12 INFO - Running setup.py (path:/tmp/pip-aS6K7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:12 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)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:12 INFO - Running setup.py (path:/tmp/pip-8fJFe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:12 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)) 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:12 INFO - Running setup.py (path:/tmp/pip-lsqJL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:13 INFO - Running setup.py (path:/tmp/pip-X08578-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:13 INFO - Running setup.py (path:/tmp/pip-be_n8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:13 INFO - Running setup.py (path:/tmp/pip-rtlhip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:13 INFO - Running setup.py (path:/tmp/pip-ehJE7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:13 INFO - Running setup.py (path:/tmp/pip-czuq4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:13 INFO - Running setup.py (path:/tmp/pip-5cw1Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:13 INFO - Running setup.py (path:/tmp/pip-csoX6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:13 INFO - Running setup.py (path:/tmp/pip-QOD6ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:13 INFO - Running setup.py (path:/tmp/pip-PFNDLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:13 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)) 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:13 INFO - Running setup.py (path:/tmp/pip-LJ1tAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:13 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)) 13:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:26:13 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)) 13:26:13 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)) 13:26:13 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)) 13:26:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:15 INFO - Downloading blessings-1.6.tar.gz 13:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:15 INFO - Installing collected packages: blessings 13:26:15 INFO - Running setup.py install for blessings 13:26:15 INFO - Successfully installed blessings 13:26:15 INFO - Cleaning up... 13:26:15 INFO - Return code: 0 13:26:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:16 INFO - Reading from file tmpfile_stdout 13:26:16 INFO - Current package versions: 13:26:16 INFO - argparse == 1.2.1 13:26:16 INFO - blessings == 1.6 13:26:16 INFO - blobuploader == 1.2.4 13:26:16 INFO - docopt == 0.6.1 13:26:16 INFO - functools32 == 3.2.3-2 13:26:16 INFO - jsonschema == 2.5.1 13:26:16 INFO - manifestparser == 1.1 13:26:16 INFO - mozInstall == 1.12 13:26:16 INFO - mozcrash == 0.17 13:26:16 INFO - mozdebug == 0.1 13:26:16 INFO - mozdevice == 0.48 13:26:16 INFO - mozfile == 1.2 13:26:16 INFO - mozhttpd == 0.7 13:26:16 INFO - mozinfo == 0.9 13:26:16 INFO - mozleak == 0.1 13:26:16 INFO - mozlog == 3.4 13:26:16 INFO - moznetwork == 0.27 13:26:16 INFO - mozprocess == 0.23 13:26:16 INFO - mozprofile == 0.28 13:26:16 INFO - mozrunner == 6.12 13:26:16 INFO - mozscreenshot == 0.1 13:26:16 INFO - mozsystemmonitor == 0.3 13:26:16 INFO - moztest == 0.7 13:26:16 INFO - mozversion == 1.4 13:26:16 INFO - psutil == 3.1.1 13:26:16 INFO - requests == 1.2.3 13:26:16 INFO - wsgiref == 0.1.2 13:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:16 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 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:16 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 13:26:16 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 13:26:16 INFO - Using env: {'DISPLAY': ':0', 13:26:16 INFO - 'HOME': '/home/cltbld', 13:26:16 INFO - 'LANG': 'en_US.UTF-8', 13:26:16 INFO - 'LANGUAGE': 'en_US:en', 13:26:16 INFO - 'LOGNAME': 'cltbld', 13:26:16 INFO - 'MAIL': '/var/mail/cltbld', 13:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:16 INFO - 'MOZ_NO_REMOTE': '1', 13:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:16 INFO - 'NO_EM_RESTART': '1', 13:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:16 INFO - 'PWD': '/builds/slave/test', 13:26:16 INFO - 'SHELL': '/bin/bash', 13:26:16 INFO - 'SHLVL': '1', 13:26:16 INFO - 'TERM': 'linux', 13:26:16 INFO - 'TMOUT': '86400', 13:26:16 INFO - 'USER': 'cltbld', 13:26:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:16 INFO - '_': '/tools/buildbot/bin/python'} 13:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 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)) 13:26:16 INFO - Cleaning up... 13:26:16 INFO - Return code: 0 13:26:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff38d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', '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 13:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:26:16 INFO - Using env: {'DISPLAY': ':0', 13:26:16 INFO - 'HOME': '/home/cltbld', 13:26:16 INFO - 'LANG': 'en_US.UTF-8', 13:26:16 INFO - 'LANGUAGE': 'en_US:en', 13:26:16 INFO - 'LOGNAME': 'cltbld', 13:26:16 INFO - 'MAIL': '/var/mail/cltbld', 13:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:16 INFO - 'MOZ_NO_REMOTE': '1', 13:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:16 INFO - 'NO_EM_RESTART': '1', 13:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:16 INFO - 'PWD': '/builds/slave/test', 13:26:16 INFO - 'SHELL': '/bin/bash', 13:26:16 INFO - 'SHLVL': '1', 13:26:16 INFO - 'TERM': 'linux', 13:26:16 INFO - 'TMOUT': '86400', 13:26:16 INFO - 'USER': 'cltbld', 13:26:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:16 INFO - '_': '/tools/buildbot/bin/python'} 13:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:16 INFO - Cleaning up... 13:26:16 INFO - Return code: 0 13:26:16 INFO - Running post-action listener: _resource_record_post_action 13:26:16 INFO - Running post-action listener: _start_resource_monitoring 13:26:16 INFO - Starting resource monitoring. 13:26:16 INFO - [mozharness: 2016-10-29 20:26:16.658434Z] Finished create-virtualenv step (success) 13:26:16 INFO - [mozharness: 2016-10-29 20:26:16.658934Z] Running install step. 13:26:16 INFO - Running pre-action listener: _resource_record_pre_action 13:26:16 INFO - Running main action method: install 13:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:16 INFO - Reading from file tmpfile_stdout 13:26:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:16 INFO - Reading from file tmpfile_stdout 13:26:16 INFO - Output received: 13:26:16 INFO - Usage: mozinstall [options] installer 13:26:16 INFO - Options: 13:26:16 INFO - -h, --help show this help message and exit 13:26:16 INFO - -d DEST, --destination=DEST 13:26:16 INFO - Directory to install application into. [default: 13:26:16 INFO - "/builds/slave/test"] 13:26:16 INFO - --app=APP Application being installed. [default: firefox] 13:26:16 INFO - mkdir: /builds/slave/test/build/application 13:26:16 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'] 13:26:16 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 13:26:33 INFO - Reading from file tmpfile_stdout 13:26:33 INFO - Output received: 13:26:33 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:33 INFO - Running post-action listener: _resource_record_post_action 13:26:33 INFO - [mozharness: 2016-10-29 20:26:33.826376Z] Finished install step (success) 13:26:33 INFO - [mozharness: 2016-10-29 20:26:33.826648Z] Running run-tests step. 13:26:33 INFO - Running pre-action listener: _resource_record_pre_action 13:26:33 INFO - Running main action method: run_tests 13:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:33 INFO - Python 2.7.3 13:26:33 INFO - Return code: 0 13:26:33 INFO - grabbing minidump binary from tooltool 13:26: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')]} 13:26:33 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 0x1de6f60>, '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 0x1de7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:33 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 13:26:33 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 13:26:33 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 13:26:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:33 INFO - Return code: 0 13:26:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:33 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:26:33 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 13:26:33 INFO - Using env: {'DISPLAY': ':0', 13:26:33 INFO - 'HOME': '/home/cltbld', 13:26:33 INFO - 'LANG': 'en_US.UTF-8', 13:26:33 INFO - 'LANGUAGE': 'en_US:en', 13:26:33 INFO - 'LOGNAME': 'cltbld', 13:26:33 INFO - 'MAIL': '/var/mail/cltbld', 13:26:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:33 INFO - 'MOZ_NO_REMOTE': '1', 13:26:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:33 INFO - 'NO_EM_RESTART': '1', 13:26:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:33 INFO - 'PWD': '/builds/slave/test', 13:26:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:33 INFO - 'SHELL': '/bin/bash', 13:26:33 INFO - 'SHLVL': '1', 13:26:33 INFO - 'TERM': 'linux', 13:26:33 INFO - 'TMOUT': '86400', 13:26:33 INFO - 'USER': 'cltbld', 13:26:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723', 13:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:33 INFO - '_': '/tools/buildbot/bin/python'} 13:26:33 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/1477698451/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:26:34 INFO - mozversion application_buildid: 20161028164731 13:26:34 INFO - mozversion application_changeset: c136ac92dcdc37dfd09f4868887f1ccf86522989 13:26:34 INFO - mozversion application_display_name: Nightly 13:26:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:34 INFO - mozversion application_name: Firefox 13:26:34 INFO - mozversion application_remotingname: firefox 13:26:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:26:34 INFO - mozversion application_vendor: Mozilla 13:26:34 INFO - mozversion application_version: 52.0a1 13:26:34 INFO - mozversion platform_buildid: 20161028164731 13:26:34 INFO - mozversion platform_changeset: c136ac92dcdc37dfd09f4868887f1ccf86522989 13:26:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:26:34 INFO - mozversion platform_version: 52.0a1 13:26:34 INFO - using testdate: 1477772794 13:26:34 INFO - actual date: 1477772794 13:26:34 INFO - starting webserver on 'localhost:45966' 13:26:34 INFO - SUITE-START | Running 2 tests 13:26:34 INFO - TEST-START | dromaeo_css 13:26:34 INFO - operating with platform_type : linux_ 13:26:34 INFO - Initialising browser for dromaeo_css test... 13:26:34 INFO - TEST-INFO | started process 17111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPRkF2Z/profile http://localhost:45966/getInfo.html) 13:26:38 INFO - PROCESS | 17111 | __metrics Screen width/height:1600/1200 13:26:38 INFO - PROCESS | 17111 | colorDepth:24 13:26:38 INFO - PROCESS | 17111 | Browser inner width/height: 1024/697 13:26:38 INFO - PROCESS | 17111 | __metrics 13:26:39 INFO - PROCESS | 17111 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:26:39 INFO - PROCESS | 17111 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:39 INFO - PROCESS | 17111 | console.error: PushService: 13:26:39 INFO - PROCESS | 17111 | stateChangeProcessEnqueue: Error transitioning state 13:26:39 INFO - PROCESS | 17111 | UnknownError 13:26:40 INFO - TEST-INFO | 17111: exit 0 13:26:40 INFO - Browser initialized. 13:26:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:40 INFO - TEST-INFO | started process 17193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPRkF2Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:52 INFO - PROCESS | 17193 | RSS: Main: 176173056 13:26:52 INFO - PROCESS | 17193 | 13:27:43 INFO - PROCESS | 17193 | 1477772863855 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] 13:29:54 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45966/tests/dromaeo/cssquery-ext.html) 13:29:56 INFO - PROCESS | 17193 | RSS: Main: 271613952 13:29:56 INFO - PROCESS | 17193 | 13:32:58 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-ext.html (next: http://localhost:45966/tests/dromaeo/cssquery-jquery.html) 13:32:59 INFO - PROCESS | 17193 | RSS: Main: 276783104 13:32:59 INFO - PROCESS | 17193 | 13:36:01 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45966/tests/dromaeo/cssquery-mootools.html) 13:36:01 INFO - PROCESS | 17193 | RSS: Main: 213721088 13:36:01 INFO - PROCESS | 17193 | 13:39:03 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45966/tests/dromaeo/cssquery-prototype.html) 13:39:04 INFO - PROCESS | 17193 | RSS: Main: 215965696 13:39:04 INFO - PROCESS | 17193 | 13:42:07 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45966/tests/dromaeo/cssquery-yui.html) 13:42:07 INFO - PROCESS | 17193 | RSS: Main: 216039424 13:42:07 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:45966/tests/dromaeo/cssquery-yui.html (next: http://localhost:45966/tests/dromaeo/cssquery-dojo.html) 13:45:10 INFO - PROCESS | 17193 | RSS: Main: 307781632 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | __start_tp_report 13:45:10 INFO - PROCESS | 17193 | _x_x_mozilla_page_load 13:45:10 INFO - PROCESS | 17193 | _x_x_mozilla_page_load_details 13:45:10 INFO - PROCESS | 17193 | |i|pagename|runs| 13:45:10 INFO - PROCESS | 17193 | |0;dojo.html;3062.555929390238;3089.1504836170066;3117.392108538835;3121.3757248550282;3124.6875312468756;5105.234214867763;5203.4796520347945;5297.284866543016;5358.276632654591;5431.321084864392;5261.079311120558;5282.920756188661;5408.134698448239;5430.266913966613;5474.72626368681;4798.352222449959;4826.565609095181;4880.3655524781725;4896.069746748124;4898.926516102261;4909.3126962225315;4977.47736487669;4983.053219888227;4995.468623955539;5022.17134172861;4797.568218860284;4832.565069143794;4857.6599638025355;4933.383327084114;4958.826441074581;4880.048390563841;4880.219164933629;4899.1426500362295;4902.142125128124;4903.239997800347;4856.830010949635;4862.440819305754;4864.756762161913;4864.854054378375;4871.683340582851;5311.9468805311835;5362.678239305654;5366.087765079946;5368.0605893968395;5373.086575282172;5701.600887937846;5704.058830292996;5708.1437784332265;5710.086386178233;5710.14347847822;5644.209810626516;5646.096624540054;5666.46168613981;5667.716614169275;5668.178114173463;5234.424213336491;5279.1817268323475;5280.023195708806;5288.497592728685;5340.91988620171;5755.453231942959;5827.562932780059;5830.650160990354;5848.064309710426;5849.590528663038;5612.635178713371;5614.606977511535;5618.073017951992;5621.80323688669;5623.662580245198;5463.754131064112;5536.640118392292;5587.972060139755;5658.264425624642;5658.660480371191;5636.774529018875;5638.351589567253;5645.068563686946;5658.34928983164;5706.3722990471015;5646.068398714248;5650.7174641267775;5652.321721393377;5661.830145095653;5710.942890571124;4326.826926922888;4335.479742430865;4348.586884245991;4351.695381323277;4402.713823601455;3882.398228274622;3902.2585708715255;3945.92108157841;3952.4664170336637;3953.703472239536;5414.6209765316835;5421.159720243369;5422.701751403711;5424.430434804289;5426.538744206787;5554.333479982428;5622.859428514238;5701.543876489871;5707.0583353747;5710.942890571124;5224.164133738584;5334.1732031535175;5348.893022139536;5394.541463975606;5408.323959505062;4872.6832755870755;4873.122837889143;4874.195757699939;4919.532644398776;4929.605631549467;5816.534677225812;5854.736536855852;5863.296404431496;5879.817481904272;5883.558733094949;5553.194786755978;5624.465675760796;5624.690642014729;5629.634073785191;5633.88732225345;5923.229980102731;5934.584579079423;5940.79207227745;6002.789902353396;6012.458878700938;5558.499735023867;5576.079946808731;5584.218209450762;5592.608517403743;5597.6641401516035;5482.39693633692;5608.747606357805;5677.602567820378;5695.686737229492;5696.458836410535;5503.394626590992;5559.72201389937;5565.415631358649;5578.442155784389;5662.66024038559;5547.778088876561;5555.194496798023;5556.666600004012;5560.5551555876245;5561.443855614568;5437.619366644297;5533.363663178786;5542.916856247079;5549.833504994856;5635.464630860061;5512.283403157564;5586.776528938797;5589.496945274945;5593.916091258716;5672.546196304368;5525.834224973257;5529.695866727368;5530.6128570999645;5535.750891209825;5603.803866864803 13:45:10 INFO - PROCESS | 17193 | |1;ext.html;568.2413977340251;589.4135335341335;609.5397974529229;628.2555172121037;632.8829166604181;31508.68491315086;32237.51643725343;42298.577014229886;43130.56869431305;43206.35190472146;45060.77469612656;45570.77214613931;45592.77203613977;45595.544044559545;45648;8856.822863542726;9011.098890111001;9016.413933094327;9018.368714189977;9026.232770214507;8900.910990890105;9005.14451127142;9015;9015.098490150998;9016.909830901706;8975.237104846063;9011.639534418615;9035.322350823682;9037.36738428307;9038.502882341501;8962.193402593764;9010.189082982562;9013.594388252544;9013.909860901405;9017.909820901838;8879.778005549848;8943.731688049369;8945.686900958435;8945.83704118467;8950.68672596456;42882.35676464855;43265.783671081444;43269.35095973563;43281.567184328385;43287.35068973968;3378.1892345836823;3392.372411103929;3399.1502124468884;3488.4244099723514;3525.189206482498;30757.69242307593;30869.845650771826;31187;34119.6588034119;34168.8951090894;4200.642945349649;4216.198922204771;4340.7178533395545;4355.346697995295;4496.055828276066;321732;325813;326515;327029;331865;59944.70027649834;60282.39717602856;60324.25298331805;60363.39636603666;60372.69813650904;62947;63277.36722632715;63447.36552634507;63477.68261158665;63566;16044.598885027968;16209;16277.430289939795;16298;16332.918335408485;12001.519939202508;12004.27974321526;12014.399280035963;12025.556933167902;12092.939535302443;17983.96778066068;19348.754536252938;19371.225150994083;19472.46543893296;19570.119344629526;7170.175429825533;7203.082751485656;7245.673944672502;7331.120265568059;7364.410847132217;945.4421891084294;1036.3781730961364;1077.4074259157433;1086.163653986426;1095.5508241620896;31905.361892762015;32064.679353206637;32484.512732309035;32491.71461277359;32907.83546082302;1107.1087774341572;1131.728385187549;1135.73310272086;1192.2846292224597;1197.1201167142144;16691.582710432092;17159.656806863793;17313;17329.913350433166;17345.2194651241;526641;529681;533661.6535338621;534500;537521;59050;59473;59601.40398596045;59667.70166149142;59687.40312596819;1296.9870301296867;1322.8809407153403;1339.5311640925597;1351.86481351866;1358.8573199814075;29471.557926631547;32037.839810801728;32187.67320972913;32320.191995200308;32340.514892277104;51311.74344128255;52064;52131.47868521266;52152.47847521628;52169;392637;395682;396017;396581;397440;26647.467050659267;26681.599776002986;28219.71780282171;28733.28166795847;28910.85544572264;48380;48991.51008489869;49020;49593;50323.74838125786;40638.027732512644;41331;42153.36769948392;43029.56970430256;43283;41643.16713665649;41724.374134388614;42229.36655950225;43315;43633.56366436295;34058.65941340555;34664.480032800035;42419.363709544996;43405.34891976686;44365.33451998287;32232.516512252805;33863.3227335447;36439.63560364363;36710.44934325934;37322.813385932895;27803.582946255417;28050.57924131099;28335.716642833308;28355.574666380435;28394.85802570974 13:45:10 INFO - PROCESS | 17193 | |2;jquery.html;378.5873397996185;384.7595252966897;388.976661400316;393.5286401399214;419.4526143382884;14398.856011439882;15470.458533951314;17846.28614855406;19636.116374763133;19677.606447871032;15023.722983546411;16600.50198494047;17980.280788768465;18323.26706931721;18520.536986575342;5021.221710634848;5253.290805741233;5286.471352864722;5294.232336311233;5296.2055691646365;5152.381714194302;5318.149096144618;5347.839564813062;5351.812686555972;5351.919721204185;5360;5405.945940540603;5418.322709661293;5419.783208671648;5420.539254163401;5350.892982140335;5406.053940560386;5412.107002344608;5413.945860541384;5565.777368905239;5641.8589535261535;5742.913856292159;5744.770209191627;5746.741396637161;5747.655140691572;13138.474461021548;15016.699666006727;21796.346109616738;22972.77027229723;23360.299191024296;2268.4215525041172;2275.0785931697687;2280.3842962400226;2315.8378913476063;2319.0516325624885;12720.618381448572;13654.180749155083;13738.244396558186;14026.85973140276;14153.150810951376;1846.8245516675895;1994.3717728915344;2005.91976320947;2039.3168288623328;2091.2994146960787;91828.54085729596;92018.5399073007;92312.53843730806;94113.52943235308;95330.52334738351;16914.577135571708;16940.322387104625;17013.829861701226;17343.739843902353;17633.647327053386;32379.838100809815;32389.838050810067;32419.51370729441;32464.513032304534;32601.347973040407;8253.133420990709;8635.568221588896;8652.740417787476;8733.432326898732;9728.756781080388;7352;7369.189389167187;7383.2616738326815;7396.223396543393;7423.44324175689;7509.924900751032;8492.150784921581;8657.870131948026;8777.42946708462;8976.102389760972;3141.7643676724338;3224.6306255024574;3465.8909149072056;3467.6185619581825;3483.1466290758926;923.7967647117623;957.1911734584404;963.8939716631165;1016.2632091733434;1028.598846449885;17884.463466096036;18316;19651.115699793543;19677.8032219676;19804.20783168686;965.5365424596233;993.344392700814;996.9202463803024;1013.5489707080426;1043.4313299251926;10230.386176829414;11019.118470522339;11076.612318568812;11084.667459976214;11150.944245278723;448454;454707;457413;457936;458654;86438.56780716057;87795.56102219448;87830.56084719663;89341;90184.5490772542;972.9513524323755;993.3096497933867;997.4115271989562;1006.8137394582026;1009.1825621246813;16479.670406592042;16508.679305655278;17092.40176593813;17274.740878886576;17598.120093995505;39318.41022384609;39462;40268.79865600653;40802;42141.157176856905;53522;55382.44617553934;55560.72219638876;56024.439755601925;56652.7167364177;5850.180974663635;5892.322382926019;7923.960380198062;8158.469699469753;8228.876566851623;12264.816027759412;13087.934560327138;13332.3333833306;13347.132436391603;13515.662108447368;11650;11882.881171188523;11892.048636108917;12294.569690060805;12432.627021189379;6312.684365781784;7648.73229436967;11370.829437558277;11386.715332116763;11581.363025033705;10951.961326104241;11864.881351186377;11884.227525210834;11946.701332466759;12203.755924881276;8352.206540378655;8448.704295349879;8457.281131103926;8562.74311770648;8956.417832840845;11211;11330.98021178065;11622.5350985963;11665.941670291933;11674.824877626672 13:45:10 INFO - PROCESS | 17193 | |3;mootools.html;1456.7305048566016;1470.698506806105;1596.497103412425;1723.7155869281569;1733;7377.26227377262;7597.506162099474;8117.87823182652;8647.827043459127;8648.91351086489;8136.2677359037825;8429.452085614446;8436.662533498667;8690.217880390763;8705.695300664462;2256.1201131558705;2259.830512711549;2267.025179172955;2284.371797755614;2292.4612716011725;1932.5168707823045;1985.7815640279557;2218.3234113595345;2263.162629826966;2275.704158459398;2171.522265101675;2238.362066810951;2246.887655617221;2261.2989973108306;2263.4454558633156;2177.42298290953;2202.1411649456645;2218.5895609312247;2231.3752149398197;2234.463728705099;2223.644216925284;2251.876146811941;2263.173941511353;2265.9206927757614;2272.1479445208047;8536.27441667459;8710.477371357676;8711.825763484694;8719.651213951434;8725.869111963326;5052.267421223902;5189.299444574972;5195.168772996302;5196.480351964773;5197.116490196676;3317.2370354818527;3347.832608369572;3406.8296585170892;3429.8971030869116;3430.6259519113332;1033.2508931025022;1045.4581421110927;1061.2359101446946;1071.539238127605;1075.8816530181673;11554.653360399201;11640.301581905029;11645.475953582109;11692.123090768226;11701.94149029258;4008.7394319369146;4168.791560422027;4244.617984381421;4247.638950689165;4292.720973136736;9198.632054717737;9241.584128714225;9242.86135707965;9246.352755307198;9249.445033297889;5065.721385323843;5073.315102461194;5077.593792496591;5077.949220507748;5081.466446023114;4612.5156858530045;4710.24636058229;4727.834525791581;4777.140114779373;4795.256735206049;3441.8107004115013;3518.612952575215;3547.6807087362263;3598.7300952428673;3602.3155600435834;976.9316147869723;983.7983213441228;1049.4070849969742;1059.5602824827765;1066.4241309692834;809.6639894443857;831.9625616847256;858.5106489301163;930.6510058727977;937.6202637931649;5296.761645725952;5406.8918621627345;5469.644473109315;5493.121100623881;5623.3533143689;860.3848248502351;898.4429653614801;908.1780988205685;951.8334291499099;958.1903291718487;3599.172190396171;3682.705383569308;3688.8524459021874;3766.077311058808;3790.7915064671706;10084.798304034024;10625.309354891908;10660.840087398696;10662.200334974908;10679.038886500251;10573.101286390589;10616.044555989844;10625.84061239082;10626.415547144827;10627.149828013895;7834.529928204212;7883.290503854566;8023.077346105156;8032.0361556612415;8152.673893044212;5412.56699464034;5457.345118585795;5457.536109430743;5463.562914966873;5654.773809047592;9403.811923761623;9534.809303813747;9544.0455954404;9549.618015279311;9622.566984485855;9647.758806029906;9793.657221997197;9813.656522021694;9823.705288841345;9946.502674866084;6923.2038315594355;6987.615681137586;7070.823229419306;7072.858542829217;7075.150981882207;7858;8070.83858322842;8097.757067287991;8122.390820688353;8237.341012719087;6208.255009398901;7073.858522829618;7289.125304963438;7408.925910741039;7532.096148462219;7275;7276.272372762682;7317;7412.147603025721;7413.518121322097;6786.660666966533;6805.455563554805;6814.318568143146;6871.381575658214;6918.481113916376;4727.3854398927915;4783.306420569068;4807.399075115611;4852.0295940811275;4962.751862406937;4680.110778951988;4706.4822869485015;4762.833300834454;4824.589909857701;5008.273800299009 13:45:10 INFO - PROCESS | 17193 | |4;prototype.html;308.50792985188633;315.78684388038073;320;322.4051624752331;324.1782082421062;4940.851774446764;5093.821716239932;5134.9743251283735;5143.125668636336;5163.664361816479;4924.060751398884;5075.746212689369;5099.235114732792;5118;5132.384113906327;4035.132446523997;4047.433359329696;4047.959520404788;4052.371882358239;4056.472658554384;3955.3473676843287;4038.676905847525;4046.1300820323627;4063.3701776224584;4074.4295798588223;3984.2031593681236;4003.3794761811964;4007.7595344279434;4011.117554138085;4020;3974.4237085622713;3980.621840925122;3996.1208534122447;4006.519217693881;4027.3958906164016;3580.874669386585;3584.265225628766;3584.426491761306;3596.226811235571;3628.4738712886483;4843.539863712942;5040.521150490734;5055.51972562606;5056.620753443506;5063.772130254148;4601.24079526881;4605.355250264965;4607.493175750665;4608.723476591415;4612.278755534251;5273.841784746463;5289.788408463657;5338.145896656555;5348.411674715778;5353.491418315254;3754.4180651998986;3875.8255878485534;3904.902377440558;3911.513624822549;3912.39357899526;5517.420670829545;5522.061249587539;5526.972365138148;5528.668279903179;5539.944600553983;3989.3617021276455;3994.5406278277787;4007.519097708235;4011.6991225657607;4017.4978127734034;3764.322421964073;3942.4677668514955;4056.6551843093075;4060.634542891095;4062.857799977046;4510.616597589176;4528.592426681615;4531.909361812745;4543.68194226401;4543.954890375232;5357.812476563302;5367.2485851980755;5367.4364191759305;5388;5436.483534064258;1291.916025458361;1316.1576590981779;1329.6570463831406;1329.9601011969658;1362.8841548468292;923.4274749655257;937.5265490927038;943.4056544376998;945.135201290825;947.4599478297305;5249.343832020997;5257.815976440883;5263.26314315996;5276;5276.868078298074;5440.211169380417;5442.537384322298;5506.614536982373;5518.668879867221;5536.75084621193;5151.922721159186;5185.429602743695;5196.480351964773;5202.869928251824;5214.243934629458;2536.365908522869;2562.4618830045524;2571.2928944540026;2573.266619013572;2576.6730133981014;4917.680350777188;4975.900481990412;4997.925031124536;5019.573336266385;5046.394432668103;4858.368412106403;4883.536064073907;4891.04358256693;4894.874178938864;4930.299046828838;4975.90048199034;5018.644965859125;5026.29631851541;5035.949640503622;5042.184813467149;4455;4727.432708075053;4784.712917224978;4791.425028996543;4797.697105389363;4757.691634800458;4760.309755085563;4761.309610106446;4767.952320476889;4773.785179666993;4920.901581968412;4953.851384458472;5051.141305978066;5083.2883396323805;5086.567641750345;3365.543153497911;3494.270336183605;3510.2979404119787;3539.619548376084;3543.5924868639404;4723.31511930775;4755.429348478205;4808;4815.349927759848;4834.670465621982;4653.115488227273;4700.318453824108;4713.952860471351;4744.576627011814;4747.406574178228;4382.364557139261;4661.30080487916;4675.812967481263;4688.390509233778;4695.45050133462;5119;5128.1794912813775;5232.189010703347;5278.4193738687945;5297.066570701743;5326.41409444953;5349.919751203813;5373;5397.703126327932;5403.594730395157;5098.745062746922;5205.947940520547;5217.973910130425;5245.659032162897;5258.447862974485 13:45:10 INFO - PROCESS | 17193 | |5;yui.html;733.376629864615;739.6080077558896;764.6138699956521;768.5235154204394;832.0556168748473;13270.336483175839;14321.570352889405;14329.99690021699;14353.138811671308;14460.276986150702;12350.1972371796;12426.6448059024;12445.626631201056;12450.875491245108;12459.252444853293;648.902664600309;664.7872680742164;782.6869252299083;784.7763387434583;808.7775861638067;799.7360870912585;808.9555074470902;810.785141937387;811.0146172400532;814.5967745965755;849.8682704180862;853.63293783673;855.0765173612483;855.5209082913557;856.0241324889631;684.9246582875879;699.4579201119122;827.4084029918637;847.9576021198947;849.0533055642975;622.7633499270294;625.433982246068;626.5363630913091;626.8432891777056;627.0030651264511;13450;13461.730765384735;13479.326033698373;13480.325983700874;13494.257815820127;13365.532206372827;13508.864911350858;13567.321633918364;13617.387217575133;13654.726905461835;11351.469899215403;11779.58771443004;12021.398930053463;12190.939045304805;12445.377731113407;4253.936190957138;4261.957380426187;4288.078063216423;4330.2638551446325;4490.730556166641;65908.67045664789;66378;69466.27472153903;69471.1370204086;69661;10061.094501494901;10168.796624067478;10176;10273.845892311621;10422.5830966762;18015.54961125956;18024.36914708005;18182.272709091754;18190.90904545469;18461.7230741539;7132.679029443688;7214.098237720285;7450.925490745131;7813.10149332834;8303.169683031769;4331.242032644274;4380.4305440292555;4412.911741765147;4533.478649955297;4602.861914142581;3274.574305340338;3370.224848284908;3385.610654774732;3406.0633325835593;3418.572678415198;606.2149516376303;609.3906093906094;614.4715544631613;618.6257314324858;627.4290395739855;642.540583482812;667.893137098062;674.4490258787488;684.3225207045089;694.7985084325489;8464;8684.131586841391;8864.955675221712;8965.551722413853;9016.23362014223;626.2891618013588;629.3546884446507;642.4667525953447;643.797203880776;680.2177495879778;3853.460515527828;3945.2109578084496;3961.920761584752;3983.4821473208876;4163.91672166555;64379.67810160919;69054.33239346495;87487;87733.56133219293;89833.55083224543;62921.370786291554;67757;68926.65536672284;71537.28462715306;71773;55464;55622.443775561725;56093.47579358939;62332;63538.68230658817;9370.25037996945;10060.899391006289;10177.643782467578;10191.184705223415;10198.388096714221;42098.78950605227;43393.13213735771;43456.565434345255;44473;44760.10479790451;53108.734456327475;55369.44630553643;56770.71614642066;56796.716016419654;58547;11909.166358354832;11979.880201198224;12215.877841221474;12217.411736474556;12683.302418367079;13370.9331453346;13378.464861405435;14170;14373.7843932339;14758.114513129247;12575.685607859878;12820.679483013;12964;13328.200307981551;13656.522021729192;12241.326727030098;12477.251364918135;12700.491980320683;12951.481940722266;13046.478140874258;11681.532738690697;12077.154599177973;12392.938035309766;12496.750064998467;12515.624531264077;9985.666507405498;10358.844617330897;10604.992525710046;10629.532869656494;10630.787384252117;9894.703158905244;10049.447280399649;10437.774232150101;11149.442527873412;11330.37682927447 13:45:10 INFO - PROCESS | 17193 | __end_tp_report 13:45:10 INFO - PROCESS | 17193 | __start_cc_report 13:45:10 INFO - PROCESS | 17193 | _x_x_mozilla_cycle_collect,1338 13:45:10 INFO - PROCESS | 17193 | __end_cc_report 13:45:10 INFO - PROCESS | 17193 | __startTimestamp1477773910967__endTimestamp 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | ------- Summary: start ------- 13:45:10 INFO - PROCESS | 17193 | Number of tests: 6 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#0] dojo.html Cycles:165 Average:5291.72 Median:5530.61 stddev:584.76 (10.6%) stddev-sans-first:559.80 13:45:10 INFO - PROCESS | 17193 | Values: 3062.6 3089.2 3117.4 3121.4 3124.7 5105.2 5203.5 5297.3 5358.3 5431.3 5261.1 5282.9 5408.1 5430.3 5474.7 4798.4 4826.6 4880.4 4896.1 4898.9 4909.3 4977.5 4983.1 4995.5 5022.2 4797.6 4832.6 4857.7 4933.4 4958.8 4880.0 4880.2 4899.1 4902.1 4903.2 4856.8 4862.4 4864.8 4864.9 4871.7 5311.9 5362.7 5366.1 5368.1 5373.1 5701.6 5704.1 5708.1 5710.1 5710.1 5644.2 5646.1 5666.5 5667.7 5668.2 5234.4 5279.2 5280.0 5288.5 5340.9 5755.5 5827.6 5830.7 5848.1 5849.6 5612.6 5614.6 5618.1 5621.8 5623.7 5463.8 5536.6 5588.0 5658.3 5658.7 5636.8 5638.4 5645.1 5658.3 5706.4 5646.1 5650.7 5652.3 5661.8 5710.9 4326.8 4335.5 4348.6 4351.7 4402.7 3882.4 3902.3 3945.9 3952.5 3953.7 5414.6 5421.2 5422.7 5424.4 5426.5 5554.3 5622.9 5701.5 5707.1 5710.9 5224.2 5334.2 5348.9 5394.5 5408.3 4872.7 4873.1 4874.2 4919.5 4929.6 5816.5 5854.7 5863.3 5879.8 5883.6 5553.2 5624.5 5624.7 5629.6 5633.9 5923.2 5934.6 5940.8 6002.8 6012.5 5558.5 5576.1 5584.2 5592.6 5597.7 5482.4 5608.7 5677.6 5695.7 5696.5 5503.4 5559.7 5565.4 5578.4 5662.7 5547.8 5555.2 5556.7 5560.6 5561.4 5437.6 5533.4 5542.9 5549.8 5635.5 5512.3 5586.8 5589.5 5593.9 5672.5 5525.8 5529.7 5530.6 5535.8 5603.8 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#1] ext.html Cycles:180 Average:58522.45 Median:42263.97 stddev:113084.63 (267.6%) stddev-sans-first:113318.15 13:45:10 INFO - PROCESS | 17193 | Values: 568.2 589.4 609.5 628.3 632.9 31508.7 32237.5 42298.6 43130.6 43206.4 45060.8 45570.8 45592.8 45595.5 45648.0 8856.8 9011.1 9016.4 9018.4 9026.2 8900.9 9005.1 9015.0 9015.1 9016.9 8975.2 9011.6 9035.3 9037.4 9038.5 8962.2 9010.2 9013.6 9013.9 9017.9 8879.8 8943.7 8945.7 8945.8 8950.7 42882.4 43265.8 43269.4 43281.6 43287.4 3378.2 3392.4 3399.2 3488.4 3525.2 30757.7 30869.8 31187.0 34119.7 34168.9 4200.6 4216.2 4340.7 4355.3 4496.1 321732.0 325813.0 326515.0 327029.0 331865.0 59944.7 60282.4 60324.3 60363.4 60372.7 62947.0 63277.4 63447.4 63477.7 63566.0 16044.6 16209.0 16277.4 16298.0 16332.9 12001.5 12004.3 12014.4 12025.6 12092.9 17984.0 19348.8 19371.2 19472.5 19570.1 7170.2 7203.1 7245.7 7331.1 7364.4 945.4 1036.4 1077.4 1086.2 1095.6 31905.4 32064.7 32484.5 32491.7 32907.8 1107.1 1131.7 1135.7 1192.3 1197.1 16691.6 17159.7 17313.0 17329.9 17345.2 526641.0 529681.0 533661.7 534500.0 537521.0 59050.0 59473.0 59601.4 59667.7 59687.4 1297.0 1322.9 1339.5 1351.9 1358.9 29471.6 32037.8 32187.7 32320.2 32340.5 51311.7 52064.0 52131.5 52152.5 52169.0 392637.0 395682.0 396017.0 396581.0 397440.0 26647.5 26681.6 28219.7 28733.3 28910.9 48380.0 48991.5 49020.0 49593.0 50323.7 40638.0 41331.0 42153.4 43029.6 43283.0 41643.2 41724.4 42229.4 43315.0 43633.6 34058.7 34664.5 42419.4 43405.3 44365.3 32232.5 33863.3 36439.6 36710.4 37322.8 27803.6 28050.6 28335.7 28355.6 28394.9 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#2] jquery.html Cycles:180 Average:28708.70 Median:386.87 stddev:75382.85 (19485.4%) stddev-sans-first:75564.30 13:45:10 INFO - PROCESS | 17193 | Values: 378.6 384.8 389.0 393.5 419.5 14398.9 15470.5 17846.3 19636.1 19677.6 15023.7 16600.5 17980.3 18323.3 18520.5 5021.2 5253.3 5286.5 5294.2 5296.2 5152.4 5318.1 5347.8 5351.8 5351.9 5360.0 5405.9 5418.3 5419.8 5420.5 5350.9 5406.1 5412.1 5413.9 5565.8 5641.9 5742.9 5744.8 5746.7 5747.7 13138.5 15016.7 21796.3 22972.8 23360.3 2268.4 2275.1 2280.4 2315.8 2319.1 12720.6 13654.2 13738.2 14026.9 14153.2 1846.8 1994.4 2005.9 2039.3 2091.3 91828.5 92018.5 92312.5 94113.5 95330.5 16914.6 16940.3 17013.8 17343.7 17633.6 32379.8 32389.8 32419.5 32464.5 32601.3 8253.1 8635.6 8652.7 8733.4 9728.8 7352.0 7369.2 7383.3 7396.2 7423.4 7509.9 8492.2 8657.9 8777.4 8976.1 3141.8 3224.6 3465.9 3467.6 3483.1 923.8 957.2 963.9 1016.3 1028.6 17884.5 18316.0 19651.1 19677.8 19804.2 965.5 993.3 996.9 1013.5 1043.4 10230.4 11019.1 11076.6 11084.7 11150.9 448454.0 454707.0 457413.0 457936.0 458654.0 86438.6 87795.6 87830.6 89341.0 90184.5 973.0 993.3 997.4 1006.8 1009.2 16479.7 16508.7 17092.4 17274.7 17598.1 39318.4 39462.0 40268.8 40802.0 42141.2 53522.0 55382.4 55560.7 56024.4 56652.7 5850.2 5892.3 7924.0 8158.5 8228.9 12264.8 13087.9 13332.3 13347.1 13515.7 11650.0 11882.9 11892.0 12294.6 12432.6 6312.7 7648.7 11370.8 11386.7 11581.4 10952.0 11864.9 11884.2 11946.7 12203.8 8352.2 8448.7 8457.3 8562.7 8956.4 11211.0 11331.0 11622.5 11665.9 11674.8 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#3] mootools.html Cycles:180 Average:5497.94 Median:5075.45 stddev:3142.78 (61.9%) stddev-sans-first:3136.93 13:45:10 INFO - PROCESS | 17193 | Values: 1456.7 1470.7 1596.5 1723.7 1733.0 7377.3 7597.5 8117.9 8647.8 8648.9 8136.3 8429.5 8436.7 8690.2 8705.7 2256.1 2259.8 2267.0 2284.4 2292.5 1932.5 1985.8 2218.3 2263.2 2275.7 2171.5 2238.4 2246.9 2261.3 2263.4 2177.4 2202.1 2218.6 2231.4 2234.5 2223.6 2251.9 2263.2 2265.9 2272.1 8536.3 8710.5 8711.8 8719.7 8725.9 5052.3 5189.3 5195.2 5196.5 5197.1 3317.2 3347.8 3406.8 3429.9 3430.6 1033.3 1045.5 1061.2 1071.5 1075.9 11554.7 11640.3 11645.5 11692.1 11701.9 4008.7 4168.8 4244.6 4247.6 4292.7 9198.6 9241.6 9242.9 9246.4 9249.4 5065.7 5073.3 5077.6 5077.9 5081.5 4612.5 4710.2 4727.8 4777.1 4795.3 3441.8 3518.6 3547.7 3598.7 3602.3 976.9 983.8 1049.4 1059.6 1066.4 809.7 832.0 858.5 930.7 937.6 5296.8 5406.9 5469.6 5493.1 5623.4 860.4 898.4 908.2 951.8 958.2 3599.2 3682.7 3688.9 3766.1 3790.8 10084.8 10625.3 10660.8 10662.2 10679.0 10573.1 10616.0 10625.8 10626.4 10627.1 7834.5 7883.3 8023.1 8032.0 8152.7 5412.6 5457.3 5457.5 5463.6 5654.8 9403.8 9534.8 9544.0 9549.6 9622.6 9647.8 9793.7 9813.7 9823.7 9946.5 6923.2 6987.6 7070.8 7072.9 7075.2 7858.0 8070.8 8097.8 8122.4 8237.3 6208.3 7073.9 7289.1 7408.9 7532.1 7275.0 7276.3 7317.0 7412.1 7413.5 6786.7 6805.5 6814.3 6871.4 6918.5 4727.4 4783.3 4807.4 4852.0 4962.8 4680.1 4706.5 4762.8 4824.6 5008.3 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#4] prototype.html Cycles:180 Average:4332.42 Median:4794.56 stddev:1241.72 (25.9%) stddev-sans-first:1207.91 13:45:10 INFO - PROCESS | 17193 | Values: 308.5 315.8 320.0 322.4 324.2 4940.9 5093.8 5135.0 5143.1 5163.7 4924.1 5075.7 5099.2 5118.0 5132.4 4035.1 4047.4 4048.0 4052.4 4056.5 3955.3 4038.7 4046.1 4063.4 4074.4 3984.2 4003.4 4007.8 4011.1 4020.0 3974.4 3980.6 3996.1 4006.5 4027.4 3580.9 3584.3 3584.4 3596.2 3628.5 4843.5 5040.5 5055.5 5056.6 5063.8 4601.2 4605.4 4607.5 4608.7 4612.3 5273.8 5289.8 5338.1 5348.4 5353.5 3754.4 3875.8 3904.9 3911.5 3912.4 5517.4 5522.1 5527.0 5528.7 5539.9 3989.4 3994.5 4007.5 4011.7 4017.5 3764.3 3942.5 4056.7 4060.6 4062.9 4510.6 4528.6 4531.9 4543.7 4544.0 5357.8 5367.2 5367.4 5388.0 5436.5 1291.9 1316.2 1329.7 1330.0 1362.9 923.4 937.5 943.4 945.1 947.5 5249.3 5257.8 5263.3 5276.0 5276.9 5440.2 5442.5 5506.6 5518.7 5536.8 5151.9 5185.4 5196.5 5202.9 5214.2 2536.4 2562.5 2571.3 2573.3 2576.7 4917.7 4975.9 4997.9 5019.6 5046.4 4858.4 4883.5 4891.0 4894.9 4930.3 4975.9 5018.6 5026.3 5035.9 5042.2 4455.0 4727.4 4784.7 4791.4 4797.7 4757.7 4760.3 4761.3 4768.0 4773.8 4920.9 4953.9 5051.1 5083.3 5086.6 3365.5 3494.3 3510.3 3539.6 3543.6 4723.3 4755.4 4808.0 4815.3 4834.7 4653.1 4700.3 4714.0 4744.6 4747.4 4382.4 4661.3 4675.8 4688.4 4695.5 5119.0 5128.2 5232.2 5278.4 5297.1 5326.4 5349.9 5373.0 5397.7 5403.6 5098.7 5205.9 5218.0 5245.7 5258.4 13:45:10 INFO - PROCESS | 17193 | 13:45:10 INFO - PROCESS | 17193 | [#5] yui.html Cycles:180 Average:16749.89 Median:4396.67 stddev:21719.95 (494.0%) stddev-sans-first:21747.58 13:45:10 INFO - PROCESS | 17193 | Values: 733.4 739.6 764.6 768.5 832.1 13270.3 14321.6 14330.0 14353.1 14460.3 12350.2 12426.6 12445.6 12450.9 12459.3 648.9 664.8 782.7 784.8 808.8 799.7 809.0 810.8 811.0 814.6 849.9 853.6 855.1 855.5 856.0 684.9 699.5 827.4 848.0 849.1 622.8 625.4 626.5 626.8 627.0 13450.0 13461.7 13479.3 13480.3 13494.3 13365.5 13508.9 13567.3 13617.4 13654.7 11351.5 11779.6 12021.4 12190.9 12445.4 4253.9 4262.0 4288.1 4330.3 4490.7 65908.7 66378.0 69466.3 69471.1 69661.0 10061.1 10168.8 10176.0 10273.8 10422.6 18015.5 18024.4 18182.3 18190.9 18461.7 7132.7 7214.1 7450.9 7813.1 8303.2 4331.2 4380.4 4412.9 4533.5 4602.9 3274.6 3370.2 3385.6 3406.1 3418.6 606.2 609.4 614.5 618.6 627.4 642.5 667.9 674.4 684.3 694.8 8464.0 8684.1 8865.0 8965.6 9016.2 626.3 629.4 642.5 643.8 680.2 3853.5 3945.2 3961.9 3983.5 4163.9 64379.7 69054.3 87487.0 87733.6 89833.6 62921.4 67757.0 68926.7 71537.3 71773.0 55464.0 55622.4 56093.5 62332.0 63538.7 9370.3 10060.9 10177.6 10191.2 10198.4 42098.8 43393.1 43456.6 44473.0 44760.1 53108.7 55369.4 56770.7 56796.7 58547.0 11909.2 11979.9 12215.9 12217.4 12683.3 13370.9 13378.5 14170.0 14373.8 14758.1 12575.7 12820.7 12964.0 13328.2 13656.5 12241.3 12477.3 12700.5 12951.5 13046.5 11681.5 12077.2 12392.9 12496.8 12515.6 9985.7 10358.8 10605.0 10629.5 10630.8 9894.7 10049.4 10437.8 11149.4 11330.4 13:45:10 INFO - PROCESS | 17193 | -------- Summary: end -------- 13:45:10 INFO - PROCESS | 17193 | 13:45:11 INFO - TEST-INFO | 17193: exit 0 13:45:12 INFO - TEST-OK | dromaeo_css | took 1117900ms 13:45:12 INFO - TEST-START | kraken 13:45:12 INFO - operating with platform_type : linux_ 13:45:12 INFO - Initialising browser for kraken test... 13:45:12 INFO - TEST-INFO | started process 17501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4JhjRO/profile http://localhost:45966/getInfo.html) 13:45:16 INFO - PROCESS | 17501 | __metrics Screen width/height:1600/1200 13:45:16 INFO - PROCESS | 17501 | colorDepth:24 13:45:16 INFO - PROCESS | 17501 | Browser inner width/height: 1024/697 13:45:16 INFO - PROCESS | 17501 | __metrics 13:45:17 INFO - PROCESS | 17501 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:45:17 INFO - PROCESS | 17501 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:18 INFO - PROCESS | 17501 | console.error: PushService: 13:45:18 INFO - PROCESS | 17501 | stateChangeProcessEnqueue: Error transitioning state 13:45:18 INFO - PROCESS | 17501 | UnknownError 13:45:18 INFO - TEST-INFO | 17501: exit 0 13:45:18 INFO - Browser initialized. 13:45:18 INFO - Running cycle 1/1 for kraken test... 13:45:18 INFO - TEST-INFO | started process 17583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4JhjRO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:30 INFO - PROCESS | 17583 | RSS: Main: 172773376 13:45:30 INFO - PROCESS | 17583 | 13:45:33 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45966/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:34 INFO - PROCESS | 17583 | RSS: Main: 238338048 13:45:34 INFO - PROCESS | 17583 | 13:45:36 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45966/tests/kraken/driver.html?testName=audio-dft) 13:45:37 INFO - PROCESS | 17583 | RSS: Main: 217145344 13:45:37 INFO - PROCESS | 17583 | 13:45:40 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45966/tests/kraken/driver.html?testName=audio-fft) 13:45:41 INFO - PROCESS | 17583 | RSS: Main: 298405888 13:45:41 INFO - PROCESS | 17583 | 13:45:43 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45966/tests/kraken/driver.html?testName=audio-oscillator) 13:45:43 INFO - PROCESS | 17583 | RSS: Main: 209428480 13:45:43 INFO - PROCESS | 17583 | 13:45:46 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:46 INFO - PROCESS | 17583 | RSS: Main: 212295680 13:45:46 INFO - PROCESS | 17583 | 13:45:49 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45966/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:50 INFO - PROCESS | 17583 | RSS: Main: 248610816 13:45:50 INFO - PROCESS | 17583 | 13:45:53 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45966/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:54 INFO - PROCESS | 17583 | RSS: Main: 247369728 13:45:54 INFO - PROCESS | 17583 | 13:45:56 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45966/tests/kraken/driver.html?testName=json-parse-financial) 13:45:57 INFO - PROCESS | 17583 | RSS: Main: 246706176 13:45:57 INFO - PROCESS | 17583 | 13:45:58 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:59 INFO - PROCESS | 17583 | RSS: Main: 209002496 13:45:59 INFO - PROCESS | 17583 | 13:46:01 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:01 INFO - PROCESS | 17583 | RSS: Main: 216424448 13:46:01 INFO - PROCESS | 17583 | 13:46:03 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:04 INFO - PROCESS | 17583 | RSS: Main: 225767424 13:46:04 INFO - PROCESS | 17583 | 13:46:07 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:08 INFO - PROCESS | 17583 | RSS: Main: 230776832 13:46:08 INFO - PROCESS | 17583 | 13:46:10 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:11 INFO - PROCESS | 17583 | RSS: Main: 232128512 13:46:11 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:45966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45966/tests/kraken/driver.html?testName=ai-astar) 13:46:13 INFO - PROCESS | 17583 | RSS: Main: 283090944 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | __start_tp_report 13:46:13 INFO - PROCESS | 17583 | _x_x_mozilla_page_load 13:46:13 INFO - PROCESS | 17583 | _x_x_mozilla_page_load_details 13:46:13 INFO - PROCESS | 17583 | |i|pagename|runs| 13:46:13 INFO - PROCESS | 17583 | |0;ai-astar;104;112;112;111;111;112;112;110;111;111 13:46:13 INFO - PROCESS | 17583 | |1;audio-beat-detection;149;128;124;166;124;124;121;121;158;123 13:46:13 INFO - PROCESS | 17583 | |2;audio-dft;161;161;160;164;162;162;164;163;162;161 13:46:13 INFO - PROCESS | 17583 | |3;audio-fft;75;75;75;117;77;76;78;75;99;75 13:46:13 INFO - PROCESS | 17583 | |4;audio-oscillator;82;83;111;81;82;81;105;82;82;114 13:46:13 INFO - PROCESS | 17583 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;118;117;117 13:46:13 INFO - PROCESS | 17583 | |6;imaging-darkroom;145;146;146;146;145;145;145;147;145;146 13:46:13 INFO - PROCESS | 17583 | |7;imaging-desaturate;84;85;84;85;85;85;85;85;85;85 13:46:13 INFO - PROCESS | 17583 | |8;json-parse-financial;53;52;53;55;53;55;54;54;55;54 13:46:13 INFO - PROCESS | 17583 | |9;json-stringify-tinderbox;60;61;60;62;62;61;62;61;65;61 13:46:13 INFO - PROCESS | 17583 | |10;stanford-crypto-aes;80;90;82;85;80;86;80;93;88;79 13:46:13 INFO - PROCESS | 17583 | |11;stanford-crypto-ccm;136;137;145;130;133;147;144;136;181;141 13:46:13 INFO - PROCESS | 17583 | |12;stanford-crypto-pbkdf2;168;172;171;171;171;171;166;166;172;171 13:46:13 INFO - PROCESS | 17583 | |13;stanford-crypto-sha256-iterative;73;65;65;65;65;66;64;64;63;64 13:46:13 INFO - PROCESS | 17583 | __end_tp_report 13:46:13 INFO - PROCESS | 17583 | __start_cc_report 13:46:13 INFO - PROCESS | 17583 | _x_x_mozilla_cycle_collect,1683 13:46:13 INFO - PROCESS | 17583 | __end_cc_report 13:46:13 INFO - PROCESS | 17583 | __startTimestamp1477773973352__endTimestamp 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | ------- Summary: start ------- 13:46:13 INFO - PROCESS | 17583 | Number of tests: 14 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.41 (2.2%) stddev-sans-first:0.71 13:46:13 INFO - PROCESS | 17583 | Values: 104.0 112.0 112.0 111.0 111.0 112.0 112.0 110.0 111.0 111.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:126.00 stddev:17.06 (13.5%) stddev-sans-first:17.19 13:46:13 INFO - PROCESS | 17583 | Values: 149.0 128.0 124.0 166.0 124.0 124.0 121.0 121.0 158.0 123.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 13:46:13 INFO - PROCESS | 17583 | Values: 161.0 161.0 160.0 164.0 162.0 162.0 164.0 163.0 162.0 161.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:14.28 (18.9%) stddev-sans-first:14.91 13:46:13 INFO - PROCESS | 17583 | Values: 75.0 75.0 75.0 117.0 77.0 76.0 78.0 75.0 99.0 75.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.78 (16.8%) stddev-sans-first:14.28 13:46:13 INFO - PROCESS | 17583 | Values: 82.0 83.0 111.0 81.0 82.0 81.0 105.0 82.0 82.0 114.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:46:13 INFO - PROCESS | 17583 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:46:13 INFO - PROCESS | 17583 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 147.0 145.0 146.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 13:46:13 INFO - PROCESS | 17583 | Values: 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 13:46:13 INFO - PROCESS | 17583 | Values: 53.0 52.0 53.0 55.0 53.0 55.0 54.0 54.0 55.0 54.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:1.43 (2.3%) stddev-sans-first:1.41 13:46:13 INFO - PROCESS | 17583 | Values: 60.0 61.0 60.0 62.0 62.0 61.0 62.0 61.0 65.0 61.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.50 stddev:4.88 (5.7%) stddev-sans-first:4.92 13:46:13 INFO - PROCESS | 17583 | Values: 80.0 90.0 82.0 85.0 80.0 86.0 80.0 93.0 88.0 79.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:142.50 stddev:14.42 (10.1%) stddev-sans-first:15.07 13:46:13 INFO - PROCESS | 17583 | Values: 136.0 137.0 145.0 130.0 133.0 147.0 144.0 136.0 181.0 141.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.00 stddev:2.33 (1.4%) stddev-sans-first:2.37 13:46:13 INFO - PROCESS | 17583 | Values: 168.0 172.0 171.0 171.0 171.0 171.0 166.0 166.0 172.0 171.0 13:46:13 INFO - PROCESS | 17583 | 13:46:13 INFO - PROCESS | 17583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.80 (4.3%) stddev-sans-first:0.88 13:46:13 INFO - PROCESS | 17583 | Values: 73.0 65.0 65.0 65.0 65.0 66.0 64.0 64.0 63.0 64.0 13:46:13 INFO - PROCESS | 17583 | -------- Summary: end -------- 13:46:13 INFO - PROCESS | 17583 | 13:46:14 INFO - TEST-INFO | 17583: exit 0 13:46:14 INFO - TEST-OK | kraken | took 62613ms 13:46:14 INFO - SUITE-END | took 1180s 13:46:15 INFO - Completed test suite (00:19:40) 13:46:15 INFO - javascript benchmark 13:46:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.555929390238, 3089.1504836170066, 3117.392108538835, 3121.3757248550282, 3124.6875312468756, 5105.234214867763, 5203.4796520347945, 5297.284866543016, 5358.276632654591, 5431.321084864392, 5261.079311120558, 5282.920756188661, 5408.134698448239, 5430.266913966613, 5474.72626368681, 4798.352222449959, 4826.565609095181, 4880.3655524781725, 4896.069746748124, 4898.926516102261, 4909.3126962225315, 4977.47736487669, 4983.053219888227, 4995.468623955539, 5022.17134172861, 4797.568218860284, 4832.565069143794, 4857.6599638025355, 4933.383327084114, 4958.826441074581, 4880.048390563841, 4880.219164933629, 4899.1426500362295, 4902.142125128124, 4903.239997800347, 4856.830010949635, 4862.440819305754, 4864.756762161913, 4864.854054378375, 4871.683340582851, 5311.9468805311835, 5362.678239305654, 5366.087765079946, 5368.0605893968395, 5373.086575282172, 5701.600887937846, 5704.058830292996, 5708.1437784332265, 5710.086386178233, 5710.14347847822, 5644.209810626516, 5646.096624540054, 5666.46168613981, 5667.716614169275, 5668.178114173463, 5234.424213336491, 5279.1817268323475, 5280.023195708806, 5288.497592728685, 5340.91988620171, 5755.453231942959, 5827.562932780059, 5830.650160990354, 5848.064309710426, 5849.590528663038, 5612.635178713371, 5614.606977511535, 5618.073017951992, 5621.80323688669, 5623.662580245198, 5463.754131064112, 5536.640118392292, 5587.972060139755, 5658.264425624642, 5658.660480371191, 5636.774529018875, 5638.351589567253, 5645.068563686946, 5658.34928983164, 5706.3722990471015, 5646.068398714248, 5650.7174641267775, 5652.321721393377, 5661.830145095653, 5710.942890571124, 4326.826926922888, 4335.479742430865, 4348.586884245991, 4351.695381323277, 4402.713823601455, 3882.398228274622, 3902.2585708715255, 3945.92108157841, 3952.4664170336637, 3953.703472239536, 5414.6209765316835, 5421.159720243369, 5422.701751403711, 5424.430434804289, 5426.538744206787, 5554.333479982428, 5622.859428514238, 5701.543876489871, 5707.0583353747, 5710.942890571124, 5224.164133738584, 5334.1732031535175, 5348.893022139536, 5394.541463975606, 5408.323959505062, 4872.6832755870755, 4873.122837889143, 4874.195757699939, 4919.532644398776, 4929.605631549467, 5816.534677225812, 5854.736536855852, 5863.296404431496, 5879.817481904272, 5883.558733094949, 5553.194786755978, 5624.465675760796, 5624.690642014729, 5629.634073785191, 5633.88732225345, 5923.229980102731, 5934.584579079423, 5940.79207227745, 6002.789902353396, 6012.458878700938, 5558.499735023867, 5576.079946808731, 5584.218209450762, 5592.608517403743, 5597.6641401516035, 5482.39693633692, 5608.747606357805, 5677.602567820378, 5695.686737229492, 5696.458836410535, 5503.394626590992, 5559.72201389937, 5565.415631358649, 5578.442155784389, 5662.66024038559, 5547.778088876561, 5555.194496798023, 5556.666600004012, 5560.5551555876245, 5561.443855614568, 5437.619366644297, 5533.363663178786, 5542.916856247079, 5549.833504994856, 5635.464630860061, 5512.283403157564, 5586.776528938797, 5589.496945274945, 5593.916091258716, 5672.546196304368, 5525.834224973257, 5529.695866727368, 5530.6128570999645, 5535.750891209825, 5603.803866864803], "value": 5253.153436556221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2413977340251, 589.4135335341335, 609.5397974529229, 628.2555172121037, 632.8829166604181, 31508.68491315086, 32237.51643725343, 42298.577014229886, 43130.56869431305, 43206.35190472146, 45060.77469612656, 45570.77214613931, 45592.77203613977, 45595.544044559545, 45648.0, 8856.822863542726, 9011.098890111001, 9016.413933094327, 9018.368714189977, 9026.232770214507, 8900.910990890105, 9005.14451127142, 9015.0, 9015.098490150998, 9016.909830901706, 8975.237104846063, 9011.639534418615, 9035.322350823682, 9037.36738428307, 9038.502882341501, 8962.193402593764, 9010.189082982562, 9013.594388252544, 9013.909860901405, 9017.909820901838, 8879.778005549848, 8943.731688049369, 8945.686900958435, 8945.83704118467, 8950.68672596456, 42882.35676464855, 43265.783671081444, 43269.35095973563, 43281.567184328385, 43287.35068973968, 3378.1892345836823, 3392.372411103929, 3399.1502124468884, 3488.4244099723514, 3525.189206482498, 30757.69242307593, 30869.845650771826, 31187.0, 34119.6588034119, 34168.8951090894, 4200.642945349649, 4216.198922204771, 4340.7178533395545, 4355.346697995295, 4496.055828276066, 321732.0, 325813.0, 326515.0, 327029.0, 331865.0, 59944.70027649834, 60282.39717602856, 60324.25298331805, 60363.39636603666, 60372.69813650904, 62947.0, 63277.36722632715, 63447.36552634507, 63477.68261158665, 63566.0, 16044.598885027968, 16209.0, 16277.430289939795, 16298.0, 16332.918335408485, 12001.519939202508, 12004.27974321526, 12014.399280035963, 12025.556933167902, 12092.939535302443, 17983.96778066068, 19348.754536252938, 19371.225150994083, 19472.46543893296, 19570.119344629526, 7170.175429825533, 7203.082751485656, 7245.673944672502, 7331.120265568059, 7364.410847132217, 945.4421891084294, 1036.3781730961364, 1077.4074259157433, 1086.163653986426, 1095.5508241620896, 31905.361892762015, 32064.679353206637, 32484.512732309035, 32491.71461277359, 32907.83546082302, 1107.1087774341572, 1131.728385187549, 1135.73310272086, 1192.2846292224597, 1197.1201167142144, 16691.582710432092, 17159.656806863793, 17313.0, 17329.913350433166, 17345.2194651241, 526641.0, 529681.0, 533661.6535338621, 534500.0, 537521.0, 59050.0, 59473.0, 59601.40398596045, 59667.70166149142, 59687.40312596819, 1296.9870301296867, 1322.8809407153403, 1339.5311640925597, 1351.86481351866, 1358.8573199814075, 29471.557926631547, 32037.839810801728, 32187.67320972913, 32320.191995200308, 32340.514892277104, 51311.74344128255, 52064.0, 52131.47868521266, 52152.47847521628, 52169.0, 392637.0, 395682.0, 396017.0, 396581.0, 397440.0, 26647.467050659267, 26681.599776002986, 28219.71780282171, 28733.28166795847, 28910.85544572264, 48380.0, 48991.51008489869, 49020.0, 49593.0, 50323.74838125786, 40638.027732512644, 41331.0, 42153.36769948392, 43029.56970430256, 43283.0, 41643.16713665649, 41724.374134388614, 42229.36655950225, 43315.0, 43633.56366436295, 34058.65941340555, 34664.480032800035, 42419.363709544996, 43405.34891976686, 44365.33451998287, 32232.516512252805, 33863.3227335447, 36439.63560364363, 36710.44934325934, 37322.813385932895, 27803.582946255417, 28050.57924131099, 28335.716642833308, 28355.574666380435, 28394.85802570974], "value": 20073.338462709296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5873397996185, 384.7595252966897, 388.976661400316, 393.5286401399214, 419.4526143382884, 14398.856011439882, 15470.458533951314, 17846.28614855406, 19636.116374763133, 19677.606447871032, 15023.722983546411, 16600.50198494047, 17980.280788768465, 18323.26706931721, 18520.536986575342, 5021.221710634848, 5253.290805741233, 5286.471352864722, 5294.232336311233, 5296.2055691646365, 5152.381714194302, 5318.149096144618, 5347.839564813062, 5351.812686555972, 5351.919721204185, 5360.0, 5405.945940540603, 5418.322709661293, 5419.783208671648, 5420.539254163401, 5350.892982140335, 5406.053940560386, 5412.107002344608, 5413.945860541384, 5565.777368905239, 5641.8589535261535, 5742.913856292159, 5744.770209191627, 5746.741396637161, 5747.655140691572, 13138.474461021548, 15016.699666006727, 21796.346109616738, 22972.77027229723, 23360.299191024296, 2268.4215525041172, 2275.0785931697687, 2280.3842962400226, 2315.8378913476063, 2319.0516325624885, 12720.618381448572, 13654.180749155083, 13738.244396558186, 14026.85973140276, 14153.150810951376, 1846.8245516675895, 1994.3717728915344, 2005.91976320947, 2039.3168288623328, 2091.2994146960787, 91828.54085729596, 92018.5399073007, 92312.53843730806, 94113.52943235308, 95330.52334738351, 16914.577135571708, 16940.322387104625, 17013.829861701226, 17343.739843902353, 17633.647327053386, 32379.838100809815, 32389.838050810067, 32419.51370729441, 32464.513032304534, 32601.347973040407, 8253.133420990709, 8635.568221588896, 8652.740417787476, 8733.432326898732, 9728.756781080388, 7352.0, 7369.189389167187, 7383.2616738326815, 7396.223396543393, 7423.44324175689, 7509.924900751032, 8492.150784921581, 8657.870131948026, 8777.42946708462, 8976.102389760972, 3141.7643676724338, 3224.6306255024574, 3465.8909149072056, 3467.6185619581825, 3483.1466290758926, 923.7967647117623, 957.1911734584404, 963.8939716631165, 1016.2632091733434, 1028.598846449885, 17884.463466096036, 18316.0, 19651.115699793543, 19677.8032219676, 19804.20783168686, 965.5365424596233, 993.344392700814, 996.9202463803024, 1013.5489707080426, 1043.4313299251926, 10230.386176829414, 11019.118470522339, 11076.612318568812, 11084.667459976214, 11150.944245278723, 448454.0, 454707.0, 457413.0, 457936.0, 458654.0, 86438.56780716057, 87795.56102219448, 87830.56084719663, 89341.0, 90184.5490772542, 972.9513524323755, 993.3096497933867, 997.4115271989562, 1006.8137394582026, 1009.1825621246813, 16479.670406592042, 16508.679305655278, 17092.40176593813, 17274.740878886576, 17598.120093995505, 39318.41022384609, 39462.0, 40268.79865600653, 40802.0, 42141.157176856905, 53522.0, 55382.44617553934, 55560.72219638876, 56024.439755601925, 56652.7167364177, 5850.180974663635, 5892.322382926019, 7923.960380198062, 8158.469699469753, 8228.876566851623, 12264.816027759412, 13087.934560327138, 13332.3333833306, 13347.132436391603, 13515.662108447368, 11650.0, 11882.881171188523, 11892.048636108917, 12294.569690060805, 12432.627021189379, 6312.684365781784, 7648.73229436967, 11370.829437558277, 11386.715332116763, 11581.363025033705, 10951.961326104241, 11864.881351186377, 11884.227525210834, 11946.701332466759, 12203.755924881276, 8352.206540378655, 8448.704295349879, 8457.281131103926, 8562.74311770648, 8956.417832840845, 11211.0, 11330.98021178065, 11622.5350985963, 11665.941670291933, 11674.824877626672], "value": 9625.758161612126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.7305048566016, 1470.698506806105, 1596.497103412425, 1723.7155869281569, 1733.0, 7377.26227377262, 7597.506162099474, 8117.87823182652, 8647.827043459127, 8648.91351086489, 8136.2677359037825, 8429.452085614446, 8436.662533498667, 8690.217880390763, 8705.695300664462, 2256.1201131558705, 2259.830512711549, 2267.025179172955, 2284.371797755614, 2292.4612716011725, 1932.5168707823045, 1985.7815640279557, 2218.3234113595345, 2263.162629826966, 2275.704158459398, 2171.522265101675, 2238.362066810951, 2246.887655617221, 2261.2989973108306, 2263.4454558633156, 2177.42298290953, 2202.1411649456645, 2218.5895609312247, 2231.3752149398197, 2234.463728705099, 2223.644216925284, 2251.876146811941, 2263.173941511353, 2265.9206927757614, 2272.1479445208047, 8536.27441667459, 8710.477371357676, 8711.825763484694, 8719.651213951434, 8725.869111963326, 5052.267421223902, 5189.299444574972, 5195.168772996302, 5196.480351964773, 5197.116490196676, 3317.2370354818527, 3347.832608369572, 3406.8296585170892, 3429.8971030869116, 3430.6259519113332, 1033.2508931025022, 1045.4581421110927, 1061.2359101446946, 1071.539238127605, 1075.8816530181673, 11554.653360399201, 11640.301581905029, 11645.475953582109, 11692.123090768226, 11701.94149029258, 4008.7394319369146, 4168.791560422027, 4244.617984381421, 4247.638950689165, 4292.720973136736, 9198.632054717737, 9241.584128714225, 9242.86135707965, 9246.352755307198, 9249.445033297889, 5065.721385323843, 5073.315102461194, 5077.593792496591, 5077.949220507748, 5081.466446023114, 4612.5156858530045, 4710.24636058229, 4727.834525791581, 4777.140114779373, 4795.256735206049, 3441.8107004115013, 3518.612952575215, 3547.6807087362263, 3598.7300952428673, 3602.3155600435834, 976.9316147869723, 983.7983213441228, 1049.4070849969742, 1059.5602824827765, 1066.4241309692834, 809.6639894443857, 831.9625616847256, 858.5106489301163, 930.6510058727977, 937.6202637931649, 5296.761645725952, 5406.8918621627345, 5469.644473109315, 5493.121100623881, 5623.3533143689, 860.3848248502351, 898.4429653614801, 908.1780988205685, 951.8334291499099, 958.1903291718487, 3599.172190396171, 3682.705383569308, 3688.8524459021874, 3766.077311058808, 3790.7915064671706, 10084.798304034024, 10625.309354891908, 10660.840087398696, 10662.200334974908, 10679.038886500251, 10573.101286390589, 10616.044555989844, 10625.84061239082, 10626.415547144827, 10627.149828013895, 7834.529928204212, 7883.290503854566, 8023.077346105156, 8032.0361556612415, 8152.673893044212, 5412.56699464034, 5457.345118585795, 5457.536109430743, 5463.562914966873, 5654.773809047592, 9403.811923761623, 9534.809303813747, 9544.0455954404, 9549.618015279311, 9622.566984485855, 9647.758806029906, 9793.657221997197, 9813.656522021694, 9823.705288841345, 9946.502674866084, 6923.2038315594355, 6987.615681137586, 7070.823229419306, 7072.858542829217, 7075.150981882207, 7858.0, 8070.83858322842, 8097.757067287991, 8122.390820688353, 8237.341012719087, 6208.255009398901, 7073.858522829618, 7289.125304963438, 7408.925910741039, 7532.096148462219, 7275.0, 7276.272372762682, 7317.0, 7412.147603025721, 7413.518121322097, 6786.660666966533, 6805.455563554805, 6814.318568143146, 6871.381575658214, 6918.481113916376, 4727.3854398927915, 4783.306420569068, 4807.399075115611, 4852.0295940811275, 4962.751862406937, 4680.110778951988, 4706.4822869485015, 4762.833300834454, 4824.589909857701, 5008.273800299009], "value": 4386.087370720601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.50792985188633, 315.78684388038073, 320.0, 322.4051624752331, 324.1782082421062, 4940.851774446764, 5093.821716239932, 5134.9743251283735, 5143.125668636336, 5163.664361816479, 4924.060751398884, 5075.746212689369, 5099.235114732792, 5118.0, 5132.384113906327, 4035.132446523997, 4047.433359329696, 4047.959520404788, 4052.371882358239, 4056.472658554384, 3955.3473676843287, 4038.676905847525, 4046.1300820323627, 4063.3701776224584, 4074.4295798588223, 3984.2031593681236, 4003.3794761811964, 4007.7595344279434, 4011.117554138085, 4020.0, 3974.4237085622713, 3980.621840925122, 3996.1208534122447, 4006.519217693881, 4027.3958906164016, 3580.874669386585, 3584.265225628766, 3584.426491761306, 3596.226811235571, 3628.4738712886483, 4843.539863712942, 5040.521150490734, 5055.51972562606, 5056.620753443506, 5063.772130254148, 4601.24079526881, 4605.355250264965, 4607.493175750665, 4608.723476591415, 4612.278755534251, 5273.841784746463, 5289.788408463657, 5338.145896656555, 5348.411674715778, 5353.491418315254, 3754.4180651998986, 3875.8255878485534, 3904.902377440558, 3911.513624822549, 3912.39357899526, 5517.420670829545, 5522.061249587539, 5526.972365138148, 5528.668279903179, 5539.944600553983, 3989.3617021276455, 3994.5406278277787, 4007.519097708235, 4011.6991225657607, 4017.4978127734034, 3764.322421964073, 3942.4677668514955, 4056.6551843093075, 4060.634542891095, 4062.857799977046, 4510.616597589176, 4528.592426681615, 4531.909361812745, 4543.68194226401, 4543.954890375232, 5357.812476563302, 5367.2485851980755, 5367.4364191759305, 5388.0, 5436.483534064258, 1291.916025458361, 1316.1576590981779, 1329.6570463831406, 1329.9601011969658, 1362.8841548468292, 923.4274749655257, 937.5265490927038, 943.4056544376998, 945.135201290825, 947.4599478297305, 5249.343832020997, 5257.815976440883, 5263.26314315996, 5276.0, 5276.868078298074, 5440.211169380417, 5442.537384322298, 5506.614536982373, 5518.668879867221, 5536.75084621193, 5151.922721159186, 5185.429602743695, 5196.480351964773, 5202.869928251824, 5214.243934629458, 2536.365908522869, 2562.4618830045524, 2571.2928944540026, 2573.266619013572, 2576.6730133981014, 4917.680350777188, 4975.900481990412, 4997.925031124536, 5019.573336266385, 5046.394432668103, 4858.368412106403, 4883.536064073907, 4891.04358256693, 4894.874178938864, 4930.299046828838, 4975.90048199034, 5018.644965859125, 5026.29631851541, 5035.949640503622, 5042.184813467149, 4455.0, 4727.432708075053, 4784.712917224978, 4791.425028996543, 4797.697105389363, 4757.691634800458, 4760.309755085563, 4761.309610106446, 4767.952320476889, 4773.785179666993, 4920.901581968412, 4953.851384458472, 5051.141305978066, 5083.2883396323805, 5086.567641750345, 3365.543153497911, 3494.270336183605, 3510.2979404119787, 3539.619548376084, 3543.5924868639404, 4723.31511930775, 4755.429348478205, 4808.0, 4815.349927759848, 4834.670465621982, 4653.115488227273, 4700.318453824108, 4713.952860471351, 4744.576627011814, 4747.406574178228, 4382.364557139261, 4661.30080487916, 4675.812967481263, 4688.390509233778, 4695.45050133462, 5119.0, 5128.1794912813775, 5232.189010703347, 5278.4193738687945, 5297.066570701743, 5326.41409444953, 5349.919751203813, 5373.0, 5397.703126327932, 5403.594730395157, 5098.745062746922, 5205.947940520547, 5217.973910130425, 5245.659032162897, 5258.447862974485], "value": 3941.390177375151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.376629864615, 739.6080077558896, 764.6138699956521, 768.5235154204394, 832.0556168748473, 13270.336483175839, 14321.570352889405, 14329.99690021699, 14353.138811671308, 14460.276986150702, 12350.1972371796, 12426.6448059024, 12445.626631201056, 12450.875491245108, 12459.252444853293, 648.902664600309, 664.7872680742164, 782.6869252299083, 784.7763387434583, 808.7775861638067, 799.7360870912585, 808.9555074470902, 810.785141937387, 811.0146172400532, 814.5967745965755, 849.8682704180862, 853.63293783673, 855.0765173612483, 855.5209082913557, 856.0241324889631, 684.9246582875879, 699.4579201119122, 827.4084029918637, 847.9576021198947, 849.0533055642975, 622.7633499270294, 625.433982246068, 626.5363630913091, 626.8432891777056, 627.0030651264511, 13450.0, 13461.730765384735, 13479.326033698373, 13480.325983700874, 13494.257815820127, 13365.532206372827, 13508.864911350858, 13567.321633918364, 13617.387217575133, 13654.726905461835, 11351.469899215403, 11779.58771443004, 12021.398930053463, 12190.939045304805, 12445.377731113407, 4253.936190957138, 4261.957380426187, 4288.078063216423, 4330.2638551446325, 4490.730556166641, 65908.67045664789, 66378.0, 69466.27472153903, 69471.1370204086, 69661.0, 10061.094501494901, 10168.796624067478, 10176.0, 10273.845892311621, 10422.5830966762, 18015.54961125956, 18024.36914708005, 18182.272709091754, 18190.90904545469, 18461.7230741539, 7132.679029443688, 7214.098237720285, 7450.925490745131, 7813.10149332834, 8303.169683031769, 4331.242032644274, 4380.4305440292555, 4412.911741765147, 4533.478649955297, 4602.861914142581, 3274.574305340338, 3370.224848284908, 3385.610654774732, 3406.0633325835593, 3418.572678415198, 606.2149516376303, 609.3906093906094, 614.4715544631613, 618.6257314324858, 627.4290395739855, 642.540583482812, 667.893137098062, 674.4490258787488, 684.3225207045089, 694.7985084325489, 8464.0, 8684.131586841391, 8864.955675221712, 8965.551722413853, 9016.23362014223, 626.2891618013588, 629.3546884446507, 642.4667525953447, 643.797203880776, 680.2177495879778, 3853.460515527828, 3945.2109578084496, 3961.920761584752, 3983.4821473208876, 4163.91672166555, 64379.67810160919, 69054.33239346495, 87487.0, 87733.56133219293, 89833.55083224543, 62921.370786291554, 67757.0, 68926.65536672284, 71537.28462715306, 71773.0, 55464.0, 55622.443775561725, 56093.47579358939, 62332.0, 63538.68230658817, 9370.25037996945, 10060.899391006289, 10177.643782467578, 10191.184705223415, 10198.388096714221, 42098.78950605227, 43393.13213735771, 43456.565434345255, 44473.0, 44760.10479790451, 53108.734456327475, 55369.44630553643, 56770.71614642066, 56796.716016419654, 58547.0, 11909.166358354832, 11979.880201198224, 12215.877841221474, 12217.411736474556, 12683.302418367079, 13370.9331453346, 13378.464861405435, 14170.0, 14373.7843932339, 14758.114513129247, 12575.685607859878, 12820.679483013, 12964.0, 13328.200307981551, 13656.522021729192, 12241.326727030098, 12477.251364918135, 12700.491980320683, 12951.481940722266, 13046.478140874258, 11681.532738690697, 12077.154599177973, 12392.938035309766, 12496.750064998467, 12515.624531264077, 9985.666507405498, 10358.844617330897, 10604.992525710046, 10629.532869656494, 10630.787384252117, 9894.703158905244, 10049.447280399649, 10437.774232150101, 11149.442527873412, 11330.37682927447], "value": 6862.306183994509, "unit": "score"}], "name": "dromaeo_css", "value": 7027.2772672471065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 110.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 124.0, 166.0, 124.0, 124.0, 121.0, 121.0, 158.0, 123.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 164.0, 162.0, 162.0, 164.0, 163.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 77.0, 76.0, 78.0, 75.0, 99.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 81.0, 82.0, 81.0, 105.0, 82.0, 82.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 55.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 62.0, 62.0, 61.0, 62.0, 61.0, 65.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 82.0, 85.0, 80.0, 86.0, 80.0, 93.0, 88.0, 79.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 145.0, 130.0, 133.0, 147.0, 144.0, 136.0, 181.0, 141.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 171.0, 171.0, 171.0, 171.0, 166.0, 166.0, 172.0, 171.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 63.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1504.6000000000001, "alertThreshold": 2.0}]} 13:46:15 INFO - Return code: 0 13:46:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:15 INFO - # TBPL SUCCESS # 13:46:15 INFO - Running post-action listener: _resource_record_post_action 13:46:15 INFO - [mozharness: 2016-10-29 20:46:15.160485Z] Finished run-tests step (success) 13:46:15 INFO - Running post-run listener: _resource_record_post_run 13:46:15 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390795264; Read time: 16; Write time: 389680 13:46:15 INFO - TinderboxPrint: CPU usage
13.1% 13:46:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:46:15 INFO - TinderboxPrint: I/O write bytes / time
390,795,264 / 389,680 13:46:15 INFO - TinderboxPrint: CPU idle
8,300.5 (86.8%) 13:46:15 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 13:46:15 INFO - TinderboxPrint: Swap in / out
0 / 0 13:46:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103698432; Read time: 0; Write time: 140528 13:46:15 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286752768; Read time: 0; Write time: 249096 13:46:15 INFO - Running post-run listener: _upload_blobber_files 13:46:15 INFO - Blob upload gear active. 13:46:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:15 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 13:46:15 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'] 13:46:15 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 13:46:16 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:19 INFO - (blobuploader) - INFO - Done attempting. 13:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:20 INFO - (blobuploader) - INFO - Done attempting. 13:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:21 INFO - (blobuploader) - INFO - Done attempting. 13:46:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:21 INFO - Return code: 0 13:46:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac988991ad4caad99ad3cb28e6a93f293b4604b9f7648deb2f18de201284021b83f0047928df3327bf111521a69189be87afdd7434d401172e45b881382b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc6a0d7adb2dbd3b48906eb826c3e5c932aa5f9a97f5d526cc7623fdc89f99e34482e0d706ee445e85d6a1666f0343e53a2a9c0249aa4153d2fd630c3355c902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa9d4c303eaf66102db9c477faa46c38c695022e09a913d92a95c91c2f8c314547ebfc5572e1dc3082668e290632682d13fd27ff6a461684baee151496f8ec96"} 13:46:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:21 INFO - Contents: 13:46:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac988991ad4caad99ad3cb28e6a93f293b4604b9f7648deb2f18de201284021b83f0047928df3327bf111521a69189be87afdd7434d401172e45b881382b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc6a0d7adb2dbd3b48906eb826c3e5c932aa5f9a97f5d526cc7623fdc89f99e34482e0d706ee445e85d6a1666f0343e53a2a9c0249aa4153d2fd630c3355c902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa9d4c303eaf66102db9c477faa46c38c695022e09a913d92a95c91c2f8c314547ebfc5572e1dc3082668e290632682d13fd27ff6a461684baee151496f8ec96"} 13:46:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:21 INFO - Copying logs to upload dir... 13:46:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.728291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-29 13:46:21.022662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 13:46:21.025957) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 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/ac988991ad4caad99ad3cb28e6a93f293b4604b9f7648deb2f18de201284021b83f0047928df3327bf111521a69189be87afdd7434d401172e45b881382b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc6a0d7adb2dbd3b48906eb826c3e5c932aa5f9a97f5d526cc7623fdc89f99e34482e0d706ee445e85d6a1666f0343e53a2a9c0249aa4153d2fd630c3355c902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa9d4c303eaf66102db9c477faa46c38c695022e09a913d92a95c91c2f8c314547ebfc5572e1dc3082668e290632682d13fd27ff6a461684baee151496f8ec96"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698451/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/ac988991ad4caad99ad3cb28e6a93f293b4604b9f7648deb2f18de201284021b83f0047928df3327bf111521a69189be87afdd7434d401172e45b881382b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc6a0d7adb2dbd3b48906eb826c3e5c932aa5f9a97f5d526cc7623fdc89f99e34482e0d706ee445e85d6a1666f0343e53a2a9c0249aa4153d2fd630c3355c902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa9d4c303eaf66102db9c477faa46c38c695022e09a913d92a95c91c2f8c314547ebfc5572e1dc3082668e290632682d13fd27ff6a461684baee151496f8ec96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 13:46:21.051966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:46:21.052301) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477772740.698688-946510723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:46:21.135488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 13:46:21.135821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 13:46:21.136105) ========= ========= Total master_lag: 0.18 =========