builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1477929583.14 results: success (0) buildid: 20161031064000 builduid: dbe3b41c633d491788a549da2e367fcd revision: 45b462d40300df32424e2b582eb3b491de7331de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.144049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.144527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.144799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.159421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.159747) ========= 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=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 08:59:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-10-31 08:59:44 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.293422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.293749) ========= 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=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014605 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.343254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:43.343614) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 45b462d40300df32424e2b582eb3b491de7331de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 45b462d40300df32424e2b582eb3b491de7331de --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=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 08:59:44,316 truncating revision to first 12 chars 2016-10-31 08:59:44,317 Setting DEBUG logging. 2016-10-31 08:59:44,317 attempt 1/10 2016-10-31 08:59:44,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/45b462d40300?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 08:59:44,926 unpacking tar archive at: mozilla-inbound-45b462d40300/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:44.332864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:44.333209) ========= script_repo_revision: 45b462d40300df32424e2b582eb3b491de7331de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:44.333601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:44.333860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 08:59:44.344088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 08:59:44.344409) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:45 INFO - MultiFileLogger online at 20161031 08:59:45 in /builds/slave/test 08:59:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:59:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:45 INFO - {'append_to_log': False, 08:59:45 INFO - 'base_work_dir': '/builds/slave/test', 08:59:45 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:59:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:45 INFO - 'branch': 'Mozilla-Inbound', 08:59:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:45 INFO - 'config_files': ('talos/linux_config.py',), 08:59:45 INFO - 'default_actions': ('clobber', 08:59:45 INFO - 'read-buildbot-config', 08:59:45 INFO - 'download-and-extract', 08:59:45 INFO - 'populate-webroot', 08:59:45 INFO - 'create-virtualenv', 08:59:45 INFO - 'install', 08:59:45 INFO - 'run-tests'), 08:59:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:45 INFO - 'download_minidump_stackwalk': True, 08:59:45 INFO - 'download_symbols': 'ondemand', 08:59:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:45 INFO - 'installer_path': 'installer.exe', 08:59:45 INFO - 'log_level': 'info', 08:59:45 INFO - 'log_name': 'talos', 08:59:45 INFO - 'log_to_console': True, 08:59:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:45 INFO - 'opt_config_files': (), 08:59:45 INFO - 'pip_index': False, 08:59:45 INFO - 'sps_profile': False, 08:59:45 INFO - 'sps_profile_interval': 0, 08:59:45 INFO - 'suite': 'dromaeojs-e10s', 08:59:45 INFO - 'system_bits': '32', 08:59:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:45 INFO - 'title': 'talos-linux64-ix-053', 08:59:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:45 INFO - 'use_talos_json': True, 08:59:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:45 INFO - 'work_dir': 'build'} 08:59:45 INFO - [mozharness: 2016-10-31 15:59:45.420612Z] Running clobber step. 08:59:45 INFO - Running pre-action listener: _resource_record_pre_action 08:59:45 INFO - Running main action method: clobber 08:59:45 INFO - rmtree: /builds/slave/test/build 08:59:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:45 INFO - Running post-action listener: _resource_record_post_action 08:59:45 INFO - [mozharness: 2016-10-31 15:59:45.894946Z] Finished clobber step (success) 08:59:45 INFO - [mozharness: 2016-10-31 15:59:45.895049Z] Running read-buildbot-config step. 08:59:45 INFO - Running pre-action listener: _resource_record_pre_action 08:59:45 INFO - Running main action method: read_buildbot_config 08:59:45 INFO - Using buildbot properties: 08:59:45 INFO - { 08:59:45 INFO - "project": "", 08:59:45 INFO - "product": "firefox", 08:59:45 INFO - "script_repo_revision": "production", 08:59:45 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:59:45 INFO - "repository": "", 08:59:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 08:59:45 INFO - "buildid": "20161031064000", 08:59:45 INFO - "stage_platform": "linux64-pgo", 08:59:45 INFO - "basedir": "/builds/slave/test", 08:59:45 INFO - "buildnumber": 1934, 08:59:45 INFO - "platform": "ubuntu64_hw", 08:59:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:59:45 INFO - "slavebuilddir": "test", 08:59:45 INFO - "branch": "mozilla-inbound", 08:59:45 INFO - "revision": "45b462d40300df32424e2b582eb3b491de7331de", 08:59:45 INFO - "slavename": "talos-linux64-ix-053", 08:59:45 INFO - "builduid": "dbe3b41c633d491788a549da2e367fcd", 08:59:45 INFO - "repo_path": "integration/mozilla-inbound" 08:59:45 INFO - } 08:59:45 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:59:45 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 08:59:45 INFO - Running post-action listener: _resource_record_post_action 08:59:45 INFO - [mozharness: 2016-10-31 15:59:45.897400Z] Finished read-buildbot-config step (success) 08:59:45 INFO - [mozharness: 2016-10-31 15:59:45.897489Z] Running download-and-extract step. 08:59:45 INFO - Running pre-action listener: _resource_record_pre_action 08:59:45 INFO - Running main action method: download_and_extract 08:59:45 INFO - mkdir: /builds/slave/test/build/tests 08:59:45 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')]} 08:59:45 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:59:45 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/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 08:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/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 08:59:45 INFO - Downloaded 1361 bytes. 08:59:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:59:45 INFO - Using the following test package requirements: 08:59:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:59:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:59:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'jsshell-linux-x86_64.zip'], 08:59:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:59:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:59:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:59:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:59:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:59:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:59:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:59:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:59:45 INFO - Http code: 200 08:59:45 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 08:59:45 INFO - x-amz-cf-id: OZxuPER24przNahi2W-YDPz5PjLfm8bsnXm-Nx_jQiDkk4u2mZoeXg== 08:59:45 INFO - x-amz-replication-status: COMPLETED 08:59:45 INFO - x-amz-version-id: VkVqfvIGZA6rjA2DlErbzKwIhdSzgAhX 08:59:46 INFO - Expected file size: 22006176 08:59:46 INFO - Obtained file size: 22006176 08:59:50 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 08:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:50 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:59:50 INFO - Http code: 200 08:59:50 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 08:59:50 INFO - x-amz-cf-id: dwSsX8nvfrK3CITZAfT0Gu3-C-VuWeKbaU6bB76psMB1L1FAcJNaNg== 08:59:50 INFO - x-amz-replication-status: COMPLETED 08:59:50 INFO - x-amz-version-id: VkVqfvIGZA6rjA2DlErbzKwIhdSzgAhX 08:59:50 INFO - Expected file size: 22006176 08:59:50 INFO - Obtained file size: 22006176 08:59:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:59:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:59:55 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:59:55 INFO - Http code: 200 08:59:55 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:59:55 INFO - x-amz-cf-id: 9Y94PC971Rud4VI00kiwp_4nQTr32yWhpEErsl7IWgApdCdO32l5SQ== 08:59:55 INFO - x-amz-replication-status: COMPLETED 08:59:55 INFO - x-amz-version-id: HR3U1.5qBDABe9WVR1xDmv_.QlOEipCT 08:59:55 INFO - Expected file size: 14409038 08:59:55 INFO - Obtained file size: 14409038 08:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:55 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:59:55 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/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 08:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/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 08:59:56 INFO - Downloaded 59641622 bytes. 08:59:56 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:59:56 INFO - mkdir: /builds/slave/test/properties 08:59:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:56 INFO - Contents: 08:59:56 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:59:56 INFO - Running post-action listener: _resource_record_post_action 08:59:56 INFO - Running post-action listener: set_extra_try_arguments 08:59:56 INFO - [mozharness: 2016-10-31 15:59:56.662705Z] Finished download-and-extract step (success) 08:59:56 INFO - [mozharness: 2016-10-31 15:59:56.662965Z] Running populate-webroot step. 08:59:56 INFO - Running pre-action listener: _resource_record_pre_action 08:59:56 INFO - Running main action method: populate_webroot 08:59:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:56 INFO - '--tppagecycles', 08:59:56 INFO - '7'], 08:59:56 INFO - 'tests': ['tsvgm']}}, 08:59:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['damp', 'tps']}, 08:59:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'tests': ['damp', 'tps']}, 08:59:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['dromaeo_dom']}, 08:59:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['basic_compositor_video']}, 08:59:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tsvgx', 08:59:56 INFO - 'tsvgr_opacity', 08:59:56 INFO - 'tart', 08:59:56 INFO - 'tscrollx', 08:59:56 INFO - 'cart']}, 08:59:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:56 INFO - 'tsvgr_opacity', 08:59:56 INFO - 'tart', 08:59:56 INFO - 'tscrollx', 08:59:56 INFO - 'cart']}, 08:59:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tp5o']}, 08:59:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'tests': ['tp5o']}, 08:59:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s', 08:59:56 INFO - '--xperf_path', 08:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:56 INFO - 'tests': ['tp5n']}, 08:59:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:56 INFO - 'talos_options': ['--xperf_path', 08:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:56 INFO - 'tests': ['tp5n']}}, 08:59:56 INFO - 'talos.zip': {'path': '', 08:59:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:56 INFO - Running post-action listener: _resource_record_post_action 08:59:56 INFO - [mozharness: 2016-10-31 15:59:56.678810Z] Finished populate-webroot step (success) 08:59:56 INFO - [mozharness: 2016-10-31 15:59:56.678898Z] Running create-virtualenv step. 08:59:56 INFO - Running pre-action listener: _resource_record_pre_action 08:59:56 INFO - Running main action method: create_virtualenv 08:59:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:56 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 08:59:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:56 INFO - Using real prefix '/usr' 08:59:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:59 INFO - Installing pip.................done. 08:59:59 INFO - Return code: 0 08:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:59 INFO - Reading from file tmpfile_stdout 08:59:59 INFO - Output received: 08:59:59 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) 08:59:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:59 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')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 08:59:59 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 08:59:59 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 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 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 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:59 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')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 08:59:59 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 08:59:59 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 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Downloading/unpacking psutil>=3.1.1 08:59:59 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 08:59:59 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 08:59:59 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 08:59:59 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 08:59:59 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 08:59:59 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 09:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:01 INFO - Installing collected packages: psutil 09:00:01 INFO - Running setup.py install for psutil 09:00:01 INFO - building 'psutil._psutil_linux' extension 09:00:01 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 09:00:02 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 09:00:02 INFO - building 'psutil._psutil_posix' extension 09:00:02 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 09:00:02 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 09:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:02 INFO - Successfully installed psutil 09:00:02 INFO - Cleaning up... 09:00:02 INFO - Return code: 0 09:00:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:00:02 INFO - Using env: {'DISPLAY': ':0', 09:00:02 INFO - 'HOME': '/home/cltbld', 09:00:02 INFO - 'LANG': 'en_US.UTF-8', 09:00:02 INFO - 'LANGUAGE': 'en_US:en', 09:00:02 INFO - 'LOGNAME': 'cltbld', 09:00:02 INFO - 'MAIL': '/var/mail/cltbld', 09:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:02 INFO - 'MOZ_NO_REMOTE': '1', 09:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:02 INFO - 'NO_EM_RESTART': '1', 09:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:02 INFO - 'PWD': '/builds/slave/test', 09:00:02 INFO - 'SHELL': '/bin/bash', 09:00:02 INFO - 'SHLVL': '1', 09:00:02 INFO - 'TERM': 'linux', 09:00:02 INFO - 'TMOUT': '86400', 09:00:02 INFO - 'USER': 'cltbld', 09:00:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:02 INFO - '_': '/tools/buildbot/bin/python'} 09:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:04 INFO - Installing collected packages: mozsystemmonitor 09:00:04 INFO - Running setup.py install for mozsystemmonitor 09:00:04 INFO - Successfully installed mozsystemmonitor 09:00:04 INFO - Cleaning up... 09:00:04 INFO - Return code: 0 09:00:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00:04 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')]} 09:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:04 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')]} 09:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:04 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:04 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 09:00:04 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 09:00:04 INFO - Using env: {'DISPLAY': ':0', 09:00:04 INFO - 'HOME': '/home/cltbld', 09:00:04 INFO - 'LANG': 'en_US.UTF-8', 09:00:04 INFO - 'LANGUAGE': 'en_US:en', 09:00:04 INFO - 'LOGNAME': 'cltbld', 09:00:04 INFO - 'MAIL': '/var/mail/cltbld', 09:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:04 INFO - 'MOZ_NO_REMOTE': '1', 09:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:04 INFO - 'NO_EM_RESTART': '1', 09:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:04 INFO - 'PWD': '/builds/slave/test', 09:00:04 INFO - 'SHELL': '/bin/bash', 09:00:04 INFO - 'SHLVL': '1', 09:00:04 INFO - 'TERM': 'linux', 09:00:04 INFO - 'TMOUT': '86400', 09:00:04 INFO - 'USER': 'cltbld', 09:00:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:04 INFO - '_': '/tools/buildbot/bin/python'} 09:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:07 INFO - warning: no files found matching '*.txt' 09:00:07 INFO - no previously-included directories found matching 'build' 09:00:07 INFO - no previously-included directories found matching 'dist' 09:00:07 INFO - no previously-included directories found matching '.git*' 09:00:07 INFO - Installing collected packages: jsonschema, functools32 09:00:07 INFO - Running setup.py install for functools32 09:00:07 INFO - warning: no files found matching '*.txt' 09:00:07 INFO - no previously-included directories found matching 'build' 09:00:07 INFO - no previously-included directories found matching 'dist' 09:00:07 INFO - no previously-included directories found matching '.git*' 09:00:07 INFO - Successfully installed jsonschema functools32 09:00:07 INFO - Cleaning up... 09:00:07 INFO - Return code: 0 09:00:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:00:07 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')]} 09:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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')]} 09:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:07 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 09:00:07 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 09:00:07 INFO - Using env: {'DISPLAY': ':0', 09:00:07 INFO - 'HOME': '/home/cltbld', 09:00:07 INFO - 'LANG': 'en_US.UTF-8', 09:00:07 INFO - 'LANGUAGE': 'en_US:en', 09:00:07 INFO - 'LOGNAME': 'cltbld', 09:00:07 INFO - 'MAIL': '/var/mail/cltbld', 09:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:07 INFO - 'MOZ_NO_REMOTE': '1', 09:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:07 INFO - 'NO_EM_RESTART': '1', 09:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:07 INFO - 'PWD': '/builds/slave/test', 09:00:07 INFO - 'SHELL': '/bin/bash', 09:00:07 INFO - 'SHLVL': '1', 09:00:07 INFO - 'TERM': 'linux', 09:00:07 INFO - 'TMOUT': '86400', 09:00:07 INFO - 'USER': 'cltbld', 09:00:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:07 INFO - '_': '/tools/buildbot/bin/python'} 09:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:00:07 INFO - Cleaning up... 09:00:07 INFO - Return code: 0 09:00:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:07 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')]} 09:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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')]} 09:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:07 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 09:00:07 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 09:00:07 INFO - Using env: {'DISPLAY': ':0', 09:00:07 INFO - 'HOME': '/home/cltbld', 09:00:07 INFO - 'LANG': 'en_US.UTF-8', 09:00:07 INFO - 'LANGUAGE': 'en_US:en', 09:00:07 INFO - 'LOGNAME': 'cltbld', 09:00:07 INFO - 'MAIL': '/var/mail/cltbld', 09:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:07 INFO - 'MOZ_NO_REMOTE': '1', 09:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:07 INFO - 'NO_EM_RESTART': '1', 09:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:07 INFO - 'PWD': '/builds/slave/test', 09:00:07 INFO - 'SHELL': '/bin/bash', 09:00:07 INFO - 'SHLVL': '1', 09:00:07 INFO - 'TERM': 'linux', 09:00:07 INFO - 'TMOUT': '86400', 09:00:07 INFO - 'USER': 'cltbld', 09:00:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:07 INFO - '_': '/tools/buildbot/bin/python'} 09:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 INFO - Downloading docopt-0.6.1.tar.gz 09:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:10 INFO - Running setup.py install for blobuploader 09:00:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:10 INFO - Running setup.py install for requests 09:00:11 INFO - Running setup.py install for docopt 09:00:11 INFO - Successfully installed blobuploader requests docopt 09:00:11 INFO - Cleaning up... 09:00:11 INFO - Return code: 0 09:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:11 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')]} 09:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:11 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')]} 09:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:11 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:11 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 09:00:11 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 09:00:11 INFO - Using env: {'DISPLAY': ':0', 09:00:11 INFO - 'HOME': '/home/cltbld', 09:00:11 INFO - 'LANG': 'en_US.UTF-8', 09:00:11 INFO - 'LANGUAGE': 'en_US:en', 09:00:11 INFO - 'LOGNAME': 'cltbld', 09:00:11 INFO - 'MAIL': '/var/mail/cltbld', 09:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:11 INFO - 'MOZ_NO_REMOTE': '1', 09:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:11 INFO - 'NO_EM_RESTART': '1', 09:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:11 INFO - 'PWD': '/builds/slave/test', 09:00:11 INFO - 'SHELL': '/bin/bash', 09:00:11 INFO - 'SHLVL': '1', 09:00:11 INFO - 'TERM': 'linux', 09:00:11 INFO - 'TMOUT': '86400', 09:00:11 INFO - 'USER': 'cltbld', 09:00:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:11 INFO - '_': '/tools/buildbot/bin/python'} 09:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:11 INFO - Running setup.py (path:/tmp/pip-bzM9ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:11 INFO - Running setup.py (path:/tmp/pip-v2YfFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:11 INFO - Running setup.py (path:/tmp/pip-vcBYxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:11 INFO - Running setup.py (path:/tmp/pip-G0Zw2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:11 INFO - Running setup.py (path:/tmp/pip-hrZfP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:11 INFO - Running setup.py (path:/tmp/pip-Z4Yvr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:11 INFO - Running setup.py (path:/tmp/pip-9VTl3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:11 INFO - Running setup.py (path:/tmp/pip-D7CoA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:12 INFO - Running setup.py (path:/tmp/pip-sf8cDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:12 INFO - Running setup.py (path:/tmp/pip-lpc_pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:12 INFO - Running setup.py (path:/tmp/pip-PxwvKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:12 INFO - Running setup.py (path:/tmp/pip-kA7N_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:12 INFO - Running setup.py (path:/tmp/pip-agwdv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:12 INFO - Running setup.py (path:/tmp/pip-DmmXXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:12 INFO - Running setup.py (path:/tmp/pip-qL53eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:12 INFO - Running setup.py (path:/tmp/pip-b8jOue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:12 INFO - Running setup.py (path:/tmp/pip-a2NuAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:12 INFO - Running setup.py install for manifestparser 09:00:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:12 INFO - Running setup.py install for mozcrash 09:00:12 INFO - Running setup.py install for mozdebug 09:00:12 INFO - Running setup.py install for mozdevice 09:00:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for mozfile 09:00:13 INFO - Running setup.py install for mozhttpd 09:00:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for mozinfo 09:00:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for mozInstall 09:00:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for mozleak 09:00:13 INFO - Running setup.py install for mozlog 09:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for moznetwork 09:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:13 INFO - Running setup.py install for mozprocess 09:00:13 INFO - Running setup.py install for mozprofile 09:00:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:14 INFO - Running setup.py install for mozrunner 09:00:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:14 INFO - Running setup.py install for mozscreenshot 09:00:14 INFO - Running setup.py install for moztest 09:00:14 INFO - Running setup.py install for mozversion 09:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:14 INFO - Cleaning up... 09:00:14 INFO - Return code: 0 09:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:14 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 09:00:14 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 09:00:14 INFO - Using env: {'DISPLAY': ':0', 09:00:14 INFO - 'HOME': '/home/cltbld', 09:00:14 INFO - 'LANG': 'en_US.UTF-8', 09:00:14 INFO - 'LANGUAGE': 'en_US:en', 09:00:14 INFO - 'LOGNAME': 'cltbld', 09:00:14 INFO - 'MAIL': '/var/mail/cltbld', 09:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:14 INFO - 'MOZ_NO_REMOTE': '1', 09:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:14 INFO - 'NO_EM_RESTART': '1', 09:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:14 INFO - 'PWD': '/builds/slave/test', 09:00:14 INFO - 'SHELL': '/bin/bash', 09:00:14 INFO - 'SHLVL': '1', 09:00:14 INFO - 'TERM': 'linux', 09:00:14 INFO - 'TMOUT': '86400', 09:00:14 INFO - 'USER': 'cltbld', 09:00:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:14 INFO - '_': '/tools/buildbot/bin/python'} 09:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:14 INFO - Running setup.py (path:/tmp/pip-4pfFZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:14 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)) 09:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:14 INFO - Running setup.py (path:/tmp/pip-195t8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:14 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)) 09:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:14 INFO - Running setup.py (path:/tmp/pip-UHi04g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:14 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)) 09:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:14 INFO - Running setup.py (path:/tmp/pip-l6_kI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:14 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)) 09:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:14 INFO - Running setup.py (path:/tmp/pip-MKDW9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:15 INFO - Running setup.py (path:/tmp/pip-0lSTtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:15 INFO - Running setup.py (path:/tmp/pip-2IrLqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:15 INFO - Running setup.py (path:/tmp/pip-DGlrF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:15 INFO - Running setup.py (path:/tmp/pip-NgfIpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:15 INFO - Running setup.py (path:/tmp/pip-HR6r5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:15 INFO - Running setup.py (path:/tmp/pip-_5TNUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:15 INFO - Running setup.py (path:/tmp/pip-sLCk8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:15 INFO - Running setup.py (path:/tmp/pip-U0DLMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:15 INFO - Running setup.py (path:/tmp/pip-Z9qZzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:15 INFO - Running setup.py (path:/tmp/pip-0ZyZk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:15 INFO - Running setup.py (path:/tmp/pip-ufLDYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:15 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)) 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:15 INFO - Running setup.py (path:/tmp/pip-xOAD1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:15 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)) 09:00:15 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)) 09:00:15 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)) 09:00:15 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)) 09:00:15 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)) 09:00:15 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)) 09:00:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:17 INFO - Downloading blessings-1.6.tar.gz 09:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:17 INFO - Installing collected packages: blessings 09:00:17 INFO - Running setup.py install for blessings 09:00:18 INFO - Successfully installed blessings 09:00:18 INFO - Cleaning up... 09:00:18 INFO - Return code: 0 09:00:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:18 INFO - Reading from file tmpfile_stdout 09:00:18 INFO - Current package versions: 09:00:18 INFO - argparse == 1.2.1 09:00:18 INFO - blessings == 1.6 09:00:18 INFO - blobuploader == 1.2.4 09:00:18 INFO - docopt == 0.6.1 09:00:18 INFO - functools32 == 3.2.3-2 09:00:18 INFO - jsonschema == 2.5.1 09:00:18 INFO - manifestparser == 1.1 09:00:18 INFO - mozInstall == 1.12 09:00:18 INFO - mozcrash == 0.17 09:00:18 INFO - mozdebug == 0.1 09:00:18 INFO - mozdevice == 0.48 09:00:18 INFO - mozfile == 1.2 09:00:18 INFO - mozhttpd == 0.7 09:00:18 INFO - mozinfo == 0.9 09:00:18 INFO - mozleak == 0.1 09:00:18 INFO - mozlog == 3.4 09:00:18 INFO - moznetwork == 0.27 09:00:18 INFO - mozprocess == 0.23 09:00:18 INFO - mozprofile == 0.28 09:00:18 INFO - mozrunner == 6.12 09:00:18 INFO - mozscreenshot == 0.1 09:00:18 INFO - mozsystemmonitor == 0.3 09:00:18 INFO - moztest == 0.7 09:00:18 INFO - mozversion == 1.4 09:00:18 INFO - psutil == 3.1.1 09:00:18 INFO - requests == 1.2.3 09:00:18 INFO - wsgiref == 0.1.2 09:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:18 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 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:18 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 09:00:18 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 09:00:18 INFO - Using env: {'DISPLAY': ':0', 09:00:18 INFO - 'HOME': '/home/cltbld', 09:00:18 INFO - 'LANG': 'en_US.UTF-8', 09:00:18 INFO - 'LANGUAGE': 'en_US:en', 09:00:18 INFO - 'LOGNAME': 'cltbld', 09:00:18 INFO - 'MAIL': '/var/mail/cltbld', 09:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:18 INFO - 'MOZ_NO_REMOTE': '1', 09:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:18 INFO - 'NO_EM_RESTART': '1', 09:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:18 INFO - 'PWD': '/builds/slave/test', 09:00:18 INFO - 'SHELL': '/bin/bash', 09:00:18 INFO - 'SHLVL': '1', 09:00:18 INFO - 'TERM': 'linux', 09:00:18 INFO - 'TMOUT': '86400', 09:00:18 INFO - 'USER': 'cltbld', 09:00:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:18 INFO - '_': '/tools/buildbot/bin/python'} 09:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 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)) 09:00:18 INFO - Cleaning up... 09:00:18 INFO - Return code: 0 09:00:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3447c15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, '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': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', '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 09:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:00:18 INFO - Using env: {'DISPLAY': ':0', 09:00:18 INFO - 'HOME': '/home/cltbld', 09:00:18 INFO - 'LANG': 'en_US.UTF-8', 09:00:18 INFO - 'LANGUAGE': 'en_US:en', 09:00:18 INFO - 'LOGNAME': 'cltbld', 09:00:18 INFO - 'MAIL': '/var/mail/cltbld', 09:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:18 INFO - 'MOZ_NO_REMOTE': '1', 09:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:18 INFO - 'NO_EM_RESTART': '1', 09:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:18 INFO - 'PWD': '/builds/slave/test', 09:00:18 INFO - 'SHELL': '/bin/bash', 09:00:18 INFO - 'SHLVL': '1', 09:00:18 INFO - 'TERM': 'linux', 09:00:18 INFO - 'TMOUT': '86400', 09:00:18 INFO - 'USER': 'cltbld', 09:00:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:18 INFO - '_': '/tools/buildbot/bin/python'} 09:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:18 INFO - Cleaning up... 09:00:18 INFO - Return code: 0 09:00:18 INFO - Running post-action listener: _resource_record_post_action 09:00:18 INFO - Running post-action listener: _start_resource_monitoring 09:00:18 INFO - Starting resource monitoring. 09:00:18 INFO - [mozharness: 2016-10-31 16:00:18.811148Z] Finished create-virtualenv step (success) 09:00:18 INFO - [mozharness: 2016-10-31 16:00:18.811647Z] Running install step. 09:00:18 INFO - Running pre-action listener: _resource_record_pre_action 09:00:18 INFO - Running main action method: install 09:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:19 INFO - Reading from file tmpfile_stdout 09:00:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:19 INFO - Reading from file tmpfile_stdout 09:00:19 INFO - Output received: 09:00:19 INFO - Usage: mozinstall [options] installer 09:00:19 INFO - Options: 09:00:19 INFO - -h, --help show this help message and exit 09:00:19 INFO - -d DEST, --destination=DEST 09:00:19 INFO - Directory to install application into. [default: 09:00:19 INFO - "/builds/slave/test"] 09:00:19 INFO - --app=APP Application being installed. [default: firefox] 09:00:19 INFO - mkdir: /builds/slave/test/build/application 09:00:19 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'] 09:00:19 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 09:00:36 INFO - Reading from file tmpfile_stdout 09:00:36 INFO - Output received: 09:00:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:36 INFO - Running post-action listener: _resource_record_post_action 09:00:36 INFO - [mozharness: 2016-10-31 16:00:36.078701Z] Finished install step (success) 09:00:36 INFO - [mozharness: 2016-10-31 16:00:36.079017Z] Running run-tests step. 09:00:36 INFO - Running pre-action listener: _resource_record_pre_action 09:00:36 INFO - Running main action method: run_tests 09:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:36 INFO - Python 2.7.3 09:00:36 INFO - Return code: 0 09:00:36 INFO - grabbing minidump binary from tooltool 09:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:36 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 0x15f3f60>, '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 0x15f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:36 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 09:00:36 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 09:00:36 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 09:00:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:36 INFO - Return code: 0 09:00:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:00:36 INFO - Using env: {'DISPLAY': ':0', 09:00:36 INFO - 'HOME': '/home/cltbld', 09:00:36 INFO - 'LANG': 'en_US.UTF-8', 09:00:36 INFO - 'LANGUAGE': 'en_US:en', 09:00:36 INFO - 'LOGNAME': 'cltbld', 09:00:36 INFO - 'MAIL': '/var/mail/cltbld', 09:00:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:36 INFO - 'MOZ_NO_REMOTE': '1', 09:00:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:36 INFO - 'NO_EM_RESTART': '1', 09:00:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:36 INFO - 'PWD': '/builds/slave/test', 09:00:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:36 INFO - 'SHELL': '/bin/bash', 09:00:36 INFO - 'SHLVL': '1', 09:00:36 INFO - 'TERM': 'linux', 09:00:36 INFO - 'TMOUT': '86400', 09:00:36 INFO - 'USER': 'cltbld', 09:00:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965', 09:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:36 INFO - '_': '/tools/buildbot/bin/python'} 09:00:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:00:36 INFO - mozversion application_buildid: 20161029153002 09:00:36 INFO - mozversion application_changeset: 45b462d40300df32424e2b582eb3b491de7331de 09:00:36 INFO - mozversion application_display_name: Nightly 09:00:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:36 INFO - mozversion application_name: Firefox 09:00:36 INFO - mozversion application_remotingname: firefox 09:00:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:00:36 INFO - mozversion application_vendor: Mozilla 09:00:36 INFO - mozversion application_version: 52.0a1 09:00:36 INFO - mozversion platform_buildid: 20161029153002 09:00:36 INFO - mozversion platform_changeset: 45b462d40300df32424e2b582eb3b491de7331de 09:00:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:00:36 INFO - mozversion platform_version: 52.0a1 09:00:36 INFO - using testdate: 1477929636 09:00:36 INFO - actual date: 1477929636 09:00:36 INFO - starting webserver on 'localhost:56929' 09:00:36 INFO - SUITE-START | Running 2 tests 09:00:36 INFO - TEST-START | dromaeo_css 09:00:36 INFO - operating with platform_type : linux_ 09:00:36 INFO - Initialising browser for dromaeo_css test... 09:00:36 INFO - TEST-INFO | started process 22394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7FtC1/profile http://localhost:56929/getInfo.html) 09:00:41 INFO - PROCESS | 22394 | __metrics Screen width/height:1600/1200 09:00:41 INFO - PROCESS | 22394 | colorDepth:24 09:00:41 INFO - PROCESS | 22394 | Browser inner width/height: 1024/697 09:00:41 INFO - PROCESS | 22394 | __metrics 09:00:41 ERROR - PROCESS | 22394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 09:00:42 INFO - TEST-INFO | 22394: exit 0 09:00:42 INFO - Browser initialized. 09:00:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:42 INFO - TEST-INFO | started process 22513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7FtC1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:54 INFO - PROCESS | 22513 | RSS: Main: 185651200 09:00:54 INFO - PROCESS | 22513 | 09:01:44 INFO - PROCESS | 22513 | 1477929704452 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] 09:03:55 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56929/tests/dromaeo/cssquery-ext.html) 09:03:56 INFO - PROCESS | 22513 | RSS: Main: 197836800 09:03:56 INFO - PROCESS | 22513 | 09:06:58 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-ext.html (next: http://localhost:56929/tests/dromaeo/cssquery-jquery.html) 09:06:59 INFO - PROCESS | 22513 | RSS: Main: 196038656 09:06:59 INFO - PROCESS | 22513 | 09:10:01 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56929/tests/dromaeo/cssquery-mootools.html) 09:10:02 INFO - PROCESS | 22513 | RSS: Main: 198283264 09:10:02 INFO - PROCESS | 22513 | 09:13:03 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56929/tests/dromaeo/cssquery-prototype.html) 09:13:04 INFO - PROCESS | 22513 | RSS: Main: 194756608 09:13:04 INFO - PROCESS | 22513 | 09:16:07 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56929/tests/dromaeo/cssquery-yui.html) 09:16:07 INFO - PROCESS | 22513 | RSS: Main: 198053888 09:16:07 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-yui.html (next: http://localhost:56929/tests/dromaeo/cssquery-dojo.html) 09:19:10 INFO - PROCESS | 22513 | RSS: Main: 197447680 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | __start_tp_report 09:19:10 INFO - PROCESS | 22513 | _x_x_mozilla_page_load 09:19:10 INFO - PROCESS | 22513 | _x_x_mozilla_page_load_details 09:19:10 INFO - PROCESS | 22513 | |i|pagename|runs| 09:19:10 INFO - PROCESS | 22513 | |0;dojo.html;2987.432387846309;2991.6260467441566;2994.5957295765065;3008.638963324401;3014.3067094568255;5092.694438333693;5190.584753219738;5192.558632516236;5234.37187537496;5250.396204436491;5117.616178786588;5214.634975551713;5236.450172731866;5254.658447200929;5270.604704647148;4729.219678753002;4750.667453278272;4834.854954351357;4839.854804355875;4918.696545415468;4728.267118596623;4810.422749270093;4854.223324268118;4911.803527858881;4958.107540642683;4667.88330291742;4717.198076327033;4719.433667959866;4720.858374248778;4778.689385189969;4775.283707443877;4779.784909679072;4783.282507623884;4818.132736107499;4833.661643684944;4749.57253847152;4758.405199350082;4776.211925032366;4785.353977213066;4809.567138957475;5053.67151135175;5070;5090.465501122366;5218.452062533455;5251.632385733;5505.807296744635;5567.777288908439;5575.69333686647;5591;5677.290338707661;5596.104623260258;5633.8309850704545;5637.379888212294;5652.321721393418;5664.8867022659315;5059.089363914531;5232.927249913759;5270.604704647167;5275.815346462856;5332.813351532716;5540.307461567304;5668.688222147822;5694.800681976194;5698.715064246771;5807.709614519257;5504.80733174337;5517.200005999108;5521.917171242435;5522.447755224445;5546.473085056913;5497.47773961473;5587.161925711094;5597.972010139923;5604;5656.632318899258;5366.490183432567;5471.945280547223;5528.917066244009;5591.384947655754;5591.52472039873;5568.888622227614;5570.275864137636;5575.0522411190195;5581.190727344512;5617.101263797773;4307.633851122627;4313.374560688682;4319.611234988866;4324.459442569679;4374.606285434326;3788.0340513168967;3791.5829258781514;3818.866339678098;3853.2871418787613;3907.355286377716;5299.4700529946695;5319.867003324948;5352.4915133062295;5366.731663416814;5391.272178255964;5622.409646987089;5631.577631677558;5635.520980716685;5639.43605639441;5652.236948012048;5143.099957507421;5165.509276618715;5252.684838909678;5307.044731948209;5387.515123638891;4849.854504364875;4875.341828853059;4895.730734809548;4924.285978533093;4945.901081978341;5764.884702305846;5776.653400795965;5785.10330898703;5787.594868359174;5789.2763404574425;5471.343438787371;5528.944710552843;5599.1041433370465;5611.158326251095;5679.119736440858;5766.654000759968;5796.449337312949;5814.360420353673;5838.883222335445;5886.52907767369;5500.642458240201;5531.197976293495;5552.444755524415;5562.22128901946;5576.637518561281;5410.891782164414;5591.692456914909;5602.831915042555;5603.663780173202;5618;5359.651622644516;5406.567474601944;5417.458254174709;5459.12653975362;5526.50261476469;5421.295231619864;5432.266644003167;5439.374471935778;5441.401445841034;5460.426655201306;5162.612804039637;5242.397124330751;5389.083855744454;5399.865003374947;5435.728213589384;5396.487333703292;5464.426235245242;5475;5476.342838859362;5533.557315414677;5308.920366194588;5353.357597088374;5354.411014788292;5356.651817631841;5358.705271210121 09:19:10 INFO - PROCESS | 22513 | |1;ext.html;553.2359575001301;554.8474169603356;562.558391662545;581.2617975171531;600.6486205569743;39921.99999999996;41063.38404923925;41137.3829392559;44150.33774493377;44243.55756442434;42268.36597451041;42538.36192457108;42619.36070958938;42689.35965960513;42746;8777.99053108891;8963.193312601865;9017.504037277948;9021.95489022554;9031.41295815773;8788.560571971377;8856.158664926821;8856.734297971072;8878.73363799087;8890.511021893793;8925.642974281021;8948.373613847034;8966.148215919477;8971.95514022429;8974.326925480582;8828.117188281185;8874.334424918125;8891.288696904232;8918.687845925426;8935.419197752126;8717.215450609476;8814.206721395105;8819;8844.46933184011;8845.778855528599;40960;41408.378874316906;41488.79255603703;41516.1696766066;41549.376759348634;3298.3897978873983;3407.914802129942;3465.9826700866333;3798.449224862407;4047.0894048838777;30507.847460762776;30974.818399516003;31018;31163.53254701181;31684.524732129037;4282.143571285756;4305.182015417092;4366.235908715962;4367.716098453622;4553.112143132091;321799;324183;325260;326649;329087;56215.71892140513;56632;56754;56820.71589642108;56980.14529782056;59292.40707592869;59323;59392.70303648454;59394;59544.70227648921;14989.700205996038;15179.848201518063;15208.239588020777;15248.390064397521;15265.923670381577;12744.681382965315;12827.871721282667;12897;12903.032272579594;12912.806307905388;15311.707982783755;16731.330746770236;16840.663186736198;16880.746788797933;16916.238769255415;5744.908467391182;5754.712264386848;5762.337331206881;5806.245188125601;5873.471387575053;850.4217132349937;995.5320999130397;1077.5743581285349;1080.8702955645374;1098.8681358237063;30397.336759023572;30508.389832203233;30637.234069148002;30666;30908.836800702757;1064.7489200189746;1099.373357186412;1099.8240281555072;1122.7586068995206;1124.7637996020928;15762.975406598534;16569.337226511045;16592.419265325654;16659;16707.331706731595;506587;507193;511148;513283;516834;57350.426495735344;57592.71203643955;58182.418175818544;58292.417075829544;58311;1277.2145130744525;1315.6316231455016;1331.081553727944;1334.3261652865435;1336.3785839584639;29048.854755726086;30044.849775750983;30116.24709382283;30931.536026959162;31687.841560792047;53515.73242133764;54068.18897716459;54136.729316353165;54180;54273.18590221071;441952;442373;443035;445060;447695;40813.59186408217;41312.793436032625;41713;41844.581554185286;42084.57915420929;46299.53700463087;47099;47452.52547474481;47506.28740568963;48240.276395854795;38732.80633596814;39441.80279098701;39524.40713389359;39660;41848.581514184465;39409.728258440126;39855.2028959425;39930;41336.58663413447;41728.95677608084;38496.230075397776;39767;39885;40170;40374.798126009184;30683.693163068085;34407.483887741204;35162.64837351696;35618.39914515067;36407.27185456329;27039.59440608353;27156.32109197207;27410.588841167;27551.724482754915;27598.2836024501 09:19:10 INFO - PROCESS | 22513 | |2;jquery.html;383.3559619838672;388.67545599424517;397.24919901386374;397.866714650592;425.8701096165668;15166.772498412533;15881.047137171778;18625.53436164095;19564.608707825835;19618.705719414203;11606.187566870323;11799.7640047199;11994.46024928878;12239.632811015661;12264.632061038183;5138.177891537364;5404.864878378053;5415.13357862742;5420.457954204568;5424.891502169954;5147.099257629919;5265.921011184835;5351.946480535184;5388.892222155555;5411.296531450906;5335.226392173152;5346.144616861303;5346.625736198448;5373.704446255454;5384.542313903323;5325.041492531343;5340.038793017256;5536.584756143306;5804.88390232193;5834.708264586754;5767.942320576824;5770.076787713946;5773.9422605773825;5782.190493330937;5799.971000145015;13480.191188528719;13693.109947853458;13804.102733322303;14065.929670351583;14106.083104598169;2176.2969211303343;2195.100008996304;2350.5416443793465;2370.798482129021;2863.883085596619;9873.80252394948;10526.473676316231;10714.410707411089;13009.154404963647;13448.663783405394;1838.209569884949;1944.7471828662324;1954.8045195480481;1999.8900060496667;2009.4072248686527;80580;81518.59240703759;82750.58624706898;84259;84482.57758711166;10872.130229581615;11044.779104417867;11090.168237382068;11117.55529778816;11158.776824463464;15187.620309492351;15196.544103676908;15207.467738629317;15214;15281.847181528265;8077.474964127313;8098.473599216032;8117.878231826528;8336.208060234268;8346.374021948257;7851.646675899598;7879.699849524764;8001.719939802079;8003.159668234868;8114.797130071677;4589.311603259538;4611.492735799059;4718.127146477844;4779.139754844092;4785.760711964388;1919.659081291785;1930.8760363599927;1972.8027197280157;1973.1416833677397;2007.1469625409143;888.6667499687617;931.9487428191379;937.2267878999852;965.2712202287369;1058.380847204394;17881.28474860991;18154.364597239033;19707.211711531665;19748.40754777359;20977.26579569738;975.9902400975899;981.8821741391079;983.9114479696862;997.5660587644398;1023.8822535408375;10494.580216791395;11214.439278036229;11241.325520468798;11282.605108821152;11285.774284514428;447426;449705;455676;468374.5812709351;473115;91365;93500;94321;95016;95926;1015.4821041268858;1055.4353420919772;1056.741098430874;1060.713607326033;1079.5142186016324;15741.921290393475;17210.569735756708;17553.297868085134;17721.202545885724;17796;41736.58263417327;42593.5740642602;43207.78396107999;43769.78115109532;44554.3316850241;54487.455125448236;54929.45070549243;58849.75835049812;58990.41009589849;60130;8322.70870519529;8365.163483651586;8381.706640267805;8690;8706.390552661253;12499.500019999097;12989.895858852104;13001.609951701465;13036.47854085826;13199.20804751718;11275.605353812578;11333.433328333385;11378.772424551296;11408.828867566826;11631.825522616999;11035.558577656804;11165.38590377537;11320.26418282809;11321;11925.165238433226;11403;11427.485763140845;11432.485538150637;11743.88256117428;11762.059035277329;8240.62917168717;8288.21261980111;8318.79203019905;8368.163183681583;8741.475511469078;9939.353941993748;11201.71995700114;11576.073914086684;11643.41782910834;11720.41397930083 09:19:10 INFO - PROCESS | 22513 | |3;mootools.html;1415.7168566286741;1465.2527211122326;1559.1970135380282;1694.7542606322077;1703.8210987846276;7506.699732010727;7772.922270777291;8109.513429194252;8604.741857744262;8638.222559969594;8030.678772849094;8305.377096717755;8317.542535160565;8401.747947561567;8440.535770532633;2281.863088214704;2316.2124877541632;2328.080408238745;2329.406001469623;2330.1727886600265;2269.7503274639776;2310.191432998454;2326.9069237230574;2331.8134549236106;2331.8717470539113;2324.0587562037404;2327.511222643247;2338.3218866528773;2342.613468777658;2349.2130136404326;2229.2866282789514;2277.134688818255;2293.323469576479;2293.564222797663;2294.7475777664445;2261.796438320559;2270.9545809083725;2285.8057065149483;2297.173017713622;2298.9655155172686;8222.342212623036;8289.212524810133;8463.74608761738;8579.914200857975;8590.828183436359;5181.171012637998;5262.97368513155;5331.706756128411;5336.7865285388925;5338.172583249602;3224.8226347550876;3227.2415982244156;3539.94690079649;3546.7871927684423;3548.27260411615;1099.4612639806517;1114.726891911487;1127.9605213817558;1128.2609890521721;1176.04152615618;11481.368524731137;11524.366159861203;11565.479553420117;11582.594609188638;11584.362860042778;4394.8242070317465;4485;4565.611922986517;4576.885577860514;4729.739864307496;9662.420254784736;9687.225021998223;9741.951290243504;9787.559559819825;9798.75503112428;5240.737963101906;5241.24002019705;5248.8425347239645;5250.868728281824;5254.894902101936;4540;4686.671932964659;4703.882402939886;4820.325154478376;4882.9755851221225;3582.4268117101137;3720.5535335759882;3762.6425489578446;3778.7165962552367;3784.8864534064023;1167.2937872587133;1174.365842445087;1176.5764324843049;1179.1981452612306;1182.7693599747965;700.6496751624188;796.5419883566972;900.4732231644562;911.5761171055491;945.716285114463;5698.487136157766;5703;5710.65736055838;5713.714314284269;5795.739191736382;956.6460409648474;966.8108226880835;993.2352088891513;997.586001809241;1057.4606950455322;3639.763415377992;3833.310004199215;3857.7685338879755;3861.864834730771;3864.381698928214;10279;10408.531616077295;10467.738306542398;10495.26533142688;10529.84205236922;10313.329633573794;10344.741381465523;10373.170146388271;10388.220883433622;10488.318259313273;7505.737299194502;7869.291763741291;7870.134285228621;7979.202079791974;8072.677092916335;5681.0910254359105;5778.36437991829;5784.797532086357;5814.796482123105;5923;9364.95317523408;9474.95262523683;9482.38364506305;9490.383125096847;9550.426974381558;9671.613135474503;9789.070038346346;9827.31208815376;9842.311038227255;9926.255530835071;6395.808125756234;7053.329933656294;7412.518186317872;7456.701731930662;7531.246875312425;8138.918610814053;8284.751457456287;8303.95848020756;8313;8328.83342333162;7259.491835571459;7427.628618569158;7542.434317426105;7561.810954726176;7658.578778167254;7201.459890508128;7375.557466552024;7430.814229644302;7469.850602987801;7659.387249019954;6321.336259692666;6459.483241340776;6463.870722585616;6468.450181734417;6468.8059358219325;4825.6139508839915;4846.8788280291865;4888;4912.778924948458;4932.161532539549;4671.602913752369;4676.602488788491;4760.166970780169;4783;4873.610111191168 09:19:10 INFO - PROCESS | 22513 | |4;prototype.html;310.30491698595154;326.5591451540419;328.123909162536;329.0917068889864;337.6977605043487;5187.221916712495;5403.432639572848;5459.426760190182;5479.287692599966;5506.862328441786;5355.6786592804365;5415.187721841716;5423.457654234575;5438.945610543903;5442.510174084332;4236.428082208893;4243.257429949762;4256.170046840852;4262.104957958817;4266.360045993095;4235.216484950294;4281.244689677233;4293.892652683677;4318.07161460286;4326.783660816946;4232.25935461293;4244.745315281093;4246.851360202393;4259.5740425957465;4268.829246830123;4258.510271318807;4275.850345237917;4279.572042795727;4293.463317085364;4299.613034826849;3670.596234414212;3791.2417516496535;3800.239952009609;3800.277947190025;3804.353259945788;5259.763310650992;5272.841814745564;5305.920411193835;5313.485656587893;5371.597130215249;4890.24201248807;4904.5831104356175;4909.926351104737;4919.72941488218;4921.753912304406;5508.3114610673665;5661.547076233891;5715.257016587817;5720.971395142998;5803.941960580424;4110.260153172428;4120.938185927213;4125.216208920296;4129.504459464853;4134.813933373005;5717.171010203539;5893.528517718572;5910.645361278337;5967.731452084667;5975.340973266898;4033.6571391432058;4055.655269302142;4066.6340029397497;4069.369247766601;4076.103257283393;4127.855525056609;4154.937675934863;4161.9375709364385;4170.812313445902;4176.665866730655;4672.299155126758;4818.927716084261;4829.975850120727;4850.248211527219;4856.68431551948;5725.2843394575675;5726.141078838207;5731.398203188689;5757.654540727486;5772.422757724278;1432.9928350358182;1444.407792804966;1446.4575784080969;1446.9204193769444;1449.2753623188405;839.4166054592;884.4604791077437;907.2379201470796;930.3069213436033;933.8599210118537;4737.881552961135;4756.524347565216;4801.879953001203;4808.519148085164;4847.709137451764;5100.897982040338;5123.590112790967;5130.51260130287;5138.4604616514725;5146.845594632167;4700.482946875841;4764.618830493552;4808.63935204861;4821.397325334333;4893.755312234445;2746.791411778811;2752.843805601652;2755.7244275572684;2767.6263704400053;2792.944141117166;5297.708855826792;5333.586599551122;5340.759665815048;5352.759125839347;5371.677699338053;4937.755411869576;5204.609654275944;5210.921836172461;5217.2434996925995;5221.738913054408;5194.909069095456;5213.921791173136;5272.499112584298;5281.577473802086;5288.060395005668;5094.5669618082875;5114.71869047206;5115.283860259492;5134.818991632021;5152.716600587004;4882.60939124862;5031.421386540448;5037.420696619935;5043.84868453947;5114.514121158484;5272.736363181749;6001.90997135052;6136.539759517965;6140.355262697352;6161.229846269216;4148.688848336326;4187.66498680111;4194.328907374806;4197.349410841324;4211.515675697212;5685.374608792947;5954;5957.285125784933;5985.730642121028;6002.489788368038;5755.3381361144;5763.855903602276;5771.604784014755;5773.769049237983;5791.594588378773;5803;5827.650340979555;5827.883442331215;5846.298444186725;5852.332085355653;5650.7568334966245;5674.829755107354;5677.68772717488;5686.459786320293;5756.762296106357;5767.307923049261;5779.323996041269;5816.243888294494;5851.707414629337;5870.882582348244;5483.369412517612;5646.209530665628;5752.676884316715;5759.667334729441;5775.393583673822 09:19:10 INFO - PROCESS | 22513 | |5;yui.html;643.4144928115414;763.0995425398031;783.4868161354315;803.81512252182;804.9758507244777;14453.494127705519;15230.314635841387;15301.081935083888;15498.302576384061;15608.531744047668;14848.48030318939;15026.398944042252;15070.39718411265;15125.016873903189;15145.091294522337;795.1849354411731;804.4127786715701;804.6258489802241;805.7341077444459;812.4800127918137;467.24539868113095;476.2380191693298;781.7381177305609;802.2819576479047;806.8426656801926;845.0535400351584;849.2144766091371;849.6728759427634;849.7323343146888;853.2960307746104;840.756180707594;841.167244428018;841.6843683618642;841.6885752271637;841.9410641255115;618.3074956049254;618.7865186510646;619.2878190081398;619.938006199381;620.3238470067603;13012.21926684402;13127.40926658293;13176;13178.143420677625;13191.07662463628;13234.470621175142;13660.65848353789;13683;13738.313084345842;13743.175409475463;10793.190510711727;10952.726181845437;10979.1765617579;11117.444127793658;11606.94196529012;3653.963460365389;3670.724695647837;3678.7608805427562;3683.834227459744;3707.6292370762976;52429;54014;54381.45618543843;61383;62466.37533624651;10738.516766745515;10826.225029538331;10857.185711071543;10924.672259832218;10984.945075274733;18987.240510379706;19037.42887713371;19074.52313692169;19128;19530.414087577396;7899.960500197462;7990.240927111915;8044.115147333789;8076.636551355203;8294.313717709547;4501.459824821042;4509.143262780061;4511.368408422823;4531.501534831166;4624.213883639722;3116.735077518391;3241.7730758846656;3249.52881832133;3259.788113772597;3269.7874638148446;578.5400606517828;588.2470437839572;601.648035899004;609.5732986909181;616.4051690119056;700.6609634584498;714.1358955663601;717.2182321269737;756.8372799847949;768.6156921539231;8680.956595216983;8836.204741573289;8951.239144672645;9046.436441588376;9070.54647267634;618.6875627808018;659.6404959297195;673.565550220115;674.699758607415;688.0607970120749;4268.274393353137;4836.371271734652;4894.68184568009;4915.65590408668;4992.72540010303;53705.462945370826;53844.46155538395;53935.190972135446;84882;85133.57433212794;71754.64122679354;72966.27033729701;73007.26992730111;73951;74676.62661686656;66103.66948165228;67709.96870093807;67815.3218467809;68038.31961680518;70182.64908675526;9350.392224505385;9544.33189676716;9624.470654114091;9630.229581633312;9637;40716;44571.77714111538;44744.328835068154;45661;48086;55491.44508554863;56850;57330.713346433;58034;60085;12390.504379825066;12439.937800310941;12468.5012599495;12533.435995380412;12662.493500259887;13771.655708607364;13907.513237036655;14314.785278221043;14372.712545749235;14418.567442976728;12141.878581214074;12473.376331183586;12538.49846006186;12619.558315458915;13710.65723356924;12645.87354126447;12795.80806287925;13069.673258168621;13511.121777084458;13521.526746563823;12250.203736757083;12336.259824410565;12417.62747117588;12439.129260951646;12607.747845042864;10212.234082443698;10540.420276884844;10785.784284314113;10827.949389266634;10843.837342440027;9375.217871975949;10393.808874874441;10513.264071515227;10630.192867212747;10931.453427328443 09:19:10 INFO - PROCESS | 22513 | __end_tp_report 09:19:10 INFO - PROCESS | 22513 | __start_cc_report 09:19:10 INFO - PROCESS | 22513 | _x_x_mozilla_cycle_collect,322 09:19:10 INFO - PROCESS | 22513 | __end_cc_report 09:19:10 INFO - PROCESS | 22513 | __startTimestamp1477930750707__endTimestamp 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | ------- Summary: start ------- 09:19:10 INFO - PROCESS | 22513 | Number of tests: 6 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#0] dojo.html Cycles:165 Average:5195.28 Median:5387.52 stddev:582.57 (10.8%) stddev-sans-first:558.01 09:19:10 INFO - PROCESS | 22513 | Values: 2987.4 2991.6 2994.6 3008.6 3014.3 5092.7 5190.6 5192.6 5234.4 5250.4 5117.6 5214.6 5236.5 5254.7 5270.6 4729.2 4750.7 4834.9 4839.9 4918.7 4728.3 4810.4 4854.2 4911.8 4958.1 4667.9 4717.2 4719.4 4720.9 4778.7 4775.3 4779.8 4783.3 4818.1 4833.7 4749.6 4758.4 4776.2 4785.4 4809.6 5053.7 5070.0 5090.5 5218.5 5251.6 5505.8 5567.8 5575.7 5591.0 5677.3 5596.1 5633.8 5637.4 5652.3 5664.9 5059.1 5232.9 5270.6 5275.8 5332.8 5540.3 5668.7 5694.8 5698.7 5807.7 5504.8 5517.2 5521.9 5522.4 5546.5 5497.5 5587.2 5598.0 5604.0 5656.6 5366.5 5471.9 5528.9 5591.4 5591.5 5568.9 5570.3 5575.1 5581.2 5617.1 4307.6 4313.4 4319.6 4324.5 4374.6 3788.0 3791.6 3818.9 3853.3 3907.4 5299.5 5319.9 5352.5 5366.7 5391.3 5622.4 5631.6 5635.5 5639.4 5652.2 5143.1 5165.5 5252.7 5307.0 5387.5 4849.9 4875.3 4895.7 4924.3 4945.9 5764.9 5776.7 5785.1 5787.6 5789.3 5471.3 5528.9 5599.1 5611.2 5679.1 5766.7 5796.4 5814.4 5838.9 5886.5 5500.6 5531.2 5552.4 5562.2 5576.6 5410.9 5591.7 5602.8 5603.7 5618.0 5359.7 5406.6 5417.5 5459.1 5526.5 5421.3 5432.3 5439.4 5441.4 5460.4 5162.6 5242.4 5389.1 5399.9 5435.7 5396.5 5464.4 5475.0 5476.3 5533.6 5308.9 5353.4 5354.4 5356.7 5358.7 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#1] ext.html Cycles:180 Average:58905.29 Median:41631.19 stddev:114889.05 (276.0%) stddev-sans-first:115127.80 09:19:10 INFO - PROCESS | 22513 | Values: 553.2 554.8 562.6 581.3 600.6 39922.0 41063.4 41137.4 44150.3 44243.6 42268.4 42538.4 42619.4 42689.4 42746.0 8778.0 8963.2 9017.5 9022.0 9031.4 8788.6 8856.2 8856.7 8878.7 8890.5 8925.6 8948.4 8966.1 8972.0 8974.3 8828.1 8874.3 8891.3 8918.7 8935.4 8717.2 8814.2 8819.0 8844.5 8845.8 40960.0 41408.4 41488.8 41516.2 41549.4 3298.4 3407.9 3466.0 3798.4 4047.1 30507.8 30974.8 31018.0 31163.5 31684.5 4282.1 4305.2 4366.2 4367.7 4553.1 321799.0 324183.0 325260.0 326649.0 329087.0 56215.7 56632.0 56754.0 56820.7 56980.1 59292.4 59323.0 59392.7 59394.0 59544.7 14989.7 15179.8 15208.2 15248.4 15265.9 12744.7 12827.9 12897.0 12903.0 12912.8 15311.7 16731.3 16840.7 16880.7 16916.2 5744.9 5754.7 5762.3 5806.2 5873.5 850.4 995.5 1077.6 1080.9 1098.9 30397.3 30508.4 30637.2 30666.0 30908.8 1064.7 1099.4 1099.8 1122.8 1124.8 15763.0 16569.3 16592.4 16659.0 16707.3 506587.0 507193.0 511148.0 513283.0 516834.0 57350.4 57592.7 58182.4 58292.4 58311.0 1277.2 1315.6 1331.1 1334.3 1336.4 29048.9 30044.8 30116.2 30931.5 31687.8 53515.7 54068.2 54136.7 54180.0 54273.2 441952.0 442373.0 443035.0 445060.0 447695.0 40813.6 41312.8 41713.0 41844.6 42084.6 46299.5 47099.0 47452.5 47506.3 48240.3 38732.8 39441.8 39524.4 39660.0 41848.6 39409.7 39855.2 39930.0 41336.6 41729.0 38496.2 39767.0 39885.0 40170.0 40374.8 30683.7 34407.5 35162.6 35618.4 36407.3 27039.6 27156.3 27410.6 27551.7 27598.3 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#2] jquery.html Cycles:180 Average:27736.88 Median:386.02 stddev:76023.00 (19694.3%) stddev-sans-first:76208.52 09:19:10 INFO - PROCESS | 22513 | Values: 383.4 388.7 397.2 397.9 425.9 15166.8 15881.0 18625.5 19564.6 19618.7 11606.2 11799.8 11994.5 12239.6 12264.6 5138.2 5404.9 5415.1 5420.5 5424.9 5147.1 5265.9 5351.9 5388.9 5411.3 5335.2 5346.1 5346.6 5373.7 5384.5 5325.0 5340.0 5536.6 5804.9 5834.7 5767.9 5770.1 5773.9 5782.2 5800.0 13480.2 13693.1 13804.1 14065.9 14106.1 2176.3 2195.1 2350.5 2370.8 2863.9 9873.8 10526.5 10714.4 13009.2 13448.7 1838.2 1944.7 1954.8 1999.9 2009.4 80580.0 81518.6 82750.6 84259.0 84482.6 10872.1 11044.8 11090.2 11117.6 11158.8 15187.6 15196.5 15207.5 15214.0 15281.8 8077.5 8098.5 8117.9 8336.2 8346.4 7851.6 7879.7 8001.7 8003.2 8114.8 4589.3 4611.5 4718.1 4779.1 4785.8 1919.7 1930.9 1972.8 1973.1 2007.1 888.7 931.9 937.2 965.3 1058.4 17881.3 18154.4 19707.2 19748.4 20977.3 976.0 981.9 983.9 997.6 1023.9 10494.6 11214.4 11241.3 11282.6 11285.8 447426.0 449705.0 455676.0 468374.6 473115.0 91365.0 93500.0 94321.0 95016.0 95926.0 1015.5 1055.4 1056.7 1060.7 1079.5 15741.9 17210.6 17553.3 17721.2 17796.0 41736.6 42593.6 43207.8 43769.8 44554.3 54487.5 54929.5 58849.8 58990.4 60130.0 8322.7 8365.2 8381.7 8690.0 8706.4 12499.5 12989.9 13001.6 13036.5 13199.2 11275.6 11333.4 11378.8 11408.8 11631.8 11035.6 11165.4 11320.3 11321.0 11925.2 11403.0 11427.5 11432.5 11743.9 11762.1 8240.6 8288.2 8318.8 8368.2 8741.5 9939.4 11201.7 11576.1 11643.4 11720.4 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#3] mootools.html Cycles:180 Average:5557.43 Median:5056.67 stddev:3103.14 (61.4%) stddev-sans-first:3096.24 09:19:10 INFO - PROCESS | 22513 | Values: 1415.7 1465.3 1559.2 1694.8 1703.8 7506.7 7772.9 8109.5 8604.7 8638.2 8030.7 8305.4 8317.5 8401.7 8440.5 2281.9 2316.2 2328.1 2329.4 2330.2 2269.8 2310.2 2326.9 2331.8 2331.9 2324.1 2327.5 2338.3 2342.6 2349.2 2229.3 2277.1 2293.3 2293.6 2294.7 2261.8 2271.0 2285.8 2297.2 2299.0 8222.3 8289.2 8463.7 8579.9 8590.8 5181.2 5263.0 5331.7 5336.8 5338.2 3224.8 3227.2 3539.9 3546.8 3548.3 1099.5 1114.7 1128.0 1128.3 1176.0 11481.4 11524.4 11565.5 11582.6 11584.4 4394.8 4485.0 4565.6 4576.9 4729.7 9662.4 9687.2 9742.0 9787.6 9798.8 5240.7 5241.2 5248.8 5250.9 5254.9 4540.0 4686.7 4703.9 4820.3 4883.0 3582.4 3720.6 3762.6 3778.7 3784.9 1167.3 1174.4 1176.6 1179.2 1182.8 700.6 796.5 900.5 911.6 945.7 5698.5 5703.0 5710.7 5713.7 5795.7 956.6 966.8 993.2 997.6 1057.5 3639.8 3833.3 3857.8 3861.9 3864.4 10279.0 10408.5 10467.7 10495.3 10529.8 10313.3 10344.7 10373.2 10388.2 10488.3 7505.7 7869.3 7870.1 7979.2 8072.7 5681.1 5778.4 5784.8 5814.8 5923.0 9365.0 9475.0 9482.4 9490.4 9550.4 9671.6 9789.1 9827.3 9842.3 9926.3 6395.8 7053.3 7412.5 7456.7 7531.2 8138.9 8284.8 8304.0 8313.0 8328.8 7259.5 7427.6 7542.4 7561.8 7658.6 7201.5 7375.6 7430.8 7469.9 7659.4 6321.3 6459.5 6463.9 6468.5 6468.8 4825.6 4846.9 4888.0 4912.8 4932.2 4671.6 4676.6 4760.2 4783.0 4873.6 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#4] prototype.html Cycles:180 Average:4645.35 Median:5127.05 stddev:1356.70 (26.5%) stddev-sans-first:1320.92 09:19:10 INFO - PROCESS | 22513 | Values: 310.3 326.6 328.1 329.1 337.7 5187.2 5403.4 5459.4 5479.3 5506.9 5355.7 5415.2 5423.5 5438.9 5442.5 4236.4 4243.3 4256.2 4262.1 4266.4 4235.2 4281.2 4293.9 4318.1 4326.8 4232.3 4244.7 4246.9 4259.6 4268.8 4258.5 4275.9 4279.6 4293.5 4299.6 3670.6 3791.2 3800.2 3800.3 3804.4 5259.8 5272.8 5305.9 5313.5 5371.6 4890.2 4904.6 4909.9 4919.7 4921.8 5508.3 5661.5 5715.3 5721.0 5803.9 4110.3 4120.9 4125.2 4129.5 4134.8 5717.2 5893.5 5910.6 5967.7 5975.3 4033.7 4055.7 4066.6 4069.4 4076.1 4127.9 4154.9 4161.9 4170.8 4176.7 4672.3 4818.9 4830.0 4850.2 4856.7 5725.3 5726.1 5731.4 5757.7 5772.4 1433.0 1444.4 1446.5 1446.9 1449.3 839.4 884.5 907.2 930.3 933.9 4737.9 4756.5 4801.9 4808.5 4847.7 5100.9 5123.6 5130.5 5138.5 5146.8 4700.5 4764.6 4808.6 4821.4 4893.8 2746.8 2752.8 2755.7 2767.6 2792.9 5297.7 5333.6 5340.8 5352.8 5371.7 4937.8 5204.6 5210.9 5217.2 5221.7 5194.9 5213.9 5272.5 5281.6 5288.1 5094.6 5114.7 5115.3 5134.8 5152.7 4882.6 5031.4 5037.4 5043.8 5114.5 5272.7 6001.9 6136.5 6140.4 6161.2 4148.7 4187.7 4194.3 4197.3 4211.5 5685.4 5954.0 5957.3 5985.7 6002.5 5755.3 5763.9 5771.6 5773.8 5791.6 5803.0 5827.7 5827.9 5846.3 5852.3 5650.8 5674.8 5677.7 5686.5 5756.8 5767.3 5779.3 5816.2 5851.7 5870.9 5483.4 5646.2 5752.7 5759.7 5775.4 09:19:10 INFO - PROCESS | 22513 | 09:19:10 INFO - PROCESS | 22513 | [#5] yui.html Cycles:180 Average:16669.01 Median:24281.12 stddev:21139.08 (87.1%) stddev-sans-first:21164.13 09:19:10 INFO - PROCESS | 22513 | Values: 643.4 763.1 783.5 803.8 805.0 14453.5 15230.3 15301.1 15498.3 15608.5 14848.5 15026.4 15070.4 15125.0 15145.1 795.2 804.4 804.6 805.7 812.5 467.2 476.2 781.7 802.3 806.8 845.1 849.2 849.7 849.7 853.3 840.8 841.2 841.7 841.7 841.9 618.3 618.8 619.3 619.9 620.3 13012.2 13127.4 13176.0 13178.1 13191.1 13234.5 13660.7 13683.0 13738.3 13743.2 10793.2 10952.7 10979.2 11117.4 11606.9 3654.0 3670.7 3678.8 3683.8 3707.6 52429.0 54014.0 54381.5 61383.0 62466.4 10738.5 10826.2 10857.2 10924.7 10984.9 18987.2 19037.4 19074.5 19128.0 19530.4 7900.0 7990.2 8044.1 8076.6 8294.3 4501.5 4509.1 4511.4 4531.5 4624.2 3116.7 3241.8 3249.5 3259.8 3269.8 578.5 588.2 601.6 609.6 616.4 700.7 714.1 717.2 756.8 768.6 8681.0 8836.2 8951.2 9046.4 9070.5 618.7 659.6 673.6 674.7 688.1 4268.3 4836.4 4894.7 4915.7 4992.7 53705.5 53844.5 53935.2 84882.0 85133.6 71754.6 72966.3 73007.3 73951.0 74676.6 66103.7 67710.0 67815.3 68038.3 70182.6 9350.4 9544.3 9624.5 9630.2 9637.0 40716.0 44571.8 44744.3 45661.0 48086.0 55491.4 56850.0 57330.7 58034.0 60085.0 12390.5 12439.9 12468.5 12533.4 12662.5 13771.7 13907.5 14314.8 14372.7 14418.6 12141.9 12473.4 12538.5 12619.6 13710.7 12645.9 12795.8 13069.7 13511.1 13521.5 12250.2 12336.3 12417.6 12439.1 12607.7 10212.2 10540.4 10785.8 10827.9 10843.8 9375.2 10393.8 10513.3 10630.2 10931.5 09:19:10 INFO - PROCESS | 22513 | -------- Summary: end -------- 09:19:10 INFO - PROCESS | 22513 | 09:19:11 INFO - TEST-INFO | 22513: exit 0 09:19:11 INFO - TEST-OK | dromaeo_css | took 1115378ms 09:19:11 INFO - TEST-START | kraken 09:19:11 INFO - operating with platform_type : linux_ 09:19:11 INFO - Initialising browser for kraken test... 09:19:11 INFO - TEST-INFO | started process 22877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUKh5d/profile http://localhost:56929/getInfo.html) 09:19:16 INFO - PROCESS | 22877 | __metrics Screen width/height:1600/1200 09:19:16 INFO - PROCESS | 22877 | colorDepth:24 09:19:16 INFO - PROCESS | 22877 | Browser inner width/height: 1024/697 09:19:16 INFO - PROCESS | 22877 | __metrics 09:19:16 ERROR - PROCESS | 22877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 09:19:17 INFO - TEST-INFO | 22877: exit 0 09:19:17 INFO - Browser initialized. 09:19:17 INFO - Running cycle 1/1 for kraken test... 09:19:17 INFO - TEST-INFO | started process 22999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUKh5d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:30 INFO - PROCESS | 22999 | RSS: Main: 185298944 09:19:30 INFO - PROCESS | 22999 | 09:19:33 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:33 INFO - PROCESS | 22999 | RSS: Main: 197931008 09:19:33 INFO - PROCESS | 22999 | 09:19:36 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-dft) 09:19:37 INFO - PROCESS | 22999 | RSS: Main: 195780608 09:19:37 INFO - PROCESS | 22999 | 09:19:40 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-fft) 09:19:40 INFO - PROCESS | 22999 | RSS: Main: 192643072 09:19:40 INFO - PROCESS | 22999 | 09:19:42 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-oscillator) 09:19:43 INFO - PROCESS | 22999 | RSS: Main: 193429504 09:19:43 INFO - PROCESS | 22999 | 09:19:45 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:46 INFO - PROCESS | 22999 | RSS: Main: 193544192 09:19:46 INFO - PROCESS | 22999 | 09:19:49 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:49 INFO - PROCESS | 22999 | RSS: Main: 193949696 09:19:49 INFO - PROCESS | 22999 | 09:19:53 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:53 INFO - PROCESS | 22999 | RSS: Main: 193814528 09:19:53 INFO - PROCESS | 22999 | 09:19:56 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56929/tests/kraken/driver.html?testName=json-parse-financial) 09:19:57 INFO - PROCESS | 22999 | RSS: Main: 193654784 09:19:57 INFO - PROCESS | 22999 | 09:19:58 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:59 INFO - PROCESS | 22999 | RSS: Main: 193495040 09:19:59 INFO - PROCESS | 22999 | 09:20:01 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:01 INFO - PROCESS | 22999 | RSS: Main: 193458176 09:20:01 INFO - PROCESS | 22999 | 09:20:03 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:04 INFO - PROCESS | 22999 | RSS: Main: 193744896 09:20:04 INFO - PROCESS | 22999 | 09:20:07 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:08 INFO - PROCESS | 22999 | RSS: Main: 193888256 09:20:08 INFO - PROCESS | 22999 | 09:20:10 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:11 INFO - PROCESS | 22999 | RSS: Main: 193961984 09:20:11 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56929/tests/kraken/driver.html?testName=ai-astar) 09:20:13 INFO - PROCESS | 22999 | RSS: Main: 195301376 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | __start_tp_report 09:20:13 INFO - PROCESS | 22999 | _x_x_mozilla_page_load 09:20:13 INFO - PROCESS | 22999 | _x_x_mozilla_page_load_details 09:20:13 INFO - PROCESS | 22999 | |i|pagename|runs| 09:20:13 INFO - PROCESS | 22999 | |0;ai-astar;107;115;116;115;115;114;117;114;114;114 09:20:13 INFO - PROCESS | 22999 | |1;audio-beat-detection;154;127;127;179;127;125;126;123;152;125 09:20:13 INFO - PROCESS | 22999 | |2;audio-dft;161;165;164;172;162;164;163;163;164;161 09:20:13 INFO - PROCESS | 22999 | |3;audio-fft;75;76;76;104;76;77;76;77;110;76 09:20:13 INFO - PROCESS | 22999 | |4;audio-oscillator;84;82;112;85;84;83;97;82;82;116 09:20:13 INFO - PROCESS | 22999 | |5;imaging-gaussian-blur;117;120;118;118;117;119;118;117;119;119 09:20:13 INFO - PROCESS | 22999 | |6;imaging-darkroom;147;148;146;148;148;148;146;146;147;147 09:20:13 INFO - PROCESS | 22999 | |7;imaging-desaturate;86;85;86;86;86;85;86;86;86;85 09:20:13 INFO - PROCESS | 22999 | |8;json-parse-financial;55;56;57;57;57;61;57;58;58;57 09:20:13 INFO - PROCESS | 22999 | |9;json-stringify-tinderbox;61;62;62;61;62;61;62;62;62;62 09:20:13 INFO - PROCESS | 22999 | |10;stanford-crypto-aes;83;87;84;79;81;80;80;79;79;88 09:20:13 INFO - PROCESS | 22999 | |11;stanford-crypto-ccm;141;144;151;138;138;137;135;134;170;136 09:20:13 INFO - PROCESS | 22999 | |12;stanford-crypto-pbkdf2;171;171;169;170;175;177;172;167;172;167 09:20:13 INFO - PROCESS | 22999 | |13;stanford-crypto-sha256-iterative;69;69;68;64;71;64;68;64;64;64 09:20:13 INFO - PROCESS | 22999 | __end_tp_report 09:20:13 INFO - PROCESS | 22999 | __start_cc_report 09:20:13 INFO - PROCESS | 22999 | _x_x_mozilla_cycle_collect,820 09:20:13 INFO - PROCESS | 22999 | __end_cc_report 09:20:13 INFO - PROCESS | 22999 | __startTimestamp1477930813519__endTimestamp 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ------- Summary: start ------- 09:20:13 INFO - PROCESS | 22999 | Number of tests: 14 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.69 (2.3%) stddev-sans-first:1.05 09:20:13 INFO - PROCESS | 22999 | Values: 107.0 115.0 116.0 115.0 115.0 114.0 117.0 114.0 114.0 114.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:127.00 stddev:18.80 (14.8%) stddev-sans-first:18.84 09:20:13 INFO - PROCESS | 22999 | Values: 154.0 127.0 127.0 179.0 127.0 125.0 126.0 123.0 152.0 125.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:3.14 (1.9%) stddev-sans-first:3.15 09:20:13 INFO - PROCESS | 22999 | Values: 161.0 165.0 164.0 172.0 162.0 164.0 163.0 163.0 164.0 161.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.11 (17.2%) stddev-sans-first:13.63 09:20:13 INFO - PROCESS | 22999 | Values: 75.0 76.0 76.0 104.0 76.0 77.0 76.0 77.0 110.0 76.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.50 stddev:13.09 (15.7%) stddev-sans-first:13.66 09:20:13 INFO - PROCESS | 22999 | Values: 84.0 82.0 112.0 85.0 84.0 83.0 97.0 82.0 82.0 116.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 09:20:13 INFO - PROCESS | 22999 | Values: 117.0 120.0 118.0 118.0 117.0 119.0 118.0 117.0 119.0 119.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 09:20:13 INFO - PROCESS | 22999 | Values: 147.0 148.0 146.0 148.0 148.0 148.0 146.0 146.0 147.0 147.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 09:20:13 INFO - PROCESS | 22999 | Values: 86.0 85.0 86.0 86.0 86.0 85.0 86.0 86.0 86.0 85.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:1.57 (2.7%) stddev-sans-first:1.42 09:20:13 INFO - PROCESS | 22999 | Values: 55.0 56.0 57.0 57.0 57.0 61.0 57.0 58.0 58.0 57.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 09:20:13 INFO - PROCESS | 22999 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:3.37 (4.1%) stddev-sans-first:3.55 09:20:13 INFO - PROCESS | 22999 | Values: 83.0 87.0 84.0 79.0 81.0 80.0 80.0 79.0 79.0 88.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:139.50 stddev:10.93 (7.8%) stddev-sans-first:11.58 09:20:13 INFO - PROCESS | 22999 | Values: 141.0 144.0 151.0 138.0 138.0 137.0 135.0 134.0 170.0 136.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:3.18 (1.9%) stddev-sans-first:3.37 09:20:13 INFO - PROCESS | 22999 | Values: 171.0 171.0 169.0 170.0 175.0 177.0 172.0 167.0 172.0 167.0 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:68.00 stddev:2.76 (4.1%) stddev-sans-first:2.77 09:20:13 INFO - PROCESS | 22999 | Values: 69.0 69.0 68.0 64.0 71.0 64.0 68.0 64.0 64.0 64.0 09:20:13 INFO - PROCESS | 22999 | -------- Summary: end -------- 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | 09:20:13 INFO - PROCESS | 22999 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:20:13 INFO - PROCESS | 22999 | 09:20:14 INFO - TEST-INFO | 22999: exit 0 09:20:14 INFO - TEST-OK | kraken | took 62997ms 09:20:14 INFO - SUITE-END | took 1178s 09:20:15 INFO - Completed test suite (00:19:38) 09:20:15 INFO - javascript benchmark 09:20:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7008.300416643514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.432387846309, 2991.6260467441566, 2994.5957295765065, 3008.638963324401, 3014.3067094568255, 5092.694438333693, 5190.584753219738, 5192.558632516236, 5234.37187537496, 5250.396204436491, 5117.616178786588, 5214.634975551713, 5236.450172731866, 5254.658447200929, 5270.604704647148, 4729.219678753002, 4750.667453278272, 4834.854954351357, 4839.854804355875, 4918.696545415468, 4728.267118596623, 4810.422749270093, 4854.223324268118, 4911.803527858881, 4958.107540642683, 4667.88330291742, 4717.198076327033, 4719.433667959866, 4720.858374248778, 4778.689385189969, 4775.283707443877, 4779.784909679072, 4783.282507623884, 4818.132736107499, 4833.661643684944, 4749.57253847152, 4758.405199350082, 4776.211925032366, 4785.353977213066, 4809.567138957475, 5053.67151135175, 5070.0, 5090.465501122366, 5218.452062533455, 5251.632385733, 5505.807296744635, 5567.777288908439, 5575.69333686647, 5591.0, 5677.290338707661, 5596.104623260258, 5633.8309850704545, 5637.379888212294, 5652.321721393418, 5664.8867022659315, 5059.089363914531, 5232.927249913759, 5270.604704647167, 5275.815346462856, 5332.813351532716, 5540.307461567304, 5668.688222147822, 5694.800681976194, 5698.715064246771, 5807.709614519257, 5504.80733174337, 5517.200005999108, 5521.917171242435, 5522.447755224445, 5546.473085056913, 5497.47773961473, 5587.161925711094, 5597.972010139923, 5604.0, 5656.632318899258, 5366.490183432567, 5471.945280547223, 5528.917066244009, 5591.384947655754, 5591.52472039873, 5568.888622227614, 5570.275864137636, 5575.0522411190195, 5581.190727344512, 5617.101263797773, 4307.633851122627, 4313.374560688682, 4319.611234988866, 4324.459442569679, 4374.606285434326, 3788.0340513168967, 3791.5829258781514, 3818.866339678098, 3853.2871418787613, 3907.355286377716, 5299.4700529946695, 5319.867003324948, 5352.4915133062295, 5366.731663416814, 5391.272178255964, 5622.409646987089, 5631.577631677558, 5635.520980716685, 5639.43605639441, 5652.236948012048, 5143.099957507421, 5165.509276618715, 5252.684838909678, 5307.044731948209, 5387.515123638891, 4849.854504364875, 4875.341828853059, 4895.730734809548, 4924.285978533093, 4945.901081978341, 5764.884702305846, 5776.653400795965, 5785.10330898703, 5787.594868359174, 5789.2763404574425, 5471.343438787371, 5528.944710552843, 5599.1041433370465, 5611.158326251095, 5679.119736440858, 5766.654000759968, 5796.449337312949, 5814.360420353673, 5838.883222335445, 5886.52907767369, 5500.642458240201, 5531.197976293495, 5552.444755524415, 5562.22128901946, 5576.637518561281, 5410.891782164414, 5591.692456914909, 5602.831915042555, 5603.663780173202, 5618.0, 5359.651622644516, 5406.567474601944, 5417.458254174709, 5459.12653975362, 5526.50261476469, 5421.295231619864, 5432.266644003167, 5439.374471935778, 5441.401445841034, 5460.426655201306, 5162.612804039637, 5242.397124330751, 5389.083855744454, 5399.865003374947, 5435.728213589384, 5396.487333703292, 5464.426235245242, 5475.0, 5476.342838859362, 5533.557315414677, 5308.920366194588, 5353.357597088374, 5354.411014788292, 5356.651817631841, 5358.705271210121], "value": 5156.19018049379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2359575001301, 554.8474169603356, 562.558391662545, 581.2617975171531, 600.6486205569743, 39921.99999999996, 41063.38404923925, 41137.3829392559, 44150.33774493377, 44243.55756442434, 42268.36597451041, 42538.36192457108, 42619.36070958938, 42689.35965960513, 42746.0, 8777.99053108891, 8963.193312601865, 9017.504037277948, 9021.95489022554, 9031.41295815773, 8788.560571971377, 8856.158664926821, 8856.734297971072, 8878.73363799087, 8890.511021893793, 8925.642974281021, 8948.373613847034, 8966.148215919477, 8971.95514022429, 8974.326925480582, 8828.117188281185, 8874.334424918125, 8891.288696904232, 8918.687845925426, 8935.419197752126, 8717.215450609476, 8814.206721395105, 8819.0, 8844.46933184011, 8845.778855528599, 40960.0, 41408.378874316906, 41488.79255603703, 41516.1696766066, 41549.376759348634, 3298.3897978873983, 3407.914802129942, 3465.9826700866333, 3798.449224862407, 4047.0894048838777, 30507.847460762776, 30974.818399516003, 31018.0, 31163.53254701181, 31684.524732129037, 4282.143571285756, 4305.182015417092, 4366.235908715962, 4367.716098453622, 4553.112143132091, 321799.0, 324183.0, 325260.0, 326649.0, 329087.0, 56215.71892140513, 56632.0, 56754.0, 56820.71589642108, 56980.14529782056, 59292.40707592869, 59323.0, 59392.70303648454, 59394.0, 59544.70227648921, 14989.700205996038, 15179.848201518063, 15208.239588020777, 15248.390064397521, 15265.923670381577, 12744.681382965315, 12827.871721282667, 12897.0, 12903.032272579594, 12912.806307905388, 15311.707982783755, 16731.330746770236, 16840.663186736198, 16880.746788797933, 16916.238769255415, 5744.908467391182, 5754.712264386848, 5762.337331206881, 5806.245188125601, 5873.471387575053, 850.4217132349937, 995.5320999130397, 1077.5743581285349, 1080.8702955645374, 1098.8681358237063, 30397.336759023572, 30508.389832203233, 30637.234069148002, 30666.0, 30908.836800702757, 1064.7489200189746, 1099.373357186412, 1099.8240281555072, 1122.7586068995206, 1124.7637996020928, 15762.975406598534, 16569.337226511045, 16592.419265325654, 16659.0, 16707.331706731595, 506587.0, 507193.0, 511148.0, 513283.0, 516834.0, 57350.426495735344, 57592.71203643955, 58182.418175818544, 58292.417075829544, 58311.0, 1277.2145130744525, 1315.6316231455016, 1331.081553727944, 1334.3261652865435, 1336.3785839584639, 29048.854755726086, 30044.849775750983, 30116.24709382283, 30931.536026959162, 31687.841560792047, 53515.73242133764, 54068.18897716459, 54136.729316353165, 54180.0, 54273.18590221071, 441952.0, 442373.0, 443035.0, 445060.0, 447695.0, 40813.59186408217, 41312.793436032625, 41713.0, 41844.581554185286, 42084.57915420929, 46299.53700463087, 47099.0, 47452.52547474481, 47506.28740568963, 48240.276395854795, 38732.80633596814, 39441.80279098701, 39524.40713389359, 39660.0, 41848.581514184465, 39409.728258440126, 39855.2028959425, 39930.0, 41336.58663413447, 41728.95677608084, 38496.230075397776, 39767.0, 39885.0, 40170.0, 40374.798126009184, 30683.693163068085, 34407.483887741204, 35162.64837351696, 35618.39914515067, 36407.27185456329, 27039.59440608353, 27156.32109197207, 27410.588841167, 27551.724482754915, 27598.2836024501], "value": 19771.081113545606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.3559619838672, 388.67545599424517, 397.24919901386374, 397.866714650592, 425.8701096165668, 15166.772498412533, 15881.047137171778, 18625.53436164095, 19564.608707825835, 19618.705719414203, 11606.187566870323, 11799.7640047199, 11994.46024928878, 12239.632811015661, 12264.632061038183, 5138.177891537364, 5404.864878378053, 5415.13357862742, 5420.457954204568, 5424.891502169954, 5147.099257629919, 5265.921011184835, 5351.946480535184, 5388.892222155555, 5411.296531450906, 5335.226392173152, 5346.144616861303, 5346.625736198448, 5373.704446255454, 5384.542313903323, 5325.041492531343, 5340.038793017256, 5536.584756143306, 5804.88390232193, 5834.708264586754, 5767.942320576824, 5770.076787713946, 5773.9422605773825, 5782.190493330937, 5799.971000145015, 13480.191188528719, 13693.109947853458, 13804.102733322303, 14065.929670351583, 14106.083104598169, 2176.2969211303343, 2195.100008996304, 2350.5416443793465, 2370.798482129021, 2863.883085596619, 9873.80252394948, 10526.473676316231, 10714.410707411089, 13009.154404963647, 13448.663783405394, 1838.209569884949, 1944.7471828662324, 1954.8045195480481, 1999.8900060496667, 2009.4072248686527, 80580.0, 81518.59240703759, 82750.58624706898, 84259.0, 84482.57758711166, 10872.130229581615, 11044.779104417867, 11090.168237382068, 11117.55529778816, 11158.776824463464, 15187.620309492351, 15196.544103676908, 15207.467738629317, 15214.0, 15281.847181528265, 8077.474964127313, 8098.473599216032, 8117.878231826528, 8336.208060234268, 8346.374021948257, 7851.646675899598, 7879.699849524764, 8001.719939802079, 8003.159668234868, 8114.797130071677, 4589.311603259538, 4611.492735799059, 4718.127146477844, 4779.139754844092, 4785.760711964388, 1919.659081291785, 1930.8760363599927, 1972.8027197280157, 1973.1416833677397, 2007.1469625409143, 888.6667499687617, 931.9487428191379, 937.2267878999852, 965.2712202287369, 1058.380847204394, 17881.28474860991, 18154.364597239033, 19707.211711531665, 19748.40754777359, 20977.26579569738, 975.9902400975899, 981.8821741391079, 983.9114479696862, 997.5660587644398, 1023.8822535408375, 10494.580216791395, 11214.439278036229, 11241.325520468798, 11282.605108821152, 11285.774284514428, 447426.0, 449705.0, 455676.0, 468374.5812709351, 473115.0, 91365.0, 93500.0, 94321.0, 95016.0, 95926.0, 1015.4821041268858, 1055.4353420919772, 1056.741098430874, 1060.713607326033, 1079.5142186016324, 15741.921290393475, 17210.569735756708, 17553.297868085134, 17721.202545885724, 17796.0, 41736.58263417327, 42593.5740642602, 43207.78396107999, 43769.78115109532, 44554.3316850241, 54487.455125448236, 54929.45070549243, 58849.75835049812, 58990.41009589849, 60130.0, 8322.70870519529, 8365.163483651586, 8381.706640267805, 8690.0, 8706.390552661253, 12499.500019999097, 12989.895858852104, 13001.609951701465, 13036.47854085826, 13199.20804751718, 11275.605353812578, 11333.433328333385, 11378.772424551296, 11408.828867566826, 11631.825522616999, 11035.558577656804, 11165.38590377537, 11320.26418282809, 11321.0, 11925.165238433226, 11403.0, 11427.485763140845, 11432.485538150637, 11743.88256117428, 11762.059035277329, 8240.62917168717, 8288.21261980111, 8318.79203019905, 8368.163183681583, 8741.475511469078, 9939.353941993748, 11201.71995700114, 11576.073914086684, 11643.41782910834, 11720.41397930083], "value": 8913.511187353924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.7168566286741, 1465.2527211122326, 1559.1970135380282, 1694.7542606322077, 1703.8210987846276, 7506.699732010727, 7772.922270777291, 8109.513429194252, 8604.741857744262, 8638.222559969594, 8030.678772849094, 8305.377096717755, 8317.542535160565, 8401.747947561567, 8440.535770532633, 2281.863088214704, 2316.2124877541632, 2328.080408238745, 2329.406001469623, 2330.1727886600265, 2269.7503274639776, 2310.191432998454, 2326.9069237230574, 2331.8134549236106, 2331.8717470539113, 2324.0587562037404, 2327.511222643247, 2338.3218866528773, 2342.613468777658, 2349.2130136404326, 2229.2866282789514, 2277.134688818255, 2293.323469576479, 2293.564222797663, 2294.7475777664445, 2261.796438320559, 2270.9545809083725, 2285.8057065149483, 2297.173017713622, 2298.9655155172686, 8222.342212623036, 8289.212524810133, 8463.74608761738, 8579.914200857975, 8590.828183436359, 5181.171012637998, 5262.97368513155, 5331.706756128411, 5336.7865285388925, 5338.172583249602, 3224.8226347550876, 3227.2415982244156, 3539.94690079649, 3546.7871927684423, 3548.27260411615, 1099.4612639806517, 1114.726891911487, 1127.9605213817558, 1128.2609890521721, 1176.04152615618, 11481.368524731137, 11524.366159861203, 11565.479553420117, 11582.594609188638, 11584.362860042778, 4394.8242070317465, 4485.0, 4565.611922986517, 4576.885577860514, 4729.739864307496, 9662.420254784736, 9687.225021998223, 9741.951290243504, 9787.559559819825, 9798.75503112428, 5240.737963101906, 5241.24002019705, 5248.8425347239645, 5250.868728281824, 5254.894902101936, 4540.0, 4686.671932964659, 4703.882402939886, 4820.325154478376, 4882.9755851221225, 3582.4268117101137, 3720.5535335759882, 3762.6425489578446, 3778.7165962552367, 3784.8864534064023, 1167.2937872587133, 1174.365842445087, 1176.5764324843049, 1179.1981452612306, 1182.7693599747965, 700.6496751624188, 796.5419883566972, 900.4732231644562, 911.5761171055491, 945.716285114463, 5698.487136157766, 5703.0, 5710.65736055838, 5713.714314284269, 5795.739191736382, 956.6460409648474, 966.8108226880835, 993.2352088891513, 997.586001809241, 1057.4606950455322, 3639.763415377992, 3833.310004199215, 3857.7685338879755, 3861.864834730771, 3864.381698928214, 10279.0, 10408.531616077295, 10467.738306542398, 10495.26533142688, 10529.84205236922, 10313.329633573794, 10344.741381465523, 10373.170146388271, 10388.220883433622, 10488.318259313273, 7505.737299194502, 7869.291763741291, 7870.134285228621, 7979.202079791974, 8072.677092916335, 5681.0910254359105, 5778.36437991829, 5784.797532086357, 5814.796482123105, 5923.0, 9364.95317523408, 9474.95262523683, 9482.38364506305, 9490.383125096847, 9550.426974381558, 9671.613135474503, 9789.070038346346, 9827.31208815376, 9842.311038227255, 9926.255530835071, 6395.808125756234, 7053.329933656294, 7412.518186317872, 7456.701731930662, 7531.246875312425, 8138.918610814053, 8284.751457456287, 8303.95848020756, 8313.0, 8328.83342333162, 7259.491835571459, 7427.628618569158, 7542.434317426105, 7561.810954726176, 7658.578778167254, 7201.459890508128, 7375.557466552024, 7430.814229644302, 7469.850602987801, 7659.387249019954, 6321.336259692666, 6459.483241340776, 6463.870722585616, 6468.450181734417, 6468.8059358219325, 4825.6139508839915, 4846.8788280291865, 4888.0, 4912.778924948458, 4932.161532539549, 4671.602913752369, 4676.602488788491, 4760.166970780169, 4783.0, 4873.610111191168], "value": 4478.449109744297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.30491698595154, 326.5591451540419, 328.123909162536, 329.0917068889864, 337.6977605043487, 5187.221916712495, 5403.432639572848, 5459.426760190182, 5479.287692599966, 5506.862328441786, 5355.6786592804365, 5415.187721841716, 5423.457654234575, 5438.945610543903, 5442.510174084332, 4236.428082208893, 4243.257429949762, 4256.170046840852, 4262.104957958817, 4266.360045993095, 4235.216484950294, 4281.244689677233, 4293.892652683677, 4318.07161460286, 4326.783660816946, 4232.25935461293, 4244.745315281093, 4246.851360202393, 4259.5740425957465, 4268.829246830123, 4258.510271318807, 4275.850345237917, 4279.572042795727, 4293.463317085364, 4299.613034826849, 3670.596234414212, 3791.2417516496535, 3800.239952009609, 3800.277947190025, 3804.353259945788, 5259.763310650992, 5272.841814745564, 5305.920411193835, 5313.485656587893, 5371.597130215249, 4890.24201248807, 4904.5831104356175, 4909.926351104737, 4919.72941488218, 4921.753912304406, 5508.3114610673665, 5661.547076233891, 5715.257016587817, 5720.971395142998, 5803.941960580424, 4110.260153172428, 4120.938185927213, 4125.216208920296, 4129.504459464853, 4134.813933373005, 5717.171010203539, 5893.528517718572, 5910.645361278337, 5967.731452084667, 5975.340973266898, 4033.6571391432058, 4055.655269302142, 4066.6340029397497, 4069.369247766601, 4076.103257283393, 4127.855525056609, 4154.937675934863, 4161.9375709364385, 4170.812313445902, 4176.665866730655, 4672.299155126758, 4818.927716084261, 4829.975850120727, 4850.248211527219, 4856.68431551948, 5725.2843394575675, 5726.141078838207, 5731.398203188689, 5757.654540727486, 5772.422757724278, 1432.9928350358182, 1444.407792804966, 1446.4575784080969, 1446.9204193769444, 1449.2753623188405, 839.4166054592, 884.4604791077437, 907.2379201470796, 930.3069213436033, 933.8599210118537, 4737.881552961135, 4756.524347565216, 4801.879953001203, 4808.519148085164, 4847.709137451764, 5100.897982040338, 5123.590112790967, 5130.51260130287, 5138.4604616514725, 5146.845594632167, 4700.482946875841, 4764.618830493552, 4808.63935204861, 4821.397325334333, 4893.755312234445, 2746.791411778811, 2752.843805601652, 2755.7244275572684, 2767.6263704400053, 2792.944141117166, 5297.708855826792, 5333.586599551122, 5340.759665815048, 5352.759125839347, 5371.677699338053, 4937.755411869576, 5204.609654275944, 5210.921836172461, 5217.2434996925995, 5221.738913054408, 5194.909069095456, 5213.921791173136, 5272.499112584298, 5281.577473802086, 5288.060395005668, 5094.5669618082875, 5114.71869047206, 5115.283860259492, 5134.818991632021, 5152.716600587004, 4882.60939124862, 5031.421386540448, 5037.420696619935, 5043.84868453947, 5114.514121158484, 5272.736363181749, 6001.90997135052, 6136.539759517965, 6140.355262697352, 6161.229846269216, 4148.688848336326, 4187.66498680111, 4194.328907374806, 4197.349410841324, 4211.515675697212, 5685.374608792947, 5954.0, 5957.285125784933, 5985.730642121028, 6002.489788368038, 5755.3381361144, 5763.855903602276, 5771.604784014755, 5773.769049237983, 5791.594588378773, 5803.0, 5827.650340979555, 5827.883442331215, 5846.298444186725, 5852.332085355653, 5650.7568334966245, 5674.829755107354, 5677.68772717488, 5686.459786320293, 5756.762296106357, 5767.307923049261, 5779.323996041269, 5816.243888294494, 5851.707414629337, 5870.882582348244, 5483.369412517612, 5646.209530665628, 5752.676884316715, 5759.667334729441, 5775.393583673822], "value": 4208.873055397608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.4144928115414, 763.0995425398031, 783.4868161354315, 803.81512252182, 804.9758507244777, 14453.494127705519, 15230.314635841387, 15301.081935083888, 15498.302576384061, 15608.531744047668, 14848.48030318939, 15026.398944042252, 15070.39718411265, 15125.016873903189, 15145.091294522337, 795.1849354411731, 804.4127786715701, 804.6258489802241, 805.7341077444459, 812.4800127918137, 467.24539868113095, 476.2380191693298, 781.7381177305609, 802.2819576479047, 806.8426656801926, 845.0535400351584, 849.2144766091371, 849.6728759427634, 849.7323343146888, 853.2960307746104, 840.756180707594, 841.167244428018, 841.6843683618642, 841.6885752271637, 841.9410641255115, 618.3074956049254, 618.7865186510646, 619.2878190081398, 619.938006199381, 620.3238470067603, 13012.21926684402, 13127.40926658293, 13176.0, 13178.143420677625, 13191.07662463628, 13234.470621175142, 13660.65848353789, 13683.0, 13738.313084345842, 13743.175409475463, 10793.190510711727, 10952.726181845437, 10979.1765617579, 11117.444127793658, 11606.94196529012, 3653.963460365389, 3670.724695647837, 3678.7608805427562, 3683.834227459744, 3707.6292370762976, 52429.0, 54014.0, 54381.45618543843, 61383.0, 62466.37533624651, 10738.516766745515, 10826.225029538331, 10857.185711071543, 10924.672259832218, 10984.945075274733, 18987.240510379706, 19037.42887713371, 19074.52313692169, 19128.0, 19530.414087577396, 7899.960500197462, 7990.240927111915, 8044.115147333789, 8076.636551355203, 8294.313717709547, 4501.459824821042, 4509.143262780061, 4511.368408422823, 4531.501534831166, 4624.213883639722, 3116.735077518391, 3241.7730758846656, 3249.52881832133, 3259.788113772597, 3269.7874638148446, 578.5400606517828, 588.2470437839572, 601.648035899004, 609.5732986909181, 616.4051690119056, 700.6609634584498, 714.1358955663601, 717.2182321269737, 756.8372799847949, 768.6156921539231, 8680.956595216983, 8836.204741573289, 8951.239144672645, 9046.436441588376, 9070.54647267634, 618.6875627808018, 659.6404959297195, 673.565550220115, 674.699758607415, 688.0607970120749, 4268.274393353137, 4836.371271734652, 4894.68184568009, 4915.65590408668, 4992.72540010303, 53705.462945370826, 53844.46155538395, 53935.190972135446, 84882.0, 85133.57433212794, 71754.64122679354, 72966.27033729701, 73007.26992730111, 73951.0, 74676.62661686656, 66103.66948165228, 67709.96870093807, 67815.3218467809, 68038.31961680518, 70182.64908675526, 9350.392224505385, 9544.33189676716, 9624.470654114091, 9630.229581633312, 9637.0, 40716.0, 44571.77714111538, 44744.328835068154, 45661.0, 48086.0, 55491.44508554863, 56850.0, 57330.713346433, 58034.0, 60085.0, 12390.504379825066, 12439.937800310941, 12468.5012599495, 12533.435995380412, 12662.493500259887, 13771.655708607364, 13907.513237036655, 14314.785278221043, 14372.712545749235, 14418.567442976728, 12141.878581214074, 12473.376331183586, 12538.49846006186, 12619.558315458915, 13710.65723356924, 12645.87354126447, 12795.80806287925, 13069.673258168621, 13511.121777084458, 13521.526746563823, 12250.203736757083, 12336.259824410565, 12417.62747117588, 12439.129260951646, 12607.747845042864, 10212.234082443698, 10540.420276884844, 10785.784284314113, 10827.949389266634, 10843.837342440027, 9375.217871975949, 10393.808874874441, 10513.264071515227, 10630.192867212747, 10931.453427328443], "value": 6917.172275212787, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 115.0, 115.0, 114.0, 117.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 127.0, 179.0, 127.0, 125.0, 126.0, 123.0, 152.0, 125.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 164.0, 172.0, 162.0, 164.0, 163.0, 163.0, 164.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 104.0, 76.0, 77.0, 76.0, 77.0, 110.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 112.0, 85.0, 84.0, 83.0, 97.0, 82.0, 82.0, 116.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 119.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 148.0, 148.0, 148.0, 146.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 57.0, 61.0, 57.0, 58.0, 58.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 79.0, 81.0, 80.0, 80.0, 79.0, 79.0, 88.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 151.0, 138.0, 138.0, 137.0, 135.0, 134.0, 170.0, 136.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 170.0, 175.0, 177.0, 172.0, 167.0, 172.0, 167.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 64.0, 71.0, 64.0, 68.0, 64.0, 64.0, 64.0], "value": 66.5, "unit": "score"}]}]} 09:20:15 INFO - Return code: 0 09:20:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:15 ERROR - # TBPL SUCCESS # 09:20:15 INFO - Running post-action listener: _resource_record_post_action 09:20:15 INFO - [mozharness: 2016-10-31 16:20:15.311414Z] Finished run-tests step (success) 09:20:15 INFO - Running post-run listener: _resource_record_post_run 09:20:15 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 402083840; Read time: 28; Write time: 343456 09:20:15 INFO - TinderboxPrint: CPU usage
13.4% 09:20:15 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 28 09:20:15 INFO - TinderboxPrint: I/O write bytes / time
402,083,840 / 343,456 09:20:15 INFO - TinderboxPrint: CPU idle
8,254.0 (86.5%) 09:20:15 INFO - TinderboxPrint: CPU user
1,218.8 (12.8%) 09:20:15 INFO - TinderboxPrint: Swap in / out
0 / 0 09:20:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110362624; Read time: 0; Write time: 97736 09:20:15 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288129024; Read time: 12; Write time: 244908 09:20:15 INFO - Running post-run listener: _upload_blobber_files 09:20:15 INFO - Blob upload gear active. 09:20:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:17 INFO - (blobuploader) - INFO - Done attempting. 09:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:18 INFO - (blobuploader) - INFO - Done attempting. 09:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:21 INFO - (blobuploader) - INFO - Done attempting. 09:20:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:21 INFO - Return code: 0 09:20:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92e825acdaf8d853438120e35acadec112375a15261f4caff00c1b9fe6cd0f6619643db67e468d3f86d09cc625da1f6f937e1a6a8c07be3ae45c3a663dd8dc2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91f8dc5359491b9b39ee43b5a28ddb4964c3ac64ceff3600cabed61a45b0c2e4b28b247b69444fa5cbf7f14297461fe9a35b500812aa12adc3e24341948aaab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf881c2c5f322eccc94fd1f0360f429de7659bef853190ac442df65f9b3ee353f4ca714420db48f702214cb87515a3e1b4e3b1b038583bc66e6558ed79881e0d"} 09:20:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:21 INFO - Contents: 09:20:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92e825acdaf8d853438120e35acadec112375a15261f4caff00c1b9fe6cd0f6619643db67e468d3f86d09cc625da1f6f937e1a6a8c07be3ae45c3a663dd8dc2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91f8dc5359491b9b39ee43b5a28ddb4964c3ac64ceff3600cabed61a45b0c2e4b28b247b69444fa5cbf7f14297461fe9a35b500812aa12adc3e24341948aaab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf881c2c5f322eccc94fd1f0360f429de7659bef853190ac442df65f9b3ee353f4ca714420db48f702214cb87515a3e1b4e3b1b038583bc66e6558ed79881e0d"} 09:20:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:21 INFO - Copying logs to upload dir... 09:20:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.296352 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 09:20:20.656393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 09:20:20.659991) ========= 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=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92e825acdaf8d853438120e35acadec112375a15261f4caff00c1b9fe6cd0f6619643db67e468d3f86d09cc625da1f6f937e1a6a8c07be3ae45c3a663dd8dc2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91f8dc5359491b9b39ee43b5a28ddb4964c3ac64ceff3600cabed61a45b0c2e4b28b247b69444fa5cbf7f14297461fe9a35b500812aa12adc3e24341948aaab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf881c2c5f322eccc94fd1f0360f429de7659bef853190ac442df65f9b3ee353f4ca714420db48f702214cb87515a3e1b4e3b1b038583bc66e6558ed79881e0d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477780202/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92e825acdaf8d853438120e35acadec112375a15261f4caff00c1b9fe6cd0f6619643db67e468d3f86d09cc625da1f6f937e1a6a8c07be3ae45c3a663dd8dc2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91f8dc5359491b9b39ee43b5a28ddb4964c3ac64ceff3600cabed61a45b0c2e4b28b247b69444fa5cbf7f14297461fe9a35b500812aa12adc3e24341948aaab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf881c2c5f322eccc94fd1f0360f429de7659bef853190ac442df65f9b3ee353f4ca714420db48f702214cb87515a3e1b4e3b1b038583bc66e6558ed79881e0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 09:20:20.688778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:20:20.689381) ========= 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=920470bf432669ad7e3a5387000001ca-1477929582.938646-1839061965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:20:20.773797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 09:20:20.774161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 09:20:20.774570) ========= ========= Total master_lag: 0.18 =========