builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1477352810.79 results: success (0) buildid: 20161024160719 builduid: 3b33295e1b354f05930363c1d9c31eea revision: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.789508) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.789994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.790274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.805157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.805493) ========= 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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 16:46:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-10-24 16:46:50 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.916029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.916352) ========= 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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:50.966611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 16:46:50.966962) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 --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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 16:46:51,038 truncating revision to first 12 chars 2016-10-24 16:46:51,039 Setting DEBUG logging. 2016-10-24 16:46:51,039 attempt 1/10 2016-10-24 16:46:51,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9cdd8ed1733a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 16:46:52,289 unpacking tar archive at: fx-team-9cdd8ed1733a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.639825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 16:46:52.620521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:52.620842) ========= script_repo_revision: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:52.621261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:52.621536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:46:52.629971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-24 16:46:52.630310) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:46:52 INFO - MultiFileLogger online at 20161024 16:46:52 in /builds/slave/test 16:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:46:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:52 INFO - {'append_to_log': False, 16:46:52 INFO - 'base_work_dir': '/builds/slave/test', 16:46:52 INFO - 'blob_upload_branch': 'Fx-Team', 16:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:52 INFO - 'branch': 'Fx-Team', 16:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:52 INFO - 'config_files': ('talos/linux_config.py',), 16:46:52 INFO - 'default_actions': ('clobber', 16:46:52 INFO - 'read-buildbot-config', 16:46:52 INFO - 'download-and-extract', 16:46:52 INFO - 'populate-webroot', 16:46:52 INFO - 'create-virtualenv', 16:46:52 INFO - 'install', 16:46:52 INFO - 'run-tests'), 16:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:52 INFO - 'download_minidump_stackwalk': True, 16:46:52 INFO - 'download_symbols': 'ondemand', 16:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:52 INFO - 'installer_path': 'installer.exe', 16:46:52 INFO - 'log_level': 'info', 16:46:52 INFO - 'log_name': 'talos', 16:46:52 INFO - 'log_to_console': True, 16:46:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:46:52 INFO - 'opt_config_files': (), 16:46:52 INFO - 'pip_index': False, 16:46:52 INFO - 'sps_profile': False, 16:46:52 INFO - 'sps_profile_interval': 0, 16:46:52 INFO - 'suite': 'dromaeojs', 16:46:52 INFO - 'system_bits': '32', 16:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:52 INFO - 'title': 'talos-linux64-ix-017', 16:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:52 INFO - 'use_talos_json': True, 16:46:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:52 INFO - 'work_dir': 'build'} 16:46:52 INFO - [mozharness: 2016-10-24 23:46:52.803014Z] Running clobber step. 16:46:52 INFO - Running pre-action listener: _resource_record_pre_action 16:46:52 INFO - Running main action method: clobber 16:46:52 INFO - rmtree: /builds/slave/test/build 16:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:53 INFO - Running post-action listener: _resource_record_post_action 16:46:53 INFO - [mozharness: 2016-10-24 23:46:53.243340Z] Finished clobber step (success) 16:46:53 INFO - [mozharness: 2016-10-24 23:46:53.243441Z] Running read-buildbot-config step. 16:46:53 INFO - Running pre-action listener: _resource_record_pre_action 16:46:53 INFO - Running main action method: read_buildbot_config 16:46:53 INFO - Using buildbot properties: 16:46:53 INFO - { 16:46:53 INFO - "project": "", 16:46:53 INFO - "product": "firefox", 16:46:53 INFO - "script_repo_revision": "production", 16:46:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:46:53 INFO - "repository": "", 16:46:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:46:53 INFO - "buildid": "20161024160719", 16:46:53 INFO - "stage_platform": "linux64-pgo", 16:46:53 INFO - "basedir": "/builds/slave/test", 16:46:53 INFO - "buildnumber": 1658, 16:46:53 INFO - "platform": "ubuntu64_hw", 16:46:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:46:53 INFO - "slavebuilddir": "test", 16:46:53 INFO - "branch": "fx-team", 16:46:53 INFO - "revision": "9cdd8ed1733a941de56c4d022400c3e4b2ce0d12", 16:46:53 INFO - "slavename": "talos-linux64-ix-017", 16:46:53 INFO - "builduid": "3b33295e1b354f05930363c1d9c31eea", 16:46:53 INFO - "repo_path": "integration/fx-team" 16:46:53 INFO - } 16:46:53 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:46:53 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 16:46:53 INFO - Running post-action listener: _resource_record_post_action 16:46:53 INFO - [mozharness: 2016-10-24 23:46:53.245808Z] Finished read-buildbot-config step (success) 16:46:53 INFO - [mozharness: 2016-10-24 23:46:53.245895Z] Running download-and-extract step. 16:46:53 INFO - Running pre-action listener: _resource_record_pre_action 16:46:53 INFO - Running main action method: download_and_extract 16:46:53 INFO - mkdir: /builds/slave/test/build/tests 16:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:46:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:46:53 INFO - Downloaded 1361 bytes. 16:46:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:46:53 INFO - Using the following test package requirements: 16:46:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:46:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:46:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'jsshell-linux-x86_64.zip'], 16:46:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:46:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:46:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:46:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:46:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:46:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:46:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:46:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:46:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:46:53 INFO - Http code: 200 16:46:53 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 16:46:53 INFO - x-amz-cf-id: itS12uHPOSy21M-31wkECISJv9WA_S-y8Ynrtj3uFxj-RvY_w7qJDw== 16:46:53 INFO - x-amz-replication-status: COMPLETED 16:46:53 INFO - x-amz-version-id: yDvNuWcVPzweL3inzTYhF2HTI6R8YQK8 16:46:53 INFO - Expected file size: 22021817 16:46:53 INFO - Obtained file size: 22021817 16:46:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:46:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:46:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:46:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:46:57 INFO - Http code: 200 16:46:57 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:46:57 INFO - x-amz-cf-id: n57nJz_vVKXBJI6wbTeKIml_werKCsPj5XkvFz6Lj_yRkVgJJLBjhg== 16:46:57 INFO - x-amz-replication-status: COMPLETED 16:46:57 INFO - x-amz-version-id: yDvNuWcVPzweL3inzTYhF2HTI6R8YQK8 16:46:58 INFO - Expected file size: 22021817 16:46:58 INFO - Obtained file size: 22021817 16:47:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:47:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:47:02 INFO - Http code: 200 16:47:02 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 16:47:02 INFO - x-amz-cf-id: _faQvNAv2dAJ3pT6j37x70xkIxvS84UBJW9uCUWa2rT0mwQ-pyiU8g== 16:47:02 INFO - x-amz-replication-status: COMPLETED 16:47:02 INFO - x-amz-version-id: 3TowWLeznLw.._tmdmRZ5wOkMhcAghWA 16:47:02 INFO - Expected file size: 14409028 16:47:02 INFO - Obtained file size: 14409028 16:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:47:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:47:03 INFO - Downloaded 59371378 bytes. 16:47:03 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:47:03 INFO - mkdir: /builds/slave/test/properties 16:47:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:47:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:47:03 INFO - Contents: 16:47:03 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:47:03 INFO - Running post-action listener: _resource_record_post_action 16:47:03 INFO - Running post-action listener: set_extra_try_arguments 16:47:03 INFO - [mozharness: 2016-10-24 23:47:03.969526Z] Finished download-and-extract step (success) 16:47:03 INFO - [mozharness: 2016-10-24 23:47:03.969754Z] Running populate-webroot step. 16:47:03 INFO - Running pre-action listener: _resource_record_pre_action 16:47:03 INFO - Running main action method: populate_webroot 16:47:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:03 INFO - '--tppagecycles', 16:47:03 INFO - '7'], 16:47:03 INFO - 'tests': ['tsvgm']}}, 16:47:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:47:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:47:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['damp', 'tps']}, 16:47:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'tests': ['damp', 'tps']}, 16:47:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['dromaeo_dom']}, 16:47:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['basic_compositor_video']}, 16:47:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:47:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['a11yr', 16:47:03 INFO - 'ts_paint', 16:47:03 INFO - 'tpaint', 16:47:03 INFO - 'sessionrestore', 16:47:03 INFO - 'sessionrestore_no_auto_restore', 16:47:03 INFO - 'tabpaint']}, 16:47:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['tsvgx', 16:47:03 INFO - 'tsvgr_opacity', 16:47:03 INFO - 'tart', 16:47:03 INFO - 'tscrollx', 16:47:03 INFO - 'cart']}, 16:47:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:47:03 INFO - 'tsvgr_opacity', 16:47:03 INFO - 'tart', 16:47:03 INFO - 'tscrollx', 16:47:03 INFO - 'cart']}, 16:47:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'talos_options': ['--disable-e10s'], 16:47:03 INFO - 'tests': ['tp5o']}, 16:47:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'tests': ['tp5o']}, 16:47:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'talos_options': ['--disable-e10s', 16:47:03 INFO - '--xperf_path', 16:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:03 INFO - 'tests': ['tp5n']}, 16:47:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:03 INFO - 'talos_options': ['--xperf_path', 16:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:03 INFO - 'tests': ['tp5n']}}, 16:47:03 INFO - 'talos.zip': {'path': '', 16:47:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:03 INFO - Running post-action listener: _resource_record_post_action 16:47:03 INFO - [mozharness: 2016-10-24 23:47:03.986767Z] Finished populate-webroot step (success) 16:47:03 INFO - [mozharness: 2016-10-24 23:47:03.986855Z] Running create-virtualenv step. 16:47:03 INFO - Running pre-action listener: _resource_record_pre_action 16:47:03 INFO - Running main action method: create_virtualenv 16:47:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:47: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 16:47:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:47:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:04 INFO - Using real prefix '/usr' 16:47:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:47:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:06 INFO - Installing pip.................done. 16:47:06 INFO - Return code: 0 16:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:47:06 INFO - Reading from file tmpfile_stdout 16:47:06 INFO - Output received: 16:47:06 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) 16:47:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47: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', 'pip>=1.5'] in /builds/slave/test/build 16:47: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 pip>=1.5 16:47:06 INFO - Using env: {'DISPLAY': ':0', 16:47:06 INFO - 'HOME': '/home/cltbld', 16:47:06 INFO - 'LANG': 'en_US.UTF-8', 16:47:06 INFO - 'LANGUAGE': 'en_US:en', 16:47:06 INFO - 'LOGNAME': 'cltbld', 16:47:06 INFO - 'MAIL': '/var/mail/cltbld', 16:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:06 INFO - 'MOZ_NO_REMOTE': '1', 16:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:06 INFO - 'NO_EM_RESTART': '1', 16:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:06 INFO - 'PWD': '/builds/slave/test', 16:47:06 INFO - 'SHELL': '/bin/bash', 16:47:06 INFO - 'SHLVL': '1', 16:47:06 INFO - 'TERM': 'linux', 16:47:06 INFO - 'TMOUT': '86400', 16:47:06 INFO - 'USER': 'cltbld', 16:47:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:06 INFO - '_': '/tools/buildbot/bin/python'} 16:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47: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 16:47:06 INFO - Cleaning up... 16:47:06 INFO - Return code: 0 16:47:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47: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 16:47: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 16:47:06 INFO - Using env: {'DISPLAY': ':0', 16:47:06 INFO - 'HOME': '/home/cltbld', 16:47:06 INFO - 'LANG': 'en_US.UTF-8', 16:47:06 INFO - 'LANGUAGE': 'en_US:en', 16:47:06 INFO - 'LOGNAME': 'cltbld', 16:47:06 INFO - 'MAIL': '/var/mail/cltbld', 16:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:06 INFO - 'MOZ_NO_REMOTE': '1', 16:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:07 INFO - 'NO_EM_RESTART': '1', 16:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:07 INFO - 'PWD': '/builds/slave/test', 16:47:07 INFO - 'SHELL': '/bin/bash', 16:47:07 INFO - 'SHLVL': '1', 16:47:07 INFO - 'TERM': 'linux', 16:47:07 INFO - 'TMOUT': '86400', 16:47:07 INFO - 'USER': 'cltbld', 16:47:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:07 INFO - '_': '/tools/buildbot/bin/python'} 16:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:07 INFO - Downloading/unpacking psutil>=3.1.1 16:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:09 INFO - Installing collected packages: psutil 16:47:09 INFO - Running setup.py install for psutil 16:47:09 INFO - building 'psutil._psutil_linux' extension 16:47:09 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 16:47:09 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 16:47:09 INFO - building 'psutil._psutil_posix' extension 16:47:09 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 16:47:09 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 16:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:09 INFO - Successfully installed psutil 16:47:09 INFO - Cleaning up... 16:47:09 INFO - Return code: 0 16:47:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47: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 16:47: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 16:47:09 INFO - Using env: {'DISPLAY': ':0', 16:47:09 INFO - 'HOME': '/home/cltbld', 16:47:09 INFO - 'LANG': 'en_US.UTF-8', 16:47:09 INFO - 'LANGUAGE': 'en_US:en', 16:47:09 INFO - 'LOGNAME': 'cltbld', 16:47:09 INFO - 'MAIL': '/var/mail/cltbld', 16:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:09 INFO - 'MOZ_NO_REMOTE': '1', 16:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:09 INFO - 'NO_EM_RESTART': '1', 16:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:09 INFO - 'PWD': '/builds/slave/test', 16:47:09 INFO - 'SHELL': '/bin/bash', 16:47:09 INFO - 'SHLVL': '1', 16:47:09 INFO - 'TERM': 'linux', 16:47:09 INFO - 'TMOUT': '86400', 16:47:09 INFO - 'USER': 'cltbld', 16:47:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:09 INFO - '_': '/tools/buildbot/bin/python'} 16:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:11 INFO - Installing collected packages: mozsystemmonitor 16:47:11 INFO - Running setup.py install for mozsystemmonitor 16:47:12 INFO - Successfully installed mozsystemmonitor 16:47:12 INFO - Cleaning up... 16:47:12 INFO - Return code: 0 16:47:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47: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 16:47: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 16:47:12 INFO - Using env: {'DISPLAY': ':0', 16:47:12 INFO - 'HOME': '/home/cltbld', 16:47:12 INFO - 'LANG': 'en_US.UTF-8', 16:47:12 INFO - 'LANGUAGE': 'en_US:en', 16:47:12 INFO - 'LOGNAME': 'cltbld', 16:47:12 INFO - 'MAIL': '/var/mail/cltbld', 16:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:12 INFO - 'MOZ_NO_REMOTE': '1', 16:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:12 INFO - 'NO_EM_RESTART': '1', 16:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:12 INFO - 'PWD': '/builds/slave/test', 16:47:12 INFO - 'SHELL': '/bin/bash', 16:47:12 INFO - 'SHLVL': '1', 16:47:12 INFO - 'TERM': 'linux', 16:47:12 INFO - 'TMOUT': '86400', 16:47:12 INFO - 'USER': 'cltbld', 16:47:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:12 INFO - '_': '/tools/buildbot/bin/python'} 16:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:14 INFO - warning: no files found matching '*.txt' 16:47:14 INFO - no previously-included directories found matching 'build' 16:47:14 INFO - no previously-included directories found matching 'dist' 16:47:14 INFO - no previously-included directories found matching '.git*' 16:47:14 INFO - Installing collected packages: jsonschema, functools32 16:47:14 INFO - Running setup.py install for functools32 16:47:14 INFO - warning: no files found matching '*.txt' 16:47:14 INFO - no previously-included directories found matching 'build' 16:47:14 INFO - no previously-included directories found matching 'dist' 16:47:14 INFO - no previously-included directories found matching '.git*' 16:47:14 INFO - Successfully installed jsonschema functools32 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47:14 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')]} 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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')]} 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:14 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 16:47:14 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 16:47:14 INFO - Using env: {'DISPLAY': ':0', 16:47:14 INFO - 'HOME': '/home/cltbld', 16:47:14 INFO - 'LANG': 'en_US.UTF-8', 16:47:14 INFO - 'LANGUAGE': 'en_US:en', 16:47:14 INFO - 'LOGNAME': 'cltbld', 16:47:14 INFO - 'MAIL': '/var/mail/cltbld', 16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:14 INFO - 'MOZ_NO_REMOTE': '1', 16:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:14 INFO - 'NO_EM_RESTART': '1', 16:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:14 INFO - 'PWD': '/builds/slave/test', 16:47:14 INFO - 'SHELL': '/bin/bash', 16:47:14 INFO - 'SHLVL': '1', 16:47:14 INFO - 'TERM': 'linux', 16:47:14 INFO - 'TMOUT': '86400', 16:47:14 INFO - 'USER': 'cltbld', 16:47:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:14 INFO - '_': '/tools/buildbot/bin/python'} 16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:14 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')]} 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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')]} 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:14 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 16:47:14 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 16:47:14 INFO - Using env: {'DISPLAY': ':0', 16:47:14 INFO - 'HOME': '/home/cltbld', 16:47:14 INFO - 'LANG': 'en_US.UTF-8', 16:47:14 INFO - 'LANGUAGE': 'en_US:en', 16:47:14 INFO - 'LOGNAME': 'cltbld', 16:47:14 INFO - 'MAIL': '/var/mail/cltbld', 16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:14 INFO - 'MOZ_NO_REMOTE': '1', 16:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:14 INFO - 'NO_EM_RESTART': '1', 16:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:14 INFO - 'PWD': '/builds/slave/test', 16:47:14 INFO - 'SHELL': '/bin/bash', 16:47:14 INFO - 'SHLVL': '1', 16:47:14 INFO - 'TERM': 'linux', 16:47:14 INFO - 'TMOUT': '86400', 16:47:14 INFO - 'USER': 'cltbld', 16:47:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:14 INFO - '_': '/tools/buildbot/bin/python'} 16:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:17 INFO - Downloading docopt-0.6.1.tar.gz 16:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:17 INFO - Running setup.py install for blobuploader 16:47:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:18 INFO - Running setup.py install for requests 16:47:18 INFO - Running setup.py install for docopt 16:47:18 INFO - Successfully installed blobuploader requests docopt 16:47:18 INFO - Cleaning up... 16:47:18 INFO - Return code: 0 16:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:18 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 16:47:18 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 16:47:18 INFO - Using env: {'DISPLAY': ':0', 16:47:18 INFO - 'HOME': '/home/cltbld', 16:47:18 INFO - 'LANG': 'en_US.UTF-8', 16:47:18 INFO - 'LANGUAGE': 'en_US:en', 16:47:18 INFO - 'LOGNAME': 'cltbld', 16:47:18 INFO - 'MAIL': '/var/mail/cltbld', 16:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:18 INFO - 'MOZ_NO_REMOTE': '1', 16:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:18 INFO - 'NO_EM_RESTART': '1', 16:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:18 INFO - 'PWD': '/builds/slave/test', 16:47:18 INFO - 'SHELL': '/bin/bash', 16:47:18 INFO - 'SHLVL': '1', 16:47:18 INFO - 'TERM': 'linux', 16:47:18 INFO - 'TMOUT': '86400', 16:47:18 INFO - 'USER': 'cltbld', 16:47:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:18 INFO - '_': '/tools/buildbot/bin/python'} 16:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:18 INFO - Running setup.py (path:/tmp/pip-SGFyoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:18 INFO - Running setup.py (path:/tmp/pip-nkf_sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:18 INFO - Running setup.py (path:/tmp/pip-bu4bJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:19 INFO - Running setup.py (path:/tmp/pip-mvtGx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:19 INFO - Running setup.py (path:/tmp/pip-HJ_8xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:19 INFO - Running setup.py (path:/tmp/pip-Chx4MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:19 INFO - Running setup.py (path:/tmp/pip-AKkeoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:19 INFO - Running setup.py (path:/tmp/pip-Ymzt1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:19 INFO - Running setup.py (path:/tmp/pip-X_WeKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:19 INFO - Running setup.py (path:/tmp/pip-_v_GGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:19 INFO - Running setup.py (path:/tmp/pip-VVMXY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:19 INFO - Running setup.py (path:/tmp/pip-ouXX4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:19 INFO - Running setup.py (path:/tmp/pip-7KcjwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:19 INFO - Running setup.py (path:/tmp/pip-jkBypB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:19 INFO - Running setup.py (path:/tmp/pip-ZeE9Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:19 INFO - Running setup.py (path:/tmp/pip-BwEBXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:19 INFO - Running setup.py (path:/tmp/pip-O5oGS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:20 INFO - Running setup.py install for manifestparser 16:47:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozcrash 16:47:20 INFO - Running setup.py install for mozdebug 16:47:20 INFO - Running setup.py install for mozdevice 16:47:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozfile 16:47:20 INFO - Running setup.py install for mozhttpd 16:47:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozinfo 16:47:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozInstall 16:47:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozleak 16:47:20 INFO - Running setup.py install for mozlog 16:47:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for moznetwork 16:47:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozprocess 16:47:21 INFO - Running setup.py install for mozprofile 16:47:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozrunner 16:47:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozscreenshot 16:47:21 INFO - Running setup.py install for moztest 16:47:21 INFO - Running setup.py install for mozversion 16:47:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:21 INFO - Cleaning up... 16:47:21 INFO - Return code: 0 16:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:21 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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:21 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 16:47:21 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 16:47:21 INFO - Using env: {'DISPLAY': ':0', 16:47:21 INFO - 'HOME': '/home/cltbld', 16:47:21 INFO - 'LANG': 'en_US.UTF-8', 16:47:21 INFO - 'LANGUAGE': 'en_US:en', 16:47:21 INFO - 'LOGNAME': 'cltbld', 16:47:21 INFO - 'MAIL': '/var/mail/cltbld', 16:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:21 INFO - 'MOZ_NO_REMOTE': '1', 16:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:21 INFO - 'NO_EM_RESTART': '1', 16:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:21 INFO - 'PWD': '/builds/slave/test', 16:47:21 INFO - 'SHELL': '/bin/bash', 16:47:21 INFO - 'SHLVL': '1', 16:47:21 INFO - 'TERM': 'linux', 16:47:21 INFO - 'TMOUT': '86400', 16:47:21 INFO - 'USER': 'cltbld', 16:47:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:21 INFO - '_': '/tools/buildbot/bin/python'} 16:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:22 INFO - Running setup.py (path:/tmp/pip-4JR1Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47: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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:22 INFO - Running setup.py (path:/tmp/pip-RjV6j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:22 INFO - Running setup.py (path:/tmp/pip-VuVoyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47: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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:22 INFO - Running setup.py (path:/tmp/pip-0JjBfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:22 INFO - Running setup.py (path:/tmp/pip-a5GfRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47: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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:22 INFO - Running setup.py (path:/tmp/pip-z6B9xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47: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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:22 INFO - Running setup.py (path:/tmp/pip-aT4mXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:22 INFO - Running setup.py (path:/tmp/pip-ciLWJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:22 INFO - Running setup.py (path:/tmp/pip-qwhT53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:22 INFO - Running setup.py (path:/tmp/pip-bImvez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 INFO - Running setup.py (path:/tmp/pip-K316MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:22 INFO - Running setup.py (path:/tmp/pip-W8U79P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:22 INFO - Running setup.py (path:/tmp/pip-eieZG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:22 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)) 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:22 INFO - Running setup.py (path:/tmp/pip-USXdN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:23 INFO - Running setup.py (path:/tmp/pip-8c1FEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47: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)) 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:23 INFO - Running setup.py (path:/tmp/pip-2DlGKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47: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)) 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:23 INFO - Running setup.py (path:/tmp/pip-sJcndq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47: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)) 16:47: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47: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)) 16:47: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:25 INFO - Downloading blessings-1.6.tar.gz 16:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:25 INFO - Installing collected packages: blessings 16:47:25 INFO - Running setup.py install for blessings 16:47:25 INFO - Successfully installed blessings 16:47:25 INFO - Cleaning up... 16:47:25 INFO - Return code: 0 16:47:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:25 INFO - Reading from file tmpfile_stdout 16:47:25 INFO - Current package versions: 16:47:25 INFO - argparse == 1.2.1 16:47:25 INFO - blessings == 1.6 16:47:25 INFO - blobuploader == 1.2.4 16:47:25 INFO - docopt == 0.6.1 16:47:25 INFO - functools32 == 3.2.3-2 16:47:25 INFO - jsonschema == 2.5.1 16:47:25 INFO - manifestparser == 1.1 16:47:25 INFO - mozInstall == 1.12 16:47:25 INFO - mozcrash == 0.17 16:47:25 INFO - mozdebug == 0.1 16:47:25 INFO - mozdevice == 0.48 16:47:25 INFO - mozfile == 1.2 16:47:25 INFO - mozhttpd == 0.7 16:47:25 INFO - mozinfo == 0.9 16:47:25 INFO - mozleak == 0.1 16:47:25 INFO - mozlog == 3.4 16:47:25 INFO - moznetwork == 0.27 16:47:25 INFO - mozprocess == 0.23 16:47:25 INFO - mozprofile == 0.28 16:47:25 INFO - mozrunner == 6.12 16:47:25 INFO - mozscreenshot == 0.1 16:47:25 INFO - mozsystemmonitor == 0.3 16:47:25 INFO - moztest == 0.7 16:47:25 INFO - mozversion == 1.4 16:47:25 INFO - psutil == 3.1.1 16:47:25 INFO - requests == 1.2.3 16:47:25 INFO - wsgiref == 0.1.2 16:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 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 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:25 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 16:47:25 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 16:47:25 INFO - Using env: {'DISPLAY': ':0', 16:47:25 INFO - 'HOME': '/home/cltbld', 16:47:25 INFO - 'LANG': 'en_US.UTF-8', 16:47:25 INFO - 'LANGUAGE': 'en_US:en', 16:47:25 INFO - 'LOGNAME': 'cltbld', 16:47:25 INFO - 'MAIL': '/var/mail/cltbld', 16:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:25 INFO - 'MOZ_NO_REMOTE': '1', 16:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:25 INFO - 'NO_EM_RESTART': '1', 16:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:25 INFO - 'PWD': '/builds/slave/test', 16:47:25 INFO - 'SHELL': '/bin/bash', 16:47:25 INFO - 'SHLVL': '1', 16:47:25 INFO - 'TERM': 'linux', 16:47:25 INFO - 'TMOUT': '86400', 16:47:25 INFO - 'USER': 'cltbld', 16:47:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:25 INFO - '_': '/tools/buildbot/bin/python'} 16:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 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)) 16:47:25 INFO - Cleaning up... 16:47:25 INFO - Return code: 0 16:47:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, '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': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', '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 16:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:47:25 INFO - Using env: {'DISPLAY': ':0', 16:47:25 INFO - 'HOME': '/home/cltbld', 16:47:25 INFO - 'LANG': 'en_US.UTF-8', 16:47:25 INFO - 'LANGUAGE': 'en_US:en', 16:47:25 INFO - 'LOGNAME': 'cltbld', 16:47:25 INFO - 'MAIL': '/var/mail/cltbld', 16:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:25 INFO - 'MOZ_NO_REMOTE': '1', 16:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:25 INFO - 'NO_EM_RESTART': '1', 16:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:25 INFO - 'PWD': '/builds/slave/test', 16:47:25 INFO - 'SHELL': '/bin/bash', 16:47:25 INFO - 'SHLVL': '1', 16:47:25 INFO - 'TERM': 'linux', 16:47:25 INFO - 'TMOUT': '86400', 16:47:25 INFO - 'USER': 'cltbld', 16:47:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:25 INFO - '_': '/tools/buildbot/bin/python'} 16:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:47:26 INFO - Cleaning up... 16:47:26 INFO - Return code: 0 16:47:26 INFO - Running post-action listener: _resource_record_post_action 16:47:26 INFO - Running post-action listener: _start_resource_monitoring 16:47:26 INFO - Starting resource monitoring. 16:47:26 INFO - [mozharness: 2016-10-24 23:47:26.168041Z] Finished create-virtualenv step (success) 16:47:26 INFO - [mozharness: 2016-10-24 23:47:26.168502Z] Running install step. 16:47:26 INFO - Running pre-action listener: _resource_record_pre_action 16:47:26 INFO - Running main action method: install 16:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:26 INFO - Reading from file tmpfile_stdout 16:47:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:26 INFO - Reading from file tmpfile_stdout 16:47:26 INFO - Output received: 16:47:26 INFO - Usage: mozinstall [options] installer 16:47:26 INFO - Options: 16:47:26 INFO - -h, --help show this help message and exit 16:47:26 INFO - -d DEST, --destination=DEST 16:47:26 INFO - Directory to install application into. [default: 16:47:26 INFO - "/builds/slave/test"] 16:47:26 INFO - --app=APP Application being installed. [default: firefox] 16:47:26 INFO - mkdir: /builds/slave/test/build/application 16:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:47:43 INFO - Reading from file tmpfile_stdout 16:47:43 INFO - Output received: 16:47:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:47:43 INFO - Running post-action listener: _resource_record_post_action 16:47:43 INFO - [mozharness: 2016-10-24 23:47:43.353604Z] Finished install step (success) 16:47:43 INFO - [mozharness: 2016-10-24 23:47:43.353880Z] Running run-tests step. 16:47:43 INFO - Running pre-action listener: _resource_record_pre_action 16:47:43 INFO - Running main action method: run_tests 16:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:47:43 INFO - Python 2.7.3 16:47:43 INFO - Return code: 0 16:47:43 INFO - grabbing minidump binary from tooltool 16:47: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')]} 16:47: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 0x2504790>, '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 0x2505690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2505b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:47: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 16:47: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 16:47: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 16:47:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:43 INFO - Return code: 0 16:47:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:47:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:47:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:47:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:47:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:47:43 INFO - Using env: {'DISPLAY': ':0', 16:47:43 INFO - 'HOME': '/home/cltbld', 16:47:43 INFO - 'LANG': 'en_US.UTF-8', 16:47:43 INFO - 'LANGUAGE': 'en_US:en', 16:47:43 INFO - 'LOGNAME': 'cltbld', 16:47:43 INFO - 'MAIL': '/var/mail/cltbld', 16:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:43 INFO - 'MOZ_NO_REMOTE': '1', 16:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:43 INFO - 'NO_EM_RESTART': '1', 16:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:43 INFO - 'PWD': '/builds/slave/test', 16:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:43 INFO - 'SHELL': '/bin/bash', 16:47:43 INFO - 'SHLVL': '1', 16:47:43 INFO - 'TERM': 'linux', 16:47:43 INFO - 'TMOUT': '86400', 16:47:43 INFO - 'USER': 'cltbld', 16:47:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736', 16:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:43 INFO - '_': '/tools/buildbot/bin/python'} 16:47:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:47:43 INFO - mozversion application_buildid: 20161024123133 16:47:43 INFO - mozversion application_changeset: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 16:47:43 INFO - mozversion application_display_name: Nightly 16:47:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:43 INFO - mozversion application_name: Firefox 16:47:43 INFO - mozversion application_remotingname: firefox 16:47:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:47:43 INFO - mozversion application_vendor: Mozilla 16:47:43 INFO - mozversion application_version: 52.0a1 16:47:43 INFO - mozversion platform_buildid: 20161024123133 16:47:43 INFO - mozversion platform_changeset: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 16:47:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:47:43 INFO - mozversion platform_version: 52.0a1 16:47:43 INFO - using testdate: 1477352863 16:47:43 INFO - actual date: 1477352863 16:47:43 INFO - starting webserver on 'localhost:39107' 16:47:43 INFO - SUITE-START | Running 2 tests 16:47:43 INFO - TEST-START | dromaeo_css 16:47:43 INFO - operating with platform_type : linux_ 16:47:43 INFO - Initialising browser for dromaeo_css test... 16:47:43 INFO - TEST-INFO | started process 4430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhbNNa/profile http://localhost:39107/getInfo.html) 16:47:47 INFO - PROCESS | 4430 | __metrics Screen width/height:1600/1200 16:47:47 INFO - PROCESS | 4430 | colorDepth:24 16:47:47 INFO - PROCESS | 4430 | Browser inner width/height: 1024/697 16:47:47 INFO - PROCESS | 4430 | __metrics 16:47:48 INFO - PROCESS | 4430 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:47:48 INFO - PROCESS | 4430 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:47:48 INFO - PROCESS | 4430 | console.error: PushService: 16:47:48 INFO - PROCESS | 4430 | stateChangeProcessEnqueue: Error transitioning state 16:47:48 INFO - PROCESS | 4430 | UnknownError 16:47:49 INFO - TEST-INFO | 4430: exit 0 16:47:49 INFO - Browser initialized. 16:47:49 INFO - Running cycle 1/1 for dromaeo_css test... 16:47:49 INFO - TEST-INFO | started process 4514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhbNNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:01 INFO - PROCESS | 4514 | RSS: Main: 172003328 16:48:01 INFO - PROCESS | 4514 | 16:48:53 INFO - PROCESS | 4514 | 1477352933150 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] 16:51:03 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39107/tests/dromaeo/cssquery-ext.html) 16:51:05 INFO - PROCESS | 4514 | RSS: Main: 278900736 16:51:05 INFO - PROCESS | 4514 | 16:54:07 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-ext.html (next: http://localhost:39107/tests/dromaeo/cssquery-jquery.html) 16:54:08 INFO - PROCESS | 4514 | RSS: Main: 278695936 16:54:08 INFO - PROCESS | 4514 | 16:57:10 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39107/tests/dromaeo/cssquery-mootools.html) 16:57:11 INFO - PROCESS | 4514 | RSS: Main: 275714048 16:57:11 INFO - PROCESS | 4514 | 17:00:13 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39107/tests/dromaeo/cssquery-prototype.html) 17:00:13 INFO - PROCESS | 4514 | RSS: Main: 256856064 17:00:13 INFO - PROCESS | 4514 | 17:03:16 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39107/tests/dromaeo/cssquery-yui.html) 17:03:17 INFO - PROCESS | 4514 | RSS: Main: 215650304 17:03:17 INFO - PROCESS | 4514 | 17:06:19 INFO - PROCESS | 4514 | Cycle 1(1): loaded http://localhost:39107/tests/dromaeo/cssquery-yui.html (next: http://localhost:39107/tests/dromaeo/cssquery-dojo.html) 17:06:20 INFO - PROCESS | 4514 | RSS: Main: 305377280 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | __start_tp_report 17:06:20 INFO - PROCESS | 4514 | _x_x_mozilla_page_load 17:06:20 INFO - PROCESS | 4514 | _x_x_mozilla_page_load_details 17:06:20 INFO - PROCESS | 4514 | |i|pagename|runs| 17:06:20 INFO - PROCESS | 4514 | |0;dojo.html;3062.3262882165923;3090.196548897286;3112.0197137901573;3124.6250449946;3136.7490600751926;5175.353080864892;5256.526912577867;5284.418713941468;5383;5411.404745478004;5304.416514183446;5305.177697456891;5323.041852466555;5345.385280692722;5397.2443857859935;4865.732384718839;4897.387826521676;4920.114379411704;4924.876878078059;4951.133551628469;4872.975344302362;4894.1679914414635;4945.134601444751;4958.6281028922795;4968.428630707461;4329.567043295677;4936.790486330854;4988.800447982095;4997.900041999158;5038.29463875056;4757.738324392157;4798.280257961299;4855.441624213226;4868.928835656186;4890.73100979446;4811.975940120277;4816.109019831308;4821.156297647897;4822.8794280143275;4824.011077729057;5309.52214300711;5341.866453338659;5347.304850369466;5369.570434365241;5372.462753724635;5720.141978703228;5720.542356611461;5721.284839395075;5725.08398656213;5726.026575482178;5739.540836733051;5764.221830052931;5767.826965191051;5770.79802206925;5772.105323674838;5330.600204984564;5352.437994010651;5352.464753524694;5368;5373.570114390839;5893.882122357614;5899.734511946973;5900.616459930091;5904.084866845646;5909.172715819703;5646.6894320811925;5646.745896434671;5658.151277308354;5658.575606829504;5659.490645841894;5608.355039170466;5667.234923285386;5669.149627555899;5721.542276617861;5736.827895163152;5713.428657134336;5733.455321744427;5737.741801618937;5791.247137872049;5801.187833703285;5749.080147176432;5749.655020698771;5751.022326204556;5752.13717942312;5779.797707080232;4288.785560721952;4320.4383430153875;4323.308270676676;4336.696431249782;4375.78121093944;3874.0702231464247;3884.786336751449;3909.5113110861143;3921.176552923861;3978.423128646388;5458.2904222450825;5463.153211252262;5463.617546771768;5465.699386533699;5469.288992430958;5777.537796976232;5779.248697669276;5782.739776710058;5791.797287095016;5852.795152169653;5324.334458192726;5360.839174824683;5391.137418013099;5410.702411367412;5432.375276843135;4996.300517927493;4998.4251811042195;5002.674826136289;5005.049040682259;5054.241863720398;5915.970420147872;5956.37458066914;5960.940390596039;5980.013297805987;6047.909281360783;5665.376808551138;5684.573656975661;5709.800156994485;5719.914201287067;5765.3946335634155;5975.970120149545;5985.790497332572;5986.311574169026;6017.247844019497;6059.818205453844;5670.971645141913;5672.319321681424;5676.460736230051;5680.71596420169;5689.943100569107;5625.46558076982;5684.062129748545;5715.542756579381;5791.044477661308;5801.709914504342;5597.328320601554;5617.101263797937;5663.8017669383025;5711.828645140652;5719.828405147852;5529.751161197836;5587.441255874543;5632.380438151882;5645.181448689999;5652.6043176978865;5503.752331145188;5553.611247212656;5575.972120139373;5579.581531385244;5623.044082506066;5598.272224610774;5652.7173641318595;5662.150677398423;5664.518515926027;5732.283464566929;5533.114701647717;5541.612087153861;5543.223948647112;5546.473085056913;5601.579881508822 17:06:20 INFO - PROCESS | 4514 | |1;ext.html;549.8516786648307;567.7047935073762;603.0140719922924;622.9845352076118;637.4963778614895;30513.237169070784;41287.79356103219;42143.99999999996;42211.36682949758;45716;44365.55634443655;44854;44869;44870.10259794802;44891.55108448915;8001.359891208718;8345.874811877828;8479.06730259674;8489.575521223946;8492.193241642035;7890.605469726519;10483.161347092215;10735.463226838667;10740.409277489734;11137.164712646543;10860.348379097279;10917;10928.617498387557;10928.945355273212;10929.071028962548;10770.569177232901;10842.13262938967;10843.945780271128;10858.565657373696;10865.891341086646;10515.73710657232;10585.888481709386;10588.100011499031;10588.735281617945;10595.364278143335;41520.79239603813;41891;41926.580734192576;41955.37066943998;41956.58043419557;3074.4158609864053;3233.725133363667;3298.7690861639694;3310.619278782947;3374.7176073092314;29590.556141657893;31827.363452731046;32046.198845028826;32162;33667.474939379645;4237.200021785098;4246.193223287565;4311.762853043113;4325.3728209409455;4454.844080457201;347938;348781.25609372044;349503;349693;351897;33602.495962560584;58172.418275817545;58459;58541.70729146327;58646.41353586495;34194.31611367759;35907.281854362765;36299.4555081674;36309.27381452356;36353.272934541164;14649.487267945571;14757.40970361195;14763.63090922714;14769.556913292618;14778.556643300719;10465.372077675363;10534.789304214026;11884;12291.56979505713;12384.256944583174;8060.153683863227;8102;8139.186081391932;8188.590570471452;8265.256126948603;3175.4284228839033;3201.599800024997;3209.470437377853;3209.743220542351;3249.1552196429097;968.1577027985697;977.8924318324979;986.2405947420447;1000.7648202672366;1064.973375665599;31719.365612688078;31909;31959.68040319567;32221;32522.349553008808;1023.1047833145997;1065.414022287754;1074.785042991405;1100.8568886044764;1118.9384583847966;15792.605184870241;16546.58633534171;16772.32910683559;16791.2443940023;16806.32774689023;505768;512339;512754;512799;513281;56444.71777641086;57272;57283.42716572781;57296.71351643299;57327;1161.3960740415105;1196.3121205306984;1253.931033793132;1286.5239861251398;1322.0547308674345;30922.381552368377;32851.67148328582;33045.17387065342;33264;33817.83091084529;47906;48235.276470852266;48465.5153448461;48485;48538.757306214655;381180;381255;382703;383795;386300;26588.202353929413;27665;27676.58485122765;28537.28656783597;28903.7109628901;44851;45188.09623807571;46042.30936536022;46213;47100.52899470962;38321;38393.23213535658;38483.230335393695;39231.6076839228;40168.59831401648;38448.6155138445;39181;39437.80281098576;40362.394564080976;40629.593704063765;39278.2144357117;39898.40152397658;40053.799731001156;40205.597944020185;41238;32554.186145346557;34419.4837077439;34868.302633947686;34961.12597185091;35119.12202194965;26719.599206011535;27089.322766930196;27656.723432765415;28070.000199772683;28195.731192095995 17:06:20 INFO - PROCESS | 4514 | |2;jquery.html;364.1733265487342;377.55825683949786;379.02590342818957;382.2259923654599;395.53327074052606;14251.64370890727;18207;18446.907765461154;18484.260629574834;19560.804391956113;16911.713469444643;17170.22733976971;17170.57073573158;17215.22531486083;17396.39112631058;5599.664020158783;5800.245968024172;5829.417058294179;5832.037713777222;5836.5914385993;5511.311086114236;5641.576881733887;5691.459311365414;5788.536917046647;5789.623674461168;5636.971815140939;5646.943530564703;5648;5652.293463317085;5654.688992105433;5465.07093794056;5648.322201335845;5650.943490565103;5667.914981275284;5713.228714123582;5100.489951004907;5101.642884998052;5104.05574968632;5104.668196567249;5106.974465127688;21264.78735212659;21685.67471487929;21883;21993.890030549905;22202.66695999561;2200.6919031335624;2311.133325003124;2752.779777617786;2753.3804893898914;2856.5001124803075;13431.246594448116;13716.382762775698;14153.08004979673;14539.70920581593;14558.417663293456;1874.681304178293;1913.540750219937;1930.7007413850877;1976.170008596393;1985.2356842615552;79071;81155.5942220291;82428.17571824265;82470;84149;9017.729468115967;9071.954640226757;9882.901170988342;10130.138938190335;10329.74175645615;14322.713545729235;14348.139111653334;14379.928100359431;14388.352524136439;14390.28048597566;7541.472096953161;7835.294823465915;7858.292753652198;7939.880901786478;8016.198380161937;7573.924260757432;7698.653560589787;7853.253940875607;7887.48731332473;7889.526628402315;6079.483243924316;6249.7187626556915;6261.7182226799;6315.684215789192;6357.364263573698;1876.981230187708;1885.7265696473935;1903.7715474143192;1907.7901430842596;1941.1268126258228;755.3239850333921;858.6994551906782;897.4570384917162;910.2581396162107;1042.1610603464285;17652.646947060988;19164.137613807412;19398.70901936472;19741.21035158606;19754;991.9782623897397;1014.6550172941236;1020.1889497849228;1022.8568000479938;1058.439027315524;10456.26806123564;10489.737756556147;11264.605738799102;11374.203805733685;11378.146639002109;422383;425028;444976;445580;447657;90337;90519;91765.54117229371;92234.53882730543;92676.53661731783;1041.151461558812;1044.5404022230193;1047.1099565369375;1051.6529545250048;1055.3931489393628;16302;16555.83444165543;16747.24637391296;17004.574885627462;17562.648747024734;41241.58758412497;41516.79241603773;42065.57934420739;42190.367144492244;42792.144157117305;56790.716046419504;57885.71057144687;58543;58596.70701646464;59274.407255928614;5519.724013799374;6780.559263647847;7339.339459448462;7429;7988.480748751313;10495.947520262655;12257.142000060267;12367;12620;12626.684332891751;10615.150787936793;10790;10804.919508049132;11135.944320278346;11150.442477876237;10640.680779576625;10859.185561082792;10862.837057443987;11039.668809935714;11659;11021.173411993972;11295.548178072784;11318.660440186808;11459.656210313704;11621.186516943733;7441.516301440389;7594.772156835304;7694.538327700356;7759.806004849924;7865.056193256846;10517.9474102629;10872.238943273895;10984.670459886216;11210.43947802623;11517.366544840113 17:06:20 INFO - PROCESS | 4514 | |3;mootools.html;1459.7007613439243;1504.5110339139778;1616.280755063997;1710.760493530905;1775.85793136549;7926.326262267699;8220.83558328833;8657.523836189008;9351.859722104175;9353.392029518085;8606.87089693655;8892.91107088929;8943.597538110784;9132.726018219448;9143.268538516902;2316.3166865774597;2345.097137602027;2345.5191685704476;2349.3304408243566;2356.705411823522;2002.669559522677;2071.4510654676446;2318.6406107053435;2340.4031971847157;2362.492064206195;2233.3188377544843;2295.4605667668084;2305.2853615379204;2306.815454763623;2315.8842057897036;2334.3697201755517;2336.7663233676494;2343.8124950004044;2362.11420717231;2368.8933997970134;2322.8606283623035;2324.5583339165505;2334.568104900599;2346.0498498108295;2349.706286714161;8871.334649901282;9021.233195178418;9022.368434209608;9026.368154229207;9035.18683318498;5091;5208.661437006583;5226.686398816083;5230.032443997872;5230.110881150214;3446.0867870014467;3538.628444013393;3611.656892595199;3664.743467957244;3674.1182116292166;1135.659302209342;1181.2794195540714;1191.7973944429468;1201.9338936358497;1218.074263559701;12804.42380092898;12804.743905121939;12808.423620937081;12816.231026138368;12818.679533011657;4369.650427965755;4592.97703511487;4654.394928659321;4718.079974405026;4724.126036683225;10760.139188864872;10779.191560632984;10783.568657253621;10786.137109031259;10791.6222932197;5251;5252.5535329497425;5254.028004819121;5260.736963151904;5261.237120617489;4801.039792041605;4837.4920633333695;4860.659753817199;4863.440704319049;4869.440014398389;3852.8266228019806;3970.741901776433;3972.7616343019513;4010.318245898146;4046.959530404717;1192.9045676345872;1243.359669770069;1258.282778816066;1298.7662220800346;1301.342821874966;770.1143684762455;778.1401551285861;855.170484629908;911.4941207629829;923.7598224461689;5431.456854314537;5493.2034854945805;5637.126245431965;5837.066069428871;5975.25309336333;931.2131249094505;934.5327336331834;936.864154697565;958.9952050239705;999.6801023672355;3606.567211934532;3720.6465385788306;3892.3966785148345;3962.643362097425;4013.3779264214095;10895.509702063426;11300.321980681185;11309.886901131047;11320.773584528428;11325;10597.20520960931;11045.944770276097;11212.046976006968;11223.66329010131;11225.550977960953;8105.067917189599;8322.250997410141;8323.750287491384;8328.167183281745;8328.458650187718;5838.416158384128;5913.645181289136;5988.730507127103;6032.788852390146;6315.305316415099;9987.950060249652;10332.638357657446;10367.481625918825;10452.790944181226;10602.886696896714;10415.479226038819;10556.84164737545;10597.9470102649;10688.572457101629;10728.946355268174;7778;7875.606219689107;7886.566238856918;7967.84064318722;7970.003749531309;8443.324534037385;8537.274331681876;8621.956890215508;8628.266597339296;8630.439021463584;7727.49771264866;7731.652075656497;7748.883766743616;7803.7268695595385;8109.10799812032;7445.4043676506835;7651;7665.271799179069;7728.729494467667;7944.285014348737;6628.53600247978;6650.73397064112;6690.59856408617;6712.53012289135;6712.664366781543;4860.6111511078325;4952.133376658998;4999.47505511916;5025.6482046256415;5062.746862656926;4772.546608072227;5145.202493613496;5182.170852663556;5260.73696315175;5492.972535137299 17:06:20 INFO - PROCESS | 4514 | |4;prototype.html;325.30547281553885;330.6808929383146;334.4815535919324;340.32275771215274;342.9245565975485;5065.024640390242;5224.63427560071;5258.316418865547;5269.156934890409;5295.338082739658;5084.686467657217;5180.300659410978;5190.766415511302;5210.921836172461;5218.47815218478;4111.15721277139;4116.917661646765;4121.9381709274385;4125.339945608704;4136.462259906208;3944.6252606002386;4123.443335149761;4124.8968775780695;4133.855315063958;4147.979260103695;4032.879013629581;4100.913257986636;4107.322291821846;4108.383742438628;4112.609302116309;4086.7752273624938;4096.221717873595;4096.586677596225;4100.5489396166395;4112.136451345221;3624.8368823402748;3631.691306238973;3638.5997540270814;3640.362936486131;3656.1042544576485;5126.744232537671;5158.2520534522655;5183.948160518385;5196.272521846944;5205.167173252262;4675.322078298662;4702.224133018048;4714.811407543694;4737.715737055788;4739.36018637483;5490.588205884575;5490.917636235459;5492.80775172871;5505.917411238835;5533.861653458655;3745.3445647011936;3904.3362628353248;3918.804059797027;3923.293807114718;3934.940975885364;5689.687067211302;5707.886962042403;5718.485336319751;5726.455986681301;5732.455416735404;4068.2880495913096;4095.488063992001;4102.528209255914;4103.5691252418665;4126.628603425646;3875.806209689504;4009.939850902239;4014.9397759033636;4033.616806403387;4169.728967617095;4631.397918270603;4647.256438969816;4652.418447694038;4658.464276608166;4679.508651591534;5531.668099913937;5532.5297349724915;5536.944630553643;5584.274044374287;5585.273914391103;1338.1569611144917;1348.157401623985;1420.5312246958686;1421.7725163973714;1423.9320509617787;884.5754038061766;914.9039350868063;921.7050543826045;922.9723108306762;938.7889622387181;4708.340832283483;4741.739204343725;4741.857744267678;4755.667103302736;4757.26262429324;4938.987507560942;4950;4974.303597496281;4979.278004689372;4986.678530189502;4530.569595888385;4678.8596342109795;4695.38009386761;4725.3384526166365;4742.596879265301;2616.7775739062395;2631.7236690147643;2633.0126202673996;2633.4469761350333;2660.6031833287293;5082.237664350303;5102.33669622954;5110.770015349244;5131.230315452712;5141.280220769096;4735.739534325645;4992.301077849104;5059.165237735732;5079.542841144241;5080.314157588752;5074.2895994560795;5145.819896303687;5163.302954101148;5169.327987361619;5170.276161337416;4939.987302602886;4941.97529012367;4952.257161425671;4965.900681986268;5000.649824547279;4920.1954885714795;4936.580390666833;4961.610748990289;5251.109600543878;5619.606627536034;5873.179314412546;5892.705364731832;5892.793752218652;5895.7052147393315;5899.321578018583;4097.938530921979;4130.318497447887;4131.50421949368;4153.854615088458;4162.5629308922125;5361.731913404392;5655.688937108499;5690.943090569207;5691.857703557444;5810.244668193108;5359.998400895511;5423.5932305076485;5529.198266251451;5543.1685247213245;5552.5557955362665;5557.777688892399;5562.165675148598;5566.693831839288;5566.749496272759;5576.888462230814;5350.8127215547265;5486.875190586;5503.367112782082;5512.145617429305;5539.892021595778;5520.36515800672;5542.63972841764;5545.72271386421;5548.167774833807;5562.276904002454;5431.511163995259;5471.72641367938;5475.75359108849;5476.780928762805;5481.451854814487 17:06:20 INFO - PROCESS | 4514 | |5;yui.html;663.5324922637469;704.7462913351196;746.9365103966163;796.3788245168768;813.1258896686062;14336.426542938283;15159.772603410931;15185.696286074299;15188.392464301414;15209.923950380247;15169;15174.696506069871;15215.695686086272;15233.542993710178;15269.312880920357;655.9409653131218;664.6012392564447;672.579637726421;790.1979490816825;809.3646487507308;669.4309836638843;672.6266921858366;781.890535325055;790.075611534506;790.8932294140303;848.9787755306105;857.2456238510102;859.4886042804521;861.0356400831078;861.0614430271004;846.0566468387765;851.1786126388065;851.9872201916976;856.1224744636735;858.716623514245;503.88914438823764;510.3594988289673;628.8144997225829;628.9182406287199;628.996855015722;13772.724545509134;14224.431022759078;14225.502107426191;14646.780298295535;14659.34032968519;14409.495667651687;14983.063960206588;15064.774028389584;15131.54605361841;15235.771463428058;12131.818022729665;12138.575149869712;12189.390530473442;12318;12505.249685018927;3772.641599048086;3792.715546334008;3889.2610404023144;3893.357595996657;4013.618706222904;79121.20878791196;79619;80029.19970800333;80040.59979700064;80584.19415805825;10267.486625668836;10284.537195826206;10351.43067131315;10407.791844163226;10622.097121744739;20462.897685511478;20486.18055277802;20556.177752890017;20579.279725209846;20602.58794824095;8388.916110838814;8441.620127094295;8493.405461617627;8605.139486051345;8668.78328041804;4704.270838020112;4722.079194557097;4742.73914934675;4797.184109763858;4894.070126675921;3547.130952916552;3636.090977255686;3650.8904732857527;3672.706183505313;3685.760425572329;618.554640658725;638.6551262318296;645.3997782062727;650.6226388694546;660.0462331930411;563.745665893384;643.5816719132507;645.0002496130978;662.3409707341131;664.833791552112;8667.991650603699;9498.810023799486;9677.274204434696;9686.273529485317;10345.431001295;534.4628648208526;614.6005096687189;624.6033768556999;640.1326202994875;646.7703965092419;4245.257080010986;4474.686771925999;4486.910261794811;4500.909981800346;4522.88692782683;122503;125079;126941.36529317294;128611;131050.34474827565;106417;106947;107661;109937;111067;83237;92645.53677231705;94462.52768736113;95019.04980950241;95213;8350.749477515685;8403.327733781405;8507.361947853811;8605.784855378666;8982.955085224532;54529.45470545244;54694;55243;56302;56839.05316569501;81159;83408;84087;86078.56960715157;88791.55604221938;12321.260724356567;12325.383730813603;12333.137268585357;12411.131220814455;12533;12813.231206127663;13445.193288402726;13634;13786.862131378557;14173.574792756233;12551.748965020466;12652.304123273309;13178.27519486399;13563.59309220725;13813.723725525635;11994.94508019435;12679.683007924876;12763.48946042185;12819.359032048547;12939.417726202155;12758.29829359357;12895.41970611306;13153.276569788371;13717.17696938187;13977.298019140644;10595.682129536126;10609.681709548726;10920.399378033966;11048.502817373077;11079.279846809932;10668.519916603927;11524.711882203012;11646.8935451132;11650.70873228176;11793.941030294794 17:06:20 INFO - PROCESS | 4514 | __end_tp_report 17:06:20 INFO - PROCESS | 4514 | __start_cc_report 17:06:20 INFO - PROCESS | 4514 | _x_x_mozilla_cycle_collect,1384 17:06:20 INFO - PROCESS | 4514 | __end_cc_report 17:06:20 INFO - PROCESS | 4514 | __startTimestamp1477353980240__endTimestamp 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | ------- Summary: start ------- 17:06:20 INFO - PROCESS | 4514 | Number of tests: 6 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#0] dojo.html Cycles:165 Average:5335.49 Median:5575.97 stddev:615.53 (11.0%) stddev-sans-first:591.02 17:06:20 INFO - PROCESS | 4514 | Values: 3062.3 3090.2 3112.0 3124.6 3136.7 5175.4 5256.5 5284.4 5383.0 5411.4 5304.4 5305.2 5323.0 5345.4 5397.2 4865.7 4897.4 4920.1 4924.9 4951.1 4873.0 4894.2 4945.1 4958.6 4968.4 4329.6 4936.8 4988.8 4997.9 5038.3 4757.7 4798.3 4855.4 4868.9 4890.7 4812.0 4816.1 4821.2 4822.9 4824.0 5309.5 5341.9 5347.3 5369.6 5372.5 5720.1 5720.5 5721.3 5725.1 5726.0 5739.5 5764.2 5767.8 5770.8 5772.1 5330.6 5352.4 5352.5 5368.0 5373.6 5893.9 5899.7 5900.6 5904.1 5909.2 5646.7 5646.7 5658.2 5658.6 5659.5 5608.4 5667.2 5669.1 5721.5 5736.8 5713.4 5733.5 5737.7 5791.2 5801.2 5749.1 5749.7 5751.0 5752.1 5779.8 4288.8 4320.4 4323.3 4336.7 4375.8 3874.1 3884.8 3909.5 3921.2 3978.4 5458.3 5463.2 5463.6 5465.7 5469.3 5777.5 5779.2 5782.7 5791.8 5852.8 5324.3 5360.8 5391.1 5410.7 5432.4 4996.3 4998.4 5002.7 5005.0 5054.2 5916.0 5956.4 5960.9 5980.0 6047.9 5665.4 5684.6 5709.8 5719.9 5765.4 5976.0 5985.8 5986.3 6017.2 6059.8 5671.0 5672.3 5676.5 5680.7 5689.9 5625.5 5684.1 5715.5 5791.0 5801.7 5597.3 5617.1 5663.8 5711.8 5719.8 5529.8 5587.4 5632.4 5645.2 5652.6 5503.8 5553.6 5576.0 5579.6 5623.0 5598.3 5652.7 5662.2 5664.5 5732.3 5533.1 5541.6 5543.2 5546.5 5601.6 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#1] ext.html Cycles:180 Average:56481.27 Median:192327.06 stddev:111460.51 (58.0%) stddev-sans-first:111694.07 17:06:20 INFO - PROCESS | 4514 | Values: 549.9 567.7 603.0 623.0 637.5 30513.2 41287.8 42144.0 42211.4 45716.0 44365.6 44854.0 44869.0 44870.1 44891.6 8001.4 8345.9 8479.1 8489.6 8492.2 7890.6 10483.2 10735.5 10740.4 11137.2 10860.3 10917.0 10928.6 10928.9 10929.1 10770.6 10842.1 10843.9 10858.6 10865.9 10515.7 10585.9 10588.1 10588.7 10595.4 41520.8 41891.0 41926.6 41955.4 41956.6 3074.4 3233.7 3298.8 3310.6 3374.7 29590.6 31827.4 32046.2 32162.0 33667.5 4237.2 4246.2 4311.8 4325.4 4454.8 347938.0 348781.3 349503.0 349693.0 351897.0 33602.5 58172.4 58459.0 58541.7 58646.4 34194.3 35907.3 36299.5 36309.3 36353.3 14649.5 14757.4 14763.6 14769.6 14778.6 10465.4 10534.8 11884.0 12291.6 12384.3 8060.2 8102.0 8139.2 8188.6 8265.3 3175.4 3201.6 3209.5 3209.7 3249.2 968.2 977.9 986.2 1000.8 1065.0 31719.4 31909.0 31959.7 32221.0 32522.3 1023.1 1065.4 1074.8 1100.9 1118.9 15792.6 16546.6 16772.3 16791.2 16806.3 505768.0 512339.0 512754.0 512799.0 513281.0 56444.7 57272.0 57283.4 57296.7 57327.0 1161.4 1196.3 1253.9 1286.5 1322.1 30922.4 32851.7 33045.2 33264.0 33817.8 47906.0 48235.3 48465.5 48485.0 48538.8 381180.0 381255.0 382703.0 383795.0 386300.0 26588.2 27665.0 27676.6 28537.3 28903.7 44851.0 45188.1 46042.3 46213.0 47100.5 38321.0 38393.2 38483.2 39231.6 40168.6 38448.6 39181.0 39437.8 40362.4 40629.6 39278.2 39898.4 40053.8 40205.6 41238.0 32554.2 34419.5 34868.3 34961.1 35119.1 26719.6 27089.3 27656.7 28070.0 28195.7 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#2] jquery.html Cycles:180 Average:27306.65 Median:2804.94 stddev:72471.30 (2583.7%) stddev-sans-first:72646.37 17:06:20 INFO - PROCESS | 4514 | Values: 364.2 377.6 379.0 382.2 395.5 14251.6 18207.0 18446.9 18484.3 19560.8 16911.7 17170.2 17170.6 17215.2 17396.4 5599.7 5800.2 5829.4 5832.0 5836.6 5511.3 5641.6 5691.5 5788.5 5789.6 5637.0 5646.9 5648.0 5652.3 5654.7 5465.1 5648.3 5650.9 5667.9 5713.2 5100.5 5101.6 5104.1 5104.7 5107.0 21264.8 21685.7 21883.0 21993.9 22202.7 2200.7 2311.1 2752.8 2753.4 2856.5 13431.2 13716.4 14153.1 14539.7 14558.4 1874.7 1913.5 1930.7 1976.2 1985.2 79071.0 81155.6 82428.2 82470.0 84149.0 9017.7 9072.0 9882.9 10130.1 10329.7 14322.7 14348.1 14379.9 14388.4 14390.3 7541.5 7835.3 7858.3 7939.9 8016.2 7573.9 7698.7 7853.3 7887.5 7889.5 6079.5 6249.7 6261.7 6315.7 6357.4 1877.0 1885.7 1903.8 1907.8 1941.1 755.3 858.7 897.5 910.3 1042.2 17652.6 19164.1 19398.7 19741.2 19754.0 992.0 1014.7 1020.2 1022.9 1058.4 10456.3 10489.7 11264.6 11374.2 11378.1 422383.0 425028.0 444976.0 445580.0 447657.0 90337.0 90519.0 91765.5 92234.5 92676.5 1041.2 1044.5 1047.1 1051.7 1055.4 16302.0 16555.8 16747.2 17004.6 17562.6 41241.6 41516.8 42065.6 42190.4 42792.1 56790.7 57885.7 58543.0 58596.7 59274.4 5519.7 6780.6 7339.3 7429.0 7988.5 10495.9 12257.1 12367.0 12620.0 12626.7 10615.2 10790.0 10804.9 11135.9 11150.4 10640.7 10859.2 10862.8 11039.7 11659.0 11021.2 11295.5 11318.7 11459.7 11621.2 7441.5 7594.8 7694.5 7759.8 7865.1 10517.9 10872.2 10984.7 11210.4 11517.4 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#3] mootools.html Cycles:180 Average:5859.90 Median:4819.27 stddev:3406.16 (70.7%) stddev-sans-first:3399.67 17:06:20 INFO - PROCESS | 4514 | Values: 1459.7 1504.5 1616.3 1710.8 1775.9 7926.3 8220.8 8657.5 9351.9 9353.4 8606.9 8892.9 8943.6 9132.7 9143.3 2316.3 2345.1 2345.5 2349.3 2356.7 2002.7 2071.5 2318.6 2340.4 2362.5 2233.3 2295.5 2305.3 2306.8 2315.9 2334.4 2336.8 2343.8 2362.1 2368.9 2322.9 2324.6 2334.6 2346.0 2349.7 8871.3 9021.2 9022.4 9026.4 9035.2 5091.0 5208.7 5226.7 5230.0 5230.1 3446.1 3538.6 3611.7 3664.7 3674.1 1135.7 1181.3 1191.8 1201.9 1218.1 12804.4 12804.7 12808.4 12816.2 12818.7 4369.7 4593.0 4654.4 4718.1 4724.1 10760.1 10779.2 10783.6 10786.1 10791.6 5251.0 5252.6 5254.0 5260.7 5261.2 4801.0 4837.5 4860.7 4863.4 4869.4 3852.8 3970.7 3972.8 4010.3 4047.0 1192.9 1243.4 1258.3 1298.8 1301.3 770.1 778.1 855.2 911.5 923.8 5431.5 5493.2 5637.1 5837.1 5975.3 931.2 934.5 936.9 959.0 999.7 3606.6 3720.6 3892.4 3962.6 4013.4 10895.5 11300.3 11309.9 11320.8 11325.0 10597.2 11045.9 11212.0 11223.7 11225.6 8105.1 8322.3 8323.8 8328.2 8328.5 5838.4 5913.6 5988.7 6032.8 6315.3 9988.0 10332.6 10367.5 10452.8 10602.9 10415.5 10556.8 10597.9 10688.6 10728.9 7778.0 7875.6 7886.6 7967.8 7970.0 8443.3 8537.3 8622.0 8628.3 8630.4 7727.5 7731.7 7748.9 7803.7 8109.1 7445.4 7651.0 7665.3 7728.7 7944.3 6628.5 6650.7 6690.6 6712.5 6712.7 4860.6 4952.1 4999.5 5025.6 5062.7 4772.5 5145.2 5182.2 5260.7 5493.0 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#4] prototype.html Cycles:180 Average:4499.30 Median:4976.79 stddev:1307.01 (26.3%) stddev-sans-first:1272.58 17:06:20 INFO - PROCESS | 4514 | Values: 325.3 330.7 334.5 340.3 342.9 5065.0 5224.6 5258.3 5269.2 5295.3 5084.7 5180.3 5190.8 5210.9 5218.5 4111.2 4116.9 4121.9 4125.3 4136.5 3944.6 4123.4 4124.9 4133.9 4148.0 4032.9 4100.9 4107.3 4108.4 4112.6 4086.8 4096.2 4096.6 4100.5 4112.1 3624.8 3631.7 3638.6 3640.4 3656.1 5126.7 5158.3 5183.9 5196.3 5205.2 4675.3 4702.2 4714.8 4737.7 4739.4 5490.6 5490.9 5492.8 5505.9 5533.9 3745.3 3904.3 3918.8 3923.3 3934.9 5689.7 5707.9 5718.5 5726.5 5732.5 4068.3 4095.5 4102.5 4103.6 4126.6 3875.8 4009.9 4014.9 4033.6 4169.7 4631.4 4647.3 4652.4 4658.5 4679.5 5531.7 5532.5 5536.9 5584.3 5585.3 1338.2 1348.2 1420.5 1421.8 1423.9 884.6 914.9 921.7 923.0 938.8 4708.3 4741.7 4741.9 4755.7 4757.3 4939.0 4950.0 4974.3 4979.3 4986.7 4530.6 4678.9 4695.4 4725.3 4742.6 2616.8 2631.7 2633.0 2633.4 2660.6 5082.2 5102.3 5110.8 5131.2 5141.3 4735.7 4992.3 5059.2 5079.5 5080.3 5074.3 5145.8 5163.3 5169.3 5170.3 4940.0 4942.0 4952.3 4965.9 5000.6 4920.2 4936.6 4961.6 5251.1 5619.6 5873.2 5892.7 5892.8 5895.7 5899.3 4097.9 4130.3 4131.5 4153.9 4162.6 5361.7 5655.7 5690.9 5691.9 5810.2 5360.0 5423.6 5529.2 5543.2 5552.6 5557.8 5562.2 5566.7 5566.7 5576.9 5350.8 5486.9 5503.4 5512.1 5539.9 5520.4 5542.6 5545.7 5548.2 5562.3 5431.5 5471.7 5475.8 5476.8 5481.5 17:06:20 INFO - PROCESS | 4514 | 17:06:20 INFO - PROCESS | 4514 | [#5] yui.html Cycles:180 Average:21868.81 Median:4129.44 stddev:32905.16 (796.8%) stddev-sans-first:32958.94 17:06:20 INFO - PROCESS | 4514 | Values: 663.5 704.7 746.9 796.4 813.1 14336.4 15159.8 15185.7 15188.4 15209.9 15169.0 15174.7 15215.7 15233.5 15269.3 655.9 664.6 672.6 790.2 809.4 669.4 672.6 781.9 790.1 790.9 849.0 857.2 859.5 861.0 861.1 846.1 851.2 852.0 856.1 858.7 503.9 510.4 628.8 628.9 629.0 13772.7 14224.4 14225.5 14646.8 14659.3 14409.5 14983.1 15064.8 15131.5 15235.8 12131.8 12138.6 12189.4 12318.0 12505.2 3772.6 3792.7 3889.3 3893.4 4013.6 79121.2 79619.0 80029.2 80040.6 80584.2 10267.5 10284.5 10351.4 10407.8 10622.1 20462.9 20486.2 20556.2 20579.3 20602.6 8388.9 8441.6 8493.4 8605.1 8668.8 4704.3 4722.1 4742.7 4797.2 4894.1 3547.1 3636.1 3650.9 3672.7 3685.8 618.6 638.7 645.4 650.6 660.0 563.7 643.6 645.0 662.3 664.8 8668.0 9498.8 9677.3 9686.3 10345.4 534.5 614.6 624.6 640.1 646.8 4245.3 4474.7 4486.9 4500.9 4522.9 122503.0 125079.0 126941.4 128611.0 131050.3 106417.0 106947.0 107661.0 109937.0 111067.0 83237.0 92645.5 94462.5 95019.0 95213.0 8350.7 8403.3 8507.4 8605.8 8983.0 54529.5 54694.0 55243.0 56302.0 56839.1 81159.0 83408.0 84087.0 86078.6 88791.6 12321.3 12325.4 12333.1 12411.1 12533.0 12813.2 13445.2 13634.0 13786.9 14173.6 12551.7 12652.3 13178.3 13563.6 13813.7 11994.9 12679.7 12763.5 12819.4 12939.4 12758.3 12895.4 13153.3 13717.2 13977.3 10595.7 10609.7 10920.4 11048.5 11079.3 10668.5 11524.7 11646.9 11650.7 11793.9 17:06:20 INFO - PROCESS | 4514 | -------- Summary: end -------- 17:06:20 INFO - PROCESS | 4514 | 17:06:21 INFO - TEST-INFO | 4514: exit 0 17:06:21 INFO - TEST-OK | dromaeo_css | took 1117461ms 17:06:21 INFO - TEST-START | kraken 17:06:21 INFO - operating with platform_type : linux_ 17:06:21 INFO - Initialising browser for kraken test... 17:06:21 INFO - TEST-INFO | started process 4821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXcBqM/profile http://localhost:39107/getInfo.html) 17:06:24 INFO - PROCESS | 4821 | __metrics Screen width/height:1600/1200 17:06:24 INFO - PROCESS | 4821 | colorDepth:24 17:06:24 INFO - PROCESS | 4821 | Browser inner width/height: 1024/697 17:06:24 INFO - PROCESS | 4821 | __metrics 17:06:25 INFO - PROCESS | 4821 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:06:25 INFO - PROCESS | 4821 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:06:26 INFO - PROCESS | 4821 | console.error: PushService: 17:06:26 INFO - PROCESS | 4821 | stateChangeProcessEnqueue: Error transitioning state 17:06:26 INFO - PROCESS | 4821 | UnknownError 17:06:26 INFO - TEST-INFO | 4821: exit 0 17:06:26 INFO - Browser initialized. 17:06:26 INFO - Running cycle 1/1 for kraken test... 17:06:26 INFO - TEST-INFO | started process 4903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXcBqM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:38 INFO - PROCESS | 4903 | RSS: Main: 172625920 17:06:38 INFO - PROCESS | 4903 | 17:06:41 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39107/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:42 INFO - PROCESS | 4903 | RSS: Main: 229199872 17:06:42 INFO - PROCESS | 4903 | 17:06:44 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39107/tests/kraken/driver.html?testName=audio-dft) 17:06:45 INFO - PROCESS | 4903 | RSS: Main: 216481792 17:06:45 INFO - PROCESS | 4903 | 17:06:48 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39107/tests/kraken/driver.html?testName=audio-fft) 17:06:49 INFO - PROCESS | 4903 | RSS: Main: 297496576 17:06:49 INFO - PROCESS | 4903 | 17:06:51 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39107/tests/kraken/driver.html?testName=audio-oscillator) 17:06:51 INFO - PROCESS | 4903 | RSS: Main: 206323712 17:06:51 INFO - PROCESS | 4903 | 17:06:53 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:06:54 INFO - PROCESS | 4903 | RSS: Main: 211542016 17:06:54 INFO - PROCESS | 4903 | 17:06:57 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39107/tests/kraken/driver.html?testName=imaging-darkroom) 17:06:58 INFO - PROCESS | 4903 | RSS: Main: 247463936 17:06:58 INFO - PROCESS | 4903 | 17:07:01 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39107/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:01 INFO - PROCESS | 4903 | RSS: Main: 246845440 17:07:01 INFO - PROCESS | 4903 | 17:07:04 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39107/tests/kraken/driver.html?testName=json-parse-financial) 17:07:05 INFO - PROCESS | 4903 | RSS: Main: 246091776 17:07:05 INFO - PROCESS | 4903 | 17:07:06 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:07 INFO - PROCESS | 4903 | RSS: Main: 208273408 17:07:07 INFO - PROCESS | 4903 | 17:07:08 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:09 INFO - PROCESS | 4903 | RSS: Main: 215703552 17:07:09 INFO - PROCESS | 4903 | 17:07:11 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:12 INFO - PROCESS | 4903 | RSS: Main: 225693696 17:07:12 INFO - PROCESS | 4903 | 17:07:14 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:15 INFO - PROCESS | 4903 | RSS: Main: 229306368 17:07:15 INFO - PROCESS | 4903 | 17:07:18 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:18 INFO - PROCESS | 4903 | RSS: Main: 231337984 17:07:18 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | Cycle 1(1): loaded http://localhost:39107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39107/tests/kraken/driver.html?testName=ai-astar) 17:07:20 INFO - PROCESS | 4903 | RSS: Main: 281972736 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | __start_tp_report 17:07:20 INFO - PROCESS | 4903 | _x_x_mozilla_page_load 17:07:20 INFO - PROCESS | 4903 | _x_x_mozilla_page_load_details 17:07:20 INFO - PROCESS | 4903 | |i|pagename|runs| 17:07:20 INFO - PROCESS | 4903 | |0;ai-astar;106;112;111;111;112;111;112;111;112;111 17:07:20 INFO - PROCESS | 4903 | |1;audio-beat-detection;149;123;122;155;128;122;122;124;159;124 17:07:20 INFO - PROCESS | 4903 | |2;audio-dft;160;160;161;161;160;160;160;162;161;161 17:07:20 INFO - PROCESS | 4903 | |3;audio-fft;74;76;75;107;79;76;75;76;104;75 17:07:20 INFO - PROCESS | 4903 | |4;audio-oscillator;83;81;114;82;82;83;108;83;82;117 17:07:20 INFO - PROCESS | 4903 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 17:07:20 INFO - PROCESS | 4903 | |6;imaging-darkroom;146;145;145;145;145;145;145;146;146;145 17:07:20 INFO - PROCESS | 4903 | |7;imaging-desaturate;91;84;84;84;84;84;84;85;84;84 17:07:20 INFO - PROCESS | 4903 | |8;json-parse-financial;54;52;53;52;66;55;53;54;53;54 17:07:20 INFO - PROCESS | 4903 | |9;json-stringify-tinderbox;61;60;59;60;60;60;60;60;59;61 17:07:20 INFO - PROCESS | 4903 | |10;stanford-crypto-aes;89;80;89;79;81;80;94;80;80;80 17:07:20 INFO - PROCESS | 4903 | |11;stanford-crypto-ccm;134;132;130;128;138;132;132;130;184;128 17:07:20 INFO - PROCESS | 4903 | |12;stanford-crypto-pbkdf2;171;166;166;168;171;167;169;166;167;168 17:07:20 INFO - PROCESS | 4903 | |13;stanford-crypto-sha256-iterative;65;65;66;69;70;65;66;67;65;68 17:07:20 INFO - PROCESS | 4903 | __end_tp_report 17:07:20 INFO - PROCESS | 4903 | __start_cc_report 17:07:20 INFO - PROCESS | 4903 | _x_x_mozilla_cycle_collect,1734 17:07:20 INFO - PROCESS | 4903 | __end_cc_report 17:07:20 INFO - PROCESS | 4903 | __startTimestamp1477354040914__endTimestamp 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | ------- Summary: start ------- 17:07:20 INFO - PROCESS | 4903 | Number of tests: 14 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.79 (1.6%) stddev-sans-first:0.53 17:07:20 INFO - PROCESS | 4903 | Values: 106.0 112.0 111.0 111.0 112.0 111.0 112.0 111.0 112.0 111.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:126.00 stddev:15.15 (12.0%) stddev-sans-first:14.89 17:07:20 INFO - PROCESS | 4903 | Values: 149.0 123.0 122.0 155.0 128.0 122.0 122.0 124.0 159.0 124.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 17:07:20 INFO - PROCESS | 4903 | Values: 160.0 160.0 161.0 161.0 160.0 160.0 160.0 162.0 161.0 161.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:12.63 (16.7%) stddev-sans-first:13.09 17:07:20 INFO - PROCESS | 4903 | Values: 74.0 76.0 75.0 107.0 79.0 76.0 75.0 76.0 104.0 75.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:15.01 (18.3%) stddev-sans-first:15.60 17:07:20 INFO - PROCESS | 4903 | Values: 83.0 81.0 114.0 82.0 82.0 83.0 108.0 83.0 82.0 117.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:07:20 INFO - PROCESS | 4903 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 17:07:20 INFO - PROCESS | 4903 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:84.00 stddev:2.20 (2.6%) stddev-sans-first:0.33 17:07:20 INFO - PROCESS | 4903 | Values: 91.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:4.12 (7.6%) stddev-sans-first:4.36 17:07:20 INFO - PROCESS | 4903 | Values: 54.0 52.0 53.0 52.0 66.0 55.0 53.0 54.0 53.0 54.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 17:07:20 INFO - PROCESS | 4903 | Values: 61.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 61.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.50 stddev:5.35 (6.6%) stddev-sans-first:5.25 17:07:20 INFO - PROCESS | 4903 | Values: 89.0 80.0 89.0 79.0 81.0 80.0 94.0 80.0 80.0 80.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:132.00 stddev:16.84 (12.8%) stddev-sans-first:17.84 17:07:20 INFO - PROCESS | 4903 | Values: 134.0 132.0 130.0 128.0 138.0 132.0 132.0 130.0 184.0 128.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.91 (1.1%) stddev-sans-first:1.67 17:07:20 INFO - PROCESS | 4903 | Values: 171.0 166.0 166.0 168.0 171.0 167.0 169.0 166.0 167.0 168.0 17:07:20 INFO - PROCESS | 4903 | 17:07:20 INFO - PROCESS | 4903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.84 (2.8%) stddev-sans-first:1.86 17:07:20 INFO - PROCESS | 4903 | Values: 65.0 65.0 66.0 69.0 70.0 65.0 66.0 67.0 65.0 68.0 17:07:20 INFO - PROCESS | 4903 | -------- Summary: end -------- 17:07:20 INFO - PROCESS | 4903 | 17:07:22 INFO - TEST-INFO | 4903: exit 0 17:07:22 INFO - TEST-OK | kraken | took 61006ms 17:07:22 INFO - SUITE-END | took 1178s 17:07:22 INFO - Completed test suite (00:19:38) 17:07:22 INFO - javascript benchmark 17:07:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.3262882165923, 3090.196548897286, 3112.0197137901573, 3124.6250449946, 3136.7490600751926, 5175.353080864892, 5256.526912577867, 5284.418713941468, 5383.0, 5411.404745478004, 5304.416514183446, 5305.177697456891, 5323.041852466555, 5345.385280692722, 5397.2443857859935, 4865.732384718839, 4897.387826521676, 4920.114379411704, 4924.876878078059, 4951.133551628469, 4872.975344302362, 4894.1679914414635, 4945.134601444751, 4958.6281028922795, 4968.428630707461, 4329.567043295677, 4936.790486330854, 4988.800447982095, 4997.900041999158, 5038.29463875056, 4757.738324392157, 4798.280257961299, 4855.441624213226, 4868.928835656186, 4890.73100979446, 4811.975940120277, 4816.109019831308, 4821.156297647897, 4822.8794280143275, 4824.011077729057, 5309.52214300711, 5341.866453338659, 5347.304850369466, 5369.570434365241, 5372.462753724635, 5720.141978703228, 5720.542356611461, 5721.284839395075, 5725.08398656213, 5726.026575482178, 5739.540836733051, 5764.221830052931, 5767.826965191051, 5770.79802206925, 5772.105323674838, 5330.600204984564, 5352.437994010651, 5352.464753524694, 5368.0, 5373.570114390839, 5893.882122357614, 5899.734511946973, 5900.616459930091, 5904.084866845646, 5909.172715819703, 5646.6894320811925, 5646.745896434671, 5658.151277308354, 5658.575606829504, 5659.490645841894, 5608.355039170466, 5667.234923285386, 5669.149627555899, 5721.542276617861, 5736.827895163152, 5713.428657134336, 5733.455321744427, 5737.741801618937, 5791.247137872049, 5801.187833703285, 5749.080147176432, 5749.655020698771, 5751.022326204556, 5752.13717942312, 5779.797707080232, 4288.785560721952, 4320.4383430153875, 4323.308270676676, 4336.696431249782, 4375.78121093944, 3874.0702231464247, 3884.786336751449, 3909.5113110861143, 3921.176552923861, 3978.423128646388, 5458.2904222450825, 5463.153211252262, 5463.617546771768, 5465.699386533699, 5469.288992430958, 5777.537796976232, 5779.248697669276, 5782.739776710058, 5791.797287095016, 5852.795152169653, 5324.334458192726, 5360.839174824683, 5391.137418013099, 5410.702411367412, 5432.375276843135, 4996.300517927493, 4998.4251811042195, 5002.674826136289, 5005.049040682259, 5054.241863720398, 5915.970420147872, 5956.37458066914, 5960.940390596039, 5980.013297805987, 6047.909281360783, 5665.376808551138, 5684.573656975661, 5709.800156994485, 5719.914201287067, 5765.3946335634155, 5975.970120149545, 5985.790497332572, 5986.311574169026, 6017.247844019497, 6059.818205453844, 5670.971645141913, 5672.319321681424, 5676.460736230051, 5680.71596420169, 5689.943100569107, 5625.46558076982, 5684.062129748545, 5715.542756579381, 5791.044477661308, 5801.709914504342, 5597.328320601554, 5617.101263797937, 5663.8017669383025, 5711.828645140652, 5719.828405147852, 5529.751161197836, 5587.441255874543, 5632.380438151882, 5645.181448689999, 5652.6043176978865, 5503.752331145188, 5553.611247212656, 5575.972120139373, 5579.581531385244, 5623.044082506066, 5598.272224610774, 5652.7173641318595, 5662.150677398423, 5664.518515926027, 5732.283464566929, 5533.114701647717, 5541.612087153861, 5543.223948647112, 5546.473085056913, 5601.579881508822], "value": 5293.453742238058, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8516786648307, 567.7047935073762, 603.0140719922924, 622.9845352076118, 637.4963778614895, 30513.237169070784, 41287.79356103219, 42143.99999999996, 42211.36682949758, 45716.0, 44365.55634443655, 44854.0, 44869.0, 44870.10259794802, 44891.55108448915, 8001.359891208718, 8345.874811877828, 8479.06730259674, 8489.575521223946, 8492.193241642035, 7890.605469726519, 10483.161347092215, 10735.463226838667, 10740.409277489734, 11137.164712646543, 10860.348379097279, 10917.0, 10928.617498387557, 10928.945355273212, 10929.071028962548, 10770.569177232901, 10842.13262938967, 10843.945780271128, 10858.565657373696, 10865.891341086646, 10515.73710657232, 10585.888481709386, 10588.100011499031, 10588.735281617945, 10595.364278143335, 41520.79239603813, 41891.0, 41926.580734192576, 41955.37066943998, 41956.58043419557, 3074.4158609864053, 3233.725133363667, 3298.7690861639694, 3310.619278782947, 3374.7176073092314, 29590.556141657893, 31827.363452731046, 32046.198845028826, 32162.0, 33667.474939379645, 4237.200021785098, 4246.193223287565, 4311.762853043113, 4325.3728209409455, 4454.844080457201, 347938.0, 348781.25609372044, 349503.0, 349693.0, 351897.0, 33602.495962560584, 58172.418275817545, 58459.0, 58541.70729146327, 58646.41353586495, 34194.31611367759, 35907.281854362765, 36299.4555081674, 36309.27381452356, 36353.272934541164, 14649.487267945571, 14757.40970361195, 14763.63090922714, 14769.556913292618, 14778.556643300719, 10465.372077675363, 10534.789304214026, 11884.0, 12291.56979505713, 12384.256944583174, 8060.153683863227, 8102.0, 8139.186081391932, 8188.590570471452, 8265.256126948603, 3175.4284228839033, 3201.599800024997, 3209.470437377853, 3209.743220542351, 3249.1552196429097, 968.1577027985697, 977.8924318324979, 986.2405947420447, 1000.7648202672366, 1064.973375665599, 31719.365612688078, 31909.0, 31959.68040319567, 32221.0, 32522.349553008808, 1023.1047833145997, 1065.414022287754, 1074.785042991405, 1100.8568886044764, 1118.9384583847966, 15792.605184870241, 16546.58633534171, 16772.32910683559, 16791.2443940023, 16806.32774689023, 505768.0, 512339.0, 512754.0, 512799.0, 513281.0, 56444.71777641086, 57272.0, 57283.42716572781, 57296.71351643299, 57327.0, 1161.3960740415105, 1196.3121205306984, 1253.931033793132, 1286.5239861251398, 1322.0547308674345, 30922.381552368377, 32851.67148328582, 33045.17387065342, 33264.0, 33817.83091084529, 47906.0, 48235.276470852266, 48465.5153448461, 48485.0, 48538.757306214655, 381180.0, 381255.0, 382703.0, 383795.0, 386300.0, 26588.202353929413, 27665.0, 27676.58485122765, 28537.28656783597, 28903.7109628901, 44851.0, 45188.09623807571, 46042.30936536022, 46213.0, 47100.52899470962, 38321.0, 38393.23213535658, 38483.230335393695, 39231.6076839228, 40168.59831401648, 38448.6155138445, 39181.0, 39437.80281098576, 40362.394564080976, 40629.593704063765, 39278.2144357117, 39898.40152397658, 40053.799731001156, 40205.597944020185, 41238.0, 32554.186145346557, 34419.4837077439, 34868.302633947686, 34961.12597185091, 35119.12202194965, 26719.599206011535, 27089.322766930196, 27656.723432765415, 28070.000199772683, 28195.731192095995], "value": 18696.2491236518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.1733265487342, 377.55825683949786, 379.02590342818957, 382.2259923654599, 395.53327074052606, 14251.64370890727, 18207.0, 18446.907765461154, 18484.260629574834, 19560.804391956113, 16911.713469444643, 17170.22733976971, 17170.57073573158, 17215.22531486083, 17396.39112631058, 5599.664020158783, 5800.245968024172, 5829.417058294179, 5832.037713777222, 5836.5914385993, 5511.311086114236, 5641.576881733887, 5691.459311365414, 5788.536917046647, 5789.623674461168, 5636.971815140939, 5646.943530564703, 5648.0, 5652.293463317085, 5654.688992105433, 5465.07093794056, 5648.322201335845, 5650.943490565103, 5667.914981275284, 5713.228714123582, 5100.489951004907, 5101.642884998052, 5104.05574968632, 5104.668196567249, 5106.974465127688, 21264.78735212659, 21685.67471487929, 21883.0, 21993.890030549905, 22202.66695999561, 2200.6919031335624, 2311.133325003124, 2752.779777617786, 2753.3804893898914, 2856.5001124803075, 13431.246594448116, 13716.382762775698, 14153.08004979673, 14539.70920581593, 14558.417663293456, 1874.681304178293, 1913.540750219937, 1930.7007413850877, 1976.170008596393, 1985.2356842615552, 79071.0, 81155.5942220291, 82428.17571824265, 82470.0, 84149.0, 9017.729468115967, 9071.954640226757, 9882.901170988342, 10130.138938190335, 10329.74175645615, 14322.713545729235, 14348.139111653334, 14379.928100359431, 14388.352524136439, 14390.28048597566, 7541.472096953161, 7835.294823465915, 7858.292753652198, 7939.880901786478, 8016.198380161937, 7573.924260757432, 7698.653560589787, 7853.253940875607, 7887.48731332473, 7889.526628402315, 6079.483243924316, 6249.7187626556915, 6261.7182226799, 6315.684215789192, 6357.364263573698, 1876.981230187708, 1885.7265696473935, 1903.7715474143192, 1907.7901430842596, 1941.1268126258228, 755.3239850333921, 858.6994551906782, 897.4570384917162, 910.2581396162107, 1042.1610603464285, 17652.646947060988, 19164.137613807412, 19398.70901936472, 19741.21035158606, 19754.0, 991.9782623897397, 1014.6550172941236, 1020.1889497849228, 1022.8568000479938, 1058.439027315524, 10456.26806123564, 10489.737756556147, 11264.605738799102, 11374.203805733685, 11378.146639002109, 422383.0, 425028.0, 444976.0, 445580.0, 447657.0, 90337.0, 90519.0, 91765.54117229371, 92234.53882730543, 92676.53661731783, 1041.151461558812, 1044.5404022230193, 1047.1099565369375, 1051.6529545250048, 1055.3931489393628, 16302.0, 16555.83444165543, 16747.24637391296, 17004.574885627462, 17562.648747024734, 41241.58758412497, 41516.79241603773, 42065.57934420739, 42190.367144492244, 42792.144157117305, 56790.716046419504, 57885.71057144687, 58543.0, 58596.70701646464, 59274.407255928614, 5519.724013799374, 6780.559263647847, 7339.339459448462, 7429.0, 7988.480748751313, 10495.947520262655, 12257.142000060267, 12367.0, 12620.0, 12626.684332891751, 10615.150787936793, 10790.0, 10804.919508049132, 11135.944320278346, 11150.442477876237, 10640.680779576625, 10859.185561082792, 10862.837057443987, 11039.668809935714, 11659.0, 11021.173411993972, 11295.548178072784, 11318.660440186808, 11459.656210313704, 11621.186516943733, 7441.516301440389, 7594.772156835304, 7694.538327700356, 7759.806004849924, 7865.056193256846, 10517.9474102629, 10872.238943273895, 10984.670459886216, 11210.43947802623, 11517.366544840113], "value": 9029.72280947512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.7007613439243, 1504.5110339139778, 1616.280755063997, 1710.760493530905, 1775.85793136549, 7926.326262267699, 8220.83558328833, 8657.523836189008, 9351.859722104175, 9353.392029518085, 8606.87089693655, 8892.91107088929, 8943.597538110784, 9132.726018219448, 9143.268538516902, 2316.3166865774597, 2345.097137602027, 2345.5191685704476, 2349.3304408243566, 2356.705411823522, 2002.669559522677, 2071.4510654676446, 2318.6406107053435, 2340.4031971847157, 2362.492064206195, 2233.3188377544843, 2295.4605667668084, 2305.2853615379204, 2306.815454763623, 2315.8842057897036, 2334.3697201755517, 2336.7663233676494, 2343.8124950004044, 2362.11420717231, 2368.8933997970134, 2322.8606283623035, 2324.5583339165505, 2334.568104900599, 2346.0498498108295, 2349.706286714161, 8871.334649901282, 9021.233195178418, 9022.368434209608, 9026.368154229207, 9035.18683318498, 5091.0, 5208.661437006583, 5226.686398816083, 5230.032443997872, 5230.110881150214, 3446.0867870014467, 3538.628444013393, 3611.656892595199, 3664.743467957244, 3674.1182116292166, 1135.659302209342, 1181.2794195540714, 1191.7973944429468, 1201.9338936358497, 1218.074263559701, 12804.42380092898, 12804.743905121939, 12808.423620937081, 12816.231026138368, 12818.679533011657, 4369.650427965755, 4592.97703511487, 4654.394928659321, 4718.079974405026, 4724.126036683225, 10760.139188864872, 10779.191560632984, 10783.568657253621, 10786.137109031259, 10791.6222932197, 5251.0, 5252.5535329497425, 5254.028004819121, 5260.736963151904, 5261.237120617489, 4801.039792041605, 4837.4920633333695, 4860.659753817199, 4863.440704319049, 4869.440014398389, 3852.8266228019806, 3970.741901776433, 3972.7616343019513, 4010.318245898146, 4046.959530404717, 1192.9045676345872, 1243.359669770069, 1258.282778816066, 1298.7662220800346, 1301.342821874966, 770.1143684762455, 778.1401551285861, 855.170484629908, 911.4941207629829, 923.7598224461689, 5431.456854314537, 5493.2034854945805, 5637.126245431965, 5837.066069428871, 5975.25309336333, 931.2131249094505, 934.5327336331834, 936.864154697565, 958.9952050239705, 999.6801023672355, 3606.567211934532, 3720.6465385788306, 3892.3966785148345, 3962.643362097425, 4013.3779264214095, 10895.509702063426, 11300.321980681185, 11309.886901131047, 11320.773584528428, 11325.0, 10597.20520960931, 11045.944770276097, 11212.046976006968, 11223.66329010131, 11225.550977960953, 8105.067917189599, 8322.250997410141, 8323.750287491384, 8328.167183281745, 8328.458650187718, 5838.416158384128, 5913.645181289136, 5988.730507127103, 6032.788852390146, 6315.305316415099, 9987.950060249652, 10332.638357657446, 10367.481625918825, 10452.790944181226, 10602.886696896714, 10415.479226038819, 10556.84164737545, 10597.9470102649, 10688.572457101629, 10728.946355268174, 7778.0, 7875.606219689107, 7886.566238856918, 7967.84064318722, 7970.003749531309, 8443.324534037385, 8537.274331681876, 8621.956890215508, 8628.266597339296, 8630.439021463584, 7727.49771264866, 7731.652075656497, 7748.883766743616, 7803.7268695595385, 8109.10799812032, 7445.4043676506835, 7651.0, 7665.271799179069, 7728.729494467667, 7944.285014348737, 6628.53600247978, 6650.73397064112, 6690.59856408617, 6712.53012289135, 6712.664366781543, 4860.6111511078325, 4952.133376658998, 4999.47505511916, 5025.6482046256415, 5062.746862656926, 4772.546608072227, 5145.202493613496, 5182.170852663556, 5260.73696315175, 5492.972535137299], "value": 4655.014549595372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.30547281553885, 330.6808929383146, 334.4815535919324, 340.32275771215274, 342.9245565975485, 5065.024640390242, 5224.63427560071, 5258.316418865547, 5269.156934890409, 5295.338082739658, 5084.686467657217, 5180.300659410978, 5190.766415511302, 5210.921836172461, 5218.47815218478, 4111.15721277139, 4116.917661646765, 4121.9381709274385, 4125.339945608704, 4136.462259906208, 3944.6252606002386, 4123.443335149761, 4124.8968775780695, 4133.855315063958, 4147.979260103695, 4032.879013629581, 4100.913257986636, 4107.322291821846, 4108.383742438628, 4112.609302116309, 4086.7752273624938, 4096.221717873595, 4096.586677596225, 4100.5489396166395, 4112.136451345221, 3624.8368823402748, 3631.691306238973, 3638.5997540270814, 3640.362936486131, 3656.1042544576485, 5126.744232537671, 5158.2520534522655, 5183.948160518385, 5196.272521846944, 5205.167173252262, 4675.322078298662, 4702.224133018048, 4714.811407543694, 4737.715737055788, 4739.36018637483, 5490.588205884575, 5490.917636235459, 5492.80775172871, 5505.917411238835, 5533.861653458655, 3745.3445647011936, 3904.3362628353248, 3918.804059797027, 3923.293807114718, 3934.940975885364, 5689.687067211302, 5707.886962042403, 5718.485336319751, 5726.455986681301, 5732.455416735404, 4068.2880495913096, 4095.488063992001, 4102.528209255914, 4103.5691252418665, 4126.628603425646, 3875.806209689504, 4009.939850902239, 4014.9397759033636, 4033.616806403387, 4169.728967617095, 4631.397918270603, 4647.256438969816, 4652.418447694038, 4658.464276608166, 4679.508651591534, 5531.668099913937, 5532.5297349724915, 5536.944630553643, 5584.274044374287, 5585.273914391103, 1338.1569611144917, 1348.157401623985, 1420.5312246958686, 1421.7725163973714, 1423.9320509617787, 884.5754038061766, 914.9039350868063, 921.7050543826045, 922.9723108306762, 938.7889622387181, 4708.340832283483, 4741.739204343725, 4741.857744267678, 4755.667103302736, 4757.26262429324, 4938.987507560942, 4950.0, 4974.303597496281, 4979.278004689372, 4986.678530189502, 4530.569595888385, 4678.8596342109795, 4695.38009386761, 4725.3384526166365, 4742.596879265301, 2616.7775739062395, 2631.7236690147643, 2633.0126202673996, 2633.4469761350333, 2660.6031833287293, 5082.237664350303, 5102.33669622954, 5110.770015349244, 5131.230315452712, 5141.280220769096, 4735.739534325645, 4992.301077849104, 5059.165237735732, 5079.542841144241, 5080.314157588752, 5074.2895994560795, 5145.819896303687, 5163.302954101148, 5169.327987361619, 5170.276161337416, 4939.987302602886, 4941.97529012367, 4952.257161425671, 4965.900681986268, 5000.649824547279, 4920.1954885714795, 4936.580390666833, 4961.610748990289, 5251.109600543878, 5619.606627536034, 5873.179314412546, 5892.705364731832, 5892.793752218652, 5895.7052147393315, 5899.321578018583, 4097.938530921979, 4130.318497447887, 4131.50421949368, 4153.854615088458, 4162.5629308922125, 5361.731913404392, 5655.688937108499, 5690.943090569207, 5691.857703557444, 5810.244668193108, 5359.998400895511, 5423.5932305076485, 5529.198266251451, 5543.1685247213245, 5552.5557955362665, 5557.777688892399, 5562.165675148598, 5566.693831839288, 5566.749496272759, 5576.888462230814, 5350.8127215547265, 5486.875190586, 5503.367112782082, 5512.145617429305, 5539.892021595778, 5520.36515800672, 5542.63972841764, 5545.72271386421, 5548.167774833807, 5562.276904002454, 5431.511163995259, 5471.72641367938, 5475.75359108849, 5476.780928762805, 5481.451854814487], "value": 4086.735405862219, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.5324922637469, 704.7462913351196, 746.9365103966163, 796.3788245168768, 813.1258896686062, 14336.426542938283, 15159.772603410931, 15185.696286074299, 15188.392464301414, 15209.923950380247, 15169.0, 15174.696506069871, 15215.695686086272, 15233.542993710178, 15269.312880920357, 655.9409653131218, 664.6012392564447, 672.579637726421, 790.1979490816825, 809.3646487507308, 669.4309836638843, 672.6266921858366, 781.890535325055, 790.075611534506, 790.8932294140303, 848.9787755306105, 857.2456238510102, 859.4886042804521, 861.0356400831078, 861.0614430271004, 846.0566468387765, 851.1786126388065, 851.9872201916976, 856.1224744636735, 858.716623514245, 503.88914438823764, 510.3594988289673, 628.8144997225829, 628.9182406287199, 628.996855015722, 13772.724545509134, 14224.431022759078, 14225.502107426191, 14646.780298295535, 14659.34032968519, 14409.495667651687, 14983.063960206588, 15064.774028389584, 15131.54605361841, 15235.771463428058, 12131.818022729665, 12138.575149869712, 12189.390530473442, 12318.0, 12505.249685018927, 3772.641599048086, 3792.715546334008, 3889.2610404023144, 3893.357595996657, 4013.618706222904, 79121.20878791196, 79619.0, 80029.19970800333, 80040.59979700064, 80584.19415805825, 10267.486625668836, 10284.537195826206, 10351.43067131315, 10407.791844163226, 10622.097121744739, 20462.897685511478, 20486.18055277802, 20556.177752890017, 20579.279725209846, 20602.58794824095, 8388.916110838814, 8441.620127094295, 8493.405461617627, 8605.139486051345, 8668.78328041804, 4704.270838020112, 4722.079194557097, 4742.73914934675, 4797.184109763858, 4894.070126675921, 3547.130952916552, 3636.090977255686, 3650.8904732857527, 3672.706183505313, 3685.760425572329, 618.554640658725, 638.6551262318296, 645.3997782062727, 650.6226388694546, 660.0462331930411, 563.745665893384, 643.5816719132507, 645.0002496130978, 662.3409707341131, 664.833791552112, 8667.991650603699, 9498.810023799486, 9677.274204434696, 9686.273529485317, 10345.431001295, 534.4628648208526, 614.6005096687189, 624.6033768556999, 640.1326202994875, 646.7703965092419, 4245.257080010986, 4474.686771925999, 4486.910261794811, 4500.909981800346, 4522.88692782683, 122503.0, 125079.0, 126941.36529317294, 128611.0, 131050.34474827565, 106417.0, 106947.0, 107661.0, 109937.0, 111067.0, 83237.0, 92645.53677231705, 94462.52768736113, 95019.04980950241, 95213.0, 8350.749477515685, 8403.327733781405, 8507.361947853811, 8605.784855378666, 8982.955085224532, 54529.45470545244, 54694.0, 55243.0, 56302.0, 56839.05316569501, 81159.0, 83408.0, 84087.0, 86078.56960715157, 88791.55604221938, 12321.260724356567, 12325.383730813603, 12333.137268585357, 12411.131220814455, 12533.0, 12813.231206127663, 13445.193288402726, 13634.0, 13786.862131378557, 14173.574792756233, 12551.748965020466, 12652.304123273309, 13178.27519486399, 13563.59309220725, 13813.723725525635, 11994.94508019435, 12679.683007924876, 12763.48946042185, 12819.359032048547, 12939.417726202155, 12758.29829359357, 12895.41970611306, 13153.276569788371, 13717.17696938187, 13977.298019140644, 10595.682129536126, 10609.681709548726, 10920.399378033966, 11048.502817373077, 11079.279846809932, 10668.519916603927, 11524.711882203012, 11646.8935451132, 11650.70873228176, 11793.941030294794], "value": 7450.045379975506, "unit": "score"}], "name": "dromaeo_css", "value": 7086.7101652837155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 122.0, 155.0, 128.0, 122.0, 122.0, 124.0, 159.0, 124.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 107.0, 79.0, 76.0, 75.0, 76.0, 104.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 114.0, 82.0, 82.0, 83.0, 108.0, 83.0, 82.0, 117.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 66.0, 55.0, 53.0, 54.0, 53.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 89.0, 79.0, 81.0, 80.0, 94.0, 80.0, 80.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 130.0, 128.0, 138.0, 132.0, 132.0, 130.0, 184.0, 128.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 166.0, 168.0, 171.0, 167.0, 169.0, 166.0, 167.0, 168.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 69.0, 70.0, 65.0, 66.0, 67.0, 65.0, 68.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1493.5, "alertThreshold": 2.0}]} 17:07:22 INFO - Return code: 0 17:07:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:07:22 INFO - # TBPL SUCCESS # 17:07:22 INFO - Running post-action listener: _resource_record_post_action 17:07:22 INFO - [mozharness: 2016-10-25 00:07:22.725439Z] Finished run-tests step (success) 17:07:22 INFO - Running post-run listener: _resource_record_post_run 17:07:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 2002944; Write bytes: 394457088; Read time: 340; Write time: 269844 17:07:22 INFO - TinderboxPrint: CPU usage
13.1% 17:07:22 INFO - TinderboxPrint: I/O read bytes / time
2,002,944 / 340 17:07:22 INFO - TinderboxPrint: I/O write bytes / time
394,457,088 / 269,844 17:07:22 INFO - TinderboxPrint: CPU idle
8,290.6 (86.9%) 17:07:22 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 17:07:22 INFO - TinderboxPrint: Swap in / out
0 / 0 17:07:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103620608; Read time: 0; Write time: 94560 17:07:22 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 249856; Write bytes: 290836480; Read time: 280; Write time: 175284 17:07:23 INFO - Running post-run listener: _upload_blobber_files 17:07:23 INFO - Blob upload gear active. 17:07:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:07: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 17:07: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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:07: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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:24 INFO - (blobuploader) - INFO - Done attempting. 17:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:25 INFO - (blobuploader) - INFO - Done attempting. 17:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:28 INFO - (blobuploader) - INFO - Done attempting. 17:07:28 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:28 INFO - Return code: 0 17:07:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:07:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cf235e423dc2d7b106488ff5acf2b526ba1c0018455df68707e8f4978af3481a7c72b93d6bd3b116b39255b3f7c09407ca34f90a1c925968da636cd4bef8a57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a4c8f897232eda62470337f2dc775b79cded1421fa8c0786deba297a46fad311a7621c53da73f47f6962d7bf9c558541ff2690efae1e106448a540844bd242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d4e9c7a2e10e050300f185e5915d86dc9fdda590d902f0697937cd5e52b66b3f23b424cf56d54038f1ac4a0b51e1a34ed141a7d000917d9a40d2a9caac61c02"} 17:07:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:07:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:07:28 INFO - Contents: 17:07:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cf235e423dc2d7b106488ff5acf2b526ba1c0018455df68707e8f4978af3481a7c72b93d6bd3b116b39255b3f7c09407ca34f90a1c925968da636cd4bef8a57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a4c8f897232eda62470337f2dc775b79cded1421fa8c0786deba297a46fad311a7621c53da73f47f6962d7bf9c558541ff2690efae1e106448a540844bd242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d4e9c7a2e10e050300f185e5915d86dc9fdda590d902f0697937cd5e52b66b3f23b424cf56d54038f1ac4a0b51e1a34ed141a7d000917d9a40d2a9caac61c02"} 17:07:28 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:28 INFO - Copying logs to upload dir... 17:07:28 INFO - mkdir: /builds/slave/test/build/upload/logs 17:07:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.014120 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-24 17:07:28.655929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:07:28.661909) ========= 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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cf235e423dc2d7b106488ff5acf2b526ba1c0018455df68707e8f4978af3481a7c72b93d6bd3b116b39255b3f7c09407ca34f90a1c925968da636cd4bef8a57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a4c8f897232eda62470337f2dc775b79cded1421fa8c0786deba297a46fad311a7621c53da73f47f6962d7bf9c558541ff2690efae1e106448a540844bd242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d4e9c7a2e10e050300f185e5915d86dc9fdda590d902f0697937cd5e52b66b3f23b424cf56d54038f1ac4a0b51e1a34ed141a7d000917d9a40d2a9caac61c02"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cf235e423dc2d7b106488ff5acf2b526ba1c0018455df68707e8f4978af3481a7c72b93d6bd3b116b39255b3f7c09407ca34f90a1c925968da636cd4bef8a57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a4c8f897232eda62470337f2dc775b79cded1421fa8c0786deba297a46fad311a7621c53da73f47f6962d7bf9c558541ff2690efae1e106448a540844bd242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d4e9c7a2e10e050300f185e5915d86dc9fdda590d902f0697937cd5e52b66b3f23b424cf56d54038f1ac4a0b51e1a34ed141a7d000917d9a40d2a9caac61c02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:07:28.687749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:07:28.688082) ========= 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=0333a256a5e4f052382dd180000001b1-1477352810.102134-11571736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:07:28.774170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:07:28.774487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:07:28.774775) ========= ========= Total master_lag: 0.17 =========