builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1477855441.57 results: success (0) buildid: 20161030121217 builduid: fab5dc53d66f49a5857b74ca3018581b revision: a171aae3ae491dd52e184735c51924c7a467a0bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.570006) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.570486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.570815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.582650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.583002) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 12:24:01-- 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% 46.3M=0s 2016-10-30 12:24:01 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.756039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.756357) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.806202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:01.806572) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a171aae3ae491dd52e184735c51924c7a467a0bf --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 a171aae3ae491dd52e184735c51924c7a467a0bf --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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 12:24:01,946 truncating revision to first 12 chars 2016-10-30 12:24:01,946 Setting DEBUG logging. 2016-10-30 12:24:01,947 attempt 1/10 2016-10-30 12:24:01,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a171aae3ae49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 12:24:02,270 unpacking tar archive at: mozilla-inbound-a171aae3ae49/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:02.460231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:02.460583) ========= script_repo_revision: a171aae3ae491dd52e184735c51924c7a467a0bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:02.460967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:02.461229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 12:24:02.471071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-30 12:24:02.471464) ========= /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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:02 INFO - MultiFileLogger online at 20161030 12:24:02 in /builds/slave/test 12:24:02 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 12:24:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:02 INFO - {'append_to_log': False, 12:24:02 INFO - 'base_work_dir': '/builds/slave/test', 12:24:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:24:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:02 INFO - 'branch': 'Mozilla-Inbound', 12:24:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:02 INFO - 'config_files': ('talos/linux_config.py',), 12:24:02 INFO - 'default_actions': ('clobber', 12:24:02 INFO - 'read-buildbot-config', 12:24:02 INFO - 'download-and-extract', 12:24:02 INFO - 'populate-webroot', 12:24:02 INFO - 'create-virtualenv', 12:24:02 INFO - 'install', 12:24:02 INFO - 'run-tests'), 12:24:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:02 INFO - 'download_minidump_stackwalk': True, 12:24:02 INFO - 'download_symbols': 'ondemand', 12:24:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:02 INFO - 'installer_path': 'installer.exe', 12:24:02 INFO - 'log_level': 'info', 12:24:02 INFO - 'log_name': 'talos', 12:24:02 INFO - 'log_to_console': True, 12:24:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:02 INFO - 'opt_config_files': (), 12:24:02 INFO - 'pip_index': False, 12:24:02 INFO - 'sps_profile': False, 12:24:02 INFO - 'sps_profile_interval': 0, 12:24:02 INFO - 'suite': 'dromaeojs', 12:24:02 INFO - 'system_bits': '32', 12:24:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:02 INFO - 'title': 'talos-linux64-ix-009', 12:24:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:02 INFO - 'use_talos_json': True, 12:24:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:02 INFO - 'work_dir': 'build'} 12:24:02 INFO - [mozharness: 2016-10-30 19:24:02.724614Z] Running clobber step. 12:24:02 INFO - Running pre-action listener: _resource_record_pre_action 12:24:02 INFO - Running main action method: clobber 12:24:02 INFO - rmtree: /builds/slave/test/build 12:24:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:03 INFO - Running post-action listener: _resource_record_post_action 12:24:03 INFO - [mozharness: 2016-10-30 19:24:03.235225Z] Finished clobber step (success) 12:24:03 INFO - [mozharness: 2016-10-30 19:24:03.235326Z] Running read-buildbot-config step. 12:24:03 INFO - Running pre-action listener: _resource_record_pre_action 12:24:03 INFO - Running main action method: read_buildbot_config 12:24:03 INFO - Using buildbot properties: 12:24:03 INFO - { 12:24:03 INFO - "project": "", 12:24:03 INFO - "product": "firefox", 12:24:03 INFO - "script_repo_revision": "production", 12:24:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:24:03 INFO - "repository": "", 12:24:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:24:03 INFO - "buildid": "20161030121217", 12:24:03 INFO - "stage_platform": "linux64-pgo", 12:24:03 INFO - "basedir": "/builds/slave/test", 12:24:03 INFO - "buildnumber": 2691, 12:24:03 INFO - "platform": "ubuntu64_hw", 12:24:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:24:03 INFO - "slavebuilddir": "test", 12:24:03 INFO - "branch": "mozilla-inbound", 12:24:03 INFO - "revision": "a171aae3ae491dd52e184735c51924c7a467a0bf", 12:24:03 INFO - "slavename": "talos-linux64-ix-009", 12:24:03 INFO - "builduid": "fab5dc53d66f49a5857b74ca3018581b", 12:24:03 INFO - "repo_path": "integration/mozilla-inbound" 12:24:03 INFO - } 12:24:03 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:24:03 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 12:24:03 INFO - Running post-action listener: _resource_record_post_action 12:24:03 INFO - [mozharness: 2016-10-30 19:24:03.237695Z] Finished read-buildbot-config step (success) 12:24:03 INFO - [mozharness: 2016-10-30 19:24:03.237783Z] Running download-and-extract step. 12:24:03 INFO - Running pre-action listener: _resource_record_pre_action 12:24:03 INFO - Running main action method: download_and_extract 12:24:03 INFO - mkdir: /builds/slave/test/build/tests 12:24:03 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')]} 12:24:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:24:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/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 12:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/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 12:24:03 INFO - Downloaded 1361 bytes. 12:24:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:24:03 INFO - Using the following test package requirements: 12:24:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:24:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'jsshell-linux-x86_64.zip'], 12:24:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:24:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:24:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:03 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/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:24:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:24:03 INFO - Http code: 200 12:24:03 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:24:03 INFO - x-amz-cf-id: YaoojSheGLjW3wb9VGc320Syv-XLILSMRM5IBdiUAll9ObiTVaCCSQ== 12:24:03 INFO - x-amz-replication-status: PENDING 12:24:03 INFO - x-amz-version-id: OGPtD3.n2rARLeRdc7NVDM6l48AY_y8c 12:24:03 INFO - Expected file size: 22006118 12:24:03 INFO - Obtained file size: 22006118 12:24:07 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 12:24:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:24:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:24:07 INFO - Http code: 200 12:24:07 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 12:24:07 INFO - x-amz-cf-id: GiVEbCZH9d2HFjulhhDHIzyd9mI012CBKkHr6IbEOlY_w43QnY9nLg== 12:24:07 INFO - x-amz-replication-status: PENDING 12:24:07 INFO - x-amz-version-id: OGPtD3.n2rARLeRdc7NVDM6l48AY_y8c 12:24:07 INFO - Expected file size: 22006118 12:24:07 INFO - Obtained file size: 22006118 12:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:24:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:24:12 INFO - Http code: 200 12:24:12 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 12:24:12 INFO - x-amz-cf-id: Fze_UGMXaFl9ciOyJTms4_1vlAOJBoVWHWC9HNiR_xWCFVuaITCVRA== 12:24:12 INFO - x-amz-replication-status: PENDING 12:24:12 INFO - x-amz-version-id: _88LsdvugQeBGfTrquOVcLjxapagkufS 12:24:12 INFO - Expected file size: 14409030 12:24:12 INFO - Obtained file size: 14409030 12:24: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')]} 12:24:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:24:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/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 12:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/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 12:24:13 INFO - Downloaded 59633957 bytes. 12:24:13 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:24:13 INFO - mkdir: /builds/slave/test/properties 12:24:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:13 INFO - Contents: 12:24:13 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:24:13 INFO - Running post-action listener: _resource_record_post_action 12:24:13 INFO - Running post-action listener: set_extra_try_arguments 12:24:13 INFO - [mozharness: 2016-10-30 19:24:13.996520Z] Finished download-and-extract step (success) 12:24:13 INFO - [mozharness: 2016-10-30 19:24:13.996748Z] Running populate-webroot step. 12:24:13 INFO - Running pre-action listener: _resource_record_pre_action 12:24:13 INFO - Running main action method: populate_webroot 12:24:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:14 INFO - '--tppagecycles', 12:24:14 INFO - '7'], 12:24:14 INFO - 'tests': ['tsvgm']}}, 12:24:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['damp', 'tps']}, 12:24:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'tests': ['damp', 'tps']}, 12:24:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['dromaeo_dom']}, 12:24:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['basic_compositor_video']}, 12:24:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:24:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['a11yr', 12:24:14 INFO - 'ts_paint', 12:24:14 INFO - 'tpaint', 12:24:14 INFO - 'sessionrestore', 12:24:14 INFO - 'sessionrestore_no_auto_restore', 12:24:14 INFO - 'tabpaint']}, 12:24:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['tsvgx', 12:24:14 INFO - 'tsvgr_opacity', 12:24:14 INFO - 'tart', 12:24:14 INFO - 'tscrollx', 12:24:14 INFO - 'cart']}, 12:24:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:14 INFO - 'tsvgr_opacity', 12:24:14 INFO - 'tart', 12:24:14 INFO - 'tscrollx', 12:24:14 INFO - 'cart']}, 12:24:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'talos_options': ['--disable-e10s'], 12:24:14 INFO - 'tests': ['tp5o']}, 12:24:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'tests': ['tp5o']}, 12:24:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'talos_options': ['--disable-e10s', 12:24:14 INFO - '--xperf_path', 12:24:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:14 INFO - 'tests': ['tp5n']}, 12:24:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:14 INFO - 'talos_options': ['--xperf_path', 12:24:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:14 INFO - 'tests': ['tp5n']}}, 12:24:14 INFO - 'talos.zip': {'path': '', 12:24:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:14 INFO - Running post-action listener: _resource_record_post_action 12:24:14 INFO - [mozharness: 2016-10-30 19:24:14.016080Z] Finished populate-webroot step (success) 12:24:14 INFO - [mozharness: 2016-10-30 19:24:14.016167Z] Running create-virtualenv step. 12:24:14 INFO - Running pre-action listener: _resource_record_pre_action 12:24:14 INFO - Running main action method: create_virtualenv 12:24:14 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:24:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:14 INFO - Using real prefix '/usr' 12:24:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:16 INFO - Installing pip.................done. 12:24:16 INFO - Return code: 0 12:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:24:16 INFO - Reading from file tmpfile_stdout 12:24:16 INFO - Output received: 12:24:16 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) 12:24:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24: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', 'pip>=1.5'] in /builds/slave/test/build 12:24: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 pip>=1.5 12:24:16 INFO - Using env: {'DISPLAY': ':0', 12:24:16 INFO - 'HOME': '/home/cltbld', 12:24:16 INFO - 'LANG': 'en_US.UTF-8', 12:24:16 INFO - 'LANGUAGE': 'en_US:en', 12:24:16 INFO - 'LOGNAME': 'cltbld', 12:24:16 INFO - 'MAIL': '/var/mail/cltbld', 12:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:16 INFO - 'MOZ_NO_REMOTE': '1', 12:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:16 INFO - 'NO_EM_RESTART': '1', 12:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:16 INFO - 'PWD': '/builds/slave/test', 12:24:16 INFO - 'SHELL': '/bin/bash', 12:24:16 INFO - 'SHLVL': '1', 12:24:16 INFO - 'TERM': 'linux', 12:24:16 INFO - 'TMOUT': '86400', 12:24:16 INFO - 'USER': 'cltbld', 12:24:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:16 INFO - '_': '/tools/buildbot/bin/python'} 12:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:17 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 12:24:17 INFO - Cleaning up... 12:24:17 INFO - Return code: 0 12:24:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:24:17 INFO - Using env: {'DISPLAY': ':0', 12:24:17 INFO - 'HOME': '/home/cltbld', 12:24:17 INFO - 'LANG': 'en_US.UTF-8', 12:24:17 INFO - 'LANGUAGE': 'en_US:en', 12:24:17 INFO - 'LOGNAME': 'cltbld', 12:24:17 INFO - 'MAIL': '/var/mail/cltbld', 12:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:17 INFO - 'MOZ_NO_REMOTE': '1', 12:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:17 INFO - 'NO_EM_RESTART': '1', 12:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:17 INFO - 'PWD': '/builds/slave/test', 12:24:17 INFO - 'SHELL': '/bin/bash', 12:24:17 INFO - 'SHLVL': '1', 12:24:17 INFO - 'TERM': 'linux', 12:24:17 INFO - 'TMOUT': '86400', 12:24:17 INFO - 'USER': 'cltbld', 12:24:17 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:17 INFO - '_': '/tools/buildbot/bin/python'} 12:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:17 INFO - Downloading/unpacking psutil>=3.1.1 12:24:17 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 12:24:17 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 12:24:17 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 12:24:17 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 12:24:17 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 12:24:17 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 12:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:19 INFO - Installing collected packages: psutil 12:24:19 INFO - Running setup.py install for psutil 12:24:19 INFO - building 'psutil._psutil_linux' extension 12:24:19 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 12:24:19 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 12:24:19 INFO - building 'psutil._psutil_posix' extension 12:24:19 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 12:24:19 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 12:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:19 INFO - Successfully installed psutil 12:24:19 INFO - Cleaning up... 12:24:19 INFO - Return code: 0 12:24:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:24:19 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')]} 12:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:19 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')]} 12:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:19 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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:19 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 12:24:19 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 12:24:19 INFO - Using env: {'DISPLAY': ':0', 12:24:19 INFO - 'HOME': '/home/cltbld', 12:24:19 INFO - 'LANG': 'en_US.UTF-8', 12:24:19 INFO - 'LANGUAGE': 'en_US:en', 12:24:19 INFO - 'LOGNAME': 'cltbld', 12:24:19 INFO - 'MAIL': '/var/mail/cltbld', 12:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:19 INFO - 'MOZ_NO_REMOTE': '1', 12:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:19 INFO - 'NO_EM_RESTART': '1', 12:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:19 INFO - 'PWD': '/builds/slave/test', 12:24:19 INFO - 'SHELL': '/bin/bash', 12:24:19 INFO - 'SHLVL': '1', 12:24:19 INFO - 'TERM': 'linux', 12:24:19 INFO - 'TMOUT': '86400', 12:24:19 INFO - 'USER': 'cltbld', 12:24:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:19 INFO - '_': '/tools/buildbot/bin/python'} 12:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:24:22 INFO - Installing collected packages: mozsystemmonitor 12:24:22 INFO - Running setup.py install for mozsystemmonitor 12:24:22 INFO - Successfully installed mozsystemmonitor 12:24:22 INFO - Cleaning up... 12:24:22 INFO - Return code: 0 12:24:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:24:22 INFO - Using env: {'DISPLAY': ':0', 12:24:22 INFO - 'HOME': '/home/cltbld', 12:24:22 INFO - 'LANG': 'en_US.UTF-8', 12:24:22 INFO - 'LANGUAGE': 'en_US:en', 12:24:22 INFO - 'LOGNAME': 'cltbld', 12:24:22 INFO - 'MAIL': '/var/mail/cltbld', 12:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:22 INFO - 'MOZ_NO_REMOTE': '1', 12:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:22 INFO - 'NO_EM_RESTART': '1', 12:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:22 INFO - 'PWD': '/builds/slave/test', 12:24:22 INFO - 'SHELL': '/bin/bash', 12:24:22 INFO - 'SHLVL': '1', 12:24:22 INFO - 'TERM': 'linux', 12:24:22 INFO - 'TMOUT': '86400', 12:24:22 INFO - 'USER': 'cltbld', 12:24:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:22 INFO - '_': '/tools/buildbot/bin/python'} 12:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:22 INFO - Downloading/unpacking jsonschema==2.5.1 12:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:24 INFO - warning: no files found matching '*.txt' 12:24:24 INFO - no previously-included directories found matching 'build' 12:24:24 INFO - no previously-included directories found matching 'dist' 12:24:24 INFO - no previously-included directories found matching '.git*' 12:24:24 INFO - Installing collected packages: jsonschema, functools32 12:24:24 INFO - Running setup.py install for functools32 12:24:24 INFO - warning: no files found matching '*.txt' 12:24:24 INFO - no previously-included directories found matching 'build' 12:24:24 INFO - no previously-included directories found matching 'dist' 12:24:24 INFO - no previously-included directories found matching '.git*' 12:24:24 INFO - Successfully installed jsonschema functools32 12:24:24 INFO - Cleaning up... 12:24:24 INFO - Return code: 0 12:24:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:24:24 INFO - Using env: {'DISPLAY': ':0', 12:24:24 INFO - 'HOME': '/home/cltbld', 12:24:24 INFO - 'LANG': 'en_US.UTF-8', 12:24:24 INFO - 'LANGUAGE': 'en_US:en', 12:24:24 INFO - 'LOGNAME': 'cltbld', 12:24:24 INFO - 'MAIL': '/var/mail/cltbld', 12:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:24 INFO - 'MOZ_NO_REMOTE': '1', 12:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:24 INFO - 'NO_EM_RESTART': '1', 12:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:24 INFO - 'PWD': '/builds/slave/test', 12:24:24 INFO - 'SHELL': '/bin/bash', 12:24:24 INFO - 'SHLVL': '1', 12:24:24 INFO - 'TERM': 'linux', 12:24:24 INFO - 'TMOUT': '86400', 12:24:24 INFO - 'USER': 'cltbld', 12:24:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:24 INFO - '_': '/tools/buildbot/bin/python'} 12:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:24:25 INFO - Cleaning up... 12:24:25 INFO - Return code: 0 12:24:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:25 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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:25 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 12:24:25 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 12:24:25 INFO - Using env: {'DISPLAY': ':0', 12:24:25 INFO - 'HOME': '/home/cltbld', 12:24:25 INFO - 'LANG': 'en_US.UTF-8', 12:24:25 INFO - 'LANGUAGE': 'en_US:en', 12:24:25 INFO - 'LOGNAME': 'cltbld', 12:24:25 INFO - 'MAIL': '/var/mail/cltbld', 12:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:25 INFO - 'MOZ_NO_REMOTE': '1', 12:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:25 INFO - 'NO_EM_RESTART': '1', 12:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:25 INFO - 'PWD': '/builds/slave/test', 12:24:25 INFO - 'SHELL': '/bin/bash', 12:24:25 INFO - 'SHLVL': '1', 12:24:25 INFO - 'TERM': 'linux', 12:24:25 INFO - 'TMOUT': '86400', 12:24:25 INFO - 'USER': 'cltbld', 12:24:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:25 INFO - '_': '/tools/buildbot/bin/python'} 12:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:27 INFO - Downloading docopt-0.6.1.tar.gz 12:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:28 INFO - Running setup.py install for blobuploader 12:24:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:28 INFO - Running setup.py install for requests 12:24:28 INFO - Running setup.py install for docopt 12:24:28 INFO - Successfully installed blobuploader requests docopt 12:24:28 INFO - Cleaning up... 12:24:28 INFO - Return code: 0 12:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:28 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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:28 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 12:24:28 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 12:24:28 INFO - Using env: {'DISPLAY': ':0', 12:24:28 INFO - 'HOME': '/home/cltbld', 12:24:28 INFO - 'LANG': 'en_US.UTF-8', 12:24:28 INFO - 'LANGUAGE': 'en_US:en', 12:24:28 INFO - 'LOGNAME': 'cltbld', 12:24:28 INFO - 'MAIL': '/var/mail/cltbld', 12:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:28 INFO - 'MOZ_NO_REMOTE': '1', 12:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:28 INFO - 'NO_EM_RESTART': '1', 12:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:28 INFO - 'PWD': '/builds/slave/test', 12:24:28 INFO - 'SHELL': '/bin/bash', 12:24:28 INFO - 'SHLVL': '1', 12:24:28 INFO - 'TERM': 'linux', 12:24:28 INFO - 'TMOUT': '86400', 12:24:28 INFO - 'USER': 'cltbld', 12:24:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:28 INFO - '_': '/tools/buildbot/bin/python'} 12:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:28 INFO - Running setup.py (path:/tmp/pip-lqSuaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:28 INFO - Running setup.py (path:/tmp/pip-lxiGqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:29 INFO - Running setup.py (path:/tmp/pip-K9ucP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:29 INFO - Running setup.py (path:/tmp/pip-YMmtvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:29 INFO - Running setup.py (path:/tmp/pip-a91rPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:29 INFO - Running setup.py (path:/tmp/pip-Rh30zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:29 INFO - Running setup.py (path:/tmp/pip-bOD4yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:29 INFO - Running setup.py (path:/tmp/pip-J7VGvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:29 INFO - Running setup.py (path:/tmp/pip-qZUEUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:29 INFO - Running setup.py (path:/tmp/pip-EkdGpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:29 INFO - Running setup.py (path:/tmp/pip-XLy80Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:29 INFO - Running setup.py (path:/tmp/pip-C23V2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:29 INFO - Running setup.py (path:/tmp/pip-YeazkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:29 INFO - Running setup.py (path:/tmp/pip-43QSFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:29 INFO - Running setup.py (path:/tmp/pip-ci3aye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:29 INFO - Running setup.py (path:/tmp/pip-7pHuem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:30 INFO - Running setup.py (path:/tmp/pip-eieSVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:30 INFO - Running setup.py install for manifestparser 12:24:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Running setup.py install for mozcrash 12:24:30 INFO - Running setup.py install for mozdebug 12:24:30 INFO - Running setup.py install for mozdevice 12:24:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Running setup.py install for mozfile 12:24:30 INFO - Running setup.py install for mozhttpd 12:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Running setup.py install for mozinfo 12:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Running setup.py install for mozInstall 12:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:30 INFO - Running setup.py install for mozleak 12:24:31 INFO - Running setup.py install for mozlog 12:24:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Running setup.py install for moznetwork 12:24:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Running setup.py install for mozprocess 12:24:31 INFO - Running setup.py install for mozprofile 12:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Running setup.py install for mozrunner 12:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Running setup.py install for mozscreenshot 12:24:31 INFO - Running setup.py install for moztest 12:24:31 INFO - Running setup.py install for mozversion 12:24:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:31 INFO - Cleaning up... 12:24:31 INFO - Return code: 0 12:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:31 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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:31 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 12:24:31 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 12:24:31 INFO - Using env: {'DISPLAY': ':0', 12:24:31 INFO - 'HOME': '/home/cltbld', 12:24:31 INFO - 'LANG': 'en_US.UTF-8', 12:24:31 INFO - 'LANGUAGE': 'en_US:en', 12:24:31 INFO - 'LOGNAME': 'cltbld', 12:24:31 INFO - 'MAIL': '/var/mail/cltbld', 12:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:31 INFO - 'MOZ_NO_REMOTE': '1', 12:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:31 INFO - 'NO_EM_RESTART': '1', 12:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:31 INFO - 'PWD': '/builds/slave/test', 12:24:31 INFO - 'SHELL': '/bin/bash', 12:24:31 INFO - 'SHLVL': '1', 12:24:31 INFO - 'TERM': 'linux', 12:24:31 INFO - 'TMOUT': '86400', 12:24:31 INFO - 'USER': 'cltbld', 12:24:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:31 INFO - '_': '/tools/buildbot/bin/python'} 12:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:32 INFO - Running setup.py (path:/tmp/pip-bpePrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:32 INFO - Running setup.py (path:/tmp/pip-CTvfk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:32 INFO - Running setup.py (path:/tmp/pip-pRnzPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:32 INFO - Running setup.py (path:/tmp/pip-vbW79H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:32 INFO - Running setup.py (path:/tmp/pip-dlTLJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:32 INFO - Running setup.py (path:/tmp/pip-CVaAU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:32 INFO - Running setup.py (path:/tmp/pip-Du8qSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:32 INFO - Running setup.py (path:/tmp/pip-ni2khp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:32 INFO - Running setup.py (path:/tmp/pip-KK1aeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:32 INFO - Running setup.py (path:/tmp/pip-cVGzua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:32 INFO - Running setup.py (path:/tmp/pip-Tnl3aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:32 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)) 12:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:32 INFO - Running setup.py (path:/tmp/pip-tHFM0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:33 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)) 12:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:33 INFO - Running setup.py (path:/tmp/pip-z6vzUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:33 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)) 12:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:33 INFO - Running setup.py (path:/tmp/pip-WybGhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:33 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)) 12:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:33 INFO - Running setup.py (path:/tmp/pip-I8N3ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:33 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)) 12:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:33 INFO - Running setup.py (path:/tmp/pip-Yi1vmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:33 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)) 12:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:33 INFO - Running setup.py (path:/tmp/pip-Y1Zl2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:33 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)) 12:24:33 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)) 12:24:33 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)) 12:24:33 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)) 12:24:33 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)) 12:24:33 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)) 12:24:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:35 INFO - Downloading blessings-1.6.tar.gz 12:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:35 INFO - Installing collected packages: blessings 12:24:35 INFO - Running setup.py install for blessings 12:24:35 INFO - Successfully installed blessings 12:24:35 INFO - Cleaning up... 12:24:35 INFO - Return code: 0 12:24:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:35 INFO - Reading from file tmpfile_stdout 12:24:35 INFO - Current package versions: 12:24:35 INFO - argparse == 1.2.1 12:24:35 INFO - blessings == 1.6 12:24:35 INFO - blobuploader == 1.2.4 12:24:35 INFO - docopt == 0.6.1 12:24:35 INFO - functools32 == 3.2.3-2 12:24:35 INFO - jsonschema == 2.5.1 12:24:35 INFO - manifestparser == 1.1 12:24:35 INFO - mozInstall == 1.12 12:24:35 INFO - mozcrash == 0.17 12:24:35 INFO - mozdebug == 0.1 12:24:35 INFO - mozdevice == 0.48 12:24:35 INFO - mozfile == 1.2 12:24:35 INFO - mozhttpd == 0.7 12:24:35 INFO - mozinfo == 0.9 12:24:35 INFO - mozleak == 0.1 12:24:35 INFO - mozlog == 3.4 12:24:35 INFO - moznetwork == 0.27 12:24:35 INFO - mozprocess == 0.23 12:24:35 INFO - mozprofile == 0.28 12:24:35 INFO - mozrunner == 6.12 12:24:35 INFO - mozscreenshot == 0.1 12:24:35 INFO - mozsystemmonitor == 0.3 12:24:35 INFO - moztest == 0.7 12:24:35 INFO - mozversion == 1.4 12:24:35 INFO - psutil == 3.1.1 12:24:35 INFO - requests == 1.2.3 12:24:35 INFO - wsgiref == 0.1.2 12:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:35 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')]} 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 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')]} 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 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 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:35 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 12:24:35 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 12:24:35 INFO - Using env: {'DISPLAY': ':0', 12:24:35 INFO - 'HOME': '/home/cltbld', 12:24:35 INFO - 'LANG': 'en_US.UTF-8', 12:24:35 INFO - 'LANGUAGE': 'en_US:en', 12:24:35 INFO - 'LOGNAME': 'cltbld', 12:24:35 INFO - 'MAIL': '/var/mail/cltbld', 12:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:35 INFO - 'MOZ_NO_REMOTE': '1', 12:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:35 INFO - 'NO_EM_RESTART': '1', 12:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:35 INFO - 'PWD': '/builds/slave/test', 12:24:35 INFO - 'SHELL': '/bin/bash', 12:24:35 INFO - 'SHLVL': '1', 12:24:35 INFO - 'TERM': 'linux', 12:24:35 INFO - 'TMOUT': '86400', 12:24:35 INFO - 'USER': 'cltbld', 12:24:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:35 INFO - '_': '/tools/buildbot/bin/python'} 12:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 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)) 12:24:36 INFO - Cleaning up... 12:24:36 INFO - Return code: 0 12:24:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1e055f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', '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 12:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:24:36 INFO - Using env: {'DISPLAY': ':0', 12:24:36 INFO - 'HOME': '/home/cltbld', 12:24:36 INFO - 'LANG': 'en_US.UTF-8', 12:24:36 INFO - 'LANGUAGE': 'en_US:en', 12:24:36 INFO - 'LOGNAME': 'cltbld', 12:24:36 INFO - 'MAIL': '/var/mail/cltbld', 12:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:36 INFO - 'MOZ_NO_REMOTE': '1', 12:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:36 INFO - 'NO_EM_RESTART': '1', 12:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:36 INFO - 'PWD': '/builds/slave/test', 12:24:36 INFO - 'SHELL': '/bin/bash', 12:24:36 INFO - 'SHLVL': '1', 12:24:36 INFO - 'TERM': 'linux', 12:24:36 INFO - 'TMOUT': '86400', 12:24:36 INFO - 'USER': 'cltbld', 12:24:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:36 INFO - '_': '/tools/buildbot/bin/python'} 12:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:24:36 INFO - Cleaning up... 12:24:36 INFO - Return code: 0 12:24:36 INFO - Running post-action listener: _resource_record_post_action 12:24:36 INFO - Running post-action listener: _start_resource_monitoring 12:24:36 INFO - Starting resource monitoring. 12:24:36 INFO - [mozharness: 2016-10-30 19:24:36.290011Z] Finished create-virtualenv step (success) 12:24:36 INFO - [mozharness: 2016-10-30 19:24:36.290523Z] Running install step. 12:24:36 INFO - Running pre-action listener: _resource_record_pre_action 12:24:36 INFO - Running main action method: install 12:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:36 INFO - Reading from file tmpfile_stdout 12:24:36 INFO - Detecting whether we're running mozinstall >=1.0... 12:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:24:36 INFO - Reading from file tmpfile_stdout 12:24:36 INFO - Output received: 12:24:36 INFO - Usage: mozinstall [options] installer 12:24:36 INFO - Options: 12:24:36 INFO - -h, --help show this help message and exit 12:24:36 INFO - -d DEST, --destination=DEST 12:24:36 INFO - Directory to install application into. [default: 12:24:36 INFO - "/builds/slave/test"] 12:24:36 INFO - --app=APP Application being installed. [default: firefox] 12:24:36 INFO - mkdir: /builds/slave/test/build/application 12:24:36 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'] 12:24:36 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 12:24:53 INFO - Reading from file tmpfile_stdout 12:24:53 INFO - Output received: 12:24:53 INFO - /builds/slave/test/build/application/firefox/firefox 12:24:53 INFO - Running post-action listener: _resource_record_post_action 12:24:53 INFO - [mozharness: 2016-10-30 19:24:53.616511Z] Finished install step (success) 12:24:53 INFO - [mozharness: 2016-10-30 19:24:53.616784Z] Running run-tests step. 12:24:53 INFO - Running pre-action listener: _resource_record_pre_action 12:24:53 INFO - Running main action method: run_tests 12:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:24:53 INFO - Python 2.7.3 12:24:53 INFO - Return code: 0 12:24:53 INFO - grabbing minidump binary from tooltool 12:24: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')]} 12:24:53 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 0x122cf60>, '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 0x122dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:24:53 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 12:24:53 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 12:24:53 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 12:24:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:24:53 INFO - Return code: 0 12:24:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:24:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:24:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:24:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:24:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:24:53 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/1477715405/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 12:24:53 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/1477715405/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 12:24:53 INFO - Using env: {'DISPLAY': ':0', 12:24:53 INFO - 'HOME': '/home/cltbld', 12:24:53 INFO - 'LANG': 'en_US.UTF-8', 12:24:53 INFO - 'LANGUAGE': 'en_US:en', 12:24:53 INFO - 'LOGNAME': 'cltbld', 12:24:53 INFO - 'MAIL': '/var/mail/cltbld', 12:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:53 INFO - 'MOZ_NO_REMOTE': '1', 12:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:53 INFO - 'NO_EM_RESTART': '1', 12:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:53 INFO - 'PWD': '/builds/slave/test', 12:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:24:53 INFO - 'SHELL': '/bin/bash', 12:24:53 INFO - 'SHLVL': '1', 12:24:53 INFO - 'TERM': 'linux', 12:24:53 INFO - 'TMOUT': '86400', 12:24:53 INFO - 'USER': 'cltbld', 12:24:53 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386', 12:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:53 INFO - '_': '/tools/buildbot/bin/python'} 12:24:53 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/1477715405/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 12:24:53 INFO - mozversion application_buildid: 20161028213005 12:24:53 INFO - mozversion application_changeset: a171aae3ae491dd52e184735c51924c7a467a0bf 12:24:53 INFO - mozversion application_display_name: Nightly 12:24:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:24:53 INFO - mozversion application_name: Firefox 12:24:53 INFO - mozversion application_remotingname: firefox 12:24:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:24:53 INFO - mozversion application_vendor: Mozilla 12:24:53 INFO - mozversion application_version: 52.0a1 12:24:53 INFO - mozversion platform_buildid: 20161028213005 12:24:53 INFO - mozversion platform_changeset: a171aae3ae491dd52e184735c51924c7a467a0bf 12:24:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:24:53 INFO - mozversion platform_version: 52.0a1 12:24:53 INFO - using testdate: 1477855493 12:24:53 INFO - actual date: 1477855493 12:24:53 INFO - starting webserver on 'localhost:56257' 12:24:53 INFO - SUITE-START | Running 2 tests 12:24:53 INFO - TEST-START | dromaeo_css 12:24:53 INFO - operating with platform_type : linux_ 12:24:53 INFO - Initialising browser for dromaeo_css test... 12:24:53 INFO - TEST-INFO | started process 30412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeLUulF/profile http://localhost:56257/getInfo.html) 12:24:57 INFO - PROCESS | 30412 | __metrics Screen width/height:1600/1200 12:24:57 INFO - PROCESS | 30412 | colorDepth:24 12:24:57 INFO - PROCESS | 30412 | Browser inner width/height: 1024/697 12:24:57 INFO - PROCESS | 30412 | __metrics 12:24:58 INFO - PROCESS | 30412 | 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" 12:24:58 INFO - PROCESS | 30412 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:24:59 INFO - PROCESS | 30412 | console.error: PushService: 12:24:59 INFO - PROCESS | 30412 | stateChangeProcessEnqueue: Error transitioning state 12:24:59 INFO - PROCESS | 30412 | UnknownError 12:24:59 INFO - TEST-INFO | 30412: exit 0 12:24:59 INFO - Browser initialized. 12:24:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:24:59 INFO - TEST-INFO | started process 30495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeLUulF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:11 INFO - PROCESS | 30495 | RSS: Main: 174096384 12:25:11 INFO - PROCESS | 30495 | 12:26:03 INFO - PROCESS | 30495 | 1477855563514 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] 12:28:13 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56257/tests/dromaeo/cssquery-ext.html) 12:28:16 INFO - PROCESS | 30495 | RSS: Main: 417665024 12:28:16 INFO - PROCESS | 30495 | 12:31:18 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-ext.html (next: http://localhost:56257/tests/dromaeo/cssquery-jquery.html) 12:31:19 INFO - PROCESS | 30495 | RSS: Main: 284983296 12:31:19 INFO - PROCESS | 30495 | 12:34:21 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56257/tests/dromaeo/cssquery-mootools.html) 12:34:22 INFO - PROCESS | 30495 | RSS: Main: 219172864 12:34:22 INFO - PROCESS | 30495 | 12:37:24 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56257/tests/dromaeo/cssquery-prototype.html) 12:37:24 INFO - PROCESS | 30495 | RSS: Main: 261517312 12:37:24 INFO - PROCESS | 30495 | 12:40:27 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56257/tests/dromaeo/cssquery-yui.html) 12:40:28 INFO - PROCESS | 30495 | RSS: Main: 220782592 12:40:28 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | Cycle 1(1): loaded http://localhost:56257/tests/dromaeo/cssquery-yui.html (next: http://localhost:56257/tests/dromaeo/cssquery-dojo.html) 12:43:31 INFO - PROCESS | 30495 | RSS: Main: 314757120 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | __start_tp_report 12:43:31 INFO - PROCESS | 30495 | _x_x_mozilla_page_load 12:43:31 INFO - PROCESS | 30495 | _x_x_mozilla_page_load_details 12:43:31 INFO - PROCESS | 30495 | |i|pagename|runs| 12:43:31 INFO - PROCESS | 30495 | |0;dojo.html;2969.1686327828206;3038.924026899327;3045.2539127913656;3063.816171029737;3088.2279430142466;5191.818286359978;5257.211418287254;5257.553107985826;5305.867353316169;5350.438203988583;5242.68543887367;5276.973615131928;5298.894022119565;5330;5412.377576578695;4786.928196077044;4797.208460603996;4827.879303017435;4845.781939812717;4913.852584422473;4747.4540427850725;4856.1016212000895;4904.141775189345;4924.4583095859425;4947.233178857283;4894.363732714724;4904.803807847682;4939.135651261033;4960.3303554020285;5002.624803139779;4723.36234608327;4728.361671174382;4736.123817093814;4812.422509298906;4828.7102773833685;4827.806887724487;4828.85513434594;4832.395950506187;4884.145274576935;4893.363862697826;5260.263563101169;5316.3620365556;5322.2548843161985;5322.600804939606;5343.492368225013;5498.780048798043;5549.528290095306;5606.411326810667;5679.176519404705;5686.857828554278;5667.829965101054;5695.686737229451;5716.056850619642;5778.075507918755;5780.104083867007;5309.283246761676;5313.335833020872;5316.0962636351915;5316.20256961455;5319.335083114611;5566.526845218121;5638.661680299195;5797.565182611321;5800.825975220666;5866.6480011199465;5434.945650543523;5586.916196256978;5644.6613203207935;5646.040173170571;5754.769809207669;5695.601307908407;5734.283214598176;5746.626469279484;5749.741261643236;5752.25220721312;5730.08318669011;5747.942520574741;5748;5753.079507278815;5753.942460575341;5468.015757163669;5480.232767412485;5525.778968841281;5619.100943848965;5622.353429355677;4358.106588149421;4362.672799540047;4388.736675799462;4422.977885110618;4425.159219748238;3955.564887862333;3960.386140148282;3994.7603143810884;4000.219957108336;4028.295048366524;5381.515663590218;5432;5433;5440.047991601454;5441.102218134043;5427.3758517770175;5514.61397702157;5607.971960140173;5783.971080144573;5834.795782147689;5318;5341.973290133525;5358.490943360374;5409.594280428983;5417.404085550586;4836.975815120973;4847.127517046895;4852.684575502581;4861.343718598015;4895.902081958341;5590.832275031756;5723.112917497628;5867.6772777497645;5889.23439952812;5891.499222566044;5464.781408743605;5558.110702287615;5590.888182236251;5617.550595952396;5682.318121825408;5763.077907534775;5819.185314055951;5819.5635327351465;5820.388859169726;5821.76712931495;5362.356517217959;5517.36550296705;5519.116941289374;5521.558275337883;5526.640768350045;5494.423085576117;5520;5585.497305242548;5587.44125587438;5591.161325800999;5432.619716619799;5459.454054594509;5460.426655201147;5465.699386533779;5467;5388.892222155613;5419.6206265562605;5428.647137936179;5429.131338985743;5431.103867861759;5420.512153906167;5429.185622156708;5433.755481003285;5438.45615438453;5474.835754927359;5517.751701173537;5537;5545.195946587642;5564.666120032811;5572.414896435978;5449.373322067854;5526.557875370041;5531.806386776443;5575.498205161392;5598.3282006159525 12:43:31 INFO - PROCESS | 30495 | |1;ext.html;608.191105829247;628.5129025005623;634.3054355480748;646.5732616473128;649.7985624456419;31617;43345.56654433455;44173.337399939024;44397.77801110994;48344.274835877404;44520.77739611305;44938.775306123505;45000;45004.0999180017;45060;8838.248748856355;8989.101089890992;8998.55007249635;9001.279897608209;9014.414063085911;8054.879176812353;8259.42184047117;10459.21555883308;10724.302920310194;10741.140708743322;10853;10914.563417463292;10916.890831091707;10919.39943303118;10925.562977480891;10638.042576168144;10683.679489615324;10694.358338499676;10703.46482675863;10709.196810239264;10654.147668186526;10722.624708135178;10726.356418614909;10731.731706707316;10744.73138171544;42713.35929961022;42960.14079718388;43011.784941075406;43152.352714709305;43201.75986801003;3542.742326474116;3696.131409118855;3715.777053376806;3715.8327875245677;3915.862944796947;30606.846965765253;30919;31414;32144.196395090075;32814.34371312584;4269.509006464265;4280.4221430106845;4359.084592235635;4431.9778401108115;4459.487158976694;327426;327755;327796;328049;329078.35460822785;56803.14795278074;57033.714831426405;57124.71437642785;57260.427395725506;57289;35050.64949350474;35751;35824;37706.8114659425;60620.39379606236;17416.912915435343;17709.20308586117;17721.113944302735;17725;17740.911295443697;11913.761724765629;13309.134906231258;13546.254955977516;13558.389872455764;13583.728325433436;16536.917315413586;18409.815901841077;18813.529661758566;18949.90525047366;19457.416277511697;6862.656867156622;6983.301669832976;7031.613261270679;7183.820404489929;7212;920.3787443475627;938.6808485115093;995.9950200248952;1008.2387797213057;1076.5101878645198;31441.68558314433;31505.52741708876;31616.683833161373;31947.853217937398;31994.520082198786;1009.2329829329763;1026.697124348319;1064.7125276175543;1078.1321036565482;1094.2777766673958;16333.591660208589;16973.405930792364;16993.91503042477;17011.659766804594;17076.50341102761;482889;485580;486394;487323;487927;58048.709756450946;58274.99999999915;58302.7084864573;58543.41456585465;58681.70659146762;1196.3061424373843;1237.55448038706;1322.973540529184;1339.6115126613367;1364.5565191312862;28679.856600717696;31474.842625786725;31511.36977260396;33698;33712;52846.47153528415;53571.46428535665;53593.73203133959;53605;53624.46375536351;424237;427696;429039;429263;429576;26455.206343809718;26688.599671004562;27122.864385677945;27257.454850902475;27423.725762742117;45997.77001114973;46004.7699761499;46740.53259467498;46860.29709554427;47246.76376618095;39006.6099339003;39267;39395;40515.18969620532;40946.385804213554;39179.41230881596;39192.41211381774;39293.428262869165;39963.40054899121;41094.79452602718;38430.80784596059;38648.42027369535;40053;40274.79862600668;42734.78632606817;32183.51724724084;35885.64114358927;35969.460458092624;36319;36580;27222.72777272281;27342;27653.446931060862;27765.583516247676;27856.303592410353 12:43:31 INFO - PROCESS | 30495 | |2;jquery.html;364.28599944109544;375.9492468516751;388.6696308138082;390.5508665035209;411.1879038898177;14300.07049541779;17969.28122875085;18818.717719234224;19053.237870485165;19412.708809367872;17554.122293885288;17835.464936051907;18081.276748930028;18384;18385.322935412903;5466.34403871536;5743;5751.194832723422;5754.4533269339345;5758.078707406816;4133.855315063974;4295.828166873322;4337.587929146726;5634.830955071355;5758.510526605243;6373.1714877065915;6485.967570162143;6502.6748662566915;6505.93494065058;6508.088867558546;6317.273513545955;6317.747290108367;6364.968175159141;6371.585846919936;6486.221653401599;5589.245451864028;5603.10350343943;5611.663300202001;5644.8871022579315;5651.32184137902;22169.889150554307;22227.99974001174;22359.21742738996;22410.215642452436;22454.32637020892;2378.821588380861;2497.8001759859167;2600.687917449899;2690.4753573053263;2923.9415211695646;13413.46346146153;13803.102798318077;14072.2963851807;14169.645758856112;14552.272386380639;1738.5048857982251;1918.7026010968323;1966.0071663809827;2000.4098790856733;2087.5824835032904;82148;85919.57040214758;88329;89027;90389.54805225931;10456.32033917808;10632.202584806171;10689.946550267354;10708.1433485321;10848.186386020921;14761.114333140045;14791;14900.403983840743;14914.477993270184;14929.40282388714;7607;7793.610319484003;7822.005388625864;7839.216078392229;8184.386171037196;7463;7761.883571746428;7773.494722842997;8029.799255018671;8030.39772017101;4536.251518499476;4581.496035436166;4593.47175074864;4619.69971951822;4679.1577516046755;1863.2826361850784;1908.6278175755594;1943.2712732725229;1950.4928718533283;1952.9804701952798;885.2165833237631;981.6024510073431;982.2240430060315;1006.9446180459998;1010.6513252927729;17765.467035988942;18400.907995460206;18410.539736506427;18586.25654973813;18590.530972567667;966.6713317471953;972.4991629310911;985.1478471122571;1014.7767491151935;1053.3363980692116;9691.224702023821;9904.801903961881;10136.138428233682;10225.130863876653;10241.48792560369;424367;428516;433930;434137;440529;89411.55294223617;89998;94109.5294523523;95662.52168739111;95929.0407095934;988.4563490080427;1000.259289546637;1007.3401921741271;1045.3205416479198;1052.6684094510206;12374.381280936097;16712.582185445463;17177.484675459757;17249.310027598756;17258.395956141474;39548.802255988536;42183;42403.7879810599;43365.783171083945;43844.12311753683;49907.75046124746;57045;58576.4142358588;59339.406605933385;61263.38736612577;7867.9606601966625;8049.718259860877;8158.714444994397;8278.461899976483;8385;12035.037197024041;13098.803517947428;13138.474461021453;13190.934045329712;13365;11260.38067906273;11429.371384573928;11436.656900293005;11622.128340374336;11886.465109070286;11089.944550277198;11257;11282.266652667551;11478.253913495597;11479.36863472517;11171.38557379352;11222.775544489228;11456.770864582828;11464;11516.53933842637;8075.959620201861;8118.634661440131;8137.548904732372;8271.875921861056;8407.663693452438;11176.55293788272;11349.262297950607;11625.59310424131;11776.941115294712;12045.63863084109 12:43:31 INFO - PROCESS | 30495 | |3;mootools.html;1442.7114577084583;1475.6163397516646;1596.3534768418788;1721.870859685524;1730.662520808442;7280.126384833814;7590.089189297279;7780.5720685362285;8263.628136733854;8266.504009759412;7798.376129909608;8063.072746634139;8076.515409075445;8232.382571307146;8251.216134467231;2201.3506015725397;2224.2659922225707;2224.288227767115;2224.555088982202;2230.1971290335546;1995.1919472613542;2065.297798748425;2197.5055612487145;2218.8890555472244;2300.3903965449167;1919.8272155506002;1932.3333449959741;1936.0223087340944;2131.1581925139562;2189.6496560550313;2190.9342719718434;2209.812165965895;2211.4250294923436;2212.5685491329195;2214.9557008859733;2165.8917054147228;2223.499712564676;2224.922127725522;2227.1536816009975;2239.2498512998163;8427.410081294312;8464.44981076228;8481.067082620906;8522.40343175978;8547.74356769298;4957.256411538298;5076.974615126937;5097.209932460474;5098.413682426494;5106.744662766847;3149.700778426046;3252.756043296762;3442.5868895732424;3453.7582369234165;3463.0649724574223;1038.1953985661098;1040.3757745352802;1068.1988508618535;1077.8652668416448;1174.7063234191453;10544.525496352682;10829.566817327219;11793.469293881795;11808.874402607527;11818.409079546074;4245;4306.375575541529;4320.632746216606;4342.370356298319;4351.042770590465;9317.673881414117;9317.813643727222;9320.953395233117;9328.580213890391;9328.906710932939;5099.898002039939;5103.3110530077965;5104.41299250591;5109.56568691658;5110.8466745997675;4613.077384523109;4654.25531914892;4702.482726900038;4748.216544270157;4819.638527110481;3440.501127336572;3598.892033239007;3601.891943241707;3638.0904773806546;3645.2345007548183;1125.2235957189514;1127.22784892349;1130.6381957773433;1131.0442675938818;1141.646089712192;837.7570504553734;861.4486728493769;891.2112780189449;930.3487558708931;962.841131213356;5570.805021824217;5635.5773317001385;5649.915251271234;5813.88372232553;6038.63768173911;862.9956850215709;917.3211823250747;924.2513564013171;944.7185048108878;988.8269552828226;3747.8500859965843;3940.133170702441;3981;4028.697847661437;4041.535223449282;10063.496825158712;10379.169666426667;10468.581256749798;10468.947655261827;10472.842907356397;9752.21982241419;10274.178065754722;10411.791764164675;10426.322289051188;10448.634297799692;7646.4265180111715;7989.201079891965;8004.199580041949;8020.43856930021;8021.558814265155;5454.372747134131;5637.351704554028;5707.372189059117;5733.397993210653;5749.942500574941;9121.680741174026;9246.121618446237;9350.812983740423;9371.437713737198;9373.531323433665;9388.906110939077;9524.95237523808;9565.282603804604;9655.710328690151;9706.029397060238;7411.444141689502;7459.40324774006;7527.924720752722;7609.809754756176;7630.542167469969;8074.475159114639;8151.266386025286;8153.918460815553;8158.83682326362;8158.83682326362;7175.174854891546;7483;7495.587742674205;7545.50954187976;7561.206073362438;7334.779956601311;7472.065991751031;7506.361959233526;7542;7603.619819009138;6675.0654908313845;6799.830004249933;6840.315968403319;7005.859882802213;7007.474439416962;4965.304857319906;5111.821086262112;5161.793528258828;5171.3535808024;5384.596155288291;4826.6621336506105;4867.14824905633;4952.959878425571;5052.72210028452;5134.666246693953 12:43:31 INFO - PROCESS | 30495 | |4;prototype.html;289.0634344723098;314.5329186158556;315.67327815710746;326.8806885486798;330.48939388644544;5002.949970500294;5240.790368385269;5244.344456942882;5305.283786688796;5312.389075256347;5129.717275812265;5248.580113590913;5248.6063545234065;5253.474652534745;5256.947430525694;4100.282450571153;4130.91738165238;4135.66914646829;4144.70987030908;4145.585441455845;4023.919521609566;4130.504339479252;4144.70987030908;4175.603317684815;4176.561461046592;4105.178964207155;4105.527864295615;4118.773467459288;4121.155163191538;4131.801777484526;4119.237940980928;4131.607497287753;4134.56587058359;4141.730787498818;4153;3564;3667.5965643779164;3685.7051435885332;3697.7596456230526;3717.9628203718157;5098.260752190911;5111.437741848394;5116.948830511685;5122.667026643257;5125.4618265082;4717.22165842639;4717.764111794431;4720.480747117815;4727.22000869856;4747.264174053027;5181.222816577543;5394.676319420847;5489.533389661883;5513.50378465936;5514.3658479275;4029.798510074514;4032.5564187939303;4032.5967403259733;4033.153037862023;4064.4758215669126;5714.914276285859;5717.968831973449;5730.484256416901;5752.2234498342605;5769.1346298055205;4072.827085040639;4085.754854708727;4104.548499665035;4107.726604752536;4119.855805046869;4153.8338466461;4180.372944058416;4181.477315335583;4196.412502249687;4197.454330936958;4460.487043989918;4536.637069034469;4576.931346029813;4627.6066534344955;4734.289856521549;5411.675299482044;5428.2671839301975;5431.728413579305;5452.909418116314;5454.309164159124;1336.251699048536;1366.043769361451;1403.1791402029723;1428.4429072661671;1439.330711219288;982.5824024789435;999.9500024998866;1016.3901659004538;1016.6695823857276;1023.756136294391;5279.604029697788;5280.811817341068;5296.292595183387;5312.707801070901;5314.19317432075;5553.805616803474;5559.749811258503;5580.776768929279;5590.413006634326;5606.85982850432;5087.287779710843;5238.292830467838;5306.7611957462;5320.574354051667;5331.760070796823;2957.2902503399027;3012.9246768830517;3014.3368458939;3022.9395412091635;3024.259056531164;5853.5317174625925;5874.412558744091;5888.970555147197;5897.852553686193;5943.3462319144855;5493.7802487900835;5686.744096515667;5742.712864356766;5744.454276843693;5746.741396637161;5839.948809214382;5844.736986835603;5856.443637854397;5871.266091738618;5909.70451477433;5347.812826551052;5571.582131340085;5593.776248950159;5644;5664.348599910898;5520.834374968757;5557.3331200256225;5568.6658800472105;5572.387037425961;5592.972035139798;5825.291239573618;5828.388019257917;5830.9416905832095;5842.503387212135;5870.647761134345;3733.9626603733614;3907.6127974568617;3976.721629485908;3998.5805039210663;4000.9799951001223;5431.669241035971;5512.200730894078;5682.77268909239;5696.487316141567;5717.027625469206;5546.251256080377;5560.582956278215;5575.8606034847835;5583.134614134816;5598.608097433141;5311.973440132774;5498.945010550004;5522.889542209214;5545.445455454423;5556.499575191099;5485.9725701371235;5489.149181876815;5493.505584497414;5493.835184944458;5500.532454741392;5450.863728406663;5487.945120548743;5528.91706624409;5545.390007099135;5558.555315574825;5186.144286192736;5335.226392173191;5380.919286210788;5389.299391079135;5410.891782164414 12:43:31 INFO - PROCESS | 30495 | |5;yui.html;740.5889731199189;755.5315704263357;777.1296148313886;792.1959211400427;824.4682179993904;14507.419703211872;15453.613659658486;15481.380744770224;15578.610534736637;15636.687266254668;14086.57740267791;14122.858771412282;14133.081349712262;14182.219977901212;14200.218987955659;660.408934004066;678.159082737407;782.2177822177822;810.4165001199142;814.4746638418217;795.2047952047952;804.9154838741936;805.3235282362814;805.963731632078;806.0367860406816;850.5152063323908;853.8932633420823;854.179987212277;854.5086575219274;855.0765173612515;696.4532841719276;715.1918332284537;846.2679781988597;854.2013217641494;857.0401150711212;622.1849377315685;625.9624422534663;627.4980015987192;629.9779507717208;631.1353445779266;13302.800457993138;13384;13403.329833508285;13404;13418;14905.254737263094;15050.473233436887;15121.319540620698;15315.693686126326;15410.460633877872;11804.940975295154;12010.612504471554;12029.879701202963;12076.275423474619;12255.387230638522;3838.213166300902;3844.519435070616;3848.826802793853;3931;3938.8424463021443;64340.67829660822;67633.66183169052;68488.6575567119;69181.65409172972;69874.65062674705;11213.719657008476;11233.55065797359;11271;11372.545098196146;11735.647930562096;21717.782822171575;21743.67384489234;21753.78246217549;21880;21902.152720146278;8392.706255281037;8394.412391132562;8428.241458268785;8615.6984505542;8768.254698350584;4659.2312268476;4731.95268047322;4772.689775164673;4863.392075990501;4904.558589726942;3425.1608355952453;3495.3708332500396;3506.281212351462;3538.1862171700654;3549.6627820357025;570.7916610437161;581.9243498345188;585.338567418814;587.3773799772255;593.0481577068742;729.9489035767551;730.9522161007347;754.2080815144077;779.9844003119906;785.615048626169;8506.276966457921;9417.246620270362;9503.382280151767;9681;9804.950975245221;644.3266786208424;718.224317736843;729.6509023581785;731.5135434935709;746.5035751225374;4174.3321068628875;4543.45478542577;4563.417201183552;4564.3838081859185;4671.813127474863;82057.58971205106;87605;87873.56063219771;90708;92145.53927230321;76027.61986190034;76260.23739762531;78448;78625.21374786293;81365.59317203375;70264;70500.64749676219;71081.64459177775;72407;72744;8635.956820215859;8699.565021749015;8821.426607270507;8956.552172391484;9067.7428310793;46555.53444465512;46565.53434465612;48117.75941120412;48824.75587622039;49365.25952110793;63394.36605633885;63601.6819915916;64537;65737.67131164313;67305.32694672991;10723.249372543847;11200.83198752003;11259.943700281447;11595;11897.048236140914;12663.303518306582;12821.75619266606;12961.41673624708;13008.349582521025;13329.86670133325;10190.898091019291;11428.657140285472;12910.935445322713;13287.800682989957;13324.933375333449;12349.93825030869;12513.091616378018;12921.901638360845;12923.095383323453;13030;12781.744365112832;12919.935400322938;12970.481180752664;13011.089223754247;13069.542566010145;10562;10892.346459212156;11164.720881978015;11336.886631133913;11354.432278385882;10288.537015834156;11173.162012848907;11178.441077946232;11208.83186752183;11233.063205855 12:43:31 INFO - PROCESS | 30495 | __end_tp_report 12:43:31 INFO - PROCESS | 30495 | __start_cc_report 12:43:31 INFO - PROCESS | 30495 | _x_x_mozilla_cycle_collect,2536 12:43:31 INFO - PROCESS | 30495 | __end_cc_report 12:43:31 INFO - PROCESS | 30495 | __startTimestamp1477856611587__endTimestamp 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | ------- Summary: start ------- 12:43:31 INFO - PROCESS | 30495 | Number of tests: 6 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#0] dojo.html Cycles:165 Average:5258.28 Median:5433.00 stddev:576.80 (10.6%) stddev-sans-first:549.91 12:43:31 INFO - PROCESS | 30495 | Values: 2969.2 3038.9 3045.3 3063.8 3088.2 5191.8 5257.2 5257.6 5305.9 5350.4 5242.7 5277.0 5298.9 5330.0 5412.4 4786.9 4797.2 4827.9 4845.8 4913.9 4747.5 4856.1 4904.1 4924.5 4947.2 4894.4 4904.8 4939.1 4960.3 5002.6 4723.4 4728.4 4736.1 4812.4 4828.7 4827.8 4828.9 4832.4 4884.1 4893.4 5260.3 5316.4 5322.3 5322.6 5343.5 5498.8 5549.5 5606.4 5679.2 5686.9 5667.8 5695.7 5716.1 5778.1 5780.1 5309.3 5313.3 5316.1 5316.2 5319.3 5566.5 5638.7 5797.6 5800.8 5866.6 5434.9 5586.9 5644.7 5646.0 5754.8 5695.6 5734.3 5746.6 5749.7 5752.3 5730.1 5747.9 5748.0 5753.1 5753.9 5468.0 5480.2 5525.8 5619.1 5622.4 4358.1 4362.7 4388.7 4423.0 4425.2 3955.6 3960.4 3994.8 4000.2 4028.3 5381.5 5432.0 5433.0 5440.0 5441.1 5427.4 5514.6 5608.0 5784.0 5834.8 5318.0 5342.0 5358.5 5409.6 5417.4 4837.0 4847.1 4852.7 4861.3 4895.9 5590.8 5723.1 5867.7 5889.2 5891.5 5464.8 5558.1 5590.9 5617.6 5682.3 5763.1 5819.2 5819.6 5820.4 5821.8 5362.4 5517.4 5519.1 5521.6 5526.6 5494.4 5520.0 5585.5 5587.4 5591.2 5432.6 5459.5 5460.4 5465.7 5467.0 5388.9 5419.6 5428.6 5429.1 5431.1 5420.5 5429.2 5433.8 5438.5 5474.8 5517.8 5537.0 5545.2 5564.7 5572.4 5449.4 5526.6 5531.8 5575.5 5598.3 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#1] ext.html Cycles:180 Average:57488.77 Median:3705.95 stddev:110788.97 (2989.5%) stddev-sans-first:111017.45 12:43:31 INFO - PROCESS | 30495 | Values: 608.2 628.5 634.3 646.6 649.8 31617.0 43345.6 44173.3 44397.8 48344.3 44520.8 44938.8 45000.0 45004.1 45060.0 8838.2 8989.1 8998.6 9001.3 9014.4 8054.9 8259.4 10459.2 10724.3 10741.1 10853.0 10914.6 10916.9 10919.4 10925.6 10638.0 10683.7 10694.4 10703.5 10709.2 10654.1 10722.6 10726.4 10731.7 10744.7 42713.4 42960.1 43011.8 43152.4 43201.8 3542.7 3696.1 3715.8 3715.8 3915.9 30606.8 30919.0 31414.0 32144.2 32814.3 4269.5 4280.4 4359.1 4432.0 4459.5 327426.0 327755.0 327796.0 328049.0 329078.4 56803.1 57033.7 57124.7 57260.4 57289.0 35050.6 35751.0 35824.0 37706.8 60620.4 17416.9 17709.2 17721.1 17725.0 17740.9 11913.8 13309.1 13546.3 13558.4 13583.7 16536.9 18409.8 18813.5 18949.9 19457.4 6862.7 6983.3 7031.6 7183.8 7212.0 920.4 938.7 996.0 1008.2 1076.5 31441.7 31505.5 31616.7 31947.9 31994.5 1009.2 1026.7 1064.7 1078.1 1094.3 16333.6 16973.4 16993.9 17011.7 17076.5 482889.0 485580.0 486394.0 487323.0 487927.0 58048.7 58275.0 58302.7 58543.4 58681.7 1196.3 1237.6 1323.0 1339.6 1364.6 28679.9 31474.8 31511.4 33698.0 33712.0 52846.5 53571.5 53593.7 53605.0 53624.5 424237.0 427696.0 429039.0 429263.0 429576.0 26455.2 26688.6 27122.9 27257.5 27423.7 45997.8 46004.8 46740.5 46860.3 47246.8 39006.6 39267.0 39395.0 40515.2 40946.4 39179.4 39192.4 39293.4 39963.4 41094.8 38430.8 38648.4 40053.0 40274.8 42734.8 32183.5 35885.6 35969.5 36319.0 36580.0 27222.7 27342.0 27653.4 27765.6 27856.3 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#2] jquery.html Cycles:180 Average:27460.32 Median:1644.11 stddev:71817.81 (4368.2%) stddev-sans-first:71990.46 12:43:31 INFO - PROCESS | 30495 | Values: 364.3 375.9 388.7 390.6 411.2 14300.1 17969.3 18818.7 19053.2 19412.7 17554.1 17835.5 18081.3 18384.0 18385.3 5466.3 5743.0 5751.2 5754.5 5758.1 4133.9 4295.8 4337.6 5634.8 5758.5 6373.2 6486.0 6502.7 6505.9 6508.1 6317.3 6317.7 6365.0 6371.6 6486.2 5589.2 5603.1 5611.7 5644.9 5651.3 22169.9 22228.0 22359.2 22410.2 22454.3 2378.8 2497.8 2600.7 2690.5 2923.9 13413.5 13803.1 14072.3 14169.6 14552.3 1738.5 1918.7 1966.0 2000.4 2087.6 82148.0 85919.6 88329.0 89027.0 90389.5 10456.3 10632.2 10689.9 10708.1 10848.2 14761.1 14791.0 14900.4 14914.5 14929.4 7607.0 7793.6 7822.0 7839.2 8184.4 7463.0 7761.9 7773.5 8029.8 8030.4 4536.3 4581.5 4593.5 4619.7 4679.2 1863.3 1908.6 1943.3 1950.5 1953.0 885.2 981.6 982.2 1006.9 1010.7 17765.5 18400.9 18410.5 18586.3 18590.5 966.7 972.5 985.1 1014.8 1053.3 9691.2 9904.8 10136.1 10225.1 10241.5 424367.0 428516.0 433930.0 434137.0 440529.0 89411.6 89998.0 94109.5 95662.5 95929.0 988.5 1000.3 1007.3 1045.3 1052.7 12374.4 16712.6 17177.5 17249.3 17258.4 39548.8 42183.0 42403.8 43365.8 43844.1 49907.8 57045.0 58576.4 59339.4 61263.4 7868.0 8049.7 8158.7 8278.5 8385.0 12035.0 13098.8 13138.5 13190.9 13365.0 11260.4 11429.4 11436.7 11622.1 11886.5 11089.9 11257.0 11282.3 11478.3 11479.4 11171.4 11222.8 11456.8 11464.0 11516.5 8076.0 8118.6 8137.5 8271.9 8407.7 11176.6 11349.3 11625.6 11776.9 12045.6 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#3] mootools.html Cycles:180 Average:5501.45 Median:5105.58 stddev:3081.91 (60.4%) stddev-sans-first:3075.46 12:43:31 INFO - PROCESS | 30495 | Values: 1442.7 1475.6 1596.4 1721.9 1730.7 7280.1 7590.1 7780.6 8263.6 8266.5 7798.4 8063.1 8076.5 8232.4 8251.2 2201.4 2224.3 2224.3 2224.6 2230.2 1995.2 2065.3 2197.5 2218.9 2300.4 1919.8 1932.3 1936.0 2131.2 2189.6 2190.9 2209.8 2211.4 2212.6 2215.0 2165.9 2223.5 2224.9 2227.2 2239.2 8427.4 8464.4 8481.1 8522.4 8547.7 4957.3 5077.0 5097.2 5098.4 5106.7 3149.7 3252.8 3442.6 3453.8 3463.1 1038.2 1040.4 1068.2 1077.9 1174.7 10544.5 10829.6 11793.5 11808.9 11818.4 4245.0 4306.4 4320.6 4342.4 4351.0 9317.7 9317.8 9321.0 9328.6 9328.9 5099.9 5103.3 5104.4 5109.6 5110.8 4613.1 4654.3 4702.5 4748.2 4819.6 3440.5 3598.9 3601.9 3638.1 3645.2 1125.2 1127.2 1130.6 1131.0 1141.6 837.8 861.4 891.2 930.3 962.8 5570.8 5635.6 5649.9 5813.9 6038.6 863.0 917.3 924.3 944.7 988.8 3747.9 3940.1 3981.0 4028.7 4041.5 10063.5 10379.2 10468.6 10468.9 10472.8 9752.2 10274.2 10411.8 10426.3 10448.6 7646.4 7989.2 8004.2 8020.4 8021.6 5454.4 5637.4 5707.4 5733.4 5749.9 9121.7 9246.1 9350.8 9371.4 9373.5 9388.9 9525.0 9565.3 9655.7 9706.0 7411.4 7459.4 7527.9 7609.8 7630.5 8074.5 8151.3 8153.9 8158.8 8158.8 7175.2 7483.0 7495.6 7545.5 7561.2 7334.8 7472.1 7506.4 7542.0 7603.6 6675.1 6799.8 6840.3 7005.9 7007.5 4965.3 5111.8 5161.8 5171.4 5384.6 4826.7 4867.1 4953.0 5052.7 5134.7 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#4] prototype.html Cycles:180 Average:4643.56 Median:5280.21 stddev:1352.12 (25.6%) stddev-sans-first:1315.82 12:43:31 INFO - PROCESS | 30495 | Values: 289.1 314.5 315.7 326.9 330.5 5002.9 5240.8 5244.3 5305.3 5312.4 5129.7 5248.6 5248.6 5253.5 5256.9 4100.3 4130.9 4135.7 4144.7 4145.6 4023.9 4130.5 4144.7 4175.6 4176.6 4105.2 4105.5 4118.8 4121.2 4131.8 4119.2 4131.6 4134.6 4141.7 4153.0 3564.0 3667.6 3685.7 3697.8 3718.0 5098.3 5111.4 5116.9 5122.7 5125.5 4717.2 4717.8 4720.5 4727.2 4747.3 5181.2 5394.7 5489.5 5513.5 5514.4 4029.8 4032.6 4032.6 4033.2 4064.5 5714.9 5718.0 5730.5 5752.2 5769.1 4072.8 4085.8 4104.5 4107.7 4119.9 4153.8 4180.4 4181.5 4196.4 4197.5 4460.5 4536.6 4576.9 4627.6 4734.3 5411.7 5428.3 5431.7 5452.9 5454.3 1336.3 1366.0 1403.2 1428.4 1439.3 982.6 1000.0 1016.4 1016.7 1023.8 5279.6 5280.8 5296.3 5312.7 5314.2 5553.8 5559.7 5580.8 5590.4 5606.9 5087.3 5238.3 5306.8 5320.6 5331.8 2957.3 3012.9 3014.3 3022.9 3024.3 5853.5 5874.4 5889.0 5897.9 5943.3 5493.8 5686.7 5742.7 5744.5 5746.7 5839.9 5844.7 5856.4 5871.3 5909.7 5347.8 5571.6 5593.8 5644.0 5664.3 5520.8 5557.3 5568.7 5572.4 5593.0 5825.3 5828.4 5830.9 5842.5 5870.6 3734.0 3907.6 3976.7 3998.6 4001.0 5431.7 5512.2 5682.8 5696.5 5717.0 5546.3 5560.6 5575.9 5583.1 5598.6 5312.0 5498.9 5522.9 5545.4 5556.5 5486.0 5489.1 5493.5 5493.8 5500.5 5450.9 5487.9 5528.9 5545.4 5558.6 5186.1 5335.2 5380.9 5389.3 5410.9 12:43:31 INFO - PROCESS | 30495 | 12:43:31 INFO - PROCESS | 30495 | [#5] yui.html Cycles:180 Average:18219.88 Median:26490.58 stddev:24267.74 (91.6%) stddev-sans-first:24300.32 12:43:31 INFO - PROCESS | 30495 | Values: 740.6 755.5 777.1 792.2 824.5 14507.4 15453.6 15481.4 15578.6 15636.7 14086.6 14122.9 14133.1 14182.2 14200.2 660.4 678.2 782.2 810.4 814.5 795.2 804.9 805.3 806.0 806.0 850.5 853.9 854.2 854.5 855.1 696.5 715.2 846.3 854.2 857.0 622.2 626.0 627.5 630.0 631.1 13302.8 13384.0 13403.3 13404.0 13418.0 14905.3 15050.5 15121.3 15315.7 15410.5 11804.9 12010.6 12029.9 12076.3 12255.4 3838.2 3844.5 3848.8 3931.0 3938.8 64340.7 67633.7 68488.7 69181.7 69874.7 11213.7 11233.6 11271.0 11372.5 11735.6 21717.8 21743.7 21753.8 21880.0 21902.2 8392.7 8394.4 8428.2 8615.7 8768.3 4659.2 4732.0 4772.7 4863.4 4904.6 3425.2 3495.4 3506.3 3538.2 3549.7 570.8 581.9 585.3 587.4 593.0 729.9 731.0 754.2 780.0 785.6 8506.3 9417.2 9503.4 9681.0 9805.0 644.3 718.2 729.7 731.5 746.5 4174.3 4543.5 4563.4 4564.4 4671.8 82057.6 87605.0 87873.6 90708.0 92145.5 76027.6 76260.2 78448.0 78625.2 81365.6 70264.0 70500.6 71081.6 72407.0 72744.0 8636.0 8699.6 8821.4 8956.6 9067.7 46555.5 46565.5 48117.8 48824.8 49365.3 63394.4 63601.7 64537.0 65737.7 67305.3 10723.2 11200.8 11259.9 11595.0 11897.0 12663.3 12821.8 12961.4 13008.3 13329.9 10190.9 11428.7 12910.9 13287.8 13324.9 12349.9 12513.1 12921.9 12923.1 13030.0 12781.7 12919.9 12970.5 13011.1 13069.5 10562.0 10892.3 11164.7 11336.9 11354.4 10288.5 11173.2 11178.4 11208.8 11233.1 12:43:31 INFO - PROCESS | 30495 | -------- Summary: end -------- 12:43:31 INFO - PROCESS | 30495 | 12:43:32 INFO - TEST-INFO | 30495: exit 0 12:43:32 INFO - TEST-OK | dromaeo_css | took 1118616ms 12:43:32 INFO - TEST-START | kraken 12:43:32 INFO - operating with platform_type : linux_ 12:43:32 INFO - Initialising browser for kraken test... 12:43:32 INFO - TEST-INFO | started process 30801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNAxHE/profile http://localhost:56257/getInfo.html) 12:43:36 INFO - PROCESS | 30801 | __metrics Screen width/height:1600/1200 12:43:36 INFO - PROCESS | 30801 | colorDepth:24 12:43:36 INFO - PROCESS | 30801 | Browser inner width/height: 1024/697 12:43:36 INFO - PROCESS | 30801 | __metrics 12:43:37 INFO - PROCESS | 30801 | 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" 12:43:37 INFO - PROCESS | 30801 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:37 INFO - PROCESS | 30801 | console.error: PushService: 12:43:37 INFO - PROCESS | 30801 | stateChangeProcessEnqueue: Error transitioning state 12:43:37 INFO - PROCESS | 30801 | UnknownError 12:43:38 INFO - TEST-INFO | 30801: exit 0 12:43:38 INFO - Browser initialized. 12:43:38 INFO - Running cycle 1/1 for kraken test... 12:43:38 INFO - TEST-INFO | started process 30884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNAxHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:50 INFO - PROCESS | 30884 | RSS: Main: 174252032 12:43:50 INFO - PROCESS | 30884 | 12:43:52 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56257/tests/kraken/driver.html?testName=audio-beat-detection) 12:43:53 INFO - PROCESS | 30884 | RSS: Main: 235626496 12:43:53 INFO - PROCESS | 30884 | 12:43:56 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56257/tests/kraken/driver.html?testName=audio-dft) 12:43:56 INFO - PROCESS | 30884 | RSS: Main: 217985024 12:43:56 INFO - PROCESS | 30884 | 12:44:00 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56257/tests/kraken/driver.html?testName=audio-fft) 12:44:00 INFO - PROCESS | 30884 | RSS: Main: 299536384 12:44:00 INFO - PROCESS | 30884 | 12:44:02 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56257/tests/kraken/driver.html?testName=audio-oscillator) 12:44:03 INFO - PROCESS | 30884 | RSS: Main: 208924672 12:44:03 INFO - PROCESS | 30884 | 12:44:05 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:06 INFO - PROCESS | 30884 | RSS: Main: 213970944 12:44:06 INFO - PROCESS | 30884 | 12:44:09 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56257/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:09 INFO - PROCESS | 30884 | RSS: Main: 250531840 12:44:09 INFO - PROCESS | 30884 | 12:44:13 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56257/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:13 INFO - PROCESS | 30884 | RSS: Main: 248766464 12:44:13 INFO - PROCESS | 30884 | 12:44:16 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56257/tests/kraken/driver.html?testName=json-parse-financial) 12:44:16 INFO - PROCESS | 30884 | RSS: Main: 248303616 12:44:16 INFO - PROCESS | 30884 | 12:44:18 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:19 INFO - PROCESS | 30884 | RSS: Main: 210550784 12:44:19 INFO - PROCESS | 30884 | 12:44:20 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:21 INFO - PROCESS | 30884 | RSS: Main: 218480640 12:44:21 INFO - PROCESS | 30884 | 12:44:23 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:24 INFO - PROCESS | 30884 | RSS: Main: 227123200 12:44:24 INFO - PROCESS | 30884 | 12:44:26 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:27 INFO - PROCESS | 30884 | RSS: Main: 232628224 12:44:27 INFO - PROCESS | 30884 | 12:44:30 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:30 INFO - PROCESS | 30884 | RSS: Main: 232259584 12:44:30 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | Cycle 1(1): loaded http://localhost:56257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56257/tests/kraken/driver.html?testName=ai-astar) 12:44:32 INFO - PROCESS | 30884 | RSS: Main: 283193344 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | __start_tp_report 12:44:32 INFO - PROCESS | 30884 | _x_x_mozilla_page_load 12:44:32 INFO - PROCESS | 30884 | _x_x_mozilla_page_load_details 12:44:32 INFO - PROCESS | 30884 | |i|pagename|runs| 12:44:32 INFO - PROCESS | 30884 | |0;ai-astar;108;113;112;112;113;112;112;113;112;111 12:44:32 INFO - PROCESS | 30884 | |1;audio-beat-detection;146;125;123;157;126;122;124;126;152;122 12:44:32 INFO - PROCESS | 30884 | |2;audio-dft;161;160;160;160;160;161;161;160;162;159 12:44:32 INFO - PROCESS | 30884 | |3;audio-fft;75;76;75;108;76;75;76;76;100;76 12:44:32 INFO - PROCESS | 30884 | |4;audio-oscillator;83;82;121;82;83;83;108;82;82;121 12:44:32 INFO - PROCESS | 30884 | |5;imaging-gaussian-blur;117;118;116;116;117;117;117;117;117;117 12:44:32 INFO - PROCESS | 30884 | |6;imaging-darkroom;147;147;149;147;147;147;147;147;147;148 12:44:32 INFO - PROCESS | 30884 | |7;imaging-desaturate;86;85;85;85;84;85;85;85;84;85 12:44:32 INFO - PROCESS | 30884 | |8;json-parse-financial;55;54;54;54;56;55;55;55;56;55 12:44:32 INFO - PROCESS | 30884 | |9;json-stringify-tinderbox;60;61;61;61;61;61;60;61;61;61 12:44:32 INFO - PROCESS | 30884 | |10;stanford-crypto-aes;82;83;85;79;79;79;80;79;78;79 12:44:32 INFO - PROCESS | 30884 | |11;stanford-crypto-ccm;142;137;140;140;137;136;132;134;185;135 12:44:32 INFO - PROCESS | 30884 | |12;stanford-crypto-pbkdf2;164;168;165;167;164;163;164;163;162;164 12:44:32 INFO - PROCESS | 30884 | |13;stanford-crypto-sha256-iterative;64;62;64;63;65;62;64;62;63;67 12:44:32 INFO - PROCESS | 30884 | __end_tp_report 12:44:32 INFO - PROCESS | 30884 | __start_cc_report 12:44:32 INFO - PROCESS | 30884 | _x_x_mozilla_cycle_collect,1674 12:44:32 INFO - PROCESS | 30884 | __end_cc_report 12:44:32 INFO - PROCESS | 30884 | __startTimestamp1477856672665__endTimestamp 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | ------- Summary: start ------- 12:44:32 INFO - PROCESS | 30884 | Number of tests: 14 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.48 (1.3%) stddev-sans-first:0.67 12:44:32 INFO - PROCESS | 30884 | Values: 108.0 113.0 112.0 112.0 113.0 112.0 112.0 113.0 112.0 111.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:126.00 stddev:13.69 (10.9%) stddev-sans-first:13.59 12:44:32 INFO - PROCESS | 30884 | Values: 146.0 125.0 123.0 157.0 126.0 122.0 124.0 126.0 152.0 122.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 12:44:32 INFO - PROCESS | 30884 | Values: 161.0 160.0 160.0 160.0 160.0 161.0 161.0 160.0 162.0 159.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.12 (15.9%) stddev-sans-first:12.64 12:44:32 INFO - PROCESS | 30884 | Values: 75.0 76.0 75.0 108.0 76.0 75.0 76.0 76.0 100.0 76.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:82.00 stddev:16.92 (20.6%) stddev-sans-first:17.58 12:44:32 INFO - PROCESS | 30884 | Values: 83.0 82.0 121.0 82.0 83.0 83.0 108.0 82.0 82.0 121.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:44:32 INFO - PROCESS | 30884 | Values: 117.0 118.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:44:32 INFO - PROCESS | 30884 | Values: 147.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.44 12:44:32 INFO - PROCESS | 30884 | Values: 86.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 12:44:32 INFO - PROCESS | 30884 | Values: 55.0 54.0 54.0 54.0 56.0 55.0 55.0 55.0 56.0 55.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 12:44:32 INFO - PROCESS | 30884 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.50 stddev:2.26 (2.8%) stddev-sans-first:2.32 12:44:32 INFO - PROCESS | 30884 | Values: 82.0 83.0 85.0 79.0 79.0 79.0 80.0 79.0 78.0 79.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:138.50 stddev:15.48 (11.2%) stddev-sans-first:16.41 12:44:32 INFO - PROCESS | 30884 | Values: 142.0 137.0 140.0 140.0 137.0 136.0 132.0 134.0 185.0 135.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 12:44:32 INFO - PROCESS | 30884 | Values: 164.0 168.0 165.0 167.0 164.0 163.0 164.0 163.0 162.0 164.0 12:44:32 INFO - PROCESS | 30884 | 12:44:32 INFO - PROCESS | 30884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 12:44:32 INFO - PROCESS | 30884 | Values: 64.0 62.0 64.0 63.0 65.0 62.0 64.0 62.0 63.0 67.0 12:44:32 INFO - PROCESS | 30884 | -------- Summary: end -------- 12:44:32 INFO - PROCESS | 30884 | 12:44:33 INFO - TEST-INFO | 30884: exit 0 12:44:33 INFO - TEST-OK | kraken | took 61401ms 12:44:33 INFO - SUITE-END | took 1180s 12:44:34 INFO - Completed test suite (00:19:40) 12:44:34 INFO - javascript benchmark 12:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.1686327828206, 3038.924026899327, 3045.2539127913656, 3063.816171029737, 3088.2279430142466, 5191.818286359978, 5257.211418287254, 5257.553107985826, 5305.867353316169, 5350.438203988583, 5242.68543887367, 5276.973615131928, 5298.894022119565, 5330.0, 5412.377576578695, 4786.928196077044, 4797.208460603996, 4827.879303017435, 4845.781939812717, 4913.852584422473, 4747.4540427850725, 4856.1016212000895, 4904.141775189345, 4924.4583095859425, 4947.233178857283, 4894.363732714724, 4904.803807847682, 4939.135651261033, 4960.3303554020285, 5002.624803139779, 4723.36234608327, 4728.361671174382, 4736.123817093814, 4812.422509298906, 4828.7102773833685, 4827.806887724487, 4828.85513434594, 4832.395950506187, 4884.145274576935, 4893.363862697826, 5260.263563101169, 5316.3620365556, 5322.2548843161985, 5322.600804939606, 5343.492368225013, 5498.780048798043, 5549.528290095306, 5606.411326810667, 5679.176519404705, 5686.857828554278, 5667.829965101054, 5695.686737229451, 5716.056850619642, 5778.075507918755, 5780.104083867007, 5309.283246761676, 5313.335833020872, 5316.0962636351915, 5316.20256961455, 5319.335083114611, 5566.526845218121, 5638.661680299195, 5797.565182611321, 5800.825975220666, 5866.6480011199465, 5434.945650543523, 5586.916196256978, 5644.6613203207935, 5646.040173170571, 5754.769809207669, 5695.601307908407, 5734.283214598176, 5746.626469279484, 5749.741261643236, 5752.25220721312, 5730.08318669011, 5747.942520574741, 5748.0, 5753.079507278815, 5753.942460575341, 5468.015757163669, 5480.232767412485, 5525.778968841281, 5619.100943848965, 5622.353429355677, 4358.106588149421, 4362.672799540047, 4388.736675799462, 4422.977885110618, 4425.159219748238, 3955.564887862333, 3960.386140148282, 3994.7603143810884, 4000.219957108336, 4028.295048366524, 5381.515663590218, 5432.0, 5433.0, 5440.047991601454, 5441.102218134043, 5427.3758517770175, 5514.61397702157, 5607.971960140173, 5783.971080144573, 5834.795782147689, 5318.0, 5341.973290133525, 5358.490943360374, 5409.594280428983, 5417.404085550586, 4836.975815120973, 4847.127517046895, 4852.684575502581, 4861.343718598015, 4895.902081958341, 5590.832275031756, 5723.112917497628, 5867.6772777497645, 5889.23439952812, 5891.499222566044, 5464.781408743605, 5558.110702287615, 5590.888182236251, 5617.550595952396, 5682.318121825408, 5763.077907534775, 5819.185314055951, 5819.5635327351465, 5820.388859169726, 5821.76712931495, 5362.356517217959, 5517.36550296705, 5519.116941289374, 5521.558275337883, 5526.640768350045, 5494.423085576117, 5520.0, 5585.497305242548, 5587.44125587438, 5591.161325800999, 5432.619716619799, 5459.454054594509, 5460.426655201147, 5465.699386533779, 5467.0, 5388.892222155613, 5419.6206265562605, 5428.647137936179, 5429.131338985743, 5431.103867861759, 5420.512153906167, 5429.185622156708, 5433.755481003285, 5438.45615438453, 5474.835754927359, 5517.751701173537, 5537.0, 5545.195946587642, 5564.666120032811, 5572.414896435978, 5449.373322067854, 5526.557875370041, 5531.806386776443, 5575.498205161392, 5598.3282006159525], "value": 5220.41670240307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.191105829247, 628.5129025005623, 634.3054355480748, 646.5732616473128, 649.7985624456419, 31617.0, 43345.56654433455, 44173.337399939024, 44397.77801110994, 48344.274835877404, 44520.77739611305, 44938.775306123505, 45000.0, 45004.0999180017, 45060.0, 8838.248748856355, 8989.101089890992, 8998.55007249635, 9001.279897608209, 9014.414063085911, 8054.879176812353, 8259.42184047117, 10459.21555883308, 10724.302920310194, 10741.140708743322, 10853.0, 10914.563417463292, 10916.890831091707, 10919.39943303118, 10925.562977480891, 10638.042576168144, 10683.679489615324, 10694.358338499676, 10703.46482675863, 10709.196810239264, 10654.147668186526, 10722.624708135178, 10726.356418614909, 10731.731706707316, 10744.73138171544, 42713.35929961022, 42960.14079718388, 43011.784941075406, 43152.352714709305, 43201.75986801003, 3542.742326474116, 3696.131409118855, 3715.777053376806, 3715.8327875245677, 3915.862944796947, 30606.846965765253, 30919.0, 31414.0, 32144.196395090075, 32814.34371312584, 4269.509006464265, 4280.4221430106845, 4359.084592235635, 4431.9778401108115, 4459.487158976694, 327426.0, 327755.0, 327796.0, 328049.0, 329078.35460822785, 56803.14795278074, 57033.714831426405, 57124.71437642785, 57260.427395725506, 57289.0, 35050.64949350474, 35751.0, 35824.0, 37706.8114659425, 60620.39379606236, 17416.912915435343, 17709.20308586117, 17721.113944302735, 17725.0, 17740.911295443697, 11913.761724765629, 13309.134906231258, 13546.254955977516, 13558.389872455764, 13583.728325433436, 16536.917315413586, 18409.815901841077, 18813.529661758566, 18949.90525047366, 19457.416277511697, 6862.656867156622, 6983.301669832976, 7031.613261270679, 7183.820404489929, 7212.0, 920.3787443475627, 938.6808485115093, 995.9950200248952, 1008.2387797213057, 1076.5101878645198, 31441.68558314433, 31505.52741708876, 31616.683833161373, 31947.853217937398, 31994.520082198786, 1009.2329829329763, 1026.697124348319, 1064.7125276175543, 1078.1321036565482, 1094.2777766673958, 16333.591660208589, 16973.405930792364, 16993.91503042477, 17011.659766804594, 17076.50341102761, 482889.0, 485580.0, 486394.0, 487323.0, 487927.0, 58048.709756450946, 58274.99999999915, 58302.7084864573, 58543.41456585465, 58681.70659146762, 1196.3061424373843, 1237.55448038706, 1322.973540529184, 1339.6115126613367, 1364.5565191312862, 28679.856600717696, 31474.842625786725, 31511.36977260396, 33698.0, 33712.0, 52846.47153528415, 53571.46428535665, 53593.73203133959, 53605.0, 53624.46375536351, 424237.0, 427696.0, 429039.0, 429263.0, 429576.0, 26455.206343809718, 26688.599671004562, 27122.864385677945, 27257.454850902475, 27423.725762742117, 45997.77001114973, 46004.7699761499, 46740.53259467498, 46860.29709554427, 47246.76376618095, 39006.6099339003, 39267.0, 39395.0, 40515.18969620532, 40946.385804213554, 39179.41230881596, 39192.41211381774, 39293.428262869165, 39963.40054899121, 41094.79452602718, 38430.80784596059, 38648.42027369535, 40053.0, 40274.79862600668, 42734.78632606817, 32183.51724724084, 35885.64114358927, 35969.460458092624, 36319.0, 36580.0, 27222.72777272281, 27342.0, 27653.446931060862, 27765.583516247676, 27856.303592410353], "value": 20065.82355774914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.28599944109544, 375.9492468516751, 388.6696308138082, 390.5508665035209, 411.1879038898177, 14300.07049541779, 17969.28122875085, 18818.717719234224, 19053.237870485165, 19412.708809367872, 17554.122293885288, 17835.464936051907, 18081.276748930028, 18384.0, 18385.322935412903, 5466.34403871536, 5743.0, 5751.194832723422, 5754.4533269339345, 5758.078707406816, 4133.855315063974, 4295.828166873322, 4337.587929146726, 5634.830955071355, 5758.510526605243, 6373.1714877065915, 6485.967570162143, 6502.6748662566915, 6505.93494065058, 6508.088867558546, 6317.273513545955, 6317.747290108367, 6364.968175159141, 6371.585846919936, 6486.221653401599, 5589.245451864028, 5603.10350343943, 5611.663300202001, 5644.8871022579315, 5651.32184137902, 22169.889150554307, 22227.99974001174, 22359.21742738996, 22410.215642452436, 22454.32637020892, 2378.821588380861, 2497.8001759859167, 2600.687917449899, 2690.4753573053263, 2923.9415211695646, 13413.46346146153, 13803.102798318077, 14072.2963851807, 14169.645758856112, 14552.272386380639, 1738.5048857982251, 1918.7026010968323, 1966.0071663809827, 2000.4098790856733, 2087.5824835032904, 82148.0, 85919.57040214758, 88329.0, 89027.0, 90389.54805225931, 10456.32033917808, 10632.202584806171, 10689.946550267354, 10708.1433485321, 10848.186386020921, 14761.114333140045, 14791.0, 14900.403983840743, 14914.477993270184, 14929.40282388714, 7607.0, 7793.610319484003, 7822.005388625864, 7839.216078392229, 8184.386171037196, 7463.0, 7761.883571746428, 7773.494722842997, 8029.799255018671, 8030.39772017101, 4536.251518499476, 4581.496035436166, 4593.47175074864, 4619.69971951822, 4679.1577516046755, 1863.2826361850784, 1908.6278175755594, 1943.2712732725229, 1950.4928718533283, 1952.9804701952798, 885.2165833237631, 981.6024510073431, 982.2240430060315, 1006.9446180459998, 1010.6513252927729, 17765.467035988942, 18400.907995460206, 18410.539736506427, 18586.25654973813, 18590.530972567667, 966.6713317471953, 972.4991629310911, 985.1478471122571, 1014.7767491151935, 1053.3363980692116, 9691.224702023821, 9904.801903961881, 10136.138428233682, 10225.130863876653, 10241.48792560369, 424367.0, 428516.0, 433930.0, 434137.0, 440529.0, 89411.55294223617, 89998.0, 94109.5294523523, 95662.52168739111, 95929.0407095934, 988.4563490080427, 1000.259289546637, 1007.3401921741271, 1045.3205416479198, 1052.6684094510206, 12374.381280936097, 16712.582185445463, 17177.484675459757, 17249.310027598756, 17258.395956141474, 39548.802255988536, 42183.0, 42403.7879810599, 43365.783171083945, 43844.12311753683, 49907.75046124746, 57045.0, 58576.4142358588, 59339.406605933385, 61263.38736612577, 7867.9606601966625, 8049.718259860877, 8158.714444994397, 8278.461899976483, 8385.0, 12035.037197024041, 13098.803517947428, 13138.474461021453, 13190.934045329712, 13365.0, 11260.38067906273, 11429.371384573928, 11436.656900293005, 11622.128340374336, 11886.465109070286, 11089.944550277198, 11257.0, 11282.266652667551, 11478.253913495597, 11479.36863472517, 11171.38557379352, 11222.775544489228, 11456.770864582828, 11464.0, 11516.53933842637, 8075.959620201861, 8118.634661440131, 8137.548904732372, 8271.875921861056, 8407.663693452438, 11176.55293788272, 11349.262297950607, 11625.59310424131, 11776.941115294712, 12045.63863084109], "value": 9149.574147962545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.7114577084583, 1475.6163397516646, 1596.3534768418788, 1721.870859685524, 1730.662520808442, 7280.126384833814, 7590.089189297279, 7780.5720685362285, 8263.628136733854, 8266.504009759412, 7798.376129909608, 8063.072746634139, 8076.515409075445, 8232.382571307146, 8251.216134467231, 2201.3506015725397, 2224.2659922225707, 2224.288227767115, 2224.555088982202, 2230.1971290335546, 1995.1919472613542, 2065.297798748425, 2197.5055612487145, 2218.8890555472244, 2300.3903965449167, 1919.8272155506002, 1932.3333449959741, 1936.0223087340944, 2131.1581925139562, 2189.6496560550313, 2190.9342719718434, 2209.812165965895, 2211.4250294923436, 2212.5685491329195, 2214.9557008859733, 2165.8917054147228, 2223.499712564676, 2224.922127725522, 2227.1536816009975, 2239.2498512998163, 8427.410081294312, 8464.44981076228, 8481.067082620906, 8522.40343175978, 8547.74356769298, 4957.256411538298, 5076.974615126937, 5097.209932460474, 5098.413682426494, 5106.744662766847, 3149.700778426046, 3252.756043296762, 3442.5868895732424, 3453.7582369234165, 3463.0649724574223, 1038.1953985661098, 1040.3757745352802, 1068.1988508618535, 1077.8652668416448, 1174.7063234191453, 10544.525496352682, 10829.566817327219, 11793.469293881795, 11808.874402607527, 11818.409079546074, 4245.0, 4306.375575541529, 4320.632746216606, 4342.370356298319, 4351.042770590465, 9317.673881414117, 9317.813643727222, 9320.953395233117, 9328.580213890391, 9328.906710932939, 5099.898002039939, 5103.3110530077965, 5104.41299250591, 5109.56568691658, 5110.8466745997675, 4613.077384523109, 4654.25531914892, 4702.482726900038, 4748.216544270157, 4819.638527110481, 3440.501127336572, 3598.892033239007, 3601.891943241707, 3638.0904773806546, 3645.2345007548183, 1125.2235957189514, 1127.22784892349, 1130.6381957773433, 1131.0442675938818, 1141.646089712192, 837.7570504553734, 861.4486728493769, 891.2112780189449, 930.3487558708931, 962.841131213356, 5570.805021824217, 5635.5773317001385, 5649.915251271234, 5813.88372232553, 6038.63768173911, 862.9956850215709, 917.3211823250747, 924.2513564013171, 944.7185048108878, 988.8269552828226, 3747.8500859965843, 3940.133170702441, 3981.0, 4028.697847661437, 4041.535223449282, 10063.496825158712, 10379.169666426667, 10468.581256749798, 10468.947655261827, 10472.842907356397, 9752.21982241419, 10274.178065754722, 10411.791764164675, 10426.322289051188, 10448.634297799692, 7646.4265180111715, 7989.201079891965, 8004.199580041949, 8020.43856930021, 8021.558814265155, 5454.372747134131, 5637.351704554028, 5707.372189059117, 5733.397993210653, 5749.942500574941, 9121.680741174026, 9246.121618446237, 9350.812983740423, 9371.437713737198, 9373.531323433665, 9388.906110939077, 9524.95237523808, 9565.282603804604, 9655.710328690151, 9706.029397060238, 7411.444141689502, 7459.40324774006, 7527.924720752722, 7609.809754756176, 7630.542167469969, 8074.475159114639, 8151.266386025286, 8153.918460815553, 8158.83682326362, 8158.83682326362, 7175.174854891546, 7483.0, 7495.587742674205, 7545.50954187976, 7561.206073362438, 7334.779956601311, 7472.065991751031, 7506.361959233526, 7542.0, 7603.619819009138, 6675.0654908313845, 6799.830004249933, 6840.315968403319, 7005.859882802213, 7007.474439416962, 4965.304857319906, 5111.821086262112, 5161.793528258828, 5171.3535808024, 5384.596155288291, 4826.6621336506105, 4867.14824905633, 4952.959878425571, 5052.72210028452, 5134.666246693953], "value": 4411.3894165678175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.0634344723098, 314.5329186158556, 315.67327815710746, 326.8806885486798, 330.48939388644544, 5002.949970500294, 5240.790368385269, 5244.344456942882, 5305.283786688796, 5312.389075256347, 5129.717275812265, 5248.580113590913, 5248.6063545234065, 5253.474652534745, 5256.947430525694, 4100.282450571153, 4130.91738165238, 4135.66914646829, 4144.70987030908, 4145.585441455845, 4023.919521609566, 4130.504339479252, 4144.70987030908, 4175.603317684815, 4176.561461046592, 4105.178964207155, 4105.527864295615, 4118.773467459288, 4121.155163191538, 4131.801777484526, 4119.237940980928, 4131.607497287753, 4134.56587058359, 4141.730787498818, 4153.0, 3564.0, 3667.5965643779164, 3685.7051435885332, 3697.7596456230526, 3717.9628203718157, 5098.260752190911, 5111.437741848394, 5116.948830511685, 5122.667026643257, 5125.4618265082, 4717.22165842639, 4717.764111794431, 4720.480747117815, 4727.22000869856, 4747.264174053027, 5181.222816577543, 5394.676319420847, 5489.533389661883, 5513.50378465936, 5514.3658479275, 4029.798510074514, 4032.5564187939303, 4032.5967403259733, 4033.153037862023, 4064.4758215669126, 5714.914276285859, 5717.968831973449, 5730.484256416901, 5752.2234498342605, 5769.1346298055205, 4072.827085040639, 4085.754854708727, 4104.548499665035, 4107.726604752536, 4119.855805046869, 4153.8338466461, 4180.372944058416, 4181.477315335583, 4196.412502249687, 4197.454330936958, 4460.487043989918, 4536.637069034469, 4576.931346029813, 4627.6066534344955, 4734.289856521549, 5411.675299482044, 5428.2671839301975, 5431.728413579305, 5452.909418116314, 5454.309164159124, 1336.251699048536, 1366.043769361451, 1403.1791402029723, 1428.4429072661671, 1439.330711219288, 982.5824024789435, 999.9500024998866, 1016.3901659004538, 1016.6695823857276, 1023.756136294391, 5279.604029697788, 5280.811817341068, 5296.292595183387, 5312.707801070901, 5314.19317432075, 5553.805616803474, 5559.749811258503, 5580.776768929279, 5590.413006634326, 5606.85982850432, 5087.287779710843, 5238.292830467838, 5306.7611957462, 5320.574354051667, 5331.760070796823, 2957.2902503399027, 3012.9246768830517, 3014.3368458939, 3022.9395412091635, 3024.259056531164, 5853.5317174625925, 5874.412558744091, 5888.970555147197, 5897.852553686193, 5943.3462319144855, 5493.7802487900835, 5686.744096515667, 5742.712864356766, 5744.454276843693, 5746.741396637161, 5839.948809214382, 5844.736986835603, 5856.443637854397, 5871.266091738618, 5909.70451477433, 5347.812826551052, 5571.582131340085, 5593.776248950159, 5644.0, 5664.348599910898, 5520.834374968757, 5557.3331200256225, 5568.6658800472105, 5572.387037425961, 5592.972035139798, 5825.291239573618, 5828.388019257917, 5830.9416905832095, 5842.503387212135, 5870.647761134345, 3733.9626603733614, 3907.6127974568617, 3976.721629485908, 3998.5805039210663, 4000.9799951001223, 5431.669241035971, 5512.200730894078, 5682.77268909239, 5696.487316141567, 5717.027625469206, 5546.251256080377, 5560.582956278215, 5575.8606034847835, 5583.134614134816, 5598.608097433141, 5311.973440132774, 5498.945010550004, 5522.889542209214, 5545.445455454423, 5556.499575191099, 5485.9725701371235, 5489.149181876815, 5493.505584497414, 5493.835184944458, 5500.532454741392, 5450.863728406663, 5487.945120548743, 5528.91706624409, 5545.390007099135, 5558.555315574825, 5186.144286192736, 5335.226392173191, 5380.919286210788, 5389.299391079135, 5410.891782164414], "value": 4211.7199910096015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5889731199189, 755.5315704263357, 777.1296148313886, 792.1959211400427, 824.4682179993904, 14507.419703211872, 15453.613659658486, 15481.380744770224, 15578.610534736637, 15636.687266254668, 14086.57740267791, 14122.858771412282, 14133.081349712262, 14182.219977901212, 14200.218987955659, 660.408934004066, 678.159082737407, 782.2177822177822, 810.4165001199142, 814.4746638418217, 795.2047952047952, 804.9154838741936, 805.3235282362814, 805.963731632078, 806.0367860406816, 850.5152063323908, 853.8932633420823, 854.179987212277, 854.5086575219274, 855.0765173612515, 696.4532841719276, 715.1918332284537, 846.2679781988597, 854.2013217641494, 857.0401150711212, 622.1849377315685, 625.9624422534663, 627.4980015987192, 629.9779507717208, 631.1353445779266, 13302.800457993138, 13384.0, 13403.329833508285, 13404.0, 13418.0, 14905.254737263094, 15050.473233436887, 15121.319540620698, 15315.693686126326, 15410.460633877872, 11804.940975295154, 12010.612504471554, 12029.879701202963, 12076.275423474619, 12255.387230638522, 3838.213166300902, 3844.519435070616, 3848.826802793853, 3931.0, 3938.8424463021443, 64340.67829660822, 67633.66183169052, 68488.6575567119, 69181.65409172972, 69874.65062674705, 11213.719657008476, 11233.55065797359, 11271.0, 11372.545098196146, 11735.647930562096, 21717.782822171575, 21743.67384489234, 21753.78246217549, 21880.0, 21902.152720146278, 8392.706255281037, 8394.412391132562, 8428.241458268785, 8615.6984505542, 8768.254698350584, 4659.2312268476, 4731.95268047322, 4772.689775164673, 4863.392075990501, 4904.558589726942, 3425.1608355952453, 3495.3708332500396, 3506.281212351462, 3538.1862171700654, 3549.6627820357025, 570.7916610437161, 581.9243498345188, 585.338567418814, 587.3773799772255, 593.0481577068742, 729.9489035767551, 730.9522161007347, 754.2080815144077, 779.9844003119906, 785.615048626169, 8506.276966457921, 9417.246620270362, 9503.382280151767, 9681.0, 9804.950975245221, 644.3266786208424, 718.224317736843, 729.6509023581785, 731.5135434935709, 746.5035751225374, 4174.3321068628875, 4543.45478542577, 4563.417201183552, 4564.3838081859185, 4671.813127474863, 82057.58971205106, 87605.0, 87873.56063219771, 90708.0, 92145.53927230321, 76027.61986190034, 76260.23739762531, 78448.0, 78625.21374786293, 81365.59317203375, 70264.0, 70500.64749676219, 71081.64459177775, 72407.0, 72744.0, 8635.956820215859, 8699.565021749015, 8821.426607270507, 8956.552172391484, 9067.7428310793, 46555.53444465512, 46565.53434465612, 48117.75941120412, 48824.75587622039, 49365.25952110793, 63394.36605633885, 63601.6819915916, 64537.0, 65737.67131164313, 67305.32694672991, 10723.249372543847, 11200.83198752003, 11259.943700281447, 11595.0, 11897.048236140914, 12663.303518306582, 12821.75619266606, 12961.41673624708, 13008.349582521025, 13329.86670133325, 10190.898091019291, 11428.657140285472, 12910.935445322713, 13287.800682989957, 13324.933375333449, 12349.93825030869, 12513.091616378018, 12921.901638360845, 12923.095383323453, 13030.0, 12781.744365112832, 12919.935400322938, 12970.481180752664, 13011.089223754247, 13069.542566010145, 10562.0, 10892.346459212156, 11164.720881978015, 11336.886631133913, 11354.432278385882, 10288.537015834156, 11173.162012848907, 11178.441077946232, 11208.83186752183, 11233.063205855], "value": 7174.9133642006755, "unit": "score"}], "name": "dromaeo_css", "value": 7097.035343902056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 123.0, 157.0, 126.0, 122.0, 124.0, 126.0, 152.0, 122.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 108.0, 76.0, 75.0, 76.0, 76.0, 100.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 121.0, 82.0, 83.0, 83.0, 108.0, 82.0, 82.0, 121.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 56.0, 55.0, 55.0, 55.0, 56.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 85.0, 79.0, 79.0, 79.0, 80.0, 79.0, 78.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 140.0, 140.0, 137.0, 136.0, 132.0, 134.0, 185.0, 135.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 165.0, 167.0, 164.0, 163.0, 164.0, 163.0, 162.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 65.0, 62.0, 64.0, 62.0, 63.0, 67.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1493.3999999999999, "alertThreshold": 2.0}]} 12:44:34 INFO - Return code: 0 12:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:44:34 INFO - # TBPL SUCCESS # 12:44:34 INFO - Running post-action listener: _resource_record_post_action 12:44:34 INFO - [mozharness: 2016-10-30 19:44:34.469564Z] Finished run-tests step (success) 12:44:34 INFO - Running post-run listener: _resource_record_post_run 12:44:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396587008; Read time: 8; Write time: 364940 12:44:34 INFO - TinderboxPrint: CPU usage
13.1% 12:44:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:44:34 INFO - TinderboxPrint: I/O write bytes / time
396,587,008 / 364,940 12:44:34 INFO - TinderboxPrint: CPU idle
8,308.0 (86.9%) 12:44:34 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 12:44:34 INFO - TinderboxPrint: Swap in / out
0 / 0 12:44:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103858176; Read time: 0; Write time: 146720 12:44:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289161216; Read time: 0; Write time: 217728 12:44:35 INFO - Running post-run listener: _upload_blobber_files 12:44:35 INFO - Blob upload gear active. 12:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:44:35 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 12:44:35 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'] 12:44:35 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 12:44:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:36 INFO - (blobuploader) - INFO - Done attempting. 12:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:37 INFO - (blobuploader) - INFO - Done attempting. 12:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:40 INFO - (blobuploader) - INFO - Done attempting. 12:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:44:40 INFO - Return code: 0 12:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c625f34b23dfb87cc7237a24f641b32b4c0649860ea376481181f95a810c4e7a7855cd8a85f80fa339b85f088dab659a17c9057b2a4cd2b3924b204d64b8519e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a040b70a478c7ba54a92df0768454d1d5dde28cb13eeb66e78d37394ba2b99cc79cd3a1b4d6fb0d1a9aa670986232807a7cbc29a2b09493ed621d60cea1d3e2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/65e7531a930d423aa274c610c4f3b88a21178706f3e2530740162bd2aa225f354ec52990d6741a3bccf1c6fe2327ed10695735ced2435fe86fa094e6139e6aa8"} 12:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:44:40 INFO - Contents: 12:44:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c625f34b23dfb87cc7237a24f641b32b4c0649860ea376481181f95a810c4e7a7855cd8a85f80fa339b85f088dab659a17c9057b2a4cd2b3924b204d64b8519e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a040b70a478c7ba54a92df0768454d1d5dde28cb13eeb66e78d37394ba2b99cc79cd3a1b4d6fb0d1a9aa670986232807a7cbc29a2b09493ed621d60cea1d3e2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/65e7531a930d423aa274c610c4f3b88a21178706f3e2530740162bd2aa225f354ec52990d6741a3bccf1c6fe2327ed10695735ced2435fe86fa094e6139e6aa8"} 12:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:44:40 INFO - Copying logs to upload dir... 12:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.787917 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-30 12:44:40.276158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 12:44:40.279988) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 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/c625f34b23dfb87cc7237a24f641b32b4c0649860ea376481181f95a810c4e7a7855cd8a85f80fa339b85f088dab659a17c9057b2a4cd2b3924b204d64b8519e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a040b70a478c7ba54a92df0768454d1d5dde28cb13eeb66e78d37394ba2b99cc79cd3a1b4d6fb0d1a9aa670986232807a7cbc29a2b09493ed621d60cea1d3e2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/65e7531a930d423aa274c610c4f3b88a21178706f3e2530740162bd2aa225f354ec52990d6741a3bccf1c6fe2327ed10695735ced2435fe86fa094e6139e6aa8"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477715405/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/c625f34b23dfb87cc7237a24f641b32b4c0649860ea376481181f95a810c4e7a7855cd8a85f80fa339b85f088dab659a17c9057b2a4cd2b3924b204d64b8519e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a040b70a478c7ba54a92df0768454d1d5dde28cb13eeb66e78d37394ba2b99cc79cd3a1b4d6fb0d1a9aa670986232807a7cbc29a2b09493ed621d60cea1d3e2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/65e7531a930d423aa274c610c4f3b88a21178706f3e2530740162bd2aa225f354ec52990d6741a3bccf1c6fe2327ed10695735ced2435fe86fa094e6139e6aa8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 12:44:40.308651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:44:40.309182) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477855440.924654-809818386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 12:44:40.391998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 12:44:40.392542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 12:44:40.393011) ========= ========= Total master_lag: 0.17 =========