builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1479967670.64 results: success (0) buildid: 20161123214515 builduid: c057e410f01140cda42a12eb78443f02 revision: 134a87fe0772c62d73d2d1c4408f629a2160d3b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.639305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.639859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.640186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.655329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.655769) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 22:07:51-- 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% 42.5M=0s 2016-11-23 22:07:51 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.809881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.810246) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014664 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.860017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:50.860450) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 134a87fe0772c62d73d2d1c4408f629a2160d3b0 --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 134a87fe0772c62d73d2d1c4408f629a2160d3b0 --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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 22:07:51,335 truncating revision to first 12 chars 2016-11-23 22:07:51,335 Setting DEBUG logging. 2016-11-23 22:07:51,335 attempt 1/10 2016-11-23 22:07:51,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/134a87fe0772?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 22:07:51,854 unpacking tar archive at: mozilla-inbound-134a87fe0772/testing/mozharness/ program finished with exit code 0 elapsedTime=0.830518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:51.705176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:51.705624) ========= script_repo_revision: 134a87fe0772c62d73d2d1c4408f629a2160d3b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:51.706078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:51.706395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 22:07:51.716805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 22:07:51.717120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:52 INFO - MultiFileLogger online at 20161123 22:07:52 in /builds/slave/test 22:07:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:07:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:52 INFO - {'append_to_log': False, 22:07:52 INFO - 'base_work_dir': '/builds/slave/test', 22:07:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:07:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:52 INFO - 'branch': 'Mozilla-Inbound', 22:07:52 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:52 INFO - 'config_files': ('talos/linux_config.py',), 22:07:52 INFO - 'default_actions': ('clobber', 22:07:52 INFO - 'read-buildbot-config', 22:07:52 INFO - 'download-and-extract', 22:07:52 INFO - 'populate-webroot', 22:07:52 INFO - 'create-virtualenv', 22:07:52 INFO - 'install', 22:07:52 INFO - 'run-tests'), 22:07:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:52 INFO - 'download_minidump_stackwalk': True, 22:07:52 INFO - 'download_symbols': 'ondemand', 22:07:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:52 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:52 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:52 INFO - 'installer_path': 'installer.exe', 22:07:52 INFO - 'log_level': 'info', 22:07:52 INFO - 'log_name': 'talos', 22:07:52 INFO - 'log_to_console': True, 22:07:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:52 INFO - 'opt_config_files': (), 22:07:52 INFO - 'pip_index': False, 22:07:52 INFO - 'sps_profile': False, 22:07:52 INFO - 'sps_profile_interval': 0, 22:07:52 INFO - 'suite': 'dromaeojs-e10s', 22:07:52 INFO - 'system_bits': '32', 22:07:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:52 INFO - 'title': 'talos-linux64-ix-002', 22:07:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:52 INFO - 'use_talos_json': True, 22:07:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:52 INFO - 'work_dir': 'build'} 22:07:52 INFO - [mozharness: 2016-11-24 06:07:52.288963Z] Running clobber step. 22:07:52 INFO - Running pre-action listener: _resource_record_pre_action 22:07:52 INFO - Running main action method: clobber 22:07:52 INFO - rmtree: /builds/slave/test/build 22:07:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:52 INFO - Running post-action listener: _resource_record_post_action 22:07:52 INFO - [mozharness: 2016-11-24 06:07:52.753193Z] Finished clobber step (success) 22:07:52 INFO - [mozharness: 2016-11-24 06:07:52.753357Z] Running read-buildbot-config step. 22:07:52 INFO - Running pre-action listener: _resource_record_pre_action 22:07:52 INFO - Running main action method: read_buildbot_config 22:07:52 INFO - Using buildbot properties: 22:07:52 INFO - { 22:07:52 INFO - "project": "", 22:07:52 INFO - "product": "firefox", 22:07:52 INFO - "script_repo_revision": "production", 22:07:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:07:52 INFO - "repository": "", 22:07:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:07:52 INFO - "buildid": "20161123214515", 22:07:52 INFO - "stage_platform": "linux64-pgo", 22:07:52 INFO - "basedir": "/builds/slave/test", 22:07:52 INFO - "buildnumber": 2125, 22:07:52 INFO - "platform": "ubuntu64_hw", 22:07:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:52 INFO - "slavebuilddir": "test", 22:07:52 INFO - "branch": "mozilla-inbound", 22:07:52 INFO - "revision": "134a87fe0772c62d73d2d1c4408f629a2160d3b0", 22:07:52 INFO - "slavename": "talos-linux64-ix-002", 22:07:52 INFO - "builduid": "c057e410f01140cda42a12eb78443f02", 22:07:52 INFO - "repo_path": "integration/mozilla-inbound" 22:07:52 INFO - } 22:07:52 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:07:52 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 22:07:52 INFO - Running post-action listener: _resource_record_post_action 22:07:52 INFO - [mozharness: 2016-11-24 06:07:52.755715Z] Finished read-buildbot-config step (success) 22:07:52 INFO - [mozharness: 2016-11-24 06:07:52.755804Z] Running download-and-extract step. 22:07:52 INFO - Running pre-action listener: _resource_record_pre_action 22:07:52 INFO - Running main action method: download_and_extract 22:07:52 INFO - mkdir: /builds/slave/test/build/tests 22:07:52 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')]} 22:07:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:07:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:52 INFO - Downloaded 1361 bytes. 22:07:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:07:52 INFO - Using the following test package requirements: 22:07:52 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:07:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'jsshell-linux-x86_64.zip'], 22:07:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:07:52 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:07:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:07:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:07:52 INFO - Http code: 200 22:07:52 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 22:07:52 INFO - x-amz-cf-id: zIvxf9WmQVqQNfJLm-w52TmuRQkrEtOWHphNh69BcBbWDTOJU61npA== 22:07:52 INFO - x-amz-replication-status: COMPLETED 22:07:52 INFO - x-amz-version-id: aC9yvM8o5dCNWaqhYA7XdWhf7bj8NuWF 22:07:53 INFO - Expected file size: 21747574 22:07:53 INFO - Obtained file size: 21747574 22:07:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07:57 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/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:07:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:07:57 INFO - Http code: 200 22:07:57 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 22:07:57 INFO - x-amz-cf-id: uYULRXBS4m2JTzA_RwGJOdPagZZ17VS3Ba-pV1Q1Bdx3KPmVp3AfpA== 22:07:57 INFO - x-amz-replication-status: COMPLETED 22:07:57 INFO - x-amz-version-id: aC9yvM8o5dCNWaqhYA7XdWhf7bj8NuWF 22:07:57 INFO - Expected file size: 21747574 22:07:57 INFO - Obtained file size: 21747574 22:08:01 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/1479956046/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:08:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:08:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:08:01 INFO - Http code: 200 22:08:01 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 22:08:01 INFO - x-amz-cf-id: _De9uRr1fnIhcIrnYuHqw1EGxcZ3yWYm7UxPU8GVjKC5fsTtsCOUlg== 22:08:01 INFO - x-amz-replication-status: COMPLETED 22:08:01 INFO - x-amz-version-id: IXRDe.nEnXNLkCCyufP9pUYVd5JgGOoL 22:08:02 INFO - Expected file size: 14409506 22:08:02 INFO - Obtained file size: 14409506 22:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:08:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:08:02 INFO - Downloaded 59713600 bytes. 22:08:02 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:08:02 INFO - mkdir: /builds/slave/test/properties 22:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:08:02 INFO - Contents: 22:08:02 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:08:03 INFO - Running post-action listener: _resource_record_post_action 22:08:03 INFO - Running post-action listener: set_extra_try_arguments 22:08:03 INFO - [mozharness: 2016-11-24 06:08:03.178257Z] Finished download-and-extract step (success) 22:08:03 INFO - [mozharness: 2016-11-24 06:08:03.178483Z] Running populate-webroot step. 22:08:03 INFO - Running pre-action listener: _resource_record_pre_action 22:08:03 INFO - Running main action method: populate_webroot 22:08:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:08:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:08:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:08:03 INFO - '--tppagecycles', 22:08:03 INFO - '7'], 22:08:03 INFO - 'tests': ['tsvgm']}}, 22:08:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:08:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:08:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:08:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:08:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['damp', 'tps']}, 22:08:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'tests': ['damp', 'tps']}, 22:08:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['dromaeo_dom']}, 22:08:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:08:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['basic_compositor_video']}, 22:08:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:08:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['tsvgx', 22:08:03 INFO - 'tsvgr_opacity', 22:08:03 INFO - 'tart', 22:08:03 INFO - 'tscrollx', 22:08:03 INFO - 'cart']}, 22:08:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:08:03 INFO - 'tsvgr_opacity', 22:08:03 INFO - 'tart', 22:08:03 INFO - 'tscrollx', 22:08:03 INFO - 'cart']}, 22:08:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-e10s'], 22:08:03 INFO - 'tests': ['tp5o']}, 22:08:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:08:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-e10s', 22:08:03 INFO - '--xperf_path', 22:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:03 INFO - 'tests': ['tp5n']}, 22:08:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--xperf_path', 22:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:03 INFO - 'tests': ['tp5n']}}, 22:08:03 INFO - 'talos.zip': {'path': '', 22:08:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:08:03 INFO - Running post-action listener: _resource_record_post_action 22:08:03 INFO - [mozharness: 2016-11-24 06:08:03.200598Z] Finished populate-webroot step (success) 22:08:03 INFO - [mozharness: 2016-11-24 06:08:03.200685Z] Running create-virtualenv step. 22:08:03 INFO - Running pre-action listener: _resource_record_pre_action 22:08:03 INFO - Running main action method: create_virtualenv 22:08:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:08:03 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 22:08:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:08:03 INFO - Using real prefix '/usr' 22:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:08:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:08:05 INFO - Installing pip.................done. 22:08:05 INFO - Return code: 0 22:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:08:05 INFO - Reading from file tmpfile_stdout 22:08:05 INFO - Output received: 22:08:05 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) 22:08:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:08:05 INFO - Using env: {'DISPLAY': ':0', 22:08:05 INFO - 'HOME': '/home/cltbld', 22:08:05 INFO - 'LANG': 'en_US.UTF-8', 22:08:05 INFO - 'LANGUAGE': 'en_US:en', 22:08:05 INFO - 'LOGNAME': 'cltbld', 22:08:05 INFO - 'MAIL': '/var/mail/cltbld', 22:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:05 INFO - 'MOZ_NO_REMOTE': '1', 22:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:05 INFO - 'NO_EM_RESTART': '1', 22:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:05 INFO - 'PWD': '/builds/slave/test', 22:08:05 INFO - 'SHELL': '/bin/bash', 22:08:05 INFO - 'SHLVL': '1', 22:08:05 INFO - 'TERM': 'linux', 22:08:05 INFO - 'TMOUT': '86400', 22:08:05 INFO - 'USER': 'cltbld', 22:08:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:05 INFO - '_': '/tools/buildbot/bin/python'} 22:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:06 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 22:08:06 INFO - Cleaning up... 22:08:06 INFO - Return code: 0 22:08:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:08:06 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')]} 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:06 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')]} 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:06 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:06 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 22:08:06 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 22:08:06 INFO - Using env: {'DISPLAY': ':0', 22:08:06 INFO - 'HOME': '/home/cltbld', 22:08:06 INFO - 'LANG': 'en_US.UTF-8', 22:08:06 INFO - 'LANGUAGE': 'en_US:en', 22:08:06 INFO - 'LOGNAME': 'cltbld', 22:08:06 INFO - 'MAIL': '/var/mail/cltbld', 22:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:06 INFO - 'MOZ_NO_REMOTE': '1', 22:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:06 INFO - 'NO_EM_RESTART': '1', 22:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:06 INFO - 'PWD': '/builds/slave/test', 22:08:06 INFO - 'SHELL': '/bin/bash', 22:08:06 INFO - 'SHLVL': '1', 22:08:06 INFO - 'TERM': 'linux', 22:08:06 INFO - 'TMOUT': '86400', 22:08:06 INFO - 'USER': 'cltbld', 22:08:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:06 INFO - '_': '/tools/buildbot/bin/python'} 22:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:06 INFO - Downloading/unpacking psutil>=3.1.1 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:08 INFO - Installing collected packages: psutil 22:08:08 INFO - Running setup.py install for psutil 22:08:08 INFO - building 'psutil._psutil_linux' extension 22:08:08 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 22:08:08 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 22:08:08 INFO - building 'psutil._psutil_posix' extension 22:08:08 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 22:08:08 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 22:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:08 INFO - Successfully installed psutil 22:08:08 INFO - Cleaning up... 22:08:09 INFO - Return code: 0 22:08:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:09 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 22:08:09 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 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:08:12 INFO - Installing collected packages: mozsystemmonitor 22:08:12 INFO - Running setup.py install for mozsystemmonitor 22:08:12 INFO - Successfully installed mozsystemmonitor 22:08:12 INFO - Cleaning up... 22:08:12 INFO - Return code: 0 22:08:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:12 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:12 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 22:08:12 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 22:08:12 INFO - Using env: {'DISPLAY': ':0', 22:08:12 INFO - 'HOME': '/home/cltbld', 22:08:12 INFO - 'LANG': 'en_US.UTF-8', 22:08:12 INFO - 'LANGUAGE': 'en_US:en', 22:08:12 INFO - 'LOGNAME': 'cltbld', 22:08:12 INFO - 'MAIL': '/var/mail/cltbld', 22:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:12 INFO - 'MOZ_NO_REMOTE': '1', 22:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:12 INFO - 'NO_EM_RESTART': '1', 22:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:12 INFO - 'PWD': '/builds/slave/test', 22:08:12 INFO - 'SHELL': '/bin/bash', 22:08:12 INFO - 'SHLVL': '1', 22:08:12 INFO - 'TERM': 'linux', 22:08:12 INFO - 'TMOUT': '86400', 22:08:12 INFO - 'USER': 'cltbld', 22:08:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:12 INFO - '_': '/tools/buildbot/bin/python'} 22:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:12 INFO - Downloading/unpacking jsonschema==2.5.1 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:14 INFO - warning: no files found matching '*.txt' 22:08:14 INFO - no previously-included directories found matching 'build' 22:08:14 INFO - no previously-included directories found matching 'dist' 22:08:14 INFO - no previously-included directories found matching '.git*' 22:08:14 INFO - Installing collected packages: jsonschema, functools32 22:08:14 INFO - Running setup.py install for functools32 22:08:14 INFO - warning: no files found matching '*.txt' 22:08:14 INFO - no previously-included directories found matching 'build' 22:08:14 INFO - no previously-included directories found matching 'dist' 22:08:14 INFO - no previously-included directories found matching '.git*' 22:08:14 INFO - Successfully installed jsonschema functools32 22:08:14 INFO - Cleaning up... 22:08:15 INFO - Return code: 0 22:08:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:08:15 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')]} 22:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:15 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')]} 22:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:15 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:15 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 22:08:15 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 22:08:15 INFO - Using env: {'DISPLAY': ':0', 22:08:15 INFO - 'HOME': '/home/cltbld', 22:08:15 INFO - 'LANG': 'en_US.UTF-8', 22:08:15 INFO - 'LANGUAGE': 'en_US:en', 22:08:15 INFO - 'LOGNAME': 'cltbld', 22:08:15 INFO - 'MAIL': '/var/mail/cltbld', 22:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:15 INFO - 'MOZ_NO_REMOTE': '1', 22:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:15 INFO - 'NO_EM_RESTART': '1', 22:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:15 INFO - 'PWD': '/builds/slave/test', 22:08:15 INFO - 'SHELL': '/bin/bash', 22:08:15 INFO - 'SHLVL': '1', 22:08:15 INFO - 'TERM': 'linux', 22:08:15 INFO - 'TMOUT': '86400', 22:08:15 INFO - 'USER': 'cltbld', 22:08:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:15 INFO - '_': '/tools/buildbot/bin/python'} 22:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:08:15 INFO - Cleaning up... 22:08:15 INFO - Return code: 0 22:08:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:08:15 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')]} 22:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:15 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')]} 22:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:15 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:15 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 22:08:15 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 22:08:15 INFO - Using env: {'DISPLAY': ':0', 22:08:15 INFO - 'HOME': '/home/cltbld', 22:08:15 INFO - 'LANG': 'en_US.UTF-8', 22:08:15 INFO - 'LANGUAGE': 'en_US:en', 22:08:15 INFO - 'LOGNAME': 'cltbld', 22:08:15 INFO - 'MAIL': '/var/mail/cltbld', 22:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:15 INFO - 'MOZ_NO_REMOTE': '1', 22:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:15 INFO - 'NO_EM_RESTART': '1', 22:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:15 INFO - 'PWD': '/builds/slave/test', 22:08:15 INFO - 'SHELL': '/bin/bash', 22:08:15 INFO - 'SHLVL': '1', 22:08:15 INFO - 'TERM': 'linux', 22:08:15 INFO - 'TMOUT': '86400', 22:08:15 INFO - 'USER': 'cltbld', 22:08:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:15 INFO - '_': '/tools/buildbot/bin/python'} 22:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:08:15 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 22:08:15 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 22:08:15 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 22:08:15 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 22:08:15 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 22:08:15 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 22:08:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:18 INFO - Downloading docopt-0.6.1.tar.gz 22:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:18 INFO - Running setup.py install for blobuploader 22:08:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:18 INFO - Running setup.py install for requests 22:08:18 INFO - Running setup.py install for docopt 22:08:18 INFO - Successfully installed blobuploader requests docopt 22:08:18 INFO - Cleaning up... 22:08:19 INFO - Return code: 0 22:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:19 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:19 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 22:08:19 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 22:08:19 INFO - Using env: {'DISPLAY': ':0', 22:08:19 INFO - 'HOME': '/home/cltbld', 22:08:19 INFO - 'LANG': 'en_US.UTF-8', 22:08:19 INFO - 'LANGUAGE': 'en_US:en', 22:08:19 INFO - 'LOGNAME': 'cltbld', 22:08:19 INFO - 'MAIL': '/var/mail/cltbld', 22:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:19 INFO - 'MOZ_NO_REMOTE': '1', 22:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:19 INFO - 'NO_EM_RESTART': '1', 22:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:19 INFO - 'PWD': '/builds/slave/test', 22:08:19 INFO - 'SHELL': '/bin/bash', 22:08:19 INFO - 'SHLVL': '1', 22:08:19 INFO - 'TERM': 'linux', 22:08:19 INFO - 'TMOUT': '86400', 22:08:19 INFO - 'USER': 'cltbld', 22:08:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:19 INFO - '_': '/tools/buildbot/bin/python'} 22:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:19 INFO - Running setup.py (path:/tmp/pip-dlDczi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:19 INFO - Running setup.py (path:/tmp/pip-fdF1vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:19 INFO - Running setup.py (path:/tmp/pip-9FfpYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:19 INFO - Running setup.py (path:/tmp/pip-qPkeaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:19 INFO - Running setup.py (path:/tmp/pip-uUJZsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:19 INFO - Running setup.py (path:/tmp/pip-ao9q_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:19 INFO - Running setup.py (path:/tmp/pip-__GJur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:19 INFO - Running setup.py (path:/tmp/pip-87tSi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:19 INFO - Running setup.py (path:/tmp/pip-CvOjAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:19 INFO - Running setup.py (path:/tmp/pip-baDgyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:19 INFO - Running setup.py (path:/tmp/pip-o_fsx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:20 INFO - Running setup.py (path:/tmp/pip-0DiGjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:20 INFO - Running setup.py (path:/tmp/pip-uOUEcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:20 INFO - Running setup.py (path:/tmp/pip-35Rgvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:20 INFO - Running setup.py (path:/tmp/pip-qg64Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:20 INFO - Running setup.py (path:/tmp/pip-aKVCYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:20 INFO - Running setup.py (path:/tmp/pip-frJenV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:20 INFO - Running setup.py install for manifestparser 22:08:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:20 INFO - Running setup.py install for mozcrash 22:08:20 INFO - Running setup.py install for mozdebug 22:08:20 INFO - Running setup.py install for mozdevice 22:08:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:08:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:20 INFO - Running setup.py install for mozfile 22:08:21 INFO - Running setup.py install for mozhttpd 22:08:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozinfo 22:08:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozInstall 22:08:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozleak 22:08:21 INFO - Running setup.py install for mozlog 22:08:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for moznetwork 22:08:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozprocess 22:08:21 INFO - Running setup.py install for mozprofile 22:08:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozrunner 22:08:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:21 INFO - Running setup.py install for mozscreenshot 22:08:22 INFO - Running setup.py install for moztest 22:08:22 INFO - Running setup.py install for mozversion 22:08:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:22 INFO - Cleaning up... 22:08:22 INFO - Return code: 0 22:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:22 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:22 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 22:08:22 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 22:08:22 INFO - Using env: {'DISPLAY': ':0', 22:08:22 INFO - 'HOME': '/home/cltbld', 22:08:22 INFO - 'LANG': 'en_US.UTF-8', 22:08:22 INFO - 'LANGUAGE': 'en_US:en', 22:08:22 INFO - 'LOGNAME': 'cltbld', 22:08:22 INFO - 'MAIL': '/var/mail/cltbld', 22:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:22 INFO - 'MOZ_NO_REMOTE': '1', 22:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:22 INFO - 'NO_EM_RESTART': '1', 22:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:22 INFO - 'PWD': '/builds/slave/test', 22:08:22 INFO - 'SHELL': '/bin/bash', 22:08:22 INFO - 'SHLVL': '1', 22:08:22 INFO - 'TERM': 'linux', 22:08:22 INFO - 'TMOUT': '86400', 22:08:22 INFO - 'USER': 'cltbld', 22:08:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:22 INFO - '_': '/tools/buildbot/bin/python'} 22:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:22 INFO - Running setup.py (path:/tmp/pip-6tLwIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:22 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)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:22 INFO - Running setup.py (path:/tmp/pip-rehpTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:22 INFO - Running setup.py (path:/tmp/pip-imIIGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:22 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)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:22 INFO - Running setup.py (path:/tmp/pip-avR66l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:22 INFO - Running setup.py (path:/tmp/pip-KM_SOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:22 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)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:22 INFO - Running setup.py (path:/tmp/pip-o57GXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:22 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)) 22:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:22 INFO - Running setup.py (path:/tmp/pip-7vr61Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:23 INFO - Running setup.py (path:/tmp/pip-AhKY7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:23 INFO - Running setup.py (path:/tmp/pip-KGIeca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:23 INFO - Running setup.py (path:/tmp/pip-nj76U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:23 INFO - Running setup.py (path:/tmp/pip-q3B5wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:23 INFO - Running setup.py (path:/tmp/pip-jbrGcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:23 INFO - Running setup.py (path:/tmp/pip-kqCvoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:23 INFO - Running setup.py (path:/tmp/pip-auXBXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:23 INFO - Running setup.py (path:/tmp/pip-yLPSI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:23 INFO - Running setup.py (path:/tmp/pip-IvGxAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:23 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)) 22:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:23 INFO - Running setup.py (path:/tmp/pip-AyaN7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:23 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)) 22:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:08:23 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)) 22:08:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:08:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:08:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:25 INFO - Downloading blessings-1.6.tar.gz 22:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:25 INFO - Installing collected packages: blessings 22:08:25 INFO - Running setup.py install for blessings 22:08:25 INFO - Successfully installed blessings 22:08:25 INFO - Cleaning up... 22:08:25 INFO - Return code: 0 22:08:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:26 INFO - Reading from file tmpfile_stdout 22:08:26 INFO - Current package versions: 22:08:26 INFO - argparse == 1.2.1 22:08:26 INFO - blessings == 1.6 22:08:26 INFO - blobuploader == 1.2.4 22:08:26 INFO - docopt == 0.6.1 22:08:26 INFO - functools32 == 3.2.3-2 22:08:26 INFO - jsonschema == 2.5.1 22:08:26 INFO - manifestparser == 1.1 22:08:26 INFO - mozInstall == 1.12 22:08:26 INFO - mozcrash == 1.0 22:08:26 INFO - mozdebug == 0.1 22:08:26 INFO - mozdevice == 0.49 22:08:26 INFO - mozfile == 1.2 22:08:26 INFO - mozhttpd == 0.7 22:08:26 INFO - mozinfo == 0.9 22:08:26 INFO - mozleak == 0.1 22:08:26 INFO - mozlog == 3.4 22:08:26 INFO - moznetwork == 0.27 22:08:26 INFO - mozprocess == 0.23 22:08:26 INFO - mozprofile == 0.28 22:08:26 INFO - mozrunner == 6.13 22:08:26 INFO - mozscreenshot == 0.1 22:08:26 INFO - mozsystemmonitor == 0.3 22:08:26 INFO - moztest == 0.7 22:08:26 INFO - mozversion == 1.4 22:08:26 INFO - psutil == 3.1.1 22:08:26 INFO - requests == 1.2.3 22:08:26 INFO - wsgiref == 0.1.2 22:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:26 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 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:26 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 22:08:26 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 22:08:26 INFO - Using env: {'DISPLAY': ':0', 22:08:26 INFO - 'HOME': '/home/cltbld', 22:08:26 INFO - 'LANG': 'en_US.UTF-8', 22:08:26 INFO - 'LANGUAGE': 'en_US:en', 22:08:26 INFO - 'LOGNAME': 'cltbld', 22:08:26 INFO - 'MAIL': '/var/mail/cltbld', 22:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:26 INFO - 'MOZ_NO_REMOTE': '1', 22:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:26 INFO - 'NO_EM_RESTART': '1', 22:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:26 INFO - 'PWD': '/builds/slave/test', 22:08:26 INFO - 'SHELL': '/bin/bash', 22:08:26 INFO - 'SHLVL': '1', 22:08:26 INFO - 'TERM': 'linux', 22:08:26 INFO - 'TMOUT': '86400', 22:08:26 INFO - 'USER': 'cltbld', 22:08:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:26 INFO - '_': '/tools/buildbot/bin/python'} 22:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 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)) 22:08:26 INFO - Cleaning up... 22:08:26 INFO - Return code: 0 22:08:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b3954de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', '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 22:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:08:26 INFO - Using env: {'DISPLAY': ':0', 22:08:26 INFO - 'HOME': '/home/cltbld', 22:08:26 INFO - 'LANG': 'en_US.UTF-8', 22:08:26 INFO - 'LANGUAGE': 'en_US:en', 22:08:26 INFO - 'LOGNAME': 'cltbld', 22:08:26 INFO - 'MAIL': '/var/mail/cltbld', 22:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:26 INFO - 'MOZ_NO_REMOTE': '1', 22:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:26 INFO - 'NO_EM_RESTART': '1', 22:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:26 INFO - 'PWD': '/builds/slave/test', 22:08:26 INFO - 'SHELL': '/bin/bash', 22:08:26 INFO - 'SHLVL': '1', 22:08:26 INFO - 'TERM': 'linux', 22:08:26 INFO - 'TMOUT': '86400', 22:08:26 INFO - 'USER': 'cltbld', 22:08:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:26 INFO - '_': '/tools/buildbot/bin/python'} 22:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:08:26 INFO - Cleaning up... 22:08:26 INFO - Return code: 0 22:08:26 INFO - Running post-action listener: _resource_record_post_action 22:08:26 INFO - Running post-action listener: _start_resource_monitoring 22:08:26 INFO - Starting resource monitoring. 22:08:26 INFO - [mozharness: 2016-11-24 06:08:26.668046Z] Finished create-virtualenv step (success) 22:08:26 INFO - [mozharness: 2016-11-24 06:08:26.668562Z] Running install step. 22:08:26 INFO - Running pre-action listener: _resource_record_pre_action 22:08:26 INFO - Running main action method: install 22:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:26 INFO - Reading from file tmpfile_stdout 22:08:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:26 INFO - Reading from file tmpfile_stdout 22:08:26 INFO - Output received: 22:08:26 INFO - Usage: mozinstall [options] installer 22:08:26 INFO - Options: 22:08:26 INFO - -h, --help show this help message and exit 22:08:26 INFO - -d DEST, --destination=DEST 22:08:26 INFO - Directory to install application into. [default: 22:08:26 INFO - "/builds/slave/test"] 22:08:26 INFO - --app=APP Application being installed. [default: firefox] 22:08:26 INFO - mkdir: /builds/slave/test/build/application 22:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:08:43 INFO - Reading from file tmpfile_stdout 22:08:43 INFO - Output received: 22:08:43 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:43 INFO - Running post-action listener: _resource_record_post_action 22:08:43 INFO - [mozharness: 2016-11-24 06:08:43.927799Z] Finished install step (success) 22:08:43 INFO - [mozharness: 2016-11-24 06:08:43.928072Z] Running run-tests step. 22:08:43 INFO - Running pre-action listener: _resource_record_pre_action 22:08:43 INFO - Running main action method: run_tests 22:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:43 INFO - Python 2.7.3 22:08:43 INFO - Return code: 0 22:08:43 INFO - grabbing minidump binary from tooltool 22:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:43 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 0x20d4fc0>, '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 0x20d5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:43 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 22:08:43 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 22:08:43 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 22:08:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:44 INFO - Return code: 0 22:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:44 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:08:44 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:08:44 INFO - Using env: {'DISPLAY': ':0', 22:08:44 INFO - 'HOME': '/home/cltbld', 22:08:44 INFO - 'LANG': 'en_US.UTF-8', 22:08:44 INFO - 'LANGUAGE': 'en_US:en', 22:08:44 INFO - 'LOGNAME': 'cltbld', 22:08:44 INFO - 'MAIL': '/var/mail/cltbld', 22:08:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:44 INFO - 'MOZ_NO_REMOTE': '1', 22:08:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:44 INFO - 'NO_EM_RESTART': '1', 22:08:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:44 INFO - 'PWD': '/builds/slave/test', 22:08:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:44 INFO - 'SHELL': '/bin/bash', 22:08:44 INFO - 'SHLVL': '1', 22:08:44 INFO - 'TERM': 'linux', 22:08:44 INFO - 'TMOUT': '86400', 22:08:44 INFO - 'USER': 'cltbld', 22:08:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298', 22:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:44 INFO - '_': '/tools/buildbot/bin/python'} 22:08:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:08:44 INFO - mozversion application_buildid: 20161123185406 22:08:44 INFO - mozversion application_changeset: 134a87fe0772c62d73d2d1c4408f629a2160d3b0 22:08:44 INFO - mozversion application_display_name: Nightly 22:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:44 INFO - mozversion application_name: Firefox 22:08:44 INFO - mozversion application_remotingname: firefox 22:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:44 INFO - mozversion application_vendor: Mozilla 22:08:44 INFO - mozversion application_version: 53.0a1 22:08:44 INFO - mozversion platform_buildid: 20161123185406 22:08:44 INFO - mozversion platform_changeset: 134a87fe0772c62d73d2d1c4408f629a2160d3b0 22:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:44 INFO - mozversion platform_version: 53.0a1 22:08:44 INFO - using testdate: 1479967724 22:08:44 INFO - actual date: 1479967724 22:08:44 INFO - starting webserver on 'localhost:38527' 22:08:44 INFO - SUITE-START | Running 2 tests 22:08:44 INFO - TEST-START | dromaeo_css 22:08:44 INFO - operating with platform_type : linux_ 22:08:44 INFO - Initialising browser for dromaeo_css test... 22:08:44 INFO - TEST-INFO | started process 20881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsjbsLX/profile http://localhost:38527/getInfo.html) 22:08:48 INFO - PROCESS | 20881 | __metrics Screen width/height:1600/1200 22:08:48 INFO - PROCESS | 20881 | colorDepth:24 22:08:48 INFO - PROCESS | 20881 | Browser inner width/height: 1024/697 22:08:48 INFO - PROCESS | 20881 | __metrics 22:08:49 ERROR - PROCESS | 20881 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 22:08:50 INFO - TEST-INFO | 20881: exit 0 22:08:50 INFO - Browser initialized. 22:08:50 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:50 INFO - TEST-INFO | started process 21004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsjbsLX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:09:02 INFO - PROCESS | 21004 | RSS: Main: 185909248 22:09:02 INFO - PROCESS | 21004 | 22:09:52 INFO - PROCESS | 21004 | 1479967792138 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] 22:12:03 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38527/tests/dromaeo/cssquery-ext.html) 22:12:04 INFO - PROCESS | 21004 | RSS: Main: 197648384 22:12:04 INFO - PROCESS | 21004 | 22:15:07 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-ext.html (next: http://localhost:38527/tests/dromaeo/cssquery-jquery.html) 22:15:07 INFO - PROCESS | 21004 | RSS: Main: 197644288 22:15:07 INFO - PROCESS | 21004 | 22:18:09 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38527/tests/dromaeo/cssquery-mootools.html) 22:18:10 INFO - PROCESS | 21004 | RSS: Main: 199299072 22:18:10 INFO - PROCESS | 21004 | 22:21:12 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38527/tests/dromaeo/cssquery-prototype.html) 22:21:12 INFO - PROCESS | 21004 | RSS: Main: 195776512 22:21:12 INFO - PROCESS | 21004 | 22:24:15 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38527/tests/dromaeo/cssquery-yui.html) 22:24:16 INFO - PROCESS | 21004 | RSS: Main: 199479296 22:24:16 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | Cycle 1(1): loaded http://localhost:38527/tests/dromaeo/cssquery-yui.html (next: http://localhost:38527/tests/dromaeo/cssquery-dojo.html) 22:27:18 INFO - PROCESS | 21004 | RSS: Main: 200376320 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | __start_tp_report 22:27:18 INFO - PROCESS | 21004 | _x_x_mozilla_page_load 22:27:18 INFO - PROCESS | 21004 | _x_x_mozilla_page_load_details 22:27:18 INFO - PROCESS | 21004 | |i|pagename|runs| 22:27:18 INFO - PROCESS | 21004 | |0;dojo.html;3067.1871953932214;3074.5695602615633;3084.9228769280753;3088.0735779266242;3104.36360546088;5384.6499977501535;5410.5401040911565;5423.403425623178;5445.618806683534;5482.972585137079;5423.2136340230645;5437.401885792569;5495.752691128909;5496.340439147298;5515.09001014833;4957.727324997124;4983.327250821129;5118.795248190087;5132.615053870956;5133.691978481284;4980.9252861207115;5074.112030394685;5111.7188554629665;5171.405288391827;5194.039102765982;4820.987592605557;4858.5384388483035;4877.439094504107;4908.9263661045115;4954.47977962316;4895.510448955111;4902.411710594716;4904.362432883702;4935.7532123393685;5033.7734801934;4887.780049897763;4895.902081958377;4916.483769204217;4925.827596034157;4926.729029903354;5382.67703937765;5395.10980688186;5406.729663516809;5420.485053919911;5428.9185662215095;5715.057015592422;5721.256236689203;5739.139129130622;5770.538356931435;5788.160716696098;5791.391903850077;5849.590528662995;5851.707414629252;5853.795117170878;5901.645901245939;5413.945860541384;5455.781768729285;5470.589705772043;5481.369642491085;5486.31421072366;5868.589198756046;5891.499222566044;5906.704664766745;5941.465268125889;6027.21646185993;5707.143928410772;5717.542596592262;5759.1649210865025;5810.099434587646;5832.270966129234;5829.387914269026;5829.621074630136;5834.3290521589715;5838.854028649318;5851.297844258716;5699.344575373802;5761.48146666802;5769.451902069297;5819.098039803837;5820.592558520948;5864.472197502245;5870.031444811643;5874;5885.440883116097;5922.1412895130825;4487.798049087799;4492.483364413069;4492.865214043584;4504.414426124583;4538.659600529907;3916.823742931575;3937.645611894943;3948.526176858795;3952.4268980998168;3983.780892050965;5521;5533.6956467393875;5536.086545719912;5569.721513924287;5593.74828132735;5735.1970724098655;5808.738606762706;5812.796552120655;5822.0684690449325;5825.7087145642545;5438.211459338374;5485.040117979338;5491;5521.309836270466;5528.391876893538;4942.283368911488;4984.825531106394;5014.022265658162;5028.974855125774;5097.286379906816;6211.130441738251;6211.65835879031;6215.471684906834;6218.968905155445;6222.253329600477;5882.882342353215;5892.970535147297;5904.852378690567;5907.645541267366;5925.496332811586;5926.2295901532525;5947.613405128653;5965.552583556164;5984.521238300838;6069.726862291296;5656;5807.012807822764;5830.125481177857;5863.853403664943;5865.3254875689845;5901;5919.940800591939;5922.845045216141;5924.674142922181;5929.792457263975;5554.638948468337;5631.267935168402;5734.627249228787;5753.626014309224;5777.508911742549;5648.237487939075;5672.801451949162;5676.2337084493065;5693.060644993695;5717.1995920570325;5550.195221692751;5578.163275508706;5612.186232996274;5685.77256909719;5719.48524632785;5654.519365853948;5690.772369105355;5723.284589426322;5726.513246374105;5770.971145144247;5589.776408943597;5604.159376093618;5618.157276408571;5621.353544342453;5641.9435805641415 22:27:18 INFO - PROCESS | 21004 | |1;ext.html;565.9462351076647;583.4690431707147;594.3254406248906;595.603923390945;603.4538742438092;40311.79844100779;41921.37117943233;42084;44659.55340446594;44700.55299447005;41822;42165.15669686604;42286.36570451446;42313.15373692524;42349.576504234945;8555.315574754035;8698.521581313025;8702.564871756387;8703.869441958344;10307.84538231927;10060.245481588874;10407.947960260188;10411.687649370531;10412.479376031168;10421.322614030101;10455.686329410091;10466.895331046668;10482.633107841228;10498.055175034246;10517.158627309796;10411.2191585631;10439.79120417595;10439.947800260989;10447.164226861833;10474.58101675932;10287.948560257151;10291;10361.844572331422;10371.429571373572;10375.481225938673;39276.21447571032;39435;39473.60526394757;39649.80175099135;39862.800685996386;3294.637589865113;3375.3249350130072;3565.358235517606;3686.3548878946076;3716.535433070866;29509.70490295091;29807.25481862949;29973.850130749426;30415.543766843515;30526.236844079074;4221.831126754926;4274.807633656493;4330.7185032973075;4364.061726728737;4443.977780111079;334178;336194;337952;338823;339005;56546.434535654116;56806.147907781415;56827.71586142043;56872.715636421555;56967.14549281764;59660.701696492106;59679;59905.40094598998;59911.400885991454;60168.699156504816;15574.766378504331;15763.054216747032;15775.605609859846;15791.763123552926;15792.447264345692;11341.886581134084;11584;11891.583794567321;12133.817992730115;12345.074119441078;18556;18677.252909883453;18774.245150969862;18812.717809232872;18828.152733126768;6721.327867213337;6814.965925170442;6876.724931002804;6959.756408525677;7115.53749006313;966.1353088985459;980.245211187396;1030.8402197659375;1080.184460732158;1081.7890511350367;30489.847550762104;30955.380892382025;31240;31799.682003180136;33639;1092.9289596176222;1097.0736429298256;1097.412884106999;1107.7562936154034;1114.2868564118971;15948.920255398882;16245.837541624433;16306.347746090023;16317.510474685778;16336.242664187066;484792;489147;492716;495470;496481;54161.1254987053;54285.72857135768;54686.72656636692;54812;55252.99999999919;1330.221820235154;1347.5081595217675;1372.5539199760117;1373.9106958047496;1378.6829029323312;28602.42795144127;29461;29771.553426698185;29952.70047299499;30541;48511.27233091436;49418.50581494139;49574.256386153516;49710;49736.751316244634;393560;394286;395037;396331;396722;27549.449011019267;27575.31061723473;27688.754006069372;27756;28081.157565273075;45072;45148.548514514434;45280.547194528954;46167.538324616326;48090.27864581964;38930.62659846579;38959.6104038956;39015.6098439012;39208.80395598004;40817.59182408257;38817.417738734504;39099.413508796824;39973.20053598854;40119;40349.56154823026;39517.60482395254;39635.207295853346;39824;39892;39962.2007559853;33318.666813331554;34980.47529287012;35288;36170;36193.45709814408;26132.34669133287;26812.329691757863;26963.1911042669;27066.45867082608;27359.179224623294 22:27:18 INFO - PROCESS | 21004 | |2;jquery.html;384.724921680998;385.8340913407234;390.83780231204054;398.71414687632387;420.77909097723693;17570.560735981606;18772.906135469337;19185.808141918595;19192.520186995316;19658.803411965877;19298.421047368567;19388.612227755435;19522.707159392587;19558.70661940072;19621.901890490528;5463.453654634534;5497.945020549803;5659.943400565983;5685.829425117253;5717.428257174291;5558.027345214591;5590.329160500745;5606.159076138571;5608.355039170487;5627.549796016309;5430.402655707869;5546.611737178399;5598.188262701906;5599.580031497654;5606.383297837235;5470.042742520063;5543.6119471637;5573.721313934287;5581.246531718207;5588.882223555305;4872.025594881038;4911.533404326583;4985.451600323961;4990.051890140898;4993.950060499421;22282.331530054125;22379.776202237932;22601.773982260132;22663.09347626093;23183.536329273487;2327.6043072677685;2338.368640467081;2574.3049376668196;2845.01846862832;2936.4861149298786;13947.302634868318;13966.371513281927;14072.2963851807;14133.505327313598;14410.855891441057;1594.8644365228854;1660.0454738525275;1669.5992961689228;1725.0937713826293;1729.5243807952788;77679.22320776776;78412.60793695995;79179;82081;82802.58598707028;10030.949845250727;10107.898921010843;10376.273660843668;10677.679669609925;10686.198535109897;14293.142411455347;14342.139471631735;14353.138811671333;14438.566842994727;14505.202213878338;7881.763547093597;8018.992877670873;8092.433529652868;8188.303994160563;8198.262156405834;7766;7819.530828150329;7842.686292548234;8049.597520123971;8068.354531637572;6060.878782424327;6258.593191442542;6398.9040164397575;6435.935640643627;6513.511486638521;1826.159966415437;1882.1906580170657;1894.6400183965002;1925.7303977443169;1958.383109320588;910.644848509082;946.9005754395827;1016.3901659004538;1018.6332920148741;1035.5236591167995;18990.525236869187;19420.514487137934;19544.31594894172;19736.447439460746;20042.39872803818;931.6785708930408;975.3270243532082;979.9265055120894;1042.8852826189113;1057.2018126314583;9095.454272743656;10599.205059620559;10664.146868250522;10712.143028557852;10743.677689669323;441677;453949;458395;460222;460489;91454;95806;95933;96245.51877240709;96831;983.3362480325751;1010.9292349535461;1029.9073083422527;1032.1742605915238;1036.1710631494775;16417.059905622802;16499.340026398808;16972.40596579114;17020.14899255057;17417;40097.39853902252;40376.356718976516;40527.59472405238;40576.79711601423;41010;56822.43177568337;58051.70974145102;58236;59428;59989;7990.960045199737;8128.75613731589;8210.794730131794;8371.539565323965;8771.122887711177;12131.332776697367;12157.817632735692;12662.303573303188;12720.427580758704;12814.167079139826;11253.21227514099;11481;11606.361650109326;11633.302001879914;11744.236624619372;11407.714807129889;11421.771564568828;11462.885371146182;11600.825987610362;11840.572682599874;10862.456877156268;11046.944765276123;11360.671062432017;11554.59558915434;11830.645080647595;7417.703291868264;7505.6997720090585;8365.749027529184;8499.702510412106;8639.222469977733;10412.167026638002;10825.566977321134;11139.610113645984;11493.310401375944;11510.884891150981 22:27:18 INFO - PROCESS | 21004 | |3;mootools.html;1437.425029988005;1478.2756449339822;1603.6552141289621;1689.5944973206433;1697.787776527934;7335.743248986273;7591.240875912406;7866.724664636738;8460.280876125536;8460.830783384328;8095.150009249032;8366.874496882552;8390.244877960982;8547.829043419128;8615.396922215448;2289.6565515172733;2331.8834058297102;2336.544373847092;2338.2985104468676;2341.7471652665827;2173.402314363547;2177.7168968034134;2254.8534345267585;2256.3569382725927;2257.8306627002958;2163.5348400093976;2175.3365223606793;2181.890905454729;2196.802287794098;2203.1297637433204;2142.143142742915;2152.827773778094;2169.913203471859;2171.6959625652344;2173.4566358410475;2205.6691496275525;2216.1467834883524;2222.688823564702;2225.899834507451;2245.5396643688005;8467.237948584658;8502.74491765248;8541.786455338666;8582.613782379807;8624.051354351017;5102.438731739506;5194.480551944813;5197.038547868657;5199.740012999335;5221.451747566527;3114.76639252057;3191.2021994501374;3278.8032718036993;3338.3657105149946;3343.5653365062385;1051.0750539525168;1063.3513556730388;1070.8661417322835;1117.5306371324064;1162.959296424621;11753.647390578211;11772.117091218108;11857.881421185764;11888.58389956356;11923.880761192451;4451.732896026248;4573.382593349922;4659.813607455664;4733.408323959505;4736.265878788793;9923.60305587783;9931.553080111413;9943.204543636492;9949.054839790208;9987.30088893785;5224.425313215544;5269.446708095671;5271.683698978073;5274.024305503494;5274.498922602346;4627.814887404466;4783.6651434399955;4806.110869489155;4854.732989685601;4877.829275975324;3579.8031108288774;3650.014496086042;3673.246984368198;3708.313961917054;3749.7562658427114;1083.5719890643309;1084.3168803653648;1116.4585176189541;1133.8469306643497;1151.073385924322;868.1752335281508;917.1333090229803;926.36081104038;935.6304259817334;949.7198326493701;5338.893222135535;5369.033573956725;5420.349558053059;5432.891342173134;5607.102863541813;450.517945797993;453.59629929362893;457.7368013392246;463.62909672262055;464.4937018649688;3864.3237433449035;3988.3020471417385;4012.9197416051516;4064.9796751016056;4084.4894388201474;9912.950435247778;10326.948365258277;10337.431441270652;10568.365898046142;10582.365058096539;10330;10355.844662330072;10364;10412.791744165226;10442.530086146142;7834.1774113718375;8001.359891208689;8008;8008.919910800817;8047.557384343917;5813.534917206698;5936.495397891227;5977.1034344846885;6032.969835150796;6034.8793024138395;9470.289728270269;9560.617575297189;9576.138147566753;9674.371165874196;9744.17174540172;9935.602575896883;9954.950225248827;9990.500474976367;10079.496025198858;10087.39475631435;6918.827029324307;7090.893636595559;7110.715571377087;7359.153697324876;7491.250874912465;7752.341051010727;8066.395020373613;8090.150534193825;8097.716579919675;8105.189481051848;7151.821204469722;7156.177039640508;7249.637518124178;7376.7786966391095;7385.261473852572;6936.271691472322;7101.076860008166;7116.8932466014085;7119.6084215368655;7313.268673132644;6663.633500157344;6783;6784.05023296729;6790.32096790317;6790.796276111724;4854.83008094715;4910.729909854992;4947.529984651453;4969.701817890938;4975.029869175621;4861;4943.085529177114;5014.598832093351;5051.62112841531;5098.286239926488 22:27:18 INFO - PROCESS | 21004 | |4;prototype.html;315.3661141106377;333.300069853308;340.4076906183242;343.14727901165605;343.9037069620504;5191.766370513326;5426.647267927587;5433.809816656418;5438.864028399292;5469.948769211545;5326.360836699601;5358.65168764031;5370.301860758106;5394.433584473622;5427.348718153827;4213.283741763892;4272.530021697603;4279.700420970534;4294.993504546814;4327.437433133704;4087.2424857311344;4239.427677263561;4239.427677263561;4242.045539753562;4257.276263035276;4165.937510937339;4189.287821070426;4214.6838987075935;4242.9151416971645;4244.80898359573;4201.432806571104;4204.915901681949;4217.599328063844;4233.534311225778;4248.704145235702;3694.6514522199473;3778.9055273618105;3779.111908701453;3788.753731007476;3789.9621003789885;5227.947720522784;5242.449542797989;5251.52736253739;5258.789648414059;5291.312129423189;4868.196747536652;4868.221084626478;4869.732164730938;4898.461169271377;4899.216125419951;5493.972530137364;5627.536840421479;5632.577556683265;5634.774609015634;5656.208130861642;4086.12148388095;4118.91762164758;4123.9381409278885;4126.225722939165;4129.504459464853;5715.199872017921;5861.941380586225;5869.266341707286;5904.468597826173;5930.584859059867;4092.447519584818;4099.467069281034;4116.423700681907;4117.135401565704;4135.379693046068;4181.038361176947;4188.6649068074485;4197.9370309445385;4198.979005104955;4199.097194103282;4615.930761038587;4752.239641657387;4779.426468823764;4788;4855.223164293696;5673.290838645169;5676.347220069662;5680.346760122557;5702.800401985994;5704.771809127671;1404.6277736399861;1415.8654927781845;1416.1644629668544;1422.4168091082606;1424.3661570600982;931.487681775021;950.9286803489766;952.2667545989549;968.9467079310706;976;5246.63273570854;5248.711320877312;5325.360956685223;5343.145096784496;5381.246625472437;5588.105903055492;5602.607817452821;5625.831225063254;5635.6618602883955;5655.293088363955;4976.939182402796;5310.4424035476495;5310.840674779763;5312.256284120226;5360.303160589098;2967.4213528362193;2968.3618022124915;2976.7320941115404;2978.9702102979127;2979.657339405996;5784.479396854304;5832.854178645568;5844.726952906386;5846.590738648339;5879.882402351929;5674.432556744293;5993.250843644544;6023.578349515492;6028.156058151774;6038.939610603926;6061.333253342129;6119.418655227746;6138.754449821957;6148.815535533941;6154.815355539252;5583.497485226349;5779.566532510163;5830.708464576669;5874.618149820248;5916.55625828056;5710.202715194349;5768.855778605568;5776.624519406225;5784.50831679312;5788.334341550775;5856.209411729533;5944.256967879015;5985.162077309094;5995.2206213192;5996.610220335664;4063.288924438152;4077.4291599175544;4080.469538959916;4096.40602112698;4104.404861295156;5756.30924289088;5840.970795145997;5873.500752436091;5880.470757631833;5909.23179986599;5674.375818659862;5690.345610254708;5702.258706368146;5716.514096301861;5717.514011309086;5668.26312579362;5669.886602268014;5681.892031053905;5685.630434021941;5690.605801578639;5389.912265371025;5566.91649625264;5588.497035266845;5631.465010823965;5641.182028605747;5680.460356266148;5680.517156041783;5699.943000570107;5701.771929122789;5747.5689323300085;5577.581681373832;5578.3584887738425;5589.608727389043;5612.8877422450505;5617.32592088952 22:27:18 INFO - PROCESS | 21004 | |5;yui.html;731.7365748330602;733.47922974688;754.6000619671572;820.6594263380699;825.7192554531458;14547.05444146131;15083.09501429915;15099.924500377496;15100.395984160648;15120.848791512082;13726.931365343184;13863.722725545484;13865.237411942338;13873.306334683275;13883.722325553508;653.1280740211799;669.621663759974;747.9326860582546;755.3428517190025;755.7317152410898;756.3457609168086;757.5454727163713;757.6022588141242;758.6510205305566;760.4182800157884;810.9107998120202;812.695239285268;812.7683610171102;813.0365516862507;818.2431251092745;797.9880301795478;805.7743831727155;807.1726480357622;808.1191501263621;809.7975506123469;590.0205658606735;591.4676790888192;591.8342863998088;592.0261170374753;593.6497466494789;13737.313134343243;13755.724885502234;13903.930480347635;13931.860681393158;14172.149671019668;13448.932755336258;13708.080868678393;13768.485466598666;14114.576562703136;14492.130472171599;11409.429528523624;11477.540898364055;11572.884271157349;11648.359340236284;11771.823422648667;3687.9815600922093;3700.962990370089;3718.0890681783135;3770.453284273765;3827.2345530893654;59662.40337596612;60060.39939600635;60067.39932600662;60179.39820601782;62072.06891896625;10835.945820270848;10855.2401331906;10943.726406839733;10961.616343427942;11065.834012489819;19604.411867643994;19833.702494462595;19876;20027.399178024683;20044;8129.593520323961;8228.177182281725;8324.500529968222;8395.748127556182;8458.915410845935;4100.097978444737;4141.979290103591;4194.0563373240775;4291.549387314287;4328.242557552416;3366.5455163553097;3449.034270404291;3451.6720911513366;3454.360943225511;3456.395130852141;604.9546284028715;605.6759633596005;616.556079622671;624.1137584629837;635.536058677159;620.7734177025353;652.3443938841529;676.1210426445601;690.19247480447;695.3220609905403;8647.135286471428;9245.399049061789;9364.297677674202;9369.578368973413;9503.429794212369;630.870671512348;659.9571027883268;662.2417332154656;673.5958424944994;674.6559254780097;4247.5964783345535;4427.690061695715;4442.489113751895;4445.570576165404;4468.3074123510905;78533;88934;91249;92443;92678.53660731654;60414.39585604176;78946;79101;79722.6013869927;80899;70424.94362584566;71013.64493177604;72991;73718.63140684369;73770.63114684392;8368.24685778283;8544;8600.870986935326;8648.751324655508;8649.697260595849;50128.49871501384;50411.99176016532;50541.72562234635;50586;50842.74578627083;66261.33738662745;67101.66449167723;67125.99311010436;67264;69506.65246673937;10724.142068634646;10765.677029689123;10846.457677115955;10857.728556786144;10869.29349592274;12013.339266340436;12018.158728888893;12164.209326393757;12167.2699638022;12279.938600306941;11173.888261117285;11538.480768365276;11546.13403994687;11616.651500455;11933.641990739945;11195.552177912792;11342.829857552308;11604.593839215588;11614.825777613512;11746.941265293619;11072.39101849406;11092.445377730919;11111.888881111408;11379.886201137882;11502.424878756196;9561.330706850455;9625.51872406363;9681.70954871355;9930.304878658424;9932.602695892083;9497.335186536877;9916.206703463562;10006.44964526929;10013.849792252977;10090.646827361006 22:27:18 INFO - PROCESS | 21004 | __end_tp_report 22:27:18 INFO - PROCESS | 21004 | __start_cc_report 22:27:18 INFO - PROCESS | 21004 | _x_x_mozilla_cycle_collect,322 22:27:18 INFO - PROCESS | 21004 | __end_cc_report 22:27:18 INFO - PROCESS | 21004 | __startTimestamp1479968838748__endTimestamp 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | ------- Summary: start ------- 22:27:18 INFO - PROCESS | 21004 | Number of tests: 6 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#0] dojo.html Cycles:165 Average:5424.20 Median:5621.35 stddev:627.98 (11.2%) stddev-sans-first:602.07 22:27:18 INFO - PROCESS | 21004 | Values: 3067.2 3074.6 3084.9 3088.1 3104.4 5384.6 5410.5 5423.4 5445.6 5483.0 5423.2 5437.4 5495.8 5496.3 5515.1 4957.7 4983.3 5118.8 5132.6 5133.7 4980.9 5074.1 5111.7 5171.4 5194.0 4821.0 4858.5 4877.4 4908.9 4954.5 4895.5 4902.4 4904.4 4935.8 5033.8 4887.8 4895.9 4916.5 4925.8 4926.7 5382.7 5395.1 5406.7 5420.5 5428.9 5715.1 5721.3 5739.1 5770.5 5788.2 5791.4 5849.6 5851.7 5853.8 5901.6 5413.9 5455.8 5470.6 5481.4 5486.3 5868.6 5891.5 5906.7 5941.5 6027.2 5707.1 5717.5 5759.2 5810.1 5832.3 5829.4 5829.6 5834.3 5838.9 5851.3 5699.3 5761.5 5769.5 5819.1 5820.6 5864.5 5870.0 5874.0 5885.4 5922.1 4487.8 4492.5 4492.9 4504.4 4538.7 3916.8 3937.6 3948.5 3952.4 3983.8 5521.0 5533.7 5536.1 5569.7 5593.7 5735.2 5808.7 5812.8 5822.1 5825.7 5438.2 5485.0 5491.0 5521.3 5528.4 4942.3 4984.8 5014.0 5029.0 5097.3 6211.1 6211.7 6215.5 6219.0 6222.3 5882.9 5893.0 5904.9 5907.6 5925.5 5926.2 5947.6 5965.6 5984.5 6069.7 5656.0 5807.0 5830.1 5863.9 5865.3 5901.0 5919.9 5922.8 5924.7 5929.8 5554.6 5631.3 5734.6 5753.6 5777.5 5648.2 5672.8 5676.2 5693.1 5717.2 5550.2 5578.2 5612.2 5685.8 5719.5 5654.5 5690.8 5723.3 5726.5 5771.0 5589.8 5604.2 5618.2 5621.4 5641.9 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#1] ext.html Cycles:180 Average:56866.43 Median:36181.73 stddev:109166.17 (301.7%) stddev-sans-first:109390.57 22:27:18 INFO - PROCESS | 21004 | Values: 565.9 583.5 594.3 595.6 603.5 40311.8 41921.4 42084.0 44659.6 44700.6 41822.0 42165.2 42286.4 42313.2 42349.6 8555.3 8698.5 8702.6 8703.9 10307.8 10060.2 10407.9 10411.7 10412.5 10421.3 10455.7 10466.9 10482.6 10498.1 10517.2 10411.2 10439.8 10439.9 10447.2 10474.6 10287.9 10291.0 10361.8 10371.4 10375.5 39276.2 39435.0 39473.6 39649.8 39862.8 3294.6 3375.3 3565.4 3686.4 3716.5 29509.7 29807.3 29973.9 30415.5 30526.2 4221.8 4274.8 4330.7 4364.1 4444.0 334178.0 336194.0 337952.0 338823.0 339005.0 56546.4 56806.1 56827.7 56872.7 56967.1 59660.7 59679.0 59905.4 59911.4 60168.7 15574.8 15763.1 15775.6 15791.8 15792.4 11341.9 11584.0 11891.6 12133.8 12345.1 18556.0 18677.3 18774.2 18812.7 18828.2 6721.3 6815.0 6876.7 6959.8 7115.5 966.1 980.2 1030.8 1080.2 1081.8 30489.8 30955.4 31240.0 31799.7 33639.0 1092.9 1097.1 1097.4 1107.8 1114.3 15948.9 16245.8 16306.3 16317.5 16336.2 484792.0 489147.0 492716.0 495470.0 496481.0 54161.1 54285.7 54686.7 54812.0 55253.0 1330.2 1347.5 1372.6 1373.9 1378.7 28602.4 29461.0 29771.6 29952.7 30541.0 48511.3 49418.5 49574.3 49710.0 49736.8 393560.0 394286.0 395037.0 396331.0 396722.0 27549.4 27575.3 27688.8 27756.0 28081.2 45072.0 45148.5 45280.5 46167.5 48090.3 38930.6 38959.6 39015.6 39208.8 40817.6 38817.4 39099.4 39973.2 40119.0 40349.6 39517.6 39635.2 39824.0 39892.0 39962.2 33318.7 34980.5 35288.0 36170.0 36193.5 26132.3 26812.3 26963.2 27066.5 27359.2 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#2] jquery.html Cycles:180 Average:28039.01 Median:2709.66 stddev:75293.38 (2778.7%) stddev-sans-first:75475.97 22:27:18 INFO - PROCESS | 21004 | Values: 384.7 385.8 390.8 398.7 420.8 17570.6 18772.9 19185.8 19192.5 19658.8 19298.4 19388.6 19522.7 19558.7 19621.9 5463.5 5497.9 5659.9 5685.8 5717.4 5558.0 5590.3 5606.2 5608.4 5627.5 5430.4 5546.6 5598.2 5599.6 5606.4 5470.0 5543.6 5573.7 5581.2 5588.9 4872.0 4911.5 4985.5 4990.1 4994.0 22282.3 22379.8 22601.8 22663.1 23183.5 2327.6 2338.4 2574.3 2845.0 2936.5 13947.3 13966.4 14072.3 14133.5 14410.9 1594.9 1660.0 1669.6 1725.1 1729.5 77679.2 78412.6 79179.0 82081.0 82802.6 10030.9 10107.9 10376.3 10677.7 10686.2 14293.1 14342.1 14353.1 14438.6 14505.2 7881.8 8019.0 8092.4 8188.3 8198.3 7766.0 7819.5 7842.7 8049.6 8068.4 6060.9 6258.6 6398.9 6435.9 6513.5 1826.2 1882.2 1894.6 1925.7 1958.4 910.6 946.9 1016.4 1018.6 1035.5 18990.5 19420.5 19544.3 19736.4 20042.4 931.7 975.3 979.9 1042.9 1057.2 9095.5 10599.2 10664.1 10712.1 10743.7 441677.0 453949.0 458395.0 460222.0 460489.0 91454.0 95806.0 95933.0 96245.5 96831.0 983.3 1010.9 1029.9 1032.2 1036.2 16417.1 16499.3 16972.4 17020.1 17417.0 40097.4 40376.4 40527.6 40576.8 41010.0 56822.4 58051.7 58236.0 59428.0 59989.0 7991.0 8128.8 8210.8 8371.5 8771.1 12131.3 12157.8 12662.3 12720.4 12814.2 11253.2 11481.0 11606.4 11633.3 11744.2 11407.7 11421.8 11462.9 11600.8 11840.6 10862.5 11046.9 11360.7 11554.6 11830.6 7417.7 7505.7 8365.7 8499.7 8639.2 10412.2 10825.6 11139.6 11493.3 11510.9 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#3] mootools.html Cycles:180 Average:5548.82 Median:4958.62 stddev:3162.96 (63.8%) stddev-sans-first:3156.74 22:27:18 INFO - PROCESS | 21004 | Values: 1437.4 1478.3 1603.7 1689.6 1697.8 7335.7 7591.2 7866.7 8460.3 8460.8 8095.2 8366.9 8390.2 8547.8 8615.4 2289.7 2331.9 2336.5 2338.3 2341.7 2173.4 2177.7 2254.9 2256.4 2257.8 2163.5 2175.3 2181.9 2196.8 2203.1 2142.1 2152.8 2169.9 2171.7 2173.5 2205.7 2216.1 2222.7 2225.9 2245.5 8467.2 8502.7 8541.8 8582.6 8624.1 5102.4 5194.5 5197.0 5199.7 5221.5 3114.8 3191.2 3278.8 3338.4 3343.6 1051.1 1063.4 1070.9 1117.5 1163.0 11753.6 11772.1 11857.9 11888.6 11923.9 4451.7 4573.4 4659.8 4733.4 4736.3 9923.6 9931.6 9943.2 9949.1 9987.3 5224.4 5269.4 5271.7 5274.0 5274.5 4627.8 4783.7 4806.1 4854.7 4877.8 3579.8 3650.0 3673.2 3708.3 3749.8 1083.6 1084.3 1116.5 1133.8 1151.1 868.2 917.1 926.4 935.6 949.7 5338.9 5369.0 5420.3 5432.9 5607.1 450.5 453.6 457.7 463.6 464.5 3864.3 3988.3 4012.9 4065.0 4084.5 9913.0 10326.9 10337.4 10568.4 10582.4 10330.0 10355.8 10364.0 10412.8 10442.5 7834.2 8001.4 8008.0 8008.9 8047.6 5813.5 5936.5 5977.1 6033.0 6034.9 9470.3 9560.6 9576.1 9674.4 9744.2 9935.6 9955.0 9990.5 10079.5 10087.4 6918.8 7090.9 7110.7 7359.2 7491.3 7752.3 8066.4 8090.2 8097.7 8105.2 7151.8 7156.2 7249.6 7376.8 7385.3 6936.3 7101.1 7116.9 7119.6 7313.3 6663.6 6783.0 6784.1 6790.3 6790.8 4854.8 4910.7 4947.5 4969.7 4975.0 4861.0 4943.1 5014.6 5051.6 5098.3 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#4] prototype.html Cycles:180 Average:4761.15 Median:5410.54 stddev:1402.99 (25.9%) stddev-sans-first:1366.67 22:27:18 INFO - PROCESS | 21004 | Values: 315.4 333.3 340.4 343.1 343.9 5191.8 5426.6 5433.8 5438.9 5469.9 5326.4 5358.7 5370.3 5394.4 5427.3 4213.3 4272.5 4279.7 4295.0 4327.4 4087.2 4239.4 4239.4 4242.0 4257.3 4165.9 4189.3 4214.7 4242.9 4244.8 4201.4 4204.9 4217.6 4233.5 4248.7 3694.7 3778.9 3779.1 3788.8 3790.0 5227.9 5242.4 5251.5 5258.8 5291.3 4868.2 4868.2 4869.7 4898.5 4899.2 5494.0 5627.5 5632.6 5634.8 5656.2 4086.1 4118.9 4123.9 4126.2 4129.5 5715.2 5861.9 5869.3 5904.5 5930.6 4092.4 4099.5 4116.4 4117.1 4135.4 4181.0 4188.7 4197.9 4199.0 4199.1 4615.9 4752.2 4779.4 4788.0 4855.2 5673.3 5676.3 5680.3 5702.8 5704.8 1404.6 1415.9 1416.2 1422.4 1424.4 931.5 950.9 952.3 968.9 976.0 5246.6 5248.7 5325.4 5343.1 5381.2 5588.1 5602.6 5625.8 5635.7 5655.3 4976.9 5310.4 5310.8 5312.3 5360.3 2967.4 2968.4 2976.7 2979.0 2979.7 5784.5 5832.9 5844.7 5846.6 5879.9 5674.4 5993.3 6023.6 6028.2 6038.9 6061.3 6119.4 6138.8 6148.8 6154.8 5583.5 5779.6 5830.7 5874.6 5916.6 5710.2 5768.9 5776.6 5784.5 5788.3 5856.2 5944.3 5985.2 5995.2 5996.6 4063.3 4077.4 4080.5 4096.4 4104.4 5756.3 5841.0 5873.5 5880.5 5909.2 5674.4 5690.3 5702.3 5716.5 5717.5 5668.3 5669.9 5681.9 5685.6 5690.6 5389.9 5566.9 5588.5 5631.5 5641.2 5680.5 5680.5 5699.9 5701.8 5747.6 5577.6 5578.4 5589.6 5612.9 5617.3 22:27:18 INFO - PROCESS | 21004 | 22:27:18 INFO - PROCESS | 21004 | [#5] yui.html Cycles:180 Average:17764.87 Median:591.93 stddev:24187.00 (4086.1%) stddev-sans-first:24221.03 22:27:18 INFO - PROCESS | 21004 | Values: 731.7 733.5 754.6 820.7 825.7 14547.1 15083.1 15099.9 15100.4 15120.8 13726.9 13863.7 13865.2 13873.3 13883.7 653.1 669.6 747.9 755.3 755.7 756.3 757.5 757.6 758.7 760.4 810.9 812.7 812.8 813.0 818.2 798.0 805.8 807.2 808.1 809.8 590.0 591.5 591.8 592.0 593.6 13737.3 13755.7 13903.9 13931.9 14172.1 13448.9 13708.1 13768.5 14114.6 14492.1 11409.4 11477.5 11572.9 11648.4 11771.8 3688.0 3701.0 3718.1 3770.5 3827.2 59662.4 60060.4 60067.4 60179.4 62072.1 10835.9 10855.2 10943.7 10961.6 11065.8 19604.4 19833.7 19876.0 20027.4 20044.0 8129.6 8228.2 8324.5 8395.7 8458.9 4100.1 4142.0 4194.1 4291.5 4328.2 3366.5 3449.0 3451.7 3454.4 3456.4 605.0 605.7 616.6 624.1 635.5 620.8 652.3 676.1 690.2 695.3 8647.1 9245.4 9364.3 9369.6 9503.4 630.9 660.0 662.2 673.6 674.7 4247.6 4427.7 4442.5 4445.6 4468.3 78533.0 88934.0 91249.0 92443.0 92678.5 60414.4 78946.0 79101.0 79722.6 80899.0 70424.9 71013.6 72991.0 73718.6 73770.6 8368.2 8544.0 8600.9 8648.8 8649.7 50128.5 50412.0 50541.7 50586.0 50842.7 66261.3 67101.7 67126.0 67264.0 69506.7 10724.1 10765.7 10846.5 10857.7 10869.3 12013.3 12018.2 12164.2 12167.3 12279.9 11173.9 11538.5 11546.1 11616.7 11933.6 11195.6 11342.8 11604.6 11614.8 11746.9 11072.4 11092.4 11111.9 11379.9 11502.4 9561.3 9625.5 9681.7 9930.3 9932.6 9497.3 9916.2 10006.4 10013.8 10090.6 22:27:18 INFO - PROCESS | 21004 | -------- Summary: end -------- 22:27:18 INFO - PROCESS | 21004 | 22:27:19 INFO - TEST-INFO | 21004: exit 0 22:27:19 INFO - TEST-OK | dromaeo_css | took 1115571ms 22:27:19 INFO - TEST-START | kraken 22:27:19 INFO - operating with platform_type : linux_ 22:27:19 INFO - Initialising browser for kraken test... 22:27:19 INFO - TEST-INFO | started process 21364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaD3YvI/profile http://localhost:38527/getInfo.html) 22:27:24 INFO - PROCESS | 21364 | __metrics Screen width/height:1600/1200 22:27:24 INFO - PROCESS | 21364 | colorDepth:24 22:27:24 INFO - PROCESS | 21364 | Browser inner width/height: 1024/697 22:27:24 INFO - PROCESS | 21364 | __metrics 22:27:24 ERROR - PROCESS | 21364 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 22:27:25 INFO - TEST-INFO | 21364: exit 0 22:27:25 INFO - Browser initialized. 22:27:25 INFO - Running cycle 1/1 for kraken test... 22:27:25 INFO - TEST-INFO | started process 21487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaD3YvI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:38 INFO - PROCESS | 21487 | RSS: Main: 186159104 22:27:38 INFO - PROCESS | 21487 | 22:27:40 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38527/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:41 INFO - PROCESS | 21487 | RSS: Main: 198848512 22:27:41 INFO - PROCESS | 21487 | 22:27:44 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38527/tests/kraken/driver.html?testName=audio-dft) 22:27:44 INFO - PROCESS | 21487 | RSS: Main: 196800512 22:27:44 INFO - PROCESS | 21487 | 22:27:47 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38527/tests/kraken/driver.html?testName=audio-fft) 22:27:48 INFO - PROCESS | 21487 | RSS: Main: 193740800 22:27:48 INFO - PROCESS | 21487 | 22:27:50 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38527/tests/kraken/driver.html?testName=audio-oscillator) 22:27:51 INFO - PROCESS | 21487 | RSS: Main: 194109440 22:27:51 INFO - PROCESS | 21487 | 22:27:53 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:53 INFO - PROCESS | 21487 | RSS: Main: 194203648 22:27:53 INFO - PROCESS | 21487 | 22:27:56 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38527/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:57 INFO - PROCESS | 21487 | RSS: Main: 199958528 22:27:57 INFO - PROCESS | 21487 | 22:28:01 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38527/tests/kraken/driver.html?testName=imaging-desaturate) 22:28:01 INFO - PROCESS | 21487 | RSS: Main: 195842048 22:28:01 INFO - PROCESS | 21487 | 22:28:04 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38527/tests/kraken/driver.html?testName=json-parse-financial) 22:28:05 INFO - PROCESS | 21487 | RSS: Main: 196960256 22:28:05 INFO - PROCESS | 21487 | 22:28:06 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:28:07 INFO - PROCESS | 21487 | RSS: Main: 197275648 22:28:07 INFO - PROCESS | 21487 | 22:28:09 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:28:09 INFO - PROCESS | 21487 | RSS: Main: 197550080 22:28:09 INFO - PROCESS | 21487 | 22:28:11 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:28:12 INFO - PROCESS | 21487 | RSS: Main: 197541888 22:28:12 INFO - PROCESS | 21487 | 22:28:15 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:15 INFO - PROCESS | 21487 | RSS: Main: 197742592 22:28:15 INFO - PROCESS | 21487 | 22:28:18 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:19 INFO - PROCESS | 21487 | RSS: Main: 197873664 22:28:19 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:38527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38527/tests/kraken/driver.html?testName=ai-astar) 22:28:21 INFO - PROCESS | 21487 | RSS: Main: 199737344 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | __start_tp_report 22:28:21 INFO - PROCESS | 21487 | _x_x_mozilla_page_load 22:28:21 INFO - PROCESS | 21487 | _x_x_mozilla_page_load_details 22:28:21 INFO - PROCESS | 21487 | |i|pagename|runs| 22:28:21 INFO - PROCESS | 21487 | |0;ai-astar;106;114;115;112;114;113;114;114;113;112 22:28:21 INFO - PROCESS | 21487 | |1;audio-beat-detection;152;130;136;174;143;137;128;129;144;129 22:28:21 INFO - PROCESS | 21487 | |2;audio-dft;164;165;161;164;173;163;163;162;167;164 22:28:21 INFO - PROCESS | 21487 | |3;audio-fft;77;75;77;107;76;78;78;76;93;76 22:28:21 INFO - PROCESS | 21487 | |4;audio-oscillator;84;83;103;84;84;83;94;83;84;101 22:28:21 INFO - PROCESS | 21487 | |5;imaging-gaussian-blur;119;118;118;119;117;120;118;121;117;117 22:28:21 INFO - PROCESS | 21487 | |6;imaging-darkroom;147;147;148;146;148;147;146;147;147;146 22:28:21 INFO - PROCESS | 21487 | |7;imaging-desaturate;96;97;96;96;96;95;95;96;96;96 22:28:21 INFO - PROCESS | 21487 | |8;json-parse-financial;54;53;52;54;56;54;60;53;55;63 22:28:21 INFO - PROCESS | 21487 | |9;json-stringify-tinderbox;62;63;62;63;66;62;62;62;61;62 22:28:21 INFO - PROCESS | 21487 | |10;stanford-crypto-aes;87;83;81;85;88;82;86;83;80;81 22:28:21 INFO - PROCESS | 21487 | |11;stanford-crypto-ccm;144;131;147;144;143;145;140;136;181;151 22:28:21 INFO - PROCESS | 21487 | |12;stanford-crypto-pbkdf2;175;173;169;171;166;169;163;161;164;170 22:28:21 INFO - PROCESS | 21487 | |13;stanford-crypto-sha256-iterative;66;65;71;64;67;63;64;67;64;64 22:28:21 INFO - PROCESS | 21487 | __end_tp_report 22:28:21 INFO - PROCESS | 21487 | __start_cc_report 22:28:21 INFO - PROCESS | 21487 | _x_x_mozilla_cycle_collect,817 22:28:21 INFO - PROCESS | 21487 | __end_cc_report 22:28:21 INFO - PROCESS | 21487 | __startTimestamp1479968901355__endTimestamp 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | ------- Summary: start ------- 22:28:21 INFO - PROCESS | 21487 | Number of tests: 14 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.54 (2.2%) stddev-sans-first:1.01 22:28:21 INFO - PROCESS | 21487 | Values: 106.0 114.0 115.0 112.0 114.0 113.0 114.0 114.0 113.0 112.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:140.00 stddev:14.28 (10.2%) stddev-sans-first:14.50 22:28:21 INFO - PROCESS | 21487 | Values: 152.0 130.0 136.0 174.0 143.0 137.0 128.0 129.0 144.0 129.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.37 (2.1%) stddev-sans-first:3.57 22:28:21 INFO - PROCESS | 21487 | Values: 164.0 165.0 161.0 164.0 173.0 163.0 163.0 162.0 167.0 164.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:10.44 (13.6%) stddev-sans-first:10.95 22:28:21 INFO - PROCESS | 21487 | Values: 77.0 75.0 77.0 107.0 76.0 78.0 78.0 76.0 93.0 76.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:84.00 stddev:7.94 (9.5%) stddev-sans-first:8.27 22:28:21 INFO - PROCESS | 21487 | Values: 84.0 83.0 103.0 84.0 84.0 83.0 94.0 83.0 84.0 101.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.35 (1.1%) stddev-sans-first:1.41 22:28:21 INFO - PROCESS | 21487 | Values: 119.0 118.0 118.0 119.0 117.0 120.0 118.0 121.0 117.0 117.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 22:28:21 INFO - PROCESS | 21487 | Values: 147.0 147.0 148.0 146.0 148.0 147.0 146.0 147.0 147.0 146.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:28:21 INFO - PROCESS | 21487 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.47 (6.4%) stddev-sans-first:3.64 22:28:21 INFO - PROCESS | 21487 | Values: 54.0 53.0 52.0 54.0 56.0 54.0 60.0 53.0 55.0 63.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 22:28:21 INFO - PROCESS | 21487 | Values: 62.0 63.0 62.0 63.0 66.0 62.0 62.0 62.0 61.0 62.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:2.76 (3.3%) stddev-sans-first:2.64 22:28:21 INFO - PROCESS | 21487 | Values: 87.0 83.0 81.0 85.0 88.0 82.0 86.0 83.0 80.0 81.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:144.50 stddev:13.46 (9.3%) stddev-sans-first:14.25 22:28:21 INFO - PROCESS | 21487 | Values: 144.0 131.0 147.0 144.0 143.0 145.0 140.0 136.0 181.0 151.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.50 stddev:4.51 (2.7%) stddev-sans-first:4.03 22:28:21 INFO - PROCESS | 21487 | Values: 175.0 173.0 169.0 171.0 166.0 169.0 163.0 161.0 164.0 170.0 22:28:21 INFO - PROCESS | 21487 | 22:28:21 INFO - PROCESS | 21487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:2.37 (3.6%) stddev-sans-first:2.51 22:28:21 INFO - PROCESS | 21487 | Values: 66.0 65.0 71.0 64.0 67.0 63.0 64.0 67.0 64.0 64.0 22:28:21 INFO - PROCESS | 21487 | -------- Summary: end -------- 22:28:21 INFO - PROCESS | 21487 | 22:28:22 INFO - TEST-INFO | 21487: exit 0 22:28:22 INFO - TEST-OK | kraken | took 62770ms 22:28:22 INFO - SUITE-END | took 1178s 22:28:23 INFO - Completed test suite (00:19:38) 22:28:23 INFO - javascript benchmark 22:28:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7086.929513187133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.1871953932214, 3074.5695602615633, 3084.9228769280753, 3088.0735779266242, 3104.36360546088, 5384.6499977501535, 5410.5401040911565, 5423.403425623178, 5445.618806683534, 5482.972585137079, 5423.2136340230645, 5437.401885792569, 5495.752691128909, 5496.340439147298, 5515.09001014833, 4957.727324997124, 4983.327250821129, 5118.795248190087, 5132.615053870956, 5133.691978481284, 4980.9252861207115, 5074.112030394685, 5111.7188554629665, 5171.405288391827, 5194.039102765982, 4820.987592605557, 4858.5384388483035, 4877.439094504107, 4908.9263661045115, 4954.47977962316, 4895.510448955111, 4902.411710594716, 4904.362432883702, 4935.7532123393685, 5033.7734801934, 4887.780049897763, 4895.902081958377, 4916.483769204217, 4925.827596034157, 4926.729029903354, 5382.67703937765, 5395.10980688186, 5406.729663516809, 5420.485053919911, 5428.9185662215095, 5715.057015592422, 5721.256236689203, 5739.139129130622, 5770.538356931435, 5788.160716696098, 5791.391903850077, 5849.590528662995, 5851.707414629252, 5853.795117170878, 5901.645901245939, 5413.945860541384, 5455.781768729285, 5470.589705772043, 5481.369642491085, 5486.31421072366, 5868.589198756046, 5891.499222566044, 5906.704664766745, 5941.465268125889, 6027.21646185993, 5707.143928410772, 5717.542596592262, 5759.1649210865025, 5810.099434587646, 5832.270966129234, 5829.387914269026, 5829.621074630136, 5834.3290521589715, 5838.854028649318, 5851.297844258716, 5699.344575373802, 5761.48146666802, 5769.451902069297, 5819.098039803837, 5820.592558520948, 5864.472197502245, 5870.031444811643, 5874.0, 5885.440883116097, 5922.1412895130825, 4487.798049087799, 4492.483364413069, 4492.865214043584, 4504.414426124583, 4538.659600529907, 3916.823742931575, 3937.645611894943, 3948.526176858795, 3952.4268980998168, 3983.780892050965, 5521.0, 5533.6956467393875, 5536.086545719912, 5569.721513924287, 5593.74828132735, 5735.1970724098655, 5808.738606762706, 5812.796552120655, 5822.0684690449325, 5825.7087145642545, 5438.211459338374, 5485.040117979338, 5491.0, 5521.309836270466, 5528.391876893538, 4942.283368911488, 4984.825531106394, 5014.022265658162, 5028.974855125774, 5097.286379906816, 6211.130441738251, 6211.65835879031, 6215.471684906834, 6218.968905155445, 6222.253329600477, 5882.882342353215, 5892.970535147297, 5904.852378690567, 5907.645541267366, 5925.496332811586, 5926.2295901532525, 5947.613405128653, 5965.552583556164, 5984.521238300838, 6069.726862291296, 5656.0, 5807.012807822764, 5830.125481177857, 5863.853403664943, 5865.3254875689845, 5901.0, 5919.940800591939, 5922.845045216141, 5924.674142922181, 5929.792457263975, 5554.638948468337, 5631.267935168402, 5734.627249228787, 5753.626014309224, 5777.508911742549, 5648.237487939075, 5672.801451949162, 5676.2337084493065, 5693.060644993695, 5717.1995920570325, 5550.195221692751, 5578.163275508706, 5612.186232996274, 5685.77256909719, 5719.48524632785, 5654.519365853948, 5690.772369105355, 5723.284589426322, 5726.513246374105, 5770.971145144247, 5589.776408943597, 5604.159376093618, 5618.157276408571, 5621.353544342453, 5641.9435805641415], "value": 5380.412967773252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9462351076647, 583.4690431707147, 594.3254406248906, 595.603923390945, 603.4538742438092, 40311.79844100779, 41921.37117943233, 42084.0, 44659.55340446594, 44700.55299447005, 41822.0, 42165.15669686604, 42286.36570451446, 42313.15373692524, 42349.576504234945, 8555.315574754035, 8698.521581313025, 8702.564871756387, 8703.869441958344, 10307.84538231927, 10060.245481588874, 10407.947960260188, 10411.687649370531, 10412.479376031168, 10421.322614030101, 10455.686329410091, 10466.895331046668, 10482.633107841228, 10498.055175034246, 10517.158627309796, 10411.2191585631, 10439.79120417595, 10439.947800260989, 10447.164226861833, 10474.58101675932, 10287.948560257151, 10291.0, 10361.844572331422, 10371.429571373572, 10375.481225938673, 39276.21447571032, 39435.0, 39473.60526394757, 39649.80175099135, 39862.800685996386, 3294.637589865113, 3375.3249350130072, 3565.358235517606, 3686.3548878946076, 3716.535433070866, 29509.70490295091, 29807.25481862949, 29973.850130749426, 30415.543766843515, 30526.236844079074, 4221.831126754926, 4274.807633656493, 4330.7185032973075, 4364.061726728737, 4443.977780111079, 334178.0, 336194.0, 337952.0, 338823.0, 339005.0, 56546.434535654116, 56806.147907781415, 56827.71586142043, 56872.715636421555, 56967.14549281764, 59660.701696492106, 59679.0, 59905.40094598998, 59911.400885991454, 60168.699156504816, 15574.766378504331, 15763.054216747032, 15775.605609859846, 15791.763123552926, 15792.447264345692, 11341.886581134084, 11584.0, 11891.583794567321, 12133.817992730115, 12345.074119441078, 18556.0, 18677.252909883453, 18774.245150969862, 18812.717809232872, 18828.152733126768, 6721.327867213337, 6814.965925170442, 6876.724931002804, 6959.756408525677, 7115.53749006313, 966.1353088985459, 980.245211187396, 1030.8402197659375, 1080.184460732158, 1081.7890511350367, 30489.847550762104, 30955.380892382025, 31240.0, 31799.682003180136, 33639.0, 1092.9289596176222, 1097.0736429298256, 1097.412884106999, 1107.7562936154034, 1114.2868564118971, 15948.920255398882, 16245.837541624433, 16306.347746090023, 16317.510474685778, 16336.242664187066, 484792.0, 489147.0, 492716.0, 495470.0, 496481.0, 54161.1254987053, 54285.72857135768, 54686.72656636692, 54812.0, 55252.99999999919, 1330.221820235154, 1347.5081595217675, 1372.5539199760117, 1373.9106958047496, 1378.6829029323312, 28602.42795144127, 29461.0, 29771.553426698185, 29952.70047299499, 30541.0, 48511.27233091436, 49418.50581494139, 49574.256386153516, 49710.0, 49736.751316244634, 393560.0, 394286.0, 395037.0, 396331.0, 396722.0, 27549.449011019267, 27575.31061723473, 27688.754006069372, 27756.0, 28081.157565273075, 45072.0, 45148.548514514434, 45280.547194528954, 46167.538324616326, 48090.27864581964, 38930.62659846579, 38959.6104038956, 39015.6098439012, 39208.80395598004, 40817.59182408257, 38817.417738734504, 39099.413508796824, 39973.20053598854, 40119.0, 40349.56154823026, 39517.60482395254, 39635.207295853346, 39824.0, 39892.0, 39962.2007559853, 33318.666813331554, 34980.47529287012, 35288.0, 36170.0, 36193.45709814408, 26132.34669133287, 26812.329691757863, 26963.1911042669, 27066.45867082608, 27359.179224623294], "value": 19843.88587989179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.724921680998, 385.8340913407234, 390.83780231204054, 398.71414687632387, 420.77909097723693, 17570.560735981606, 18772.906135469337, 19185.808141918595, 19192.520186995316, 19658.803411965877, 19298.421047368567, 19388.612227755435, 19522.707159392587, 19558.70661940072, 19621.901890490528, 5463.453654634534, 5497.945020549803, 5659.943400565983, 5685.829425117253, 5717.428257174291, 5558.027345214591, 5590.329160500745, 5606.159076138571, 5608.355039170487, 5627.549796016309, 5430.402655707869, 5546.611737178399, 5598.188262701906, 5599.580031497654, 5606.383297837235, 5470.042742520063, 5543.6119471637, 5573.721313934287, 5581.246531718207, 5588.882223555305, 4872.025594881038, 4911.533404326583, 4985.451600323961, 4990.051890140898, 4993.950060499421, 22282.331530054125, 22379.776202237932, 22601.773982260132, 22663.09347626093, 23183.536329273487, 2327.6043072677685, 2338.368640467081, 2574.3049376668196, 2845.01846862832, 2936.4861149298786, 13947.302634868318, 13966.371513281927, 14072.2963851807, 14133.505327313598, 14410.855891441057, 1594.8644365228854, 1660.0454738525275, 1669.5992961689228, 1725.0937713826293, 1729.5243807952788, 77679.22320776776, 78412.60793695995, 79179.0, 82081.0, 82802.58598707028, 10030.949845250727, 10107.898921010843, 10376.273660843668, 10677.679669609925, 10686.198535109897, 14293.142411455347, 14342.139471631735, 14353.138811671333, 14438.566842994727, 14505.202213878338, 7881.763547093597, 8018.992877670873, 8092.433529652868, 8188.303994160563, 8198.262156405834, 7766.0, 7819.530828150329, 7842.686292548234, 8049.597520123971, 8068.354531637572, 6060.878782424327, 6258.593191442542, 6398.9040164397575, 6435.935640643627, 6513.511486638521, 1826.159966415437, 1882.1906580170657, 1894.6400183965002, 1925.7303977443169, 1958.383109320588, 910.644848509082, 946.9005754395827, 1016.3901659004538, 1018.6332920148741, 1035.5236591167995, 18990.525236869187, 19420.514487137934, 19544.31594894172, 19736.447439460746, 20042.39872803818, 931.6785708930408, 975.3270243532082, 979.9265055120894, 1042.8852826189113, 1057.2018126314583, 9095.454272743656, 10599.205059620559, 10664.146868250522, 10712.143028557852, 10743.677689669323, 441677.0, 453949.0, 458395.0, 460222.0, 460489.0, 91454.0, 95806.0, 95933.0, 96245.51877240709, 96831.0, 983.3362480325751, 1010.9292349535461, 1029.9073083422527, 1032.1742605915238, 1036.1710631494775, 16417.059905622802, 16499.340026398808, 16972.40596579114, 17020.14899255057, 17417.0, 40097.39853902252, 40376.356718976516, 40527.59472405238, 40576.79711601423, 41010.0, 56822.43177568337, 58051.70974145102, 58236.0, 59428.0, 59989.0, 7990.960045199737, 8128.75613731589, 8210.794730131794, 8371.539565323965, 8771.122887711177, 12131.332776697367, 12157.817632735692, 12662.303573303188, 12720.427580758704, 12814.167079139826, 11253.21227514099, 11481.0, 11606.361650109326, 11633.302001879914, 11744.236624619372, 11407.714807129889, 11421.771564568828, 11462.885371146182, 11600.825987610362, 11840.572682599874, 10862.456877156268, 11046.944765276123, 11360.671062432017, 11554.59558915434, 11830.645080647595, 7417.703291868264, 7505.6997720090585, 8365.749027529184, 8499.702510412106, 8639.222469977733, 10412.167026638002, 10825.566977321134, 11139.610113645984, 11493.310401375944, 11510.884891150981], "value": 9169.894922315287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.425029988005, 1478.2756449339822, 1603.6552141289621, 1689.5944973206433, 1697.787776527934, 7335.743248986273, 7591.240875912406, 7866.724664636738, 8460.280876125536, 8460.830783384328, 8095.150009249032, 8366.874496882552, 8390.244877960982, 8547.829043419128, 8615.396922215448, 2289.6565515172733, 2331.8834058297102, 2336.544373847092, 2338.2985104468676, 2341.7471652665827, 2173.402314363547, 2177.7168968034134, 2254.8534345267585, 2256.3569382725927, 2257.8306627002958, 2163.5348400093976, 2175.3365223606793, 2181.890905454729, 2196.802287794098, 2203.1297637433204, 2142.143142742915, 2152.827773778094, 2169.913203471859, 2171.6959625652344, 2173.4566358410475, 2205.6691496275525, 2216.1467834883524, 2222.688823564702, 2225.899834507451, 2245.5396643688005, 8467.237948584658, 8502.74491765248, 8541.786455338666, 8582.613782379807, 8624.051354351017, 5102.438731739506, 5194.480551944813, 5197.038547868657, 5199.740012999335, 5221.451747566527, 3114.76639252057, 3191.2021994501374, 3278.8032718036993, 3338.3657105149946, 3343.5653365062385, 1051.0750539525168, 1063.3513556730388, 1070.8661417322835, 1117.5306371324064, 1162.959296424621, 11753.647390578211, 11772.117091218108, 11857.881421185764, 11888.58389956356, 11923.880761192451, 4451.732896026248, 4573.382593349922, 4659.813607455664, 4733.408323959505, 4736.265878788793, 9923.60305587783, 9931.553080111413, 9943.204543636492, 9949.054839790208, 9987.30088893785, 5224.425313215544, 5269.446708095671, 5271.683698978073, 5274.024305503494, 5274.498922602346, 4627.814887404466, 4783.6651434399955, 4806.110869489155, 4854.732989685601, 4877.829275975324, 3579.8031108288774, 3650.014496086042, 3673.246984368198, 3708.313961917054, 3749.7562658427114, 1083.5719890643309, 1084.3168803653648, 1116.4585176189541, 1133.8469306643497, 1151.073385924322, 868.1752335281508, 917.1333090229803, 926.36081104038, 935.6304259817334, 949.7198326493701, 5338.893222135535, 5369.033573956725, 5420.349558053059, 5432.891342173134, 5607.102863541813, 450.517945797993, 453.59629929362893, 457.7368013392246, 463.62909672262055, 464.4937018649688, 3864.3237433449035, 3988.3020471417385, 4012.9197416051516, 4064.9796751016056, 4084.4894388201474, 9912.950435247778, 10326.948365258277, 10337.431441270652, 10568.365898046142, 10582.365058096539, 10330.0, 10355.844662330072, 10364.0, 10412.791744165226, 10442.530086146142, 7834.1774113718375, 8001.359891208689, 8008.0, 8008.919910800817, 8047.557384343917, 5813.534917206698, 5936.495397891227, 5977.1034344846885, 6032.969835150796, 6034.8793024138395, 9470.289728270269, 9560.617575297189, 9576.138147566753, 9674.371165874196, 9744.17174540172, 9935.602575896883, 9954.950225248827, 9990.500474976367, 10079.496025198858, 10087.39475631435, 6918.827029324307, 7090.893636595559, 7110.715571377087, 7359.153697324876, 7491.250874912465, 7752.341051010727, 8066.395020373613, 8090.150534193825, 8097.716579919675, 8105.189481051848, 7151.821204469722, 7156.177039640508, 7249.637518124178, 7376.7786966391095, 7385.261473852572, 6936.271691472322, 7101.076860008166, 7116.8932466014085, 7119.6084215368655, 7313.268673132644, 6663.633500157344, 6783.0, 6784.05023296729, 6790.32096790317, 6790.796276111724, 4854.83008094715, 4910.729909854992, 4947.529984651453, 4969.701817890938, 4975.029869175621, 4861.0, 4943.085529177114, 5014.598832093351, 5051.62112841531, 5098.286239926488], "value": 4369.839159718937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.3661141106377, 333.300069853308, 340.4076906183242, 343.14727901165605, 343.9037069620504, 5191.766370513326, 5426.647267927587, 5433.809816656418, 5438.864028399292, 5469.948769211545, 5326.360836699601, 5358.65168764031, 5370.301860758106, 5394.433584473622, 5427.348718153827, 4213.283741763892, 4272.530021697603, 4279.700420970534, 4294.993504546814, 4327.437433133704, 4087.2424857311344, 4239.427677263561, 4239.427677263561, 4242.045539753562, 4257.276263035276, 4165.937510937339, 4189.287821070426, 4214.6838987075935, 4242.9151416971645, 4244.80898359573, 4201.432806571104, 4204.915901681949, 4217.599328063844, 4233.534311225778, 4248.704145235702, 3694.6514522199473, 3778.9055273618105, 3779.111908701453, 3788.753731007476, 3789.9621003789885, 5227.947720522784, 5242.449542797989, 5251.52736253739, 5258.789648414059, 5291.312129423189, 4868.196747536652, 4868.221084626478, 4869.732164730938, 4898.461169271377, 4899.216125419951, 5493.972530137364, 5627.536840421479, 5632.577556683265, 5634.774609015634, 5656.208130861642, 4086.12148388095, 4118.91762164758, 4123.9381409278885, 4126.225722939165, 4129.504459464853, 5715.199872017921, 5861.941380586225, 5869.266341707286, 5904.468597826173, 5930.584859059867, 4092.447519584818, 4099.467069281034, 4116.423700681907, 4117.135401565704, 4135.379693046068, 4181.038361176947, 4188.6649068074485, 4197.9370309445385, 4198.979005104955, 4199.097194103282, 4615.930761038587, 4752.239641657387, 4779.426468823764, 4788.0, 4855.223164293696, 5673.290838645169, 5676.347220069662, 5680.346760122557, 5702.800401985994, 5704.771809127671, 1404.6277736399861, 1415.8654927781845, 1416.1644629668544, 1422.4168091082606, 1424.3661570600982, 931.487681775021, 950.9286803489766, 952.2667545989549, 968.9467079310706, 976.0, 5246.63273570854, 5248.711320877312, 5325.360956685223, 5343.145096784496, 5381.246625472437, 5588.105903055492, 5602.607817452821, 5625.831225063254, 5635.6618602883955, 5655.293088363955, 4976.939182402796, 5310.4424035476495, 5310.840674779763, 5312.256284120226, 5360.303160589098, 2967.4213528362193, 2968.3618022124915, 2976.7320941115404, 2978.9702102979127, 2979.657339405996, 5784.479396854304, 5832.854178645568, 5844.726952906386, 5846.590738648339, 5879.882402351929, 5674.432556744293, 5993.250843644544, 6023.578349515492, 6028.156058151774, 6038.939610603926, 6061.333253342129, 6119.418655227746, 6138.754449821957, 6148.815535533941, 6154.815355539252, 5583.497485226349, 5779.566532510163, 5830.708464576669, 5874.618149820248, 5916.55625828056, 5710.202715194349, 5768.855778605568, 5776.624519406225, 5784.50831679312, 5788.334341550775, 5856.209411729533, 5944.256967879015, 5985.162077309094, 5995.2206213192, 5996.610220335664, 4063.288924438152, 4077.4291599175544, 4080.469538959916, 4096.40602112698, 4104.404861295156, 5756.30924289088, 5840.970795145997, 5873.500752436091, 5880.470757631833, 5909.23179986599, 5674.375818659862, 5690.345610254708, 5702.258706368146, 5716.514096301861, 5717.514011309086, 5668.26312579362, 5669.886602268014, 5681.892031053905, 5685.630434021941, 5690.605801578639, 5389.912265371025, 5566.91649625264, 5588.497035266845, 5631.465010823965, 5641.182028605747, 5680.460356266148, 5680.517156041783, 5699.943000570107, 5701.771929122789, 5747.5689323300085, 5577.581681373832, 5578.3584887738425, 5589.608727389043, 5612.8877422450505, 5617.32592088952], "value": 4310.965682241186, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7365748330602, 733.47922974688, 754.6000619671572, 820.6594263380699, 825.7192554531458, 14547.05444146131, 15083.09501429915, 15099.924500377496, 15100.395984160648, 15120.848791512082, 13726.931365343184, 13863.722725545484, 13865.237411942338, 13873.306334683275, 13883.722325553508, 653.1280740211799, 669.621663759974, 747.9326860582546, 755.3428517190025, 755.7317152410898, 756.3457609168086, 757.5454727163713, 757.6022588141242, 758.6510205305566, 760.4182800157884, 810.9107998120202, 812.695239285268, 812.7683610171102, 813.0365516862507, 818.2431251092745, 797.9880301795478, 805.7743831727155, 807.1726480357622, 808.1191501263621, 809.7975506123469, 590.0205658606735, 591.4676790888192, 591.8342863998088, 592.0261170374753, 593.6497466494789, 13737.313134343243, 13755.724885502234, 13903.930480347635, 13931.860681393158, 14172.149671019668, 13448.932755336258, 13708.080868678393, 13768.485466598666, 14114.576562703136, 14492.130472171599, 11409.429528523624, 11477.540898364055, 11572.884271157349, 11648.359340236284, 11771.823422648667, 3687.9815600922093, 3700.962990370089, 3718.0890681783135, 3770.453284273765, 3827.2345530893654, 59662.40337596612, 60060.39939600635, 60067.39932600662, 60179.39820601782, 62072.06891896625, 10835.945820270848, 10855.2401331906, 10943.726406839733, 10961.616343427942, 11065.834012489819, 19604.411867643994, 19833.702494462595, 19876.0, 20027.399178024683, 20044.0, 8129.593520323961, 8228.177182281725, 8324.500529968222, 8395.748127556182, 8458.915410845935, 4100.097978444737, 4141.979290103591, 4194.0563373240775, 4291.549387314287, 4328.242557552416, 3366.5455163553097, 3449.034270404291, 3451.6720911513366, 3454.360943225511, 3456.395130852141, 604.9546284028715, 605.6759633596005, 616.556079622671, 624.1137584629837, 635.536058677159, 620.7734177025353, 652.3443938841529, 676.1210426445601, 690.19247480447, 695.3220609905403, 8647.135286471428, 9245.399049061789, 9364.297677674202, 9369.578368973413, 9503.429794212369, 630.870671512348, 659.9571027883268, 662.2417332154656, 673.5958424944994, 674.6559254780097, 4247.5964783345535, 4427.690061695715, 4442.489113751895, 4445.570576165404, 4468.3074123510905, 78533.0, 88934.0, 91249.0, 92443.0, 92678.53660731654, 60414.39585604176, 78946.0, 79101.0, 79722.6013869927, 80899.0, 70424.94362584566, 71013.64493177604, 72991.0, 73718.63140684369, 73770.63114684392, 8368.24685778283, 8544.0, 8600.870986935326, 8648.751324655508, 8649.697260595849, 50128.49871501384, 50411.99176016532, 50541.72562234635, 50586.0, 50842.74578627083, 66261.33738662745, 67101.66449167723, 67125.99311010436, 67264.0, 69506.65246673937, 10724.142068634646, 10765.677029689123, 10846.457677115955, 10857.728556786144, 10869.29349592274, 12013.339266340436, 12018.158728888893, 12164.209326393757, 12167.2699638022, 12279.938600306941, 11173.888261117285, 11538.480768365276, 11546.13403994687, 11616.651500455, 11933.641990739945, 11195.552177912792, 11342.829857552308, 11604.593839215588, 11614.825777613512, 11746.941265293619, 11072.39101849406, 11092.445377730919, 11111.888881111408, 11379.886201137882, 11502.424878756196, 9561.330706850455, 9625.51872406363, 9681.70954871355, 9930.304878658424, 9932.602695892083, 9497.335186536877, 9916.206703463562, 10006.44964526929, 10013.849792252977, 10090.646827361006], "value": 6868.412162545554, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 112.0, 114.0, 113.0, 114.0, 114.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 136.0, 174.0, 143.0, 137.0, 128.0, 129.0, 144.0, 129.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 164.0, 173.0, 163.0, 163.0, 162.0, 167.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 107.0, 76.0, 78.0, 78.0, 76.0, 93.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 103.0, 84.0, 84.0, 83.0, 94.0, 83.0, 84.0, 101.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 119.0, 117.0, 120.0, 118.0, 121.0, 117.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 56.0, 54.0, 60.0, 53.0, 55.0, 63.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 66.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 81.0, 85.0, 88.0, 82.0, 86.0, 83.0, 80.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 131.0, 147.0, 144.0, 143.0, 145.0, 140.0, 136.0, 181.0, 151.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 169.0, 171.0, 166.0, 169.0, 163.0, 161.0, 164.0, 170.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 71.0, 64.0, 67.0, 63.0, 64.0, 67.0, 64.0, 64.0], "value": 65.5, "unit": "score"}]}]} 22:28:23 INFO - Return code: 0 22:28:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:28:23 ERROR - # TBPL SUCCESS # 22:28:23 INFO - Running post-action listener: _resource_record_post_action 22:28:23 INFO - [mozharness: 2016-11-24 06:28:23.166221Z] Finished run-tests step (success) 22:28:23 INFO - Running post-run listener: _resource_record_post_run 22:28:23 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 393093120; Read time: 0; Write time: 318664 22:28:23 INFO - TinderboxPrint: CPU usage
13.4% 22:28:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:28:23 INFO - TinderboxPrint: I/O write bytes / time
393,093,120 / 318,664 22:28:23 INFO - TinderboxPrint: CPU idle
8,261.0 (86.6%) 22:28:23 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 22:28:23 INFO - TinderboxPrint: Swap in / out
0 / 0 22:28:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103735296; Read time: 0; Write time: 86156 22:28:23 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288890880; Read time: 0; Write time: 232488 22:28:23 INFO - Running post-run listener: _upload_blobber_files 22:28:23 INFO - Blob upload gear active. 22:28:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:28:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:28:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:24 INFO - (blobuploader) - INFO - Done attempting. 22:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:28 INFO - (blobuploader) - INFO - Done attempting. 22:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:28 INFO - (blobuploader) - INFO - Done attempting. 22:28:28 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:28 INFO - Return code: 0 22:28:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:28:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b1d3cd3f0f17403d7086b819e69ea05457ce939e056276a9b81e72a6b50ef5c99bec09819f8a15d1eb4a0e1d3f66fc55e4a588fbf55d6d97903848757f035c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c5985bbf1b17410dad3d266b4ef7bbe620b70f29d66e1fff8c0a4acf3184565f3a1932580fe18b1d2dc972f506e64728b1ba78460cb834b62da20ed4336eb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b783287e0d4446d66f8c9c08f34fc3510111c038e7f0bb1697aa5370bb663cb70caf408a9d95b4e36e0f9b01e7503fb15157d722ac2fba564f42efb15e88f01f"} 22:28:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:28:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:28:28 INFO - Contents: 22:28:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b1d3cd3f0f17403d7086b819e69ea05457ce939e056276a9b81e72a6b50ef5c99bec09819f8a15d1eb4a0e1d3f66fc55e4a588fbf55d6d97903848757f035c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c5985bbf1b17410dad3d266b4ef7bbe620b70f29d66e1fff8c0a4acf3184565f3a1932580fe18b1d2dc972f506e64728b1ba78460cb834b62da20ed4336eb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b783287e0d4446d66f8c9c08f34fc3510111c038e7f0bb1697aa5370bb663cb70caf408a9d95b4e36e0f9b01e7503fb15157d722ac2fba564f42efb15e88f01f"} 22:28:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:28 INFO - Copying logs to upload dir... 22:28:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:28:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.789063 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 22:28:28.534506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 22:28:28.538278) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b1d3cd3f0f17403d7086b819e69ea05457ce939e056276a9b81e72a6b50ef5c99bec09819f8a15d1eb4a0e1d3f66fc55e4a588fbf55d6d97903848757f035c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c5985bbf1b17410dad3d266b4ef7bbe620b70f29d66e1fff8c0a4acf3184565f3a1932580fe18b1d2dc972f506e64728b1ba78460cb834b62da20ed4336eb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b783287e0d4446d66f8c9c08f34fc3510111c038e7f0bb1697aa5370bb663cb70caf408a9d95b4e36e0f9b01e7503fb15157d722ac2fba564f42efb15e88f01f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011748 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479956046/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b1d3cd3f0f17403d7086b819e69ea05457ce939e056276a9b81e72a6b50ef5c99bec09819f8a15d1eb4a0e1d3f66fc55e4a588fbf55d6d97903848757f035c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c5985bbf1b17410dad3d266b4ef7bbe620b70f29d66e1fff8c0a4acf3184565f3a1932580fe18b1d2dc972f506e64728b1ba78460cb834b62da20ed4336eb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b783287e0d4446d66f8c9c08f34fc3510111c038e7f0bb1697aa5370bb663cb70caf408a9d95b4e36e0f9b01e7503fb15157d722ac2fba564f42efb15e88f01f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 22:28:28.570750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:28:28.571307) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479967670.365772-2037508298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 22:28:28.655525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 22:28:28.655867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 22:28:28.656160) ========= ========= Total master_lag: 0.19 =========