builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1475550677.91 results: success (0) buildid: 20161003183004 builduid: 95935a8a13464a8dbc220f31b3ef0120 revision: 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:17.921366) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:17.921967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:17.922269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:17.959823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:17.960162) ========= 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=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 20:11:18-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-10-03 20:11:18 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184783 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.182987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.183281) ========= 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=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.232187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.232512) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a --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 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a --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=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 20:11:18,309 truncating revision to first 12 chars 2016-10-03 20:11:18,309 Setting DEBUG logging. 2016-10-03 20:11:18,309 attempt 1/10 2016-10-03 20:11:18,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/51e9c4c3a8ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 20:11:18,619 unpacking tar archive at: mozilla-inbound-51e9c4c3a8ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.915511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.915859) ========= script_repo_revision: 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.916277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.916564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:11:18.927461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-03 20:11:18.927752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:11:19 INFO - MultiFileLogger online at 20161003 20:11:19 in /builds/slave/test 20:11:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:11:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:19 INFO - {'append_to_log': False, 20:11:19 INFO - 'base_work_dir': '/builds/slave/test', 20:11:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:11:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:19 INFO - 'branch': 'Mozilla-Inbound', 20:11:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:19 INFO - 'config_files': ('talos/linux_config.py',), 20:11:19 INFO - 'default_actions': ('clobber', 20:11:19 INFO - 'read-buildbot-config', 20:11:19 INFO - 'download-and-extract', 20:11:19 INFO - 'populate-webroot', 20:11:19 INFO - 'create-virtualenv', 20:11:19 INFO - 'install', 20:11:19 INFO - 'run-tests'), 20:11:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:19 INFO - 'download_minidump_stackwalk': True, 20:11:19 INFO - 'download_symbols': 'ondemand', 20:11:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:19 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:19 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:19 INFO - 'installer_path': 'installer.exe', 20:11:19 INFO - 'log_level': 'info', 20:11:19 INFO - 'log_name': 'talos', 20:11:19 INFO - 'log_to_console': True, 20:11:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:11:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:11:19 INFO - 'opt_config_files': (), 20:11:19 INFO - 'pip_index': False, 20:11:19 INFO - 'sps_profile': False, 20:11:19 INFO - 'sps_profile_interval': 0, 20:11:19 INFO - 'suite': 'dromaeojs', 20:11:19 INFO - 'system_bits': '32', 20:11:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:19 INFO - 'title': 'talos-linux64-ix-035', 20:11:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:19 INFO - 'use_talos_json': True, 20:11:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:19 INFO - 'work_dir': 'build'} 20:11:19 INFO - [mozharness: 2016-10-04 03:11:19.201694Z] Running clobber step. 20:11:19 INFO - Running pre-action listener: _resource_record_pre_action 20:11:19 INFO - Running main action method: clobber 20:11:19 INFO - rmtree: /builds/slave/test/build 20:11:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:19 INFO - Running post-action listener: _resource_record_post_action 20:11:19 INFO - [mozharness: 2016-10-04 03:11:19.623742Z] Finished clobber step (success) 20:11:19 INFO - [mozharness: 2016-10-04 03:11:19.623843Z] Running read-buildbot-config step. 20:11:19 INFO - Running pre-action listener: _resource_record_pre_action 20:11:19 INFO - Running main action method: read_buildbot_config 20:11:19 INFO - Using buildbot properties: 20:11:19 INFO - { 20:11:19 INFO - "project": "", 20:11:19 INFO - "product": "firefox", 20:11:19 INFO - "script_repo_revision": "production", 20:11:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:11:19 INFO - "repository": "", 20:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:11:19 INFO - "buildid": "20161003183004", 20:11:19 INFO - "pgo_build": "True", 20:11:19 INFO - "basedir": "/builds/slave/test", 20:11:19 INFO - "buildnumber": 2525, 20:11:19 INFO - "slavename": "talos-linux64-ix-035", 20:11:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:11:19 INFO - "platform": "ubuntu64_hw", 20:11:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:11:19 INFO - "branch": "mozilla-inbound", 20:11:19 INFO - "repo_path": "integration/mozilla-inbound", 20:11:19 INFO - "revision": "51e9c4c3a8ee44aad8d93f4226a927191a3cc01a", 20:11:19 INFO - "stage_platform": "linux64-pgo", 20:11:19 INFO - "builduid": "95935a8a13464a8dbc220f31b3ef0120", 20:11:19 INFO - "slavebuilddir": "test" 20:11:19 INFO - } 20:11:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:11:19 INFO - Running post-action listener: _resource_record_post_action 20:11:19 INFO - [mozharness: 2016-10-04 03:11:19.626257Z] Finished read-buildbot-config step (success) 20:11:19 INFO - [mozharness: 2016-10-04 03:11:19.626344Z] Running download-and-extract step. 20:11:19 INFO - Running pre-action listener: _resource_record_pre_action 20:11:19 INFO - Running main action method: download_and_extract 20:11:19 INFO - mkdir: /builds/slave/test/build/tests 20:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:19 INFO - trying https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:11:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/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 20:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/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 20:11:20 INFO - Downloaded 1361 bytes. 20:11:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:11:20 INFO - Using the following test package requirements: 20:11:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:11:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:11:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'jsshell-linux-x86_64.zip'], 20:11:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:11:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:11:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:11:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:11:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:11:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:11:20 INFO - Http code: 200 20:11:20 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:11:20 INFO - x-amz-cf-id: grPXENBpJXuNYzCIR457yYXriGRID5FB2cnb_muMp-qZK56kFylykQ== 20:11:20 INFO - x-amz-version-id: yYixqMZdsq1PwVALRQeBFqizJ3MKqUZi 20:11:21 INFO - Expected file size: 21992768 20:11:21 INFO - Obtained file size: 21992768 20:11:25 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 20:11:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:11:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:11:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:11:25 INFO - Http code: 200 20:11:25 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 20:11:25 INFO - x-amz-cf-id: u7dQdRD-n09sebvEZlEaoK0MyTKnUVNprWK2n06OkF5jUF6IqdHG3g== 20:11:25 INFO - x-amz-version-id: yYixqMZdsq1PwVALRQeBFqizJ3MKqUZi 20:11:26 INFO - Expected file size: 21992768 20:11:26 INFO - Obtained file size: 21992768 20:11:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:11:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:11:31 INFO - Http code: 200 20:11:31 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 20:11:31 INFO - x-amz-cf-id: UllADRa_6Ra-Q7rzJlIvWwwwLHVLDauStiVD6oNz8_Nlw6lxo8YKFg== 20:11:31 INFO - x-amz-version-id: uio.P2XJG3GWdAXkLckxVcNmMuuz6dAO 20:11:31 INFO - Expected file size: 14408522 20:11:31 INFO - Obtained file size: 14408522 20:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:31 INFO - trying https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/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 20:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/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 20:11:33 INFO - Downloaded 59693613 bytes. 20:11:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:33 INFO - mkdir: /builds/slave/test/properties 20:11:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:33 INFO - Contents: 20:11:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:34 INFO - Running post-action listener: _resource_record_post_action 20:11:34 INFO - Running post-action listener: set_extra_try_arguments 20:11:34 INFO - [mozharness: 2016-10-04 03:11:34.156137Z] Finished download-and-extract step (success) 20:11:34 INFO - [mozharness: 2016-10-04 03:11:34.156367Z] Running populate-webroot step. 20:11:34 INFO - Running pre-action listener: _resource_record_pre_action 20:11:34 INFO - Running main action method: populate_webroot 20:11:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:34 INFO - '--tppagecycles', 20:11:34 INFO - '7'], 20:11:34 INFO - 'tests': ['tsvgm']}}, 20:11:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['damp', 'tps']}, 20:11:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'tests': ['damp', 'tps']}, 20:11:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['dromaeo_dom']}, 20:11:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['basic_compositor_video']}, 20:11:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:11:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['a11yr', 20:11:34 INFO - 'ts_paint', 20:11:34 INFO - 'tpaint', 20:11:34 INFO - 'sessionrestore', 20:11:34 INFO - 'sessionrestore_no_auto_restore', 20:11:34 INFO - 'tabpaint']}, 20:11:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['tsvgx', 20:11:34 INFO - 'tsvgr_opacity', 20:11:34 INFO - 'tart', 20:11:34 INFO - 'tscrollx', 20:11:34 INFO - 'cart']}, 20:11:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:34 INFO - 'tsvgr_opacity', 20:11:34 INFO - 'tart', 20:11:34 INFO - 'tscrollx', 20:11:34 INFO - 'cart']}, 20:11:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'talos_options': ['--disable-e10s'], 20:11:34 INFO - 'tests': ['tp5o']}, 20:11:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'tests': ['tp5o']}, 20:11:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'talos_options': ['--disable-e10s', 20:11:34 INFO - '--xperf_path', 20:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:34 INFO - 'tests': ['tp5n']}, 20:11:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:34 INFO - 'talos_options': ['--xperf_path', 20:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:34 INFO - 'tests': ['tp5n']}}, 20:11:34 INFO - 'talos.zip': {'path': '', 20:11:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:34 INFO - Running post-action listener: _resource_record_post_action 20:11:34 INFO - [mozharness: 2016-10-04 03:11:34.173808Z] Finished populate-webroot step (success) 20:11:34 INFO - [mozharness: 2016-10-04 03:11:34.173896Z] Running create-virtualenv step. 20:11:34 INFO - Running pre-action listener: _resource_record_pre_action 20:11:34 INFO - Running main action method: create_virtualenv 20:11:34 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:34 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 20:11:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:34 INFO - Using real prefix '/usr' 20:11:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:36 INFO - Installing pip.................done. 20:11:36 INFO - Return code: 0 20:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:11:37 INFO - Reading from file tmpfile_stdout 20:11:37 INFO - Output received: 20:11:37 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) 20:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:37 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')]} 20:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:37 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')]} 20:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:37 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:37 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 20:11:37 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 20:11:37 INFO - Using env: {'DISPLAY': ':0', 20:11:37 INFO - 'HOME': '/home/cltbld', 20:11:37 INFO - 'LANG': 'en_US.UTF-8', 20:11:37 INFO - 'LANGUAGE': 'en_US:en', 20:11:37 INFO - 'LOGNAME': 'cltbld', 20:11:37 INFO - 'MAIL': '/var/mail/cltbld', 20:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:37 INFO - 'MOZ_NO_REMOTE': '1', 20:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:37 INFO - 'NO_EM_RESTART': '1', 20:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:37 INFO - 'PWD': '/builds/slave/test', 20:11:37 INFO - 'SHELL': '/bin/bash', 20:11:37 INFO - 'SHLVL': '1', 20:11:37 INFO - 'TERM': 'linux', 20:11:37 INFO - 'TMOUT': '86400', 20:11:37 INFO - 'USER': 'cltbld', 20:11:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:37 INFO - '_': '/tools/buildbot/bin/python'} 20:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:37 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 20:11:37 INFO - Cleaning up... 20:11:37 INFO - Return code: 0 20:11:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:37 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')]} 20:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:37 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')]} 20:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:37 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:37 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 20:11:37 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 20:11:37 INFO - Using env: {'DISPLAY': ':0', 20:11:37 INFO - 'HOME': '/home/cltbld', 20:11:37 INFO - 'LANG': 'en_US.UTF-8', 20:11:37 INFO - 'LANGUAGE': 'en_US:en', 20:11:37 INFO - 'LOGNAME': 'cltbld', 20:11:37 INFO - 'MAIL': '/var/mail/cltbld', 20:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:37 INFO - 'MOZ_NO_REMOTE': '1', 20:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:37 INFO - 'NO_EM_RESTART': '1', 20:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:37 INFO - 'PWD': '/builds/slave/test', 20:11:37 INFO - 'SHELL': '/bin/bash', 20:11:37 INFO - 'SHLVL': '1', 20:11:37 INFO - 'TERM': 'linux', 20:11:37 INFO - 'TMOUT': '86400', 20:11:37 INFO - 'USER': 'cltbld', 20:11:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:37 INFO - '_': '/tools/buildbot/bin/python'} 20:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:37 INFO - Downloading/unpacking psutil>=3.1.1 20:11:37 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 20:11:37 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 20:11:37 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 20:11:37 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 20:11:37 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 20:11:37 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 20:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:40 INFO - Installing collected packages: psutil 20:11:40 INFO - Running setup.py install for psutil 20:11:40 INFO - building 'psutil._psutil_linux' extension 20:11:40 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 20:11:42 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 20:11:42 INFO - building 'psutil._psutil_posix' extension 20:11:42 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 20:11:42 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 20:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:42 INFO - Successfully installed psutil 20:11:42 INFO - Cleaning up... 20:11:42 INFO - Return code: 0 20:11:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:42 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')]} 20:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:42 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')]} 20:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:42 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:42 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 20:11:42 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 20:11:42 INFO - Using env: {'DISPLAY': ':0', 20:11:42 INFO - 'HOME': '/home/cltbld', 20:11:42 INFO - 'LANG': 'en_US.UTF-8', 20:11:42 INFO - 'LANGUAGE': 'en_US:en', 20:11:42 INFO - 'LOGNAME': 'cltbld', 20:11:42 INFO - 'MAIL': '/var/mail/cltbld', 20:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:42 INFO - 'MOZ_NO_REMOTE': '1', 20:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:42 INFO - 'NO_EM_RESTART': '1', 20:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:42 INFO - 'PWD': '/builds/slave/test', 20:11:42 INFO - 'SHELL': '/bin/bash', 20:11:42 INFO - 'SHLVL': '1', 20:11:42 INFO - 'TERM': 'linux', 20:11:42 INFO - 'TMOUT': '86400', 20:11:42 INFO - 'USER': 'cltbld', 20:11:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:42 INFO - '_': '/tools/buildbot/bin/python'} 20:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:42 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 20:11:42 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 20:11:42 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 20:11:42 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 20:11:42 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 20:11:42 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 20:11:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:45 INFO - Installing collected packages: mozsystemmonitor 20:11:45 INFO - Running setup.py install for mozsystemmonitor 20:11:45 INFO - Successfully installed mozsystemmonitor 20:11:45 INFO - Cleaning up... 20:11:45 INFO - Return code: 0 20:11:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:45 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:45 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 20:11:45 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 20:11:45 INFO - Using env: {'DISPLAY': ':0', 20:11:45 INFO - 'HOME': '/home/cltbld', 20:11:45 INFO - 'LANG': 'en_US.UTF-8', 20:11:45 INFO - 'LANGUAGE': 'en_US:en', 20:11:45 INFO - 'LOGNAME': 'cltbld', 20:11:45 INFO - 'MAIL': '/var/mail/cltbld', 20:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:45 INFO - 'MOZ_NO_REMOTE': '1', 20:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:45 INFO - 'NO_EM_RESTART': '1', 20:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:45 INFO - 'PWD': '/builds/slave/test', 20:11:45 INFO - 'SHELL': '/bin/bash', 20:11:45 INFO - 'SHLVL': '1', 20:11:45 INFO - 'TERM': 'linux', 20:11:45 INFO - 'TMOUT': '86400', 20:11:45 INFO - 'USER': 'cltbld', 20:11:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:45 INFO - '_': '/tools/buildbot/bin/python'} 20:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:45 INFO - Downloading/unpacking jsonschema==2.5.1 20:11:45 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 20:11:45 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 20:11:45 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 20:11:45 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 20:11:45 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 20:11:45 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 20:11:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:11:47 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 20:11:47 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 20:11:47 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 20:11:47 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 20:11:47 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 20:11:47 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 20:11:47 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:47 INFO - warning: no files found matching '*.txt' 20:11:47 INFO - no previously-included directories found matching 'build' 20:11:47 INFO - no previously-included directories found matching 'dist' 20:11:47 INFO - no previously-included directories found matching '.git*' 20:11:47 INFO - Installing collected packages: jsonschema, functools32 20:11:47 INFO - Running setup.py install for functools32 20:11:47 INFO - warning: no files found matching '*.txt' 20:11:47 INFO - no previously-included directories found matching 'build' 20:11:47 INFO - no previously-included directories found matching 'dist' 20:11:47 INFO - no previously-included directories found matching '.git*' 20:11:47 INFO - Successfully installed jsonschema functools32 20:11:47 INFO - Cleaning up... 20:11:48 INFO - Return code: 0 20:11:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:11:48 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')]} 20:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 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')]} 20:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:48 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 20:11:48 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 20:11:48 INFO - Using env: {'DISPLAY': ':0', 20:11:48 INFO - 'HOME': '/home/cltbld', 20:11:48 INFO - 'LANG': 'en_US.UTF-8', 20:11:48 INFO - 'LANGUAGE': 'en_US:en', 20:11:48 INFO - 'LOGNAME': 'cltbld', 20:11:48 INFO - 'MAIL': '/var/mail/cltbld', 20:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:48 INFO - 'MOZ_NO_REMOTE': '1', 20:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:48 INFO - 'NO_EM_RESTART': '1', 20:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:48 INFO - 'PWD': '/builds/slave/test', 20:11:48 INFO - 'SHELL': '/bin/bash', 20:11:48 INFO - 'SHLVL': '1', 20:11:48 INFO - 'TERM': 'linux', 20:11:48 INFO - 'TMOUT': '86400', 20:11:48 INFO - 'USER': 'cltbld', 20:11:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:48 INFO - '_': '/tools/buildbot/bin/python'} 20:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:11:48 INFO - Cleaning up... 20:11:48 INFO - Return code: 0 20:11:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:48 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')]} 20:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 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')]} 20:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:48 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 20:11:48 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 20:11:48 INFO - Using env: {'DISPLAY': ':0', 20:11:48 INFO - 'HOME': '/home/cltbld', 20:11:48 INFO - 'LANG': 'en_US.UTF-8', 20:11:48 INFO - 'LANGUAGE': 'en_US:en', 20:11:48 INFO - 'LOGNAME': 'cltbld', 20:11:48 INFO - 'MAIL': '/var/mail/cltbld', 20:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:48 INFO - 'MOZ_NO_REMOTE': '1', 20:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:48 INFO - 'NO_EM_RESTART': '1', 20:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:48 INFO - 'PWD': '/builds/slave/test', 20:11:48 INFO - 'SHELL': '/bin/bash', 20:11:48 INFO - 'SHLVL': '1', 20:11:48 INFO - 'TERM': 'linux', 20:11:48 INFO - 'TMOUT': '86400', 20:11:48 INFO - 'USER': 'cltbld', 20:11:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:48 INFO - '_': '/tools/buildbot/bin/python'} 20:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:48 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:48 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 20:11:48 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 20:11:48 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 20:11:48 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 20:11:48 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 20:11:48 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 20:11:50 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:50 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 20:11:51 INFO - Downloading docopt-0.6.1.tar.gz 20:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:51 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:51 INFO - Running setup.py install for blobuploader 20:11:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:51 INFO - Running setup.py install for requests 20:11:51 INFO - Running setup.py install for docopt 20:11:51 INFO - Successfully installed blobuploader requests docopt 20:11:51 INFO - Cleaning up... 20:11:51 INFO - Return code: 0 20:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:51 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')]} 20:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:51 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')]} 20:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:51 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:51 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 20:11:51 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 20:11:51 INFO - Using env: {'DISPLAY': ':0', 20:11:51 INFO - 'HOME': '/home/cltbld', 20:11:51 INFO - 'LANG': 'en_US.UTF-8', 20:11:51 INFO - 'LANGUAGE': 'en_US:en', 20:11:51 INFO - 'LOGNAME': 'cltbld', 20:11:51 INFO - 'MAIL': '/var/mail/cltbld', 20:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:51 INFO - 'MOZ_NO_REMOTE': '1', 20:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:51 INFO - 'NO_EM_RESTART': '1', 20:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:51 INFO - 'PWD': '/builds/slave/test', 20:11:51 INFO - 'SHELL': '/bin/bash', 20:11:51 INFO - 'SHLVL': '1', 20:11:51 INFO - 'TERM': 'linux', 20:11:51 INFO - 'TMOUT': '86400', 20:11:51 INFO - 'USER': 'cltbld', 20:11:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:51 INFO - '_': '/tools/buildbot/bin/python'} 20:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:51 INFO - Running setup.py (path:/tmp/pip-Ip3jDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:52 INFO - Running setup.py (path:/tmp/pip-KupQm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:52 INFO - Running setup.py (path:/tmp/pip-cy88YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:52 INFO - Running setup.py (path:/tmp/pip-1_vwvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:52 INFO - Running setup.py (path:/tmp/pip-bpNqro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:52 INFO - Running setup.py (path:/tmp/pip-4oB8PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:52 INFO - Running setup.py (path:/tmp/pip-eLCuLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:52 INFO - Running setup.py (path:/tmp/pip-DozFKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:52 INFO - Running setup.py (path:/tmp/pip-7whxQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:52 INFO - Running setup.py (path:/tmp/pip-RKFqxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:52 INFO - Running setup.py (path:/tmp/pip-2Ellqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:52 INFO - Running setup.py (path:/tmp/pip-itVkNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:52 INFO - Running setup.py (path:/tmp/pip-4WaPxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:52 INFO - Running setup.py (path:/tmp/pip-NL8827-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:52 INFO - Running setup.py (path:/tmp/pip-vagskz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:53 INFO - Running setup.py (path:/tmp/pip-DJYI39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:53 INFO - Running setup.py (path:/tmp/pip-PWNsg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:53 INFO - Running setup.py install for manifestparser 20:11:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Running setup.py install for mozcrash 20:11:53 INFO - Running setup.py install for mozdebug 20:11:53 INFO - Running setup.py install for mozdevice 20:11:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Running setup.py install for mozfile 20:11:53 INFO - Running setup.py install for mozhttpd 20:11:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Running setup.py install for mozinfo 20:11:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Running setup.py install for mozInstall 20:11:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:53 INFO - Running setup.py install for mozleak 20:11:54 INFO - Running setup.py install for mozlog 20:11:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Running setup.py install for moznetwork 20:11:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Running setup.py install for mozprocess 20:11:54 INFO - Running setup.py install for mozprofile 20:11:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Running setup.py install for mozrunner 20:11:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Running setup.py install for mozscreenshot 20:11:54 INFO - Running setup.py install for moztest 20:11:54 INFO - Running setup.py install for mozversion 20:11:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:54 INFO - Cleaning up... 20:11:54 INFO - Return code: 0 20:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:54 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')]} 20:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:54 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')]} 20:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:54 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:54 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 20:11:54 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 20:11:54 INFO - Using env: {'DISPLAY': ':0', 20:11:54 INFO - 'HOME': '/home/cltbld', 20:11:54 INFO - 'LANG': 'en_US.UTF-8', 20:11:54 INFO - 'LANGUAGE': 'en_US:en', 20:11:54 INFO - 'LOGNAME': 'cltbld', 20:11:54 INFO - 'MAIL': '/var/mail/cltbld', 20:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:54 INFO - 'MOZ_NO_REMOTE': '1', 20:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:54 INFO - 'NO_EM_RESTART': '1', 20:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:54 INFO - 'PWD': '/builds/slave/test', 20:11:54 INFO - 'SHELL': '/bin/bash', 20:11:54 INFO - 'SHLVL': '1', 20:11:54 INFO - 'TERM': 'linux', 20:11:54 INFO - 'TMOUT': '86400', 20:11:54 INFO - 'USER': 'cltbld', 20:11:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:54 INFO - '_': '/tools/buildbot/bin/python'} 20:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:55 INFO - Running setup.py (path:/tmp/pip-IWpicv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:55 INFO - Running setup.py (path:/tmp/pip-pOvCnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:55 INFO - Running setup.py (path:/tmp/pip-24MzEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:55 INFO - Running setup.py (path:/tmp/pip-m_qIhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:55 INFO - Running setup.py (path:/tmp/pip-aI3927-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:55 INFO - Running setup.py (path:/tmp/pip-zcmQNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:55 INFO - Running setup.py (path:/tmp/pip-g9iLUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:55 INFO - Running setup.py (path:/tmp/pip-rlLh53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:55 INFO - Running setup.py (path:/tmp/pip-xGkKrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:55 INFO - Running setup.py (path:/tmp/pip-bV83Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:55 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)) 20:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:55 INFO - Running setup.py (path:/tmp/pip-FZ0ihy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:56 INFO - Running setup.py (path:/tmp/pip-7_7PcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:56 INFO - Running setup.py (path:/tmp/pip-J4_p7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:56 INFO - Running setup.py (path:/tmp/pip-2qHxK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:56 INFO - Running setup.py (path:/tmp/pip-jPmZwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:56 INFO - Running setup.py (path:/tmp/pip-nmy3zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:56 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)) 20:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:56 INFO - Running setup.py (path:/tmp/pip-SmrTWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:56 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)) 20:11:56 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)) 20:11:56 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)) 20:11:56 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)) 20:11:56 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)) 20:11:56 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)) 20:11:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:56 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 20:11:56 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 20:11:56 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 20:11:56 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 20:11:56 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 20:11:56 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 20:11:58 INFO - Downloading blessings-1.6.tar.gz 20:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:58 INFO - Installing collected packages: blessings 20:11:58 INFO - Running setup.py install for blessings 20:11:58 INFO - Successfully installed blessings 20:11:58 INFO - Cleaning up... 20:11:58 INFO - Return code: 0 20:11:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:58 INFO - Reading from file tmpfile_stdout 20:11:58 INFO - Current package versions: 20:11:58 INFO - argparse == 1.2.1 20:11:58 INFO - blessings == 1.6 20:11:58 INFO - blobuploader == 1.2.4 20:11:58 INFO - docopt == 0.6.1 20:11:58 INFO - functools32 == 3.2.3-2 20:11:58 INFO - jsonschema == 2.5.1 20:11:58 INFO - manifestparser == 1.1 20:11:58 INFO - mozInstall == 1.12 20:11:58 INFO - mozcrash == 0.17 20:11:58 INFO - mozdebug == 0.1 20:11:58 INFO - mozdevice == 0.48 20:11:58 INFO - mozfile == 1.2 20:11:58 INFO - mozhttpd == 0.7 20:11:58 INFO - mozinfo == 0.9 20:11:58 INFO - mozleak == 0.1 20:11:58 INFO - mozlog == 3.4 20:11:58 INFO - moznetwork == 0.27 20:11:58 INFO - mozprocess == 0.23 20:11:58 INFO - mozprofile == 0.28 20:11:58 INFO - mozrunner == 6.12 20:11:58 INFO - mozscreenshot == 0.1 20:11:58 INFO - mozsystemmonitor == 0.3 20:11:58 INFO - moztest == 0.7 20:11:58 INFO - mozversion == 1.4 20:11:58 INFO - psutil == 3.1.1 20:11:58 INFO - requests == 1.2.3 20:11:58 INFO - wsgiref == 0.1.2 20:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:58 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')]} 20:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:58 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')]} 20:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:58 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 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11:58 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 20:11:58 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 20:11:58 INFO - Using env: {'DISPLAY': ':0', 20:11:58 INFO - 'HOME': '/home/cltbld', 20:11:58 INFO - 'LANG': 'en_US.UTF-8', 20:11:58 INFO - 'LANGUAGE': 'en_US:en', 20:11:58 INFO - 'LOGNAME': 'cltbld', 20:11:58 INFO - 'MAIL': '/var/mail/cltbld', 20:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:58 INFO - 'MOZ_NO_REMOTE': '1', 20:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:58 INFO - 'NO_EM_RESTART': '1', 20:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:58 INFO - 'PWD': '/builds/slave/test', 20:11:58 INFO - 'SHELL': '/bin/bash', 20:11:58 INFO - 'SHLVL': '1', 20:11:58 INFO - 'TERM': 'linux', 20:11:58 INFO - 'TMOUT': '86400', 20:11:58 INFO - 'USER': 'cltbld', 20:11:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:58 INFO - '_': '/tools/buildbot/bin/python'} 20:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 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)) 20:11:59 INFO - Cleaning up... 20:11:59 INFO - Return code: 0 20:11:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaaaa70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1601ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', '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 20:11: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', 'jsonschema'] in /builds/slave/test/build 20:11: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 jsonschema 20:11:59 INFO - Using env: {'DISPLAY': ':0', 20:11:59 INFO - 'HOME': '/home/cltbld', 20:11:59 INFO - 'LANG': 'en_US.UTF-8', 20:11:59 INFO - 'LANGUAGE': 'en_US:en', 20:11:59 INFO - 'LOGNAME': 'cltbld', 20:11:59 INFO - 'MAIL': '/var/mail/cltbld', 20:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:59 INFO - 'MOZ_NO_REMOTE': '1', 20:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:59 INFO - 'NO_EM_RESTART': '1', 20:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:59 INFO - 'PWD': '/builds/slave/test', 20:11:59 INFO - 'SHELL': '/bin/bash', 20:11:59 INFO - 'SHLVL': '1', 20:11:59 INFO - 'TERM': 'linux', 20:11:59 INFO - 'TMOUT': '86400', 20:11:59 INFO - 'USER': 'cltbld', 20:11:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:59 INFO - '_': '/tools/buildbot/bin/python'} 20:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:11:59 INFO - Cleaning up... 20:11:59 INFO - Return code: 0 20:11:59 INFO - Running post-action listener: _resource_record_post_action 20:11:59 INFO - Running post-action listener: _start_resource_monitoring 20:11:59 INFO - Starting resource monitoring. 20:11:59 INFO - [mozharness: 2016-10-04 03:11:59.389044Z] Finished create-virtualenv step (success) 20:11:59 INFO - [mozharness: 2016-10-04 03:11:59.389495Z] Running install step. 20:11:59 INFO - Running pre-action listener: _resource_record_pre_action 20:11:59 INFO - Running main action method: install 20:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:59 INFO - Reading from file tmpfile_stdout 20:11:59 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:59 INFO - Reading from file tmpfile_stdout 20:11:59 INFO - Output received: 20:11:59 INFO - Usage: mozinstall [options] installer 20:11:59 INFO - Options: 20:11:59 INFO - -h, --help show this help message and exit 20:11:59 INFO - -d DEST, --destination=DEST 20:11:59 INFO - Directory to install application into. [default: 20:11:59 INFO - "/builds/slave/test"] 20:11:59 INFO - --app=APP Application being installed. [default: firefox] 20:11:59 INFO - mkdir: /builds/slave/test/build/application 20:11:59 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'] 20:11:59 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 20:12:16 INFO - Reading from file tmpfile_stdout 20:12:16 INFO - Output received: 20:12:16 INFO - /builds/slave/test/build/application/firefox/firefox 20:12:16 INFO - Running post-action listener: _resource_record_post_action 20:12:16 INFO - [mozharness: 2016-10-04 03:12:16.682382Z] Finished install step (success) 20:12:16 INFO - [mozharness: 2016-10-04 03:12:16.682627Z] Running run-tests step. 20:12:16 INFO - Running pre-action listener: _resource_record_pre_action 20:12:16 INFO - Running main action method: run_tests 20:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:12:16 INFO - Python 2.7.3 20:12:16 INFO - Return code: 0 20:12:16 INFO - grabbing minidump binary from tooltool 20:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:16 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 0x15fef60>, '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 0x15ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:12:16 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 20:12:16 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 20:12:16 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 20:12:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:12:16 INFO - Return code: 0 20:12:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:12:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:12:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:12:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:12:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:12:16 INFO - Using env: {'DISPLAY': ':0', 20:12:16 INFO - 'HOME': '/home/cltbld', 20:12:16 INFO - 'LANG': 'en_US.UTF-8', 20:12:16 INFO - 'LANGUAGE': 'en_US:en', 20:12:16 INFO - 'LOGNAME': 'cltbld', 20:12:16 INFO - 'MAIL': '/var/mail/cltbld', 20:12:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:12:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:16 INFO - 'MOZ_NO_REMOTE': '1', 20:12:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:16 INFO - 'NO_EM_RESTART': '1', 20:12:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:16 INFO - 'PWD': '/builds/slave/test', 20:12:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:12:16 INFO - 'SHELL': '/bin/bash', 20:12:16 INFO - 'SHLVL': '1', 20:12:16 INFO - 'TERM': 'linux', 20:12:16 INFO - 'TMOUT': '86400', 20:12:16 INFO - 'USER': 'cltbld', 20:12:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760', 20:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:16 INFO - '_': '/tools/buildbot/bin/python'} 20:12:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:12:17 INFO - mozversion application_buildid: 20161003183004 20:12:17 INFO - mozversion application_changeset: 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a 20:12:17 INFO - mozversion application_display_name: Nightly 20:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:12:17 INFO - mozversion application_name: Firefox 20:12:17 INFO - mozversion application_remotingname: firefox 20:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:12:17 INFO - mozversion application_vendor: Mozilla 20:12:17 INFO - mozversion application_version: 52.0a1 20:12:17 INFO - mozversion platform_buildid: 20161003183004 20:12:17 INFO - mozversion platform_changeset: 51e9c4c3a8ee44aad8d93f4226a927191a3cc01a 20:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:12:17 INFO - mozversion platform_version: 52.0a1 20:12:17 INFO - using testdate: 1475550737 20:12:17 INFO - actual date: 1475550737 20:12:17 INFO - starting webserver on 'localhost:33285' 20:12:17 INFO - SUITE-START | Running 2 tests 20:12:17 INFO - TEST-START | dromaeo_css 20:12:17 INFO - operating with platform_type : linux_ 20:12:17 INFO - Initialising browser for dromaeo_css test... 20:12:17 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxbruN/profile http://localhost:33285/getInfo.html) 20:12:23 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 20:12:23 INFO - PROCESS | 3327 | colorDepth:24 20:12:23 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 20:12:23 INFO - PROCESS | 3327 | __metrics 20:12:23 INFO - PROCESS | 3327 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:12:23 INFO - PROCESS | 3327 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:12:24 INFO - PROCESS | 3327 | console.error: PushService: 20:12:24 INFO - PROCESS | 3327 | stateChangeProcessEnqueue: Error transitioning state 20:12:24 INFO - PROCESS | 3327 | UnknownError 20:12:24 INFO - TEST-INFO | 3327: exit 0 20:12:24 INFO - Browser initialized. 20:12:24 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:24 INFO - TEST-INFO | started process 3410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxbruN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:37 INFO - PROCESS | 3410 | RSS: Main: 173662208 20:12:37 INFO - PROCESS | 3410 | 20:13:28 INFO - PROCESS | 3410 | 1475550808551 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] 20:15:38 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33285/tests/dromaeo/cssquery-ext.html) 20:15:39 INFO - PROCESS | 3410 | RSS: Main: 304746496 20:15:39 INFO - PROCESS | 3410 | 20:18:42 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-ext.html (next: http://localhost:33285/tests/dromaeo/cssquery-jquery.html) 20:18:42 INFO - PROCESS | 3410 | RSS: Main: 268472320 20:18:42 INFO - PROCESS | 3410 | 20:21:44 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33285/tests/dromaeo/cssquery-mootools.html) 20:21:45 INFO - PROCESS | 3410 | RSS: Main: 213622784 20:21:45 INFO - PROCESS | 3410 | 20:24:47 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33285/tests/dromaeo/cssquery-prototype.html) 20:24:48 INFO - PROCESS | 3410 | RSS: Main: 214884352 20:24:48 INFO - PROCESS | 3410 | 20:27:50 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33285/tests/dromaeo/cssquery-yui.html) 20:27:51 INFO - PROCESS | 3410 | RSS: Main: 217636864 20:27:51 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:33285/tests/dromaeo/cssquery-yui.html (next: http://localhost:33285/tests/dromaeo/cssquery-dojo.html) 20:30:54 INFO - PROCESS | 3410 | RSS: Main: 307494912 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | __start_tp_report 20:30:54 INFO - PROCESS | 3410 | _x_x_mozilla_page_load 20:30:54 INFO - PROCESS | 3410 | _x_x_mozilla_page_load_details 20:30:54 INFO - PROCESS | 3410 | |i|pagename|runs| 20:30:54 INFO - PROCESS | 3410 | |0;dojo.html;2915.5772413000113;2963.0222026731194;2963.9407211855764;2974.2118338640253;3007.6841931597182;4977.925331120036;5073.7209453480045;5078.873028174293;5171.741412929353;5188.6886786792775;5103.719295438749;5109.233614957759;5118.232265160228;5169.1470907300345;5174.844754657357;4580.1984652685815;4623.768811559426;4635.837745678902;4747.59645430138;4778.498257682945;4638.930416043762;4675.649326300524;4695.741734204617;4723.763811809413;4771.33201351811;4724.763761811912;4738.147133515966;4751.5010923853015;4764.97617511912;4838.419389673244;4570.611498022672;4605.4933957264675;4620.976895115503;4624.9768751156025;4719.339292499053;4672.789724462407;4692.202325604621;4695.859124226278;4702.106599746037;4759.643026772971;5124.103281925648;5156.664816786897;5167.224916262553;5167.974160129175;5195.844124676266;5234.371875374942;5314.548263397616;5316.494932981361;5494.203340515603;5510.366307874566;5391.919121213185;5395.136778115482;5397.109476936301;5473.917891231635;5475.534579560742;5007.699538027694;5011.599072074226;5012.849614511534;5016.749162541858;5071.264666623393;5421.105517589633;5450.700211488406;5454.672719636835;5458.645188062763;5495.065838807413;5268.631195816256;5302.840914772563;5305.65513241638;5327.307450031549;5392.40683524812;5347.2781174541715;5347.2781174541715;5349.946500534945;5352.6253162279045;5385.084535628953;5105.846824595268;5283.260343551906;5345.1714984177515;5351;5399.163129714901;5253.737313134328;5296;5343.893122137535;5353.732313384316;5428.375736790241;4235.78821058952;4236.449261596034;4276.700630955866;4283.828646854091;4286.54991225923;3767.0770661188185;3775.1505911170316;3777.8488860445273;3822.1782316802023;3829.0810205551024;5020.648554601143;5076.36545431821;5092.898142037138;5123.897522049539;5141.665791723526;5373.946260537345;5401.243825864303;5403.35159780821;5424.972875135678;5474.2609747683555;5139.203423469368;5151.922721159186;5153.948460515347;5154.690718556899;5164.92252616211;4623.86128416148;4652.418447694038;4722.763861806965;4729.219678753036;4736.052789442126;5659.236003139606;5721.199032135588;5724.1413787931315;5744.224529688438;5810.041343178328;5439.238506608999;5482.862928426821;5483.835484935458;5486.341639003345;5491.341039075336;5574.86062848432;5757.0788673811985;5757.366689664217;5762.164486149569;5773.624714393551;5287.629865909349;5350.759215835219;5394.595405344537;5400.83797486076;5489.258950041693;5497.835064948058;5510.6969116698965;5532.889342213214;5554.1391084381985;5561.916571251515;5400.594955378284;5452.318460192476;5454.154606036071;5457.372402173801;5515.641483303572;5189.792408303626;5243.318368612056;5263.868403289948;5315.388730295911;5336.066188416934;5274.287971123849;5282.022825777243;5288.259643649969;5289.2330612061805;5338.946610533845;5362.0616392132;5371.570274377962;5376.112941364631;5384.353877534721;5448.318960129984;4716.457607375196;5071.822486213113;5126.7949282029795;5146.125158722951;5204.765785539736 20:30:54 INFO - PROCESS | 3410 | |1;ext.html;577.6967092276554;603.0833133636871;607.6748939317466;620.091565856021;634.7334119669738;31087;41778;42303.15393692124;42345.78827105868;42367.57632423675;45420.31869521952;45900.081998360016;45990.54009459904;46052.3092153618;46122.76938615302;7910.564918929485;8781.165789250012;8923.286137109015;8935.731928042169;8938.419002764833;8096;10385.376877387343;10606.946965265162;10617.0975467085;11010.119190464784;10359.792804143912;10370.32592881464;10394.324368916034;10399.272050956437;10404.855465898745;10432.478376081204;10533;10533.52599133037;10537.84193237102;10540.683779486628;10420.895791042069;10490;10490.790184196274;10490.895091049068;10499.370037797757;41020;41159.38260926089;41193.382099268536;41232.175356493004;41235.793821031;3441.8451169697423;3748.8313025913626;4070.206309769596;4094.651954583864;4169.332906734908;30732.2316942076;31383;31646.36707265865;32066.519002214984;32708.509372359433;4126;4126.5667104953845;4183.811728472226;4185.560516145792;4390.912181756347;329731;330681.9999999976;331006;331315.3434232838;332468;58979.41020589825;59397.81204375888;59463.70268148718;59597;59602.403975959685;35173.472397914054;60353.39646603566;60450.69774651187;60557;60606.696966514886;14393.280335983369;15345.846541534665;15350.923245383925;15358.769618455732;15408.306626201847;10450.111740502143;10635.574577016987;12094.092943029133;12142.514299427923;12245.693857653452;18513.629727405376;19107;19131.33040343609;19154.61690766177;19211.519712007033;5956.404359564096;7142.392896603847;7277.599732014684;7329.5968721719755;7341.853162936818;955.1928620315961;1015.8780946286493;1035.9896401035894;1039.8180318444242;1117.0728295514702;31153.863424320625;31661;31674.524882126785;31910.680893190773;32284.515732264033;1094.1192340166242;1120.7982563138714;1123.5842738186923;1173.929564226149;1215.8419405477232;16026.358945642043;16880.662386752196;16954.491365259062;16994.915025424794;17043.829561704224;504074;509496;510128;510155;510838;54726.45273547293;55974.44025559692;55981.44018559844;56017.719911400185;56065.439345606836;1201.8377519034993;1247.8689737577606;1326.1247576599592;1358.9388477518535;1363.5227670315508;27428.862855685595;31959.36081278315;32155.839220803748;32213;32540.858107535474;47566;48245.5175448241;48253.5174648249;48327.275090872965;48383.27425088697;345188;347335;347399;347794;348360;23573.410664733517;23846.880765596063;27138.879028911928;28416.57375139333;28447.857760711064;45248;45445.77277113593;45729.31406028846;46125;46404.30393544032;37404.625953741204;37509;37940.81029594945;38708.6129138705;39944;39243.2151356977;39784.60215397809;39819.60180398159;40609;41256.381154282106;39611.405828912015;39692;40149;41001.00480406411;41106.588934110274;33145.17137071496;35858.4621230687;36370.27259454743;36858.63141368552;36939.26121477502;27416.86291568609;27664.170074897786;27702.44595108127;27780;27792.861035694692 20:30:54 INFO - PROCESS | 3410 | |2;jquery.html;382.88322061771146;399.6193152657568;406.7762730498225;416.1344403640428;428.1138044248407;13639.659008524792;15412.22938853057;19192.520186995316;20074.598508029867;20110.698339524883;17966.64066718665;18391.26434942604;18400.815991840078;18476.907615461936;19610.019499025064;4903.754812259391;5761.596688231836;5824.0390335594575;6015.819525414245;6023.18686977259;5806.738696758634;5921.319048309457;5934.554908381867;5962.79130230442;5964;5809.7676092956235;5834.474897259246;5862.912056319158;5932.080527518242;5952.077427998667;5851.531877449794;5899.1417703423285;5904.1734157218025;5906.822795316148;5907.970460147693;5096.159133742928;5189.896202075975;5223.033738758342;5238.633295669305;5296.947030529723;21111.894440527853;21791.564168716697;21884.12463501458;23048.53902921949;23362.065517379284;2278.794908458247;2675.4782817350624;2682.865856707157;2858.8713507891985;2902.158374071517;10334.224933130045;10471.790564188674;10520.316179448311;10761.730956726065;12237.20458170216;1890.6596812573732;1909.7517322748092;1922.826945574891;1937.6996565532365;1992.501874531367;74760.25239747642;81876.59061704713;82727;82729.58635206785;82756;10946.4526773661;10975.725606859893;10992.945035274772;11080.335179889233;11484.253523520945;15649.60875978087;15782.526524204291;15792.447264345692;15803.525894223192;15808.209589520478;7555.773326800205;7709.190534993857;7870.606469676493;7949.761507154794;7993.280604745601;7157.785266442015;7225.710971561184;7230.819229519199;7543.170251272356;7582.090149182023;4636.4899861015265;4795.976020119877;4856.8300109495995;4909.239067944474;4986.127427700138;1944.7082937559196;1985.5731017831235;2001.2495314257153;2040.642887494712;2042.3566576528347;960.5389413081759;977.9119879210905;997.9521502422573;1029.9794004120026;1035.0425856083093;18201.180946857425;18975.240990360508;19308.131134099;19423.611527769648;19942.70085948712;1006.9748256293651;1018.1244130048152;1027.8561001459802;1027.866377370952;1042.1923009667416;10208.846867296996;10762.40806755636;10763.19276054299;10764.246502744889;10832;442825;458460;461040;461339;491033;64770.35229647737;70744.64627676828;73523;93398.53300733452;98415;929.9860502092474;1022.6267412394571;1049.9790004199874;1063.186662203415;1070.1331921143899;16965.745513817055;17048.914755426144;17646.294148233927;18269.269229230682;18361.934710246263;28228.294292642848;29162.854185729786;32756.672433275362;34441.966740997814;40504;59693;59906;60053.69973150106;61185.69407152936;61297.693511532154;5732.426757324234;8561.35789815754;8614.655413783628;8647.654093836176;8818.206361427247;11751.647450576496;12489.750204996031;12599.370031498573;12609.49562017509;12747.235165890077;10647.201459890384;10837.67486975392;11143.83284250753;11416.143789216008;11697.883021169679;10472.581096756348;10689.144868410664;10941.45292735344;11343.205975581961;11400.828987565028;11354.26197297173;11466.598669046543;11468.885311146782;11532.82700759506;11854.822177667515;8401.453905496122;8499.1500849917;8630.611622477129;8690.478571285743;8987;8608.741737747878;9501.42991420517;10497.47512624381;11023.338599684044;11299.3785341807 20:30:54 INFO - PROCESS | 3410 | |3;mootools.html;1464.7802829575562;1485.0792508644638;1612.532365613972;1761.7005109131446;1780.866435017374;7508.9624551877305;7756.379489640829;8324.875126873101;9012.549372531372;9014.909850901497;8431.45195562288;8768.167024132714;8768.210861022506;9002.684906028291;9008.864867027;2030.46192758919;2041.1835265893687;2052.302217246136;2078.3453212238173;2086.6869969504546;1844.8247416495412;1893.6686079936026;2102.7897210278925;2115.6614941609346;2118.470382404399;2106.6734656128324;2199.3841724317217;2202.658587918875;2209.6464565669494;2217.22397160994;2160.438286045624;2161.9891900540474;2172.8261739060918;2180.367693368921;2186.5080356919566;2150.817180539656;2151.3330867431146;2157.0508976050487;2157.3851452336007;2160.5138843760187;8900.332475064331;8960.417572857808;9034.32242581809;9127.178553930178;9146.2682985361;5210.609204309692;5366.141417373202;5367.892642147174;5373;5373.489518495737;3416.5900091988874;3442.3287458945515;3521.8239088045752;3522.7886326820217;3532.964670353315;1126.6676330482528;1137.9772404551945;1141.7088642396136;1163.2438914705508;1176.7646470705893;12324.630261092092;12395.442205100791;12395.566155184526;12399.070069744716;12401.999999999909;4447.777611119496;4495.730256184639;4627.352170696038;4650.558196971282;4694;10306.536205870754;10334.276600638033;10336.0697537222;10340.121089707309;10342.638007669846;5308.893822123536;5314.946850531523;5315.335583052119;5316.521513063843;5323.095073837457;4757.833475828329;4842.709437433765;4874.951250487521;4894.902101957941;4896.902061958741;3830.578636349999;3832.6550610445192;3914.9608503915165;4080.6531444827524;4117.649999750055;1131.2364154195884;1173.5481839491856;1256.8428946381703;1260.1871792693844;1286.9420876060599;853.7737499562621;899.4917871402637;924.8705181274627;936.1714882329188;948.1466679988066;5851.941480585225;5915.467607915309;5961.582689211714;6022.126791615191;6352.078948552434;941.6280569175137;956.3496822160859;956.4404823178519;983.8179936711731;995.6017592962872;3915.804209789499;4020.1356708307853;4043.73715708478;4046;4072.531658859269;10827.729306767236;11137.109031277478;11191.440427978569;11192.160587955774;11214;11120.610778622871;11124.666260012213;11139.498722557504;11144.2199046066;11150.219484635998;7787.610619469004;8072.556009419538;8081.919180808234;8197.647388180883;8316.708915187939;5648.4633959773755;5760.971195143998;5860.941390586039;5886.676232807065;5911.881762364815;9932.106110450095;10159.492025398848;10162.03460671235;10170.644027459004;10190.235732320254;10062.89937100649;10102.39385636864;10265.897341026493;10364.378137311785;10368.274220804471;7798.064232292161;7939.880901786593;8047.51714897108;8048.919510805052;8049.154838741848;8480.74557763268;8483.278921291512;8553.358498112791;8553.401261911606;8554.358423118167;7681.116671582839;7737.226277372218;7755.146933837161;7759.3404560610725;7925.484843485155;7376.594287314249;7407.407407407502;7513.211112833293;7520.586367749826;7578.962105189439;6477.449416799436;6688.565243259172;6692.163479565054;6694.899576506259;6696.229933557704;4932.728699921395;4943.283223932438;4994.126027945168;5084.669496482865;5173.611979101658;5133.1273683473155;5169.405518365436;5180.946719179639;5302.814401495929;5305.549028332635 20:30:54 INFO - PROCESS | 3410 | |4;prototype.html;336.68351749355605;339.96141786841196;346.7295509502589;352.703728867751;354.10411658503995;5382.4886635769535;5407.134858422653;5421.837344879655;5425.965263026365;5450.345958484977;5210.348706411699;5268.604854635899;5284.233786101013;5332.786688532454;5347.438518955512;4002.519697636273;4180.728252663583;4236.533981262059;4250.82996680134;4261.169072030955;4188.895277618069;4203.7057405981595;4204.453421055258;4206.579342065799;4212.241796476633;4171.791410429481;4189.664826813848;4192.622663960243;4210.4947406311285;4223.51429585597;3994.8002599870038;4054.7161698681102;4098.467199264106;4150.730202536825;4184.51878034027;3697.5932647408763;3698.685611723007;3703.2038111805823;3707.480952666629;3712.461693054519;5236.136037553799;5237.79048838046;5241.973790131063;5256;5269.947300526984;4526.615237704799;4591.760224739335;4815.542523460265;4840.419149702058;4858.732769697665;5522.944770552283;5527.336719593634;5527.778888844441;5543.117578859011;5557.41647127054;4120.979395103035;4147.403249748838;4167.97916010418;4168.7290326128705;4193.580641935812;5524.364698059734;5765.538756899438;5780.277465316835;5781.797637082682;5790.7104644768015;4022.778747168934;4041.181468339259;4043.9283589848715;4047.615476529725;4048.554658987509;4109.815058322382;4121.91756164881;4134.3178375567695;4135.462389889295;4136.110736191733;4672.679171485434;4750.524947505291;4759.881002974953;4769.523047695272;4807.567318941242;5577.8844231153935;5591.182865568707;5591.608587398924;5591.776328946878;5606.579506536945;1468.2218424235173;1472.4625511688157;1485.532057401915;1487.115166475945;1497.7004599080228;913.5067063785614;953.3707752883064;957.4494665567327;971.9076687714655;991.9553620086969;5335.573154147736;5341.759620817073;5342.4089316681375;5362.70505122222;5367.329083864517;5622.128570071645;5626.521745651584;5662.886742265132;5686.5735069869925;5687.260656114679;5130.461301563282;5130.769115389817;5285.392179899284;5307.4692530746615;5326.627136100436;2893.537034074538;2931.8827246909887;3018.170003249124;3028.1521174071295;3030.8029978051354;5929.822105336847;5952.404759524013;5978.641281523122;5980.910286345708;5991.2510936132985;5628.577856660767;5744;5759.452851979056;5765.031009030353;5822.883542329129;5898.380670029585;5911.261092363455;5921.496672782861;5923.318818335861;5950.375210602911;5451.536619387396;5640.661560306395;5664.631798933056;5698.886022279614;5706.457886500776;5667.2632557768875;5676.403977582295;5680.573956953328;5696.869769417305;5701.087825947829;5982.4316689914385;5992.730327135377;6016;6099.481544068626;6101.328853826164;3889.9222015560094;4069.7354671946227;4075.2053349596545;4171.3325867860995;4178.7283826551175;5637.830865074055;5662;5721.824387464997;5731.656100633975;5739.2252045973255;5617.382087970402;5630.943690563042;5639.971800140973;5652.85867853307;5657.688827114548;5401.9196160767215;5506.752196151263;5518.558515318845;5526.309211348582;5544.805931792368;5455.18172274162;5458.61789674719;5474.151506516497;5475.863103422446;5476.616636835383;5478.369987451494;5533.723313834373;5607.579431542569;5610.214569960127;5632.9436705632415;5430.637672612426;5434.402215756343;5486.753096110605;5493.340799103973;5496.835094946998 20:30:54 INFO - PROCESS | 3410 | |5;yui.html;747.3386053342794;756.0779326583938;759.4721668440436;767.0526899279392;774.4963039922848;15758.290876910538;16456;17018.40435584755;17062.317507299726;17155.228014739336;14393.856061439408;14640.780388294184;14734.263286835641;14752.041117327393;14811.629709257273;804.7223707820792;814.4136221920238;819.4550623835142;819.942604017719;820.7537738678402;670.3932940688685;685.372883811312;787.3661702329622;813.7070654564352;817.726061769308;860.5439117267858;869.3088994249587;870.0646804684957;870.3602851903846;870.5299138465252;856.4861083350003;856.6273670953093;857.2070834478114;857.5026484638895;857.5069335132324;514.400723157521;519.8726312053533;594.0346936228628;630.1933525087895;630.3601844128214;15405.691886162325;15598.532044038697;16132.919335403365;16175.272112754954;16188.75716864248;13322.467101315935;13509.392077356542;13538.864611353858;13625.727485450334;13815.654608634764;12671.239725616493;12829.358532073453;12996.350182490838;13039;13264.668383290398;4522.095580883803;4540.614047805941;4619.422572178478;4628.861134165947;4784.473707892129;77696;77709.22290777076;80574.59712701399;83193;83530.58234708848;11405.543778248777;11457.770844583229;11660.650180494598;11747.882521174679;12037.518499259932;20862.374128776162;20968.79031209699;21197.682034769492;21212.045457954122;21218.78781212199;8224.177582241728;8354.540500272544;8620.224179823846;8728.127187281221;8759.2992560595;4396.824127034947;4591.494935557086;4594.724316541018;4632.60622847055;4844.224924012141;3339.248669049493;3408.403529382348;3437.604675462354;3437.6390478999847;3438.2435864109857;583.4748726146418;593.6022864680674;603.6649659439054;605.467188873797;621.5742216581656;560.5599604310596;587.4771453406472;592.7954855574819;596.8060380376309;608.4949491921694;8194.918050819535;9499.715008549754;9961.701148965543;10012.69961901144;10142.137918277029;590.400743245606;607.4654304212265;643.0900276109253;682.8702546516146;718.0808565036657;4172.895677608023;4558.361829343895;4614.984703365254;4636.907261854744;4640.489546149921;63580.36419635837;101217;104159;104540.47729761302;105667;94513.5274323624;94954.52522737342;95201.52399238099;97646.51176744213;99540;53424.732876336144;79592.6020369906;82779;82933.58533207295;84247.15752842516;8544.658213671384;8626.223639872442;8714.91285087141;8742.475451472932;8830.337724670548;48836.75581622069;49036;50155.346207253824;50225;50437;45163.54836451593;45429.77285113553;46156.53843461522;70545.29454705387;71949.92075118983;11893.583724569598;12212.450439730412;12491.375431228584;12983.610491685264;13601.659958501117;14662;14838.851611483748;14842.698582176472;14915.627109322353;15120.168390738176;13683.24742139192;14125.788113178105;14134.717305654034;15061.17163556015;15121.09273443597;11380.430978450879;13165.53920612774;13171.407286672315;13472.326383680973;13969.022168448111;13171.538996135088;13291.401886915306;14059.578212653636;14112.717745645235;14925.776113358526;11119;11285.322880627189;11482.32435151108;11506.30962142274;11644.767104658029;11052.11583073336;11725.355105469282;11794.823077653671;11926.701832453911;12037.699057523632 20:30:54 INFO - PROCESS | 3410 | __end_tp_report 20:30:54 INFO - PROCESS | 3410 | __start_cc_report 20:30:54 INFO - PROCESS | 3410 | _x_x_mozilla_cycle_collect,1173 20:30:54 INFO - PROCESS | 3410 | __end_cc_report 20:30:54 INFO - PROCESS | 3410 | __startTimestamp1475551854763__endTimestamp 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | ------- Summary: start ------- 20:30:54 INFO - PROCESS | 3410 | Number of tests: 6 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#0] dojo.html Cycles:165 Average:5064.91 Median:5234.37 stddev:555.88 (10.6%) stddev-sans-first:531.40 20:30:54 INFO - PROCESS | 3410 | Values: 2915.6 2963.0 2963.9 2974.2 3007.7 4977.9 5073.7 5078.9 5171.7 5188.7 5103.7 5109.2 5118.2 5169.1 5174.8 4580.2 4623.8 4635.8 4747.6 4778.5 4638.9 4675.6 4695.7 4723.8 4771.3 4724.8 4738.1 4751.5 4765.0 4838.4 4570.6 4605.5 4621.0 4625.0 4719.3 4672.8 4692.2 4695.9 4702.1 4759.6 5124.1 5156.7 5167.2 5168.0 5195.8 5234.4 5314.5 5316.5 5494.2 5510.4 5391.9 5395.1 5397.1 5473.9 5475.5 5007.7 5011.6 5012.8 5016.7 5071.3 5421.1 5450.7 5454.7 5458.6 5495.1 5268.6 5302.8 5305.7 5327.3 5392.4 5347.3 5347.3 5349.9 5352.6 5385.1 5105.8 5283.3 5345.2 5351.0 5399.2 5253.7 5296.0 5343.9 5353.7 5428.4 4235.8 4236.4 4276.7 4283.8 4286.5 3767.1 3775.2 3777.8 3822.2 3829.1 5020.6 5076.4 5092.9 5123.9 5141.7 5373.9 5401.2 5403.4 5425.0 5474.3 5139.2 5151.9 5153.9 5154.7 5164.9 4623.9 4652.4 4722.8 4729.2 4736.1 5659.2 5721.2 5724.1 5744.2 5810.0 5439.2 5482.9 5483.8 5486.3 5491.3 5574.9 5757.1 5757.4 5762.2 5773.6 5287.6 5350.8 5394.6 5400.8 5489.3 5497.8 5510.7 5532.9 5554.1 5561.9 5400.6 5452.3 5454.2 5457.4 5515.6 5189.8 5243.3 5263.9 5315.4 5336.1 5274.3 5282.0 5288.3 5289.2 5338.9 5362.1 5371.6 5376.1 5384.4 5448.3 4716.5 5071.8 5126.8 5146.1 5204.8 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#1] ext.html Cycles:180 Average:55942.61 Median:191766.74 stddev:106781.84 (55.7%) stddev-sans-first:107000.48 20:30:54 INFO - PROCESS | 3410 | Values: 577.7 603.1 607.7 620.1 634.7 31087.0 41778.0 42303.2 42345.8 42367.6 45420.3 45900.1 45990.5 46052.3 46122.8 7910.6 8781.2 8923.3 8935.7 8938.4 8096.0 10385.4 10606.9 10617.1 11010.1 10359.8 10370.3 10394.3 10399.3 10404.9 10432.5 10533.0 10533.5 10537.8 10540.7 10420.9 10490.0 10490.8 10490.9 10499.4 41020.0 41159.4 41193.4 41232.2 41235.8 3441.8 3748.8 4070.2 4094.7 4169.3 30732.2 31383.0 31646.4 32066.5 32708.5 4126.0 4126.6 4183.8 4185.6 4390.9 329731.0 330682.0 331006.0 331315.3 332468.0 58979.4 59397.8 59463.7 59597.0 59602.4 35173.5 60353.4 60450.7 60557.0 60606.7 14393.3 15345.8 15350.9 15358.8 15408.3 10450.1 10635.6 12094.1 12142.5 12245.7 18513.6 19107.0 19131.3 19154.6 19211.5 5956.4 7142.4 7277.6 7329.6 7341.9 955.2 1015.9 1036.0 1039.8 1117.1 31153.9 31661.0 31674.5 31910.7 32284.5 1094.1 1120.8 1123.6 1173.9 1215.8 16026.4 16880.7 16954.5 16994.9 17043.8 504074.0 509496.0 510128.0 510155.0 510838.0 54726.5 55974.4 55981.4 56017.7 56065.4 1201.8 1247.9 1326.1 1358.9 1363.5 27428.9 31959.4 32155.8 32213.0 32540.9 47566.0 48245.5 48253.5 48327.3 48383.3 345188.0 347335.0 347399.0 347794.0 348360.0 23573.4 23846.9 27138.9 28416.6 28447.9 45248.0 45445.8 45729.3 46125.0 46404.3 37404.6 37509.0 37940.8 38708.6 39944.0 39243.2 39784.6 39819.6 40609.0 41256.4 39611.4 39692.0 40149.0 41001.0 41106.6 33145.2 35858.5 36370.3 36858.6 36939.3 27416.9 27664.2 27702.4 27780.0 27792.9 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#2] jquery.html Cycles:180 Average:27581.00 Median:2679.17 stddev:76341.94 (2849.5%) stddev-sans-first:76528.78 20:30:54 INFO - PROCESS | 3410 | Values: 382.9 399.6 406.8 416.1 428.1 13639.7 15412.2 19192.5 20074.6 20110.7 17966.6 18391.3 18400.8 18476.9 19610.0 4903.8 5761.6 5824.0 6015.8 6023.2 5806.7 5921.3 5934.6 5962.8 5964.0 5809.8 5834.5 5862.9 5932.1 5952.1 5851.5 5899.1 5904.2 5906.8 5908.0 5096.2 5189.9 5223.0 5238.6 5296.9 21111.9 21791.6 21884.1 23048.5 23362.1 2278.8 2675.5 2682.9 2858.9 2902.2 10334.2 10471.8 10520.3 10761.7 12237.2 1890.7 1909.8 1922.8 1937.7 1992.5 74760.3 81876.6 82727.0 82729.6 82756.0 10946.5 10975.7 10992.9 11080.3 11484.3 15649.6 15782.5 15792.4 15803.5 15808.2 7555.8 7709.2 7870.6 7949.8 7993.3 7157.8 7225.7 7230.8 7543.2 7582.1 4636.5 4796.0 4856.8 4909.2 4986.1 1944.7 1985.6 2001.2 2040.6 2042.4 960.5 977.9 998.0 1030.0 1035.0 18201.2 18975.2 19308.1 19423.6 19942.7 1007.0 1018.1 1027.9 1027.9 1042.2 10208.8 10762.4 10763.2 10764.2 10832.0 442825.0 458460.0 461040.0 461339.0 491033.0 64770.4 70744.6 73523.0 93398.5 98415.0 930.0 1022.6 1050.0 1063.2 1070.1 16965.7 17048.9 17646.3 18269.3 18361.9 28228.3 29162.9 32756.7 34442.0 40504.0 59693.0 59906.0 60053.7 61185.7 61297.7 5732.4 8561.4 8614.7 8647.7 8818.2 11751.6 12489.8 12599.4 12609.5 12747.2 10647.2 10837.7 11143.8 11416.1 11697.9 10472.6 10689.1 10941.5 11343.2 11400.8 11354.3 11466.6 11468.9 11532.8 11854.8 8401.5 8499.2 8630.6 8690.5 8987.0 8608.7 9501.4 10497.5 11023.3 11299.4 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#3] mootools.html Cycles:180 Average:5779.35 Median:4858.83 stddev:3347.13 (68.9%) stddev-sans-first:3340.81 20:30:54 INFO - PROCESS | 3410 | Values: 1464.8 1485.1 1612.5 1761.7 1780.9 7509.0 7756.4 8324.9 9012.5 9014.9 8431.5 8768.2 8768.2 9002.7 9008.9 2030.5 2041.2 2052.3 2078.3 2086.7 1844.8 1893.7 2102.8 2115.7 2118.5 2106.7 2199.4 2202.7 2209.6 2217.2 2160.4 2162.0 2172.8 2180.4 2186.5 2150.8 2151.3 2157.1 2157.4 2160.5 8900.3 8960.4 9034.3 9127.2 9146.3 5210.6 5366.1 5367.9 5373.0 5373.5 3416.6 3442.3 3521.8 3522.8 3533.0 1126.7 1138.0 1141.7 1163.2 1176.8 12324.6 12395.4 12395.6 12399.1 12402.0 4447.8 4495.7 4627.4 4650.6 4694.0 10306.5 10334.3 10336.1 10340.1 10342.6 5308.9 5314.9 5315.3 5316.5 5323.1 4757.8 4842.7 4875.0 4894.9 4896.9 3830.6 3832.7 3915.0 4080.7 4117.6 1131.2 1173.5 1256.8 1260.2 1286.9 853.8 899.5 924.9 936.2 948.1 5851.9 5915.5 5961.6 6022.1 6352.1 941.6 956.3 956.4 983.8 995.6 3915.8 4020.1 4043.7 4046.0 4072.5 10827.7 11137.1 11191.4 11192.2 11214.0 11120.6 11124.7 11139.5 11144.2 11150.2 7787.6 8072.6 8081.9 8197.6 8316.7 5648.5 5761.0 5860.9 5886.7 5911.9 9932.1 10159.5 10162.0 10170.6 10190.2 10062.9 10102.4 10265.9 10364.4 10368.3 7798.1 7939.9 8047.5 8048.9 8049.2 8480.7 8483.3 8553.4 8553.4 8554.4 7681.1 7737.2 7755.1 7759.3 7925.5 7376.6 7407.4 7513.2 7520.6 7579.0 6477.4 6688.6 6692.2 6694.9 6696.2 4932.7 4943.3 4994.1 5084.7 5173.6 5133.1 5169.4 5180.9 5302.8 5305.5 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#4] prototype.html Cycles:180 Average:4706.26 Median:5392.20 stddev:1373.65 (25.5%) stddev-sans-first:1337.78 20:30:54 INFO - PROCESS | 3410 | Values: 336.7 340.0 346.7 352.7 354.1 5382.5 5407.1 5421.8 5426.0 5450.3 5210.3 5268.6 5284.2 5332.8 5347.4 4002.5 4180.7 4236.5 4250.8 4261.2 4188.9 4203.7 4204.5 4206.6 4212.2 4171.8 4189.7 4192.6 4210.5 4223.5 3994.8 4054.7 4098.5 4150.7 4184.5 3697.6 3698.7 3703.2 3707.5 3712.5 5236.1 5237.8 5242.0 5256.0 5269.9 4526.6 4591.8 4815.5 4840.4 4858.7 5522.9 5527.3 5527.8 5543.1 5557.4 4121.0 4147.4 4168.0 4168.7 4193.6 5524.4 5765.5 5780.3 5781.8 5790.7 4022.8 4041.2 4043.9 4047.6 4048.6 4109.8 4121.9 4134.3 4135.5 4136.1 4672.7 4750.5 4759.9 4769.5 4807.6 5577.9 5591.2 5591.6 5591.8 5606.6 1468.2 1472.5 1485.5 1487.1 1497.7 913.5 953.4 957.4 971.9 992.0 5335.6 5341.8 5342.4 5362.7 5367.3 5622.1 5626.5 5662.9 5686.6 5687.3 5130.5 5130.8 5285.4 5307.5 5326.6 2893.5 2931.9 3018.2 3028.2 3030.8 5929.8 5952.4 5978.6 5980.9 5991.3 5628.6 5744.0 5759.5 5765.0 5822.9 5898.4 5911.3 5921.5 5923.3 5950.4 5451.5 5640.7 5664.6 5698.9 5706.5 5667.3 5676.4 5680.6 5696.9 5701.1 5982.4 5992.7 6016.0 6099.5 6101.3 3889.9 4069.7 4075.2 4171.3 4178.7 5637.8 5662.0 5721.8 5731.7 5739.2 5617.4 5630.9 5640.0 5652.9 5657.7 5401.9 5506.8 5518.6 5526.3 5544.8 5455.2 5458.6 5474.2 5475.9 5476.6 5478.4 5533.7 5607.6 5610.2 5632.9 5430.6 5434.4 5486.8 5493.3 5496.8 20:30:54 INFO - PROCESS | 3410 | 20:30:54 INFO - PROCESS | 3410 | [#5] yui.html Cycles:180 Average:19552.49 Median:25385.76 stddev:27178.46 (107.1%) stddev-sans-first:27218.03 20:30:54 INFO - PROCESS | 3410 | Values: 747.3 756.1 759.5 767.1 774.5 15758.3 16456.0 17018.4 17062.3 17155.2 14393.9 14640.8 14734.3 14752.0 14811.6 804.7 814.4 819.5 819.9 820.8 670.4 685.4 787.4 813.7 817.7 860.5 869.3 870.1 870.4 870.5 856.5 856.6 857.2 857.5 857.5 514.4 519.9 594.0 630.2 630.4 15405.7 15598.5 16132.9 16175.3 16188.8 13322.5 13509.4 13538.9 13625.7 13815.7 12671.2 12829.4 12996.4 13039.0 13264.7 4522.1 4540.6 4619.4 4628.9 4784.5 77696.0 77709.2 80574.6 83193.0 83530.6 11405.5 11457.8 11660.7 11747.9 12037.5 20862.4 20968.8 21197.7 21212.0 21218.8 8224.2 8354.5 8620.2 8728.1 8759.3 4396.8 4591.5 4594.7 4632.6 4844.2 3339.2 3408.4 3437.6 3437.6 3438.2 583.5 593.6 603.7 605.5 621.6 560.6 587.5 592.8 596.8 608.5 8194.9 9499.7 9961.7 10012.7 10142.1 590.4 607.5 643.1 682.9 718.1 4172.9 4558.4 4615.0 4636.9 4640.5 63580.4 101217.0 104159.0 104540.5 105667.0 94513.5 94954.5 95201.5 97646.5 99540.0 53424.7 79592.6 82779.0 82933.6 84247.2 8544.7 8626.2 8714.9 8742.5 8830.3 48836.8 49036.0 50155.3 50225.0 50437.0 45163.5 45429.8 46156.5 70545.3 71949.9 11893.6 12212.5 12491.4 12983.6 13601.7 14662.0 14838.9 14842.7 14915.6 15120.2 13683.2 14125.8 14134.7 15061.2 15121.1 11380.4 13165.5 13171.4 13472.3 13969.0 13171.5 13291.4 14059.6 14112.7 14925.8 11119.0 11285.3 11482.3 11506.3 11644.8 11052.1 11725.4 11794.8 11926.7 12037.7 20:30:54 INFO - PROCESS | 3410 | -------- Summary: end -------- 20:30:54 INFO - PROCESS | 3410 | 20:30:55 INFO - TEST-INFO | 3410: exit 0 20:30:55 INFO - TEST-OK | dromaeo_css | took 1118641ms 20:30:55 INFO - TEST-START | kraken 20:30:55 INFO - operating with platform_type : linux_ 20:30:55 INFO - Initialising browser for kraken test... 20:30:55 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhqJk_/profile http://localhost:33285/getInfo.html) 20:30:59 INFO - PROCESS | 3719 | __metrics Screen width/height:1600/1200 20:30:59 INFO - PROCESS | 3719 | colorDepth:24 20:30:59 INFO - PROCESS | 3719 | Browser inner width/height: 1024/697 20:30:59 INFO - PROCESS | 3719 | __metrics 20:31:00 INFO - PROCESS | 3719 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:31:00 INFO - PROCESS | 3719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:31:00 INFO - PROCESS | 3719 | console.error: PushService: 20:31:00 INFO - PROCESS | 3719 | stateChangeProcessEnqueue: Error transitioning state 20:31:00 INFO - PROCESS | 3719 | UnknownError 20:31:01 INFO - TEST-INFO | 3719: exit 0 20:31:01 INFO - Browser initialized. 20:31:01 INFO - Running cycle 1/1 for kraken test... 20:31:01 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhqJk_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:13 INFO - PROCESS | 3800 | RSS: Main: 173957120 20:31:13 INFO - PROCESS | 3800 | 20:31:16 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33285/tests/kraken/driver.html?testName=audio-beat-detection) 20:31:17 INFO - PROCESS | 3800 | RSS: Main: 232951808 20:31:17 INFO - PROCESS | 3800 | 20:31:19 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33285/tests/kraken/driver.html?testName=audio-dft) 20:31:20 INFO - PROCESS | 3800 | RSS: Main: 218705920 20:31:20 INFO - PROCESS | 3800 | 20:31:23 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33285/tests/kraken/driver.html?testName=audio-fft) 20:31:24 INFO - PROCESS | 3800 | RSS: Main: 300240896 20:31:24 INFO - PROCESS | 3800 | 20:31:26 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33285/tests/kraken/driver.html?testName=audio-oscillator) 20:31:26 INFO - PROCESS | 3800 | RSS: Main: 208015360 20:31:26 INFO - PROCESS | 3800 | 20:31:28 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:29 INFO - PROCESS | 3800 | RSS: Main: 213561344 20:31:29 INFO - PROCESS | 3800 | 20:31:32 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33285/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:33 INFO - PROCESS | 3800 | RSS: Main: 250208256 20:31:33 INFO - PROCESS | 3800 | 20:31:36 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33285/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:37 INFO - PROCESS | 3800 | RSS: Main: 248365056 20:31:37 INFO - PROCESS | 3800 | 20:31:40 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33285/tests/kraken/driver.html?testName=json-parse-financial) 20:31:40 INFO - PROCESS | 3800 | RSS: Main: 248598528 20:31:40 INFO - PROCESS | 3800 | 20:31:42 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:42 INFO - PROCESS | 3800 | RSS: Main: 210386944 20:31:42 INFO - PROCESS | 3800 | 20:31:44 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:45 INFO - PROCESS | 3800 | RSS: Main: 218529792 20:31:45 INFO - PROCESS | 3800 | 20:31:47 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:47 INFO - PROCESS | 3800 | RSS: Main: 227459072 20:31:47 INFO - PROCESS | 3800 | 20:31:50 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:51 INFO - PROCESS | 3800 | RSS: Main: 236306432 20:31:51 INFO - PROCESS | 3800 | 20:31:53 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:54 INFO - PROCESS | 3800 | RSS: Main: 233271296 20:31:54 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:33285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33285/tests/kraken/driver.html?testName=ai-astar) 20:31:56 INFO - PROCESS | 3800 | RSS: Main: 283910144 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | __start_tp_report 20:31:56 INFO - PROCESS | 3800 | _x_x_mozilla_page_load 20:31:56 INFO - PROCESS | 3800 | _x_x_mozilla_page_load_details 20:31:56 INFO - PROCESS | 3800 | |i|pagename|runs| 20:31:56 INFO - PROCESS | 3800 | |0;ai-astar;109;111;113;110;111;109;112;110;110;109 20:31:56 INFO - PROCESS | 3800 | |1;audio-beat-detection;145;121;123;177;122;123;121;123;155;127 20:31:56 INFO - PROCESS | 3800 | |2;audio-dft;160;159;160;162;159;163;160;162;161;163 20:31:56 INFO - PROCESS | 3800 | |3;audio-fft;76;75;76;111;76;75;75;76;102;75 20:31:56 INFO - PROCESS | 3800 | |4;audio-oscillator;83;83;115;83;83;83;100;81;81;122 20:31:56 INFO - PROCESS | 3800 | |5;imaging-gaussian-blur;116;117;117;116;118;117;116;116;116;117 20:31:56 INFO - PROCESS | 3800 | |6;imaging-darkroom;145;146;147;146;146;147;147;147;147;147 20:31:56 INFO - PROCESS | 3800 | |7;imaging-desaturate;95;94;94;95;94;95;95;95;95;95 20:31:56 INFO - PROCESS | 3800 | |8;json-parse-financial;54;53;52;52;53;54;54;55;53;53 20:31:56 INFO - PROCESS | 3800 | |9;json-stringify-tinderbox;61;61;61;62;62;60;61;61;61;61 20:31:56 INFO - PROCESS | 3800 | |10;stanford-crypto-aes;80;80;80;80;79;79;79;79;79;79 20:31:56 INFO - PROCESS | 3800 | |11;stanford-crypto-ccm;133;129;131;132;131;135;138;133;169;130 20:31:56 INFO - PROCESS | 3800 | |12;stanford-crypto-pbkdf2;172;173;167;169;169;169;171;169;175;168 20:31:56 INFO - PROCESS | 3800 | |13;stanford-crypto-sha256-iterative;66;69;68;69;67;69;68;67;74;65 20:31:56 INFO - PROCESS | 3800 | __end_tp_report 20:31:56 INFO - PROCESS | 3800 | __start_cc_report 20:31:56 INFO - PROCESS | 3800 | _x_x_mozilla_cycle_collect,1615 20:31:56 INFO - PROCESS | 3800 | __end_cc_report 20:31:56 INFO - PROCESS | 3800 | __startTimestamp1475551916408__endTimestamp 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | ------- Summary: start ------- 20:31:56 INFO - PROCESS | 3800 | Number of tests: 14 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.35 (1.2%) stddev-sans-first:1.33 20:31:56 INFO - PROCESS | 3800 | Values: 109.0 111.0 113.0 110.0 111.0 109.0 112.0 110.0 110.0 109.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:125.00 stddev:19.16 (15.3%) stddev-sans-first:19.88 20:31:56 INFO - PROCESS | 3800 | Values: 145.0 121.0 123.0 177.0 122.0 123.0 121.0 123.0 155.0 127.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.52 (0.9%) stddev-sans-first:1.58 20:31:56 INFO - PROCESS | 3800 | Values: 160.0 159.0 160.0 162.0 159.0 163.0 160.0 162.0 161.0 163.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.25 (17.5%) stddev-sans-first:13.89 20:31:56 INFO - PROCESS | 3800 | Values: 76.0 75.0 76.0 111.0 76.0 75.0 75.0 76.0 102.0 75.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.00 stddev:15.41 (18.6%) stddev-sans-first:16.04 20:31:56 INFO - PROCESS | 3800 | Values: 83.0 83.0 115.0 83.0 83.0 83.0 100.0 81.0 81.0 122.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:31:56 INFO - PROCESS | 3800 | Values: 116.0 117.0 117.0 116.0 118.0 117.0 116.0 116.0 116.0 117.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.50 20:31:56 INFO - PROCESS | 3800 | Values: 145.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:31:56 INFO - PROCESS | 3800 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:0.97 20:31:56 INFO - PROCESS | 3800 | Values: 54.0 53.0 52.0 52.0 53.0 54.0 54.0 55.0 53.0 53.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 20:31:56 INFO - PROCESS | 3800 | Values: 61.0 61.0 61.0 62.0 62.0 60.0 61.0 61.0 61.0 61.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 20:31:56 INFO - PROCESS | 3800 | Values: 80.0 80.0 80.0 80.0 79.0 79.0 79.0 79.0 79.0 79.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:133.00 stddev:11.85 (8.9%) stddev-sans-first:12.51 20:31:56 INFO - PROCESS | 3800 | Values: 133.0 129.0 131.0 132.0 131.0 135.0 138.0 133.0 169.0 130.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.00 stddev:2.49 (1.5%) stddev-sans-first:2.55 20:31:56 INFO - PROCESS | 3800 | Values: 172.0 173.0 167.0 169.0 169.0 169.0 171.0 169.0 175.0 168.0 20:31:56 INFO - PROCESS | 3800 | 20:31:56 INFO - PROCESS | 3800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:2.44 (3.6%) stddev-sans-first:2.46 20:31:56 INFO - PROCESS | 3800 | Values: 66.0 69.0 68.0 69.0 67.0 69.0 68.0 67.0 74.0 65.0 20:31:56 INFO - PROCESS | 3800 | -------- Summary: end -------- 20:31:56 INFO - PROCESS | 3800 | 20:31:57 INFO - TEST-INFO | 3800: exit 0 20:31:57 INFO - TEST-OK | kraken | took 61947ms 20:31:57 INFO - SUITE-END | took 1180s 20:31:58 INFO - Completed test suite (00:19:41) 20:31:58 INFO - javascript benchmark 20:31:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.5772413000113, 2963.0222026731194, 2963.9407211855764, 2974.2118338640253, 3007.6841931597182, 4977.925331120036, 5073.7209453480045, 5078.873028174293, 5171.741412929353, 5188.6886786792775, 5103.719295438749, 5109.233614957759, 5118.232265160228, 5169.1470907300345, 5174.844754657357, 4580.1984652685815, 4623.768811559426, 4635.837745678902, 4747.59645430138, 4778.498257682945, 4638.930416043762, 4675.649326300524, 4695.741734204617, 4723.763811809413, 4771.33201351811, 4724.763761811912, 4738.147133515966, 4751.5010923853015, 4764.97617511912, 4838.419389673244, 4570.611498022672, 4605.4933957264675, 4620.976895115503, 4624.9768751156025, 4719.339292499053, 4672.789724462407, 4692.202325604621, 4695.859124226278, 4702.106599746037, 4759.643026772971, 5124.103281925648, 5156.664816786897, 5167.224916262553, 5167.974160129175, 5195.844124676266, 5234.371875374942, 5314.548263397616, 5316.494932981361, 5494.203340515603, 5510.366307874566, 5391.919121213185, 5395.136778115482, 5397.109476936301, 5473.917891231635, 5475.534579560742, 5007.699538027694, 5011.599072074226, 5012.849614511534, 5016.749162541858, 5071.264666623393, 5421.105517589633, 5450.700211488406, 5454.672719636835, 5458.645188062763, 5495.065838807413, 5268.631195816256, 5302.840914772563, 5305.65513241638, 5327.307450031549, 5392.40683524812, 5347.2781174541715, 5347.2781174541715, 5349.946500534945, 5352.6253162279045, 5385.084535628953, 5105.846824595268, 5283.260343551906, 5345.1714984177515, 5351.0, 5399.163129714901, 5253.737313134328, 5296.0, 5343.893122137535, 5353.732313384316, 5428.375736790241, 4235.78821058952, 4236.449261596034, 4276.700630955866, 4283.828646854091, 4286.54991225923, 3767.0770661188185, 3775.1505911170316, 3777.8488860445273, 3822.1782316802023, 3829.0810205551024, 5020.648554601143, 5076.36545431821, 5092.898142037138, 5123.897522049539, 5141.665791723526, 5373.946260537345, 5401.243825864303, 5403.35159780821, 5424.972875135678, 5474.2609747683555, 5139.203423469368, 5151.922721159186, 5153.948460515347, 5154.690718556899, 5164.92252616211, 4623.86128416148, 4652.418447694038, 4722.763861806965, 4729.219678753036, 4736.052789442126, 5659.236003139606, 5721.199032135588, 5724.1413787931315, 5744.224529688438, 5810.041343178328, 5439.238506608999, 5482.862928426821, 5483.835484935458, 5486.341639003345, 5491.341039075336, 5574.86062848432, 5757.0788673811985, 5757.366689664217, 5762.164486149569, 5773.624714393551, 5287.629865909349, 5350.759215835219, 5394.595405344537, 5400.83797486076, 5489.258950041693, 5497.835064948058, 5510.6969116698965, 5532.889342213214, 5554.1391084381985, 5561.916571251515, 5400.594955378284, 5452.318460192476, 5454.154606036071, 5457.372402173801, 5515.641483303572, 5189.792408303626, 5243.318368612056, 5263.868403289948, 5315.388730295911, 5336.066188416934, 5274.287971123849, 5282.022825777243, 5288.259643649969, 5289.2330612061805, 5338.946610533845, 5362.0616392132, 5371.570274377962, 5376.112941364631, 5384.353877534721, 5448.318960129984, 4716.457607375196, 5071.822486213113, 5126.7949282029795, 5146.125158722951, 5204.765785539736], "value": 5028.746383724132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6967092276554, 603.0833133636871, 607.6748939317466, 620.091565856021, 634.7334119669738, 31087.0, 41778.0, 42303.15393692124, 42345.78827105868, 42367.57632423675, 45420.31869521952, 45900.081998360016, 45990.54009459904, 46052.3092153618, 46122.76938615302, 7910.564918929485, 8781.165789250012, 8923.286137109015, 8935.731928042169, 8938.419002764833, 8096.0, 10385.376877387343, 10606.946965265162, 10617.0975467085, 11010.119190464784, 10359.792804143912, 10370.32592881464, 10394.324368916034, 10399.272050956437, 10404.855465898745, 10432.478376081204, 10533.0, 10533.52599133037, 10537.84193237102, 10540.683779486628, 10420.895791042069, 10490.0, 10490.790184196274, 10490.895091049068, 10499.370037797757, 41020.0, 41159.38260926089, 41193.382099268536, 41232.175356493004, 41235.793821031, 3441.8451169697423, 3748.8313025913626, 4070.206309769596, 4094.651954583864, 4169.332906734908, 30732.2316942076, 31383.0, 31646.36707265865, 32066.519002214984, 32708.509372359433, 4126.0, 4126.5667104953845, 4183.811728472226, 4185.560516145792, 4390.912181756347, 329731.0, 330681.9999999976, 331006.0, 331315.3434232838, 332468.0, 58979.41020589825, 59397.81204375888, 59463.70268148718, 59597.0, 59602.403975959685, 35173.472397914054, 60353.39646603566, 60450.69774651187, 60557.0, 60606.696966514886, 14393.280335983369, 15345.846541534665, 15350.923245383925, 15358.769618455732, 15408.306626201847, 10450.111740502143, 10635.574577016987, 12094.092943029133, 12142.514299427923, 12245.693857653452, 18513.629727405376, 19107.0, 19131.33040343609, 19154.61690766177, 19211.519712007033, 5956.404359564096, 7142.392896603847, 7277.599732014684, 7329.5968721719755, 7341.853162936818, 955.1928620315961, 1015.8780946286493, 1035.9896401035894, 1039.8180318444242, 1117.0728295514702, 31153.863424320625, 31661.0, 31674.524882126785, 31910.680893190773, 32284.515732264033, 1094.1192340166242, 1120.7982563138714, 1123.5842738186923, 1173.929564226149, 1215.8419405477232, 16026.358945642043, 16880.662386752196, 16954.491365259062, 16994.915025424794, 17043.829561704224, 504074.0, 509496.0, 510128.0, 510155.0, 510838.0, 54726.45273547293, 55974.44025559692, 55981.44018559844, 56017.719911400185, 56065.439345606836, 1201.8377519034993, 1247.8689737577606, 1326.1247576599592, 1358.9388477518535, 1363.5227670315508, 27428.862855685595, 31959.36081278315, 32155.839220803748, 32213.0, 32540.858107535474, 47566.0, 48245.5175448241, 48253.5174648249, 48327.275090872965, 48383.27425088697, 345188.0, 347335.0, 347399.0, 347794.0, 348360.0, 23573.410664733517, 23846.880765596063, 27138.879028911928, 28416.57375139333, 28447.857760711064, 45248.0, 45445.77277113593, 45729.31406028846, 46125.0, 46404.30393544032, 37404.625953741204, 37509.0, 37940.81029594945, 38708.6129138705, 39944.0, 39243.2151356977, 39784.60215397809, 39819.60180398159, 40609.0, 41256.381154282106, 39611.405828912015, 39692.0, 40149.0, 41001.00480406411, 41106.588934110274, 33145.17137071496, 35858.4621230687, 36370.27259454743, 36858.63141368552, 36939.26121477502, 27416.86291568609, 27664.170074897786, 27702.44595108127, 27780.0, 27792.861035694692], "value": 19879.97944157411, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.88322061771146, 399.6193152657568, 406.7762730498225, 416.1344403640428, 428.1138044248407, 13639.659008524792, 15412.22938853057, 19192.520186995316, 20074.598508029867, 20110.698339524883, 17966.64066718665, 18391.26434942604, 18400.815991840078, 18476.907615461936, 19610.019499025064, 4903.754812259391, 5761.596688231836, 5824.0390335594575, 6015.819525414245, 6023.18686977259, 5806.738696758634, 5921.319048309457, 5934.554908381867, 5962.79130230442, 5964.0, 5809.7676092956235, 5834.474897259246, 5862.912056319158, 5932.080527518242, 5952.077427998667, 5851.531877449794, 5899.1417703423285, 5904.1734157218025, 5906.822795316148, 5907.970460147693, 5096.159133742928, 5189.896202075975, 5223.033738758342, 5238.633295669305, 5296.947030529723, 21111.894440527853, 21791.564168716697, 21884.12463501458, 23048.53902921949, 23362.065517379284, 2278.794908458247, 2675.4782817350624, 2682.865856707157, 2858.8713507891985, 2902.158374071517, 10334.224933130045, 10471.790564188674, 10520.316179448311, 10761.730956726065, 12237.20458170216, 1890.6596812573732, 1909.7517322748092, 1922.826945574891, 1937.6996565532365, 1992.501874531367, 74760.25239747642, 81876.59061704713, 82727.0, 82729.58635206785, 82756.0, 10946.4526773661, 10975.725606859893, 10992.945035274772, 11080.335179889233, 11484.253523520945, 15649.60875978087, 15782.526524204291, 15792.447264345692, 15803.525894223192, 15808.209589520478, 7555.773326800205, 7709.190534993857, 7870.606469676493, 7949.761507154794, 7993.280604745601, 7157.785266442015, 7225.710971561184, 7230.819229519199, 7543.170251272356, 7582.090149182023, 4636.4899861015265, 4795.976020119877, 4856.8300109495995, 4909.239067944474, 4986.127427700138, 1944.7082937559196, 1985.5731017831235, 2001.2495314257153, 2040.642887494712, 2042.3566576528347, 960.5389413081759, 977.9119879210905, 997.9521502422573, 1029.9794004120026, 1035.0425856083093, 18201.180946857425, 18975.240990360508, 19308.131134099, 19423.611527769648, 19942.70085948712, 1006.9748256293651, 1018.1244130048152, 1027.8561001459802, 1027.866377370952, 1042.1923009667416, 10208.846867296996, 10762.40806755636, 10763.19276054299, 10764.246502744889, 10832.0, 442825.0, 458460.0, 461040.0, 461339.0, 491033.0, 64770.35229647737, 70744.64627676828, 73523.0, 93398.53300733452, 98415.0, 929.9860502092474, 1022.6267412394571, 1049.9790004199874, 1063.186662203415, 1070.1331921143899, 16965.745513817055, 17048.914755426144, 17646.294148233927, 18269.269229230682, 18361.934710246263, 28228.294292642848, 29162.854185729786, 32756.672433275362, 34441.966740997814, 40504.0, 59693.0, 59906.0, 60053.69973150106, 61185.69407152936, 61297.693511532154, 5732.426757324234, 8561.35789815754, 8614.655413783628, 8647.654093836176, 8818.206361427247, 11751.647450576496, 12489.750204996031, 12599.370031498573, 12609.49562017509, 12747.235165890077, 10647.201459890384, 10837.67486975392, 11143.83284250753, 11416.143789216008, 11697.883021169679, 10472.581096756348, 10689.144868410664, 10941.45292735344, 11343.205975581961, 11400.828987565028, 11354.26197297173, 11466.598669046543, 11468.885311146782, 11532.82700759506, 11854.822177667515, 8401.453905496122, 8499.1500849917, 8630.611622477129, 8690.478571285743, 8987.0, 8608.741737747878, 9501.42991420517, 10497.47512624381, 11023.338599684044, 11299.3785341807], "value": 9057.30260645147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.7802829575562, 1485.0792508644638, 1612.532365613972, 1761.7005109131446, 1780.866435017374, 7508.9624551877305, 7756.379489640829, 8324.875126873101, 9012.549372531372, 9014.909850901497, 8431.45195562288, 8768.167024132714, 8768.210861022506, 9002.684906028291, 9008.864867027, 2030.46192758919, 2041.1835265893687, 2052.302217246136, 2078.3453212238173, 2086.6869969504546, 1844.8247416495412, 1893.6686079936026, 2102.7897210278925, 2115.6614941609346, 2118.470382404399, 2106.6734656128324, 2199.3841724317217, 2202.658587918875, 2209.6464565669494, 2217.22397160994, 2160.438286045624, 2161.9891900540474, 2172.8261739060918, 2180.367693368921, 2186.5080356919566, 2150.817180539656, 2151.3330867431146, 2157.0508976050487, 2157.3851452336007, 2160.5138843760187, 8900.332475064331, 8960.417572857808, 9034.32242581809, 9127.178553930178, 9146.2682985361, 5210.609204309692, 5366.141417373202, 5367.892642147174, 5373.0, 5373.489518495737, 3416.5900091988874, 3442.3287458945515, 3521.8239088045752, 3522.7886326820217, 3532.964670353315, 1126.6676330482528, 1137.9772404551945, 1141.7088642396136, 1163.2438914705508, 1176.7646470705893, 12324.630261092092, 12395.442205100791, 12395.566155184526, 12399.070069744716, 12401.999999999909, 4447.777611119496, 4495.730256184639, 4627.352170696038, 4650.558196971282, 4694.0, 10306.536205870754, 10334.276600638033, 10336.0697537222, 10340.121089707309, 10342.638007669846, 5308.893822123536, 5314.946850531523, 5315.335583052119, 5316.521513063843, 5323.095073837457, 4757.833475828329, 4842.709437433765, 4874.951250487521, 4894.902101957941, 4896.902061958741, 3830.578636349999, 3832.6550610445192, 3914.9608503915165, 4080.6531444827524, 4117.649999750055, 1131.2364154195884, 1173.5481839491856, 1256.8428946381703, 1260.1871792693844, 1286.9420876060599, 853.7737499562621, 899.4917871402637, 924.8705181274627, 936.1714882329188, 948.1466679988066, 5851.941480585225, 5915.467607915309, 5961.582689211714, 6022.126791615191, 6352.078948552434, 941.6280569175137, 956.3496822160859, 956.4404823178519, 983.8179936711731, 995.6017592962872, 3915.804209789499, 4020.1356708307853, 4043.73715708478, 4046.0, 4072.531658859269, 10827.729306767236, 11137.109031277478, 11191.440427978569, 11192.160587955774, 11214.0, 11120.610778622871, 11124.666260012213, 11139.498722557504, 11144.2199046066, 11150.219484635998, 7787.610619469004, 8072.556009419538, 8081.919180808234, 8197.647388180883, 8316.708915187939, 5648.4633959773755, 5760.971195143998, 5860.941390586039, 5886.676232807065, 5911.881762364815, 9932.106110450095, 10159.492025398848, 10162.03460671235, 10170.644027459004, 10190.235732320254, 10062.89937100649, 10102.39385636864, 10265.897341026493, 10364.378137311785, 10368.274220804471, 7798.064232292161, 7939.880901786593, 8047.51714897108, 8048.919510805052, 8049.154838741848, 8480.74557763268, 8483.278921291512, 8553.358498112791, 8553.401261911606, 8554.358423118167, 7681.116671582839, 7737.226277372218, 7755.146933837161, 7759.3404560610725, 7925.484843485155, 7376.594287314249, 7407.407407407502, 7513.211112833293, 7520.586367749826, 7578.962105189439, 6477.449416799436, 6688.565243259172, 6692.163479565054, 6694.899576506259, 6696.229933557704, 4932.728699921395, 4943.283223932438, 4994.126027945168, 5084.669496482865, 5173.611979101658, 5133.1273683473155, 5169.405518365436, 5180.946719179639, 5302.814401495929, 5305.549028332635], "value": 4583.162214782059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.68351749355605, 339.96141786841196, 346.7295509502589, 352.703728867751, 354.10411658503995, 5382.4886635769535, 5407.134858422653, 5421.837344879655, 5425.965263026365, 5450.345958484977, 5210.348706411699, 5268.604854635899, 5284.233786101013, 5332.786688532454, 5347.438518955512, 4002.519697636273, 4180.728252663583, 4236.533981262059, 4250.82996680134, 4261.169072030955, 4188.895277618069, 4203.7057405981595, 4204.453421055258, 4206.579342065799, 4212.241796476633, 4171.791410429481, 4189.664826813848, 4192.622663960243, 4210.4947406311285, 4223.51429585597, 3994.8002599870038, 4054.7161698681102, 4098.467199264106, 4150.730202536825, 4184.51878034027, 3697.5932647408763, 3698.685611723007, 3703.2038111805823, 3707.480952666629, 3712.461693054519, 5236.136037553799, 5237.79048838046, 5241.973790131063, 5256.0, 5269.947300526984, 4526.615237704799, 4591.760224739335, 4815.542523460265, 4840.419149702058, 4858.732769697665, 5522.944770552283, 5527.336719593634, 5527.778888844441, 5543.117578859011, 5557.41647127054, 4120.979395103035, 4147.403249748838, 4167.97916010418, 4168.7290326128705, 4193.580641935812, 5524.364698059734, 5765.538756899438, 5780.277465316835, 5781.797637082682, 5790.7104644768015, 4022.778747168934, 4041.181468339259, 4043.9283589848715, 4047.615476529725, 4048.554658987509, 4109.815058322382, 4121.91756164881, 4134.3178375567695, 4135.462389889295, 4136.110736191733, 4672.679171485434, 4750.524947505291, 4759.881002974953, 4769.523047695272, 4807.567318941242, 5577.8844231153935, 5591.182865568707, 5591.608587398924, 5591.776328946878, 5606.579506536945, 1468.2218424235173, 1472.4625511688157, 1485.532057401915, 1487.115166475945, 1497.7004599080228, 913.5067063785614, 953.3707752883064, 957.4494665567327, 971.9076687714655, 991.9553620086969, 5335.573154147736, 5341.759620817073, 5342.4089316681375, 5362.70505122222, 5367.329083864517, 5622.128570071645, 5626.521745651584, 5662.886742265132, 5686.5735069869925, 5687.260656114679, 5130.461301563282, 5130.769115389817, 5285.392179899284, 5307.4692530746615, 5326.627136100436, 2893.537034074538, 2931.8827246909887, 3018.170003249124, 3028.1521174071295, 3030.8029978051354, 5929.822105336847, 5952.404759524013, 5978.641281523122, 5980.910286345708, 5991.2510936132985, 5628.577856660767, 5744.0, 5759.452851979056, 5765.031009030353, 5822.883542329129, 5898.380670029585, 5911.261092363455, 5921.496672782861, 5923.318818335861, 5950.375210602911, 5451.536619387396, 5640.661560306395, 5664.631798933056, 5698.886022279614, 5706.457886500776, 5667.2632557768875, 5676.403977582295, 5680.573956953328, 5696.869769417305, 5701.087825947829, 5982.4316689914385, 5992.730327135377, 6016.0, 6099.481544068626, 6101.328853826164, 3889.9222015560094, 4069.7354671946227, 4075.2053349596545, 4171.3325867860995, 4178.7283826551175, 5637.830865074055, 5662.0, 5721.824387464997, 5731.656100633975, 5739.2252045973255, 5617.382087970402, 5630.943690563042, 5639.971800140973, 5652.85867853307, 5657.688827114548, 5401.9196160767215, 5506.752196151263, 5518.558515318845, 5526.309211348582, 5544.805931792368, 5455.18172274162, 5458.61789674719, 5474.151506516497, 5475.863103422446, 5476.616636835383, 5478.369987451494, 5533.723313834373, 5607.579431542569, 5610.214569960127, 5632.9436705632415, 5430.637672612426, 5434.402215756343, 5486.753096110605, 5493.340799103973, 5496.835094946998], "value": 4273.421401992965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3386053342794, 756.0779326583938, 759.4721668440436, 767.0526899279392, 774.4963039922848, 15758.290876910538, 16456.0, 17018.40435584755, 17062.317507299726, 17155.228014739336, 14393.856061439408, 14640.780388294184, 14734.263286835641, 14752.041117327393, 14811.629709257273, 804.7223707820792, 814.4136221920238, 819.4550623835142, 819.942604017719, 820.7537738678402, 670.3932940688685, 685.372883811312, 787.3661702329622, 813.7070654564352, 817.726061769308, 860.5439117267858, 869.3088994249587, 870.0646804684957, 870.3602851903846, 870.5299138465252, 856.4861083350003, 856.6273670953093, 857.2070834478114, 857.5026484638895, 857.5069335132324, 514.400723157521, 519.8726312053533, 594.0346936228628, 630.1933525087895, 630.3601844128214, 15405.691886162325, 15598.532044038697, 16132.919335403365, 16175.272112754954, 16188.75716864248, 13322.467101315935, 13509.392077356542, 13538.864611353858, 13625.727485450334, 13815.654608634764, 12671.239725616493, 12829.358532073453, 12996.350182490838, 13039.0, 13264.668383290398, 4522.095580883803, 4540.614047805941, 4619.422572178478, 4628.861134165947, 4784.473707892129, 77696.0, 77709.22290777076, 80574.59712701399, 83193.0, 83530.58234708848, 11405.543778248777, 11457.770844583229, 11660.650180494598, 11747.882521174679, 12037.518499259932, 20862.374128776162, 20968.79031209699, 21197.682034769492, 21212.045457954122, 21218.78781212199, 8224.177582241728, 8354.540500272544, 8620.224179823846, 8728.127187281221, 8759.2992560595, 4396.824127034947, 4591.494935557086, 4594.724316541018, 4632.60622847055, 4844.224924012141, 3339.248669049493, 3408.403529382348, 3437.604675462354, 3437.6390478999847, 3438.2435864109857, 583.4748726146418, 593.6022864680674, 603.6649659439054, 605.467188873797, 621.5742216581656, 560.5599604310596, 587.4771453406472, 592.7954855574819, 596.8060380376309, 608.4949491921694, 8194.918050819535, 9499.715008549754, 9961.701148965543, 10012.69961901144, 10142.137918277029, 590.400743245606, 607.4654304212265, 643.0900276109253, 682.8702546516146, 718.0808565036657, 4172.895677608023, 4558.361829343895, 4614.984703365254, 4636.907261854744, 4640.489546149921, 63580.36419635837, 101217.0, 104159.0, 104540.47729761302, 105667.0, 94513.5274323624, 94954.52522737342, 95201.52399238099, 97646.51176744213, 99540.0, 53424.732876336144, 79592.6020369906, 82779.0, 82933.58533207295, 84247.15752842516, 8544.658213671384, 8626.223639872442, 8714.91285087141, 8742.475451472932, 8830.337724670548, 48836.75581622069, 49036.0, 50155.346207253824, 50225.0, 50437.0, 45163.54836451593, 45429.77285113553, 46156.53843461522, 70545.29454705387, 71949.92075118983, 11893.583724569598, 12212.450439730412, 12491.375431228584, 12983.610491685264, 13601.659958501117, 14662.0, 14838.851611483748, 14842.698582176472, 14915.627109322353, 15120.168390738176, 13683.24742139192, 14125.788113178105, 14134.717305654034, 15061.17163556015, 15121.09273443597, 11380.430978450879, 13165.53920612774, 13171.407286672315, 13472.326383680973, 13969.022168448111, 13171.538996135088, 13291.401886915306, 14059.578212653636, 14112.717745645235, 14925.776113358526, 11119.0, 11285.322880627189, 11482.32435151108, 11506.30962142274, 11644.767104658029, 11052.11583073336, 11725.355105469282, 11794.823077653671, 11926.701832453911, 12037.699057523632], "value": 7394.547046199899, "unit": "score"}], "name": "dromaeo_css", "value": 7127.9086690777585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 113.0, 110.0, 111.0, 109.0, 112.0, 110.0, 110.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 123.0, 177.0, 122.0, 123.0, 121.0, 123.0, 155.0, 127.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 162.0, 159.0, 163.0, 160.0, 162.0, 161.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 111.0, 76.0, 75.0, 75.0, 76.0, 102.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 83.0, 83.0, 100.0, 81.0, 81.0, 122.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 53.0, 54.0, 54.0, 55.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 131.0, 132.0, 131.0, 135.0, 138.0, 133.0, 169.0, 130.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 167.0, 169.0, 169.0, 169.0, 171.0, 169.0, 175.0, 168.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 69.0, 67.0, 69.0, 68.0, 67.0, 74.0, 65.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1504.2, "alertThreshold": 2.0}]} 20:31:58 INFO - Return code: 0 20:31:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:58 INFO - # TBPL SUCCESS # 20:31:58 INFO - Running post-action listener: _resource_record_post_action 20:31:58 INFO - [mozharness: 2016-10-04 03:31:58.218696Z] Finished run-tests step (success) 20:31:58 INFO - Running post-run listener: _resource_record_post_run 20:31:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7872512; Write bytes: 432046080; Read time: 1676; Write time: 307140 20:31:58 INFO - TinderboxPrint: CPU usage
13.0% 20:31:58 INFO - TinderboxPrint: I/O read bytes / time
7,872,512 / 1,676 20:31:58 INFO - TinderboxPrint: I/O write bytes / time
432,046,080 / 307,140 20:31:58 INFO - TinderboxPrint: CPU idle
8,310.0 (86.9%) 20:31:58 INFO - TinderboxPrint: CPU user
1,196.9 (12.5%) 20:31:58 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 81694720; Read time: 0; Write time: 52384 20:31:58 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5656576; Write bytes: 350351360; Read time: 1508; Write time: 254756 20:31:58 INFO - Running post-run listener: _upload_blobber_files 20:31:58 INFO - Blob upload gear active. 20:31:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:58 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 20:31:58 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'] 20:31:58 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 20:31:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:00 INFO - (blobuploader) - INFO - Done attempting. 20:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:03 INFO - (blobuploader) - INFO - Done attempting. 20:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:03 INFO - (blobuploader) - INFO - Done attempting. 20:32:03 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:03 INFO - Return code: 0 20:32:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f14b83572c4d26463173c0a8eb430d2b7f50f311640b6c9edea7d0378de80cb549884feb2da6ec501beebb7b0f9fb09fc77c940708143522cb00c738c097d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de1c47b006361f78abc583e21791dd81d2eb68e88bccd08fa1ef337d34d311e5f7b102b91a5973a5c37533879b75b7c2140417c2f07a8b61b2a9593c8e0cbac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e389ccf4e3e666e41f84e7f0b0d879f33c0b1ece02a4a4d443ef9ccda75a818bce74858192a399d20c6357e5a2ef59cb1d2b7cb18f4da356a784c94a37fc2663"} 20:32:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:03 INFO - Contents: 20:32:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f14b83572c4d26463173c0a8eb430d2b7f50f311640b6c9edea7d0378de80cb549884feb2da6ec501beebb7b0f9fb09fc77c940708143522cb00c738c097d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de1c47b006361f78abc583e21791dd81d2eb68e88bccd08fa1ef337d34d311e5f7b102b91a5973a5c37533879b75b7c2140417c2f07a8b61b2a9593c8e0cbac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e389ccf4e3e666e41f84e7f0b0d879f33c0b1ece02a4a4d443ef9ccda75a818bce74858192a399d20c6357e5a2ef59cb1d2b7cb18f4da356a784c94a37fc2663"} 20:32:03 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:03 INFO - Copying logs to upload dir... 20:32:03 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.046245 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-03 20:32:03.983878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:32:03.987262) ========= 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=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f14b83572c4d26463173c0a8eb430d2b7f50f311640b6c9edea7d0378de80cb549884feb2da6ec501beebb7b0f9fb09fc77c940708143522cb00c738c097d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de1c47b006361f78abc583e21791dd81d2eb68e88bccd08fa1ef337d34d311e5f7b102b91a5973a5c37533879b75b7c2140417c2f07a8b61b2a9593c8e0cbac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e389ccf4e3e666e41f84e7f0b0d879f33c0b1ece02a4a4d443ef9ccda75a818bce74858192a399d20c6357e5a2ef59cb1d2b7cb18f4da356a784c94a37fc2663"} build_url:https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/Ne18FPWeQ56d-IkEKfYBdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f14b83572c4d26463173c0a8eb430d2b7f50f311640b6c9edea7d0378de80cb549884feb2da6ec501beebb7b0f9fb09fc77c940708143522cb00c738c097d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de1c47b006361f78abc583e21791dd81d2eb68e88bccd08fa1ef337d34d311e5f7b102b91a5973a5c37533879b75b7c2140417c2f07a8b61b2a9593c8e0cbac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e389ccf4e3e666e41f84e7f0b0d879f33c0b1ece02a4a4d443ef9ccda75a818bce74858192a399d20c6357e5a2ef59cb1d2b7cb18f4da356a784c94a37fc2663"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:32:04.012794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:32:04.013141) ========= 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=ed14279e38b05397cf4aa391000001a4-1475549633.337856-691860760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:32:04.095762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:32:04.096090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:32:04.096401) ========= ========= Total master_lag: 0.18 =========