builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1475317458.0 results: success (0) buildid: 20161001003005 builduid: d9d4603ac83c43b79d9153281f47f8af revision: 87cd291d2db621da6b3eb1057027cc0725b6eb1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.000130) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.000543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.000850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.064919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.065227) ========= 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=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 03:24: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-01 03:24:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127526 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.207344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.207667) ========= 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=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019820 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:18.257216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 03:24:18.257544) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87cd291d2db621da6b3eb1057027cc0725b6eb1d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 87cd291d2db621da6b3eb1057027cc0725b6eb1d --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=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 03:24:18,875 truncating revision to first 12 chars 2016-10-01 03:24:18,875 Setting DEBUG logging. 2016-10-01 03:24:18,875 attempt 1/10 2016-10-01 03:24:18,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/87cd291d2db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 03:24:19,820 unpacking tar archive at: fx-team-87cd291d2db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.292853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 03:24:19.563259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:19.563563) ========= script_repo_revision: 87cd291d2db621da6b3eb1057027cc0725b6eb1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:19.563962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:19.564227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 03:24:19.573477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-01 03:24:19.573768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:20 INFO - MultiFileLogger online at 20161001 03:24:20 in /builds/slave/test 03:24:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:24:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:20 INFO - {'append_to_log': False, 03:24:20 INFO - 'base_work_dir': '/builds/slave/test', 03:24:20 INFO - 'blob_upload_branch': 'Fx-Team', 03:24:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:20 INFO - 'branch': 'Fx-Team', 03:24:20 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:20 INFO - 'config_files': ('talos/linux_config.py',), 03:24:20 INFO - 'default_actions': ('clobber', 03:24:20 INFO - 'read-buildbot-config', 03:24:20 INFO - 'download-and-extract', 03:24:20 INFO - 'populate-webroot', 03:24:20 INFO - 'create-virtualenv', 03:24:20 INFO - 'install', 03:24:20 INFO - 'run-tests'), 03:24:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:20 INFO - 'download_minidump_stackwalk': True, 03:24:20 INFO - 'download_symbols': 'ondemand', 03:24:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:20 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:20 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:20 INFO - 'installer_path': 'installer.exe', 03:24:20 INFO - 'log_level': 'info', 03:24:20 INFO - 'log_name': 'talos', 03:24:20 INFO - 'log_to_console': True, 03:24:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:20 INFO - 'opt_config_files': (), 03:24:20 INFO - 'pip_index': False, 03:24:20 INFO - 'sps_profile': False, 03:24:20 INFO - 'sps_profile_interval': 0, 03:24:20 INFO - 'suite': 'dromaeojs', 03:24:20 INFO - 'system_bits': '32', 03:24:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:20 INFO - 'title': 'talos-linux64-ix-007', 03:24:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:20 INFO - 'use_talos_json': True, 03:24:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:20 INFO - 'work_dir': 'build'} 03:24:20 INFO - [mozharness: 2016-10-01 10:24:20.291584Z] Running clobber step. 03:24:20 INFO - Running pre-action listener: _resource_record_pre_action 03:24:20 INFO - Running main action method: clobber 03:24:20 INFO - rmtree: /builds/slave/test/build 03:24:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:20 INFO - Running post-action listener: _resource_record_post_action 03:24:20 INFO - [mozharness: 2016-10-01 10:24:20.747141Z] Finished clobber step (success) 03:24:20 INFO - [mozharness: 2016-10-01 10:24:20.747243Z] Running read-buildbot-config step. 03:24:20 INFO - Running pre-action listener: _resource_record_pre_action 03:24:20 INFO - Running main action method: read_buildbot_config 03:24:20 INFO - Using buildbot properties: 03:24:20 INFO - { 03:24:20 INFO - "project": "", 03:24:20 INFO - "product": "firefox", 03:24:20 INFO - "script_repo_revision": "production", 03:24:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:24:20 INFO - "repository": "", 03:24:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:24:20 INFO - "buildid": "20161001003005", 03:24:20 INFO - "pgo_build": "True", 03:24:20 INFO - "basedir": "/builds/slave/test", 03:24:20 INFO - "buildnumber": 1608, 03:24:20 INFO - "slavename": "talos-linux64-ix-007", 03:24:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:24:20 INFO - "platform": "ubuntu64_hw", 03:24:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:24:20 INFO - "branch": "fx-team", 03:24:20 INFO - "repo_path": "integration/fx-team", 03:24:20 INFO - "revision": "87cd291d2db621da6b3eb1057027cc0725b6eb1d", 03:24:20 INFO - "stage_platform": "linux64-pgo", 03:24:20 INFO - "builduid": "d9d4603ac83c43b79d9153281f47f8af", 03:24:20 INFO - "slavebuilddir": "test" 03:24:20 INFO - } 03:24:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:24:20 INFO - Running post-action listener: _resource_record_post_action 03:24:20 INFO - [mozharness: 2016-10-01 10:24:20.749742Z] Finished read-buildbot-config step (success) 03:24:20 INFO - [mozharness: 2016-10-01 10:24:20.749831Z] Running download-and-extract step. 03:24:20 INFO - Running pre-action listener: _resource_record_pre_action 03:24:20 INFO - Running main action method: download_and_extract 03:24:20 INFO - mkdir: /builds/slave/test/build/tests 03:24:20 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')]} 03:24:20 INFO - trying https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:24:20 INFO - Downloading https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/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 03:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/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 03:24:21 INFO - Downloaded 1361 bytes. 03:24:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:24:21 INFO - Using the following test package requirements: 03:24:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:24:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:24:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:24:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'jsshell-linux-x86_64.zip'], 03:24:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:24:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:24:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:24:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:24:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:24:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:24:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:24:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:24:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:21 INFO - Fetch https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:24:21 INFO - Http code: 200 03:24:21 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 03:24:21 INFO - x-amz-cf-id: cUB5rVAvq3M63YZhS0a67cXN0GLx-XDqIWPztMdPpD3w1ylux4GKLw== 03:24:21 INFO - x-amz-version-id: Ph3EKqsOB4PddiHF3JX8XOOvfS7VBA0t 03:24:22 INFO - Expected file size: 21991637 03:24:22 INFO - Obtained file size: 21991637 03:24:26 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 03:24:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:24:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:26 INFO - Fetch https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:24:26 INFO - Http code: 200 03:24:26 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 03:24:26 INFO - x-amz-cf-id: AYNo-0UW4tdJOySb0fKxOs-9PexMuj2WUIZnumU93LSp5EIoSjQOWA== 03:24:26 INFO - x-amz-version-id: Ph3EKqsOB4PddiHF3JX8XOOvfS7VBA0t 03:24:27 INFO - Expected file size: 21991637 03:24:27 INFO - Obtained file size: 21991637 03:24:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:24:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:24:31 INFO - Fetch https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:24:31 INFO - Http code: 200 03:24:31 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 03:24:31 INFO - x-amz-cf-id: oWbZod6EgGe2deCGhZ9TtRHA22koLDXX_nXEQzpZ6XsU24FfZRg3-Q== 03:24:31 INFO - x-amz-version-id: TGhsKbjC9_x5UMGSMgSqnDMebdQpUrVk 03:24:32 INFO - Expected file size: 14408522 03:24:32 INFO - Obtained file size: 14408522 03:24:32 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')]} 03:24:32 INFO - trying https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/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 03:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/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 03:24:33 INFO - Downloaded 59666328 bytes. 03:24:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:33 INFO - mkdir: /builds/slave/test/properties 03:24:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:33 INFO - Contents: 03:24:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - Running post-action listener: set_extra_try_arguments 03:24:34 INFO - [mozharness: 2016-10-01 10:24:34.212651Z] Finished download-and-extract step (success) 03:24:34 INFO - [mozharness: 2016-10-01 10:24:34.212878Z] Running populate-webroot step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: populate_webroot 03:24:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:34 INFO - '--tppagecycles', 03:24:34 INFO - '7'], 03:24:34 INFO - 'tests': ['tsvgm']}}, 03:24:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['damp', 'tps']}, 03:24:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'tests': ['damp', 'tps']}, 03:24:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['dromaeo_dom']}, 03:24:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['basic_compositor_video']}, 03:24:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:24:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tsvgx', 03:24:34 INFO - 'tsvgr_opacity', 03:24:34 INFO - 'tart', 03:24:34 INFO - 'tscrollx', 03:24:34 INFO - 'cart']}, 03:24:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:34 INFO - 'tsvgr_opacity', 03:24:34 INFO - 'tart', 03:24:34 INFO - 'tscrollx', 03:24:34 INFO - 'cart']}, 03:24:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tp5o']}, 03:24:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'tests': ['tp5o']}, 03:24:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s', 03:24:34 INFO - '--xperf_path', 03:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:34 INFO - 'tests': ['tp5n']}, 03:24:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:34 INFO - 'talos_options': ['--xperf_path', 03:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:34 INFO - 'tests': ['tp5n']}}, 03:24:34 INFO - 'talos.zip': {'path': '', 03:24:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - [mozharness: 2016-10-01 10:24:34.233234Z] Finished populate-webroot step (success) 03:24:34 INFO - [mozharness: 2016-10-01 10:24:34.233322Z] Running create-virtualenv step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: create_virtualenv 03:24:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24: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 03:24:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:34 INFO - Using real prefix '/usr' 03:24:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:36 INFO - Installing pip.................done. 03:24:36 INFO - Return code: 0 03:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:37 INFO - Reading from file tmpfile_stdout 03:24:37 INFO - Output received: 03:24: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) 03:24:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24: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 03:24: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 03:24:37 INFO - Using env: {'DISPLAY': ':0', 03:24:37 INFO - 'HOME': '/home/cltbld', 03:24:37 INFO - 'LANG': 'en_US.UTF-8', 03:24:37 INFO - 'LANGUAGE': 'en_US:en', 03:24:37 INFO - 'LOGNAME': 'cltbld', 03:24:37 INFO - 'MAIL': '/var/mail/cltbld', 03:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:37 INFO - 'MOZ_NO_REMOTE': '1', 03:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:37 INFO - 'NO_EM_RESTART': '1', 03:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:37 INFO - 'PWD': '/builds/slave/test', 03:24:37 INFO - 'SHELL': '/bin/bash', 03:24:37 INFO - 'SHLVL': '1', 03:24:37 INFO - 'TERM': 'linux', 03:24:37 INFO - 'TMOUT': '86400', 03:24:37 INFO - 'USER': 'cltbld', 03:24:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:37 INFO - '_': '/tools/buildbot/bin/python'} 03:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24: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 03:24:37 INFO - Cleaning up... 03:24:37 INFO - Return code: 0 03:24:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24: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 03:24: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 03:24:37 INFO - Using env: {'DISPLAY': ':0', 03:24:37 INFO - 'HOME': '/home/cltbld', 03:24:37 INFO - 'LANG': 'en_US.UTF-8', 03:24:37 INFO - 'LANGUAGE': 'en_US:en', 03:24:37 INFO - 'LOGNAME': 'cltbld', 03:24:37 INFO - 'MAIL': '/var/mail/cltbld', 03:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:37 INFO - 'MOZ_NO_REMOTE': '1', 03:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:37 INFO - 'NO_EM_RESTART': '1', 03:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:37 INFO - 'PWD': '/builds/slave/test', 03:24:37 INFO - 'SHELL': '/bin/bash', 03:24:37 INFO - 'SHLVL': '1', 03:24:37 INFO - 'TERM': 'linux', 03:24:37 INFO - 'TMOUT': '86400', 03:24:37 INFO - 'USER': 'cltbld', 03:24:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:37 INFO - '_': '/tools/buildbot/bin/python'} 03:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:37 INFO - Downloading/unpacking psutil>=3.1.1 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:39 INFO - Installing collected packages: psutil 03:24:39 INFO - Running setup.py install for psutil 03:24:39 INFO - building 'psutil._psutil_linux' extension 03:24:39 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 03:24:39 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 03:24:39 INFO - building 'psutil._psutil_posix' extension 03:24:39 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 03:24:39 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 03:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:39 INFO - Successfully installed psutil 03:24:39 INFO - Cleaning up... 03:24:40 INFO - Return code: 0 03:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:40 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')]} 03:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:40 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')]} 03:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:40 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:40 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 03:24:40 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 03:24:40 INFO - Using env: {'DISPLAY': ':0', 03:24:40 INFO - 'HOME': '/home/cltbld', 03:24:40 INFO - 'LANG': 'en_US.UTF-8', 03:24:40 INFO - 'LANGUAGE': 'en_US:en', 03:24:40 INFO - 'LOGNAME': 'cltbld', 03:24:40 INFO - 'MAIL': '/var/mail/cltbld', 03:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:40 INFO - 'MOZ_NO_REMOTE': '1', 03:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:40 INFO - 'NO_EM_RESTART': '1', 03:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:40 INFO - 'PWD': '/builds/slave/test', 03:24:40 INFO - 'SHELL': '/bin/bash', 03:24:40 INFO - 'SHLVL': '1', 03:24:40 INFO - 'TERM': 'linux', 03:24:40 INFO - 'TMOUT': '86400', 03:24:40 INFO - 'USER': 'cltbld', 03:24:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:40 INFO - '_': '/tools/buildbot/bin/python'} 03:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:40 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 03:24:40 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 03:24:40 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 03:24:40 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 03:24:40 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 03:24:40 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 03:24:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:42 INFO - Installing collected packages: mozsystemmonitor 03:24:42 INFO - Running setup.py install for mozsystemmonitor 03:24:42 INFO - Successfully installed mozsystemmonitor 03:24:42 INFO - Cleaning up... 03:24:42 INFO - Return code: 0 03:24:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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', '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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:24: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 jsonschema==2.5.1 03:24:42 INFO - Using env: {'DISPLAY': ':0', 03:24:42 INFO - 'HOME': '/home/cltbld', 03:24:42 INFO - 'LANG': 'en_US.UTF-8', 03:24:42 INFO - 'LANGUAGE': 'en_US:en', 03:24:42 INFO - 'LOGNAME': 'cltbld', 03:24:42 INFO - 'MAIL': '/var/mail/cltbld', 03:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:42 INFO - 'MOZ_NO_REMOTE': '1', 03:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:42 INFO - 'NO_EM_RESTART': '1', 03:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:42 INFO - 'PWD': '/builds/slave/test', 03:24:42 INFO - 'SHELL': '/bin/bash', 03:24:42 INFO - 'SHLVL': '1', 03:24:42 INFO - 'TERM': 'linux', 03:24:42 INFO - 'TMOUT': '86400', 03:24:42 INFO - 'USER': 'cltbld', 03:24:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:42 INFO - '_': '/tools/buildbot/bin/python'} 03:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:24:44 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 03:24:44 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 03:24:44 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 03:24:44 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 03:24:44 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 03:24:44 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 03:24:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:44 INFO - warning: no files found matching '*.txt' 03:24:44 INFO - no previously-included directories found matching 'build' 03:24:44 INFO - no previously-included directories found matching 'dist' 03:24:44 INFO - no previously-included directories found matching '.git*' 03:24:44 INFO - Installing collected packages: jsonschema, functools32 03:24:44 INFO - Running setup.py install for functools32 03:24:44 INFO - warning: no files found matching '*.txt' 03:24:44 INFO - no previously-included directories found matching 'build' 03:24:44 INFO - no previously-included directories found matching 'dist' 03:24:44 INFO - no previously-included directories found matching '.git*' 03:24:44 INFO - Successfully installed jsonschema functools32 03:24:44 INFO - Cleaning up... 03:24:44 INFO - Return code: 0 03:24:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:44 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')]} 03:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:44 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')]} 03:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:44 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:44 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 03:24:44 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 03:24:44 INFO - Using env: {'DISPLAY': ':0', 03:24:44 INFO - 'HOME': '/home/cltbld', 03:24:44 INFO - 'LANG': 'en_US.UTF-8', 03:24:44 INFO - 'LANGUAGE': 'en_US:en', 03:24:44 INFO - 'LOGNAME': 'cltbld', 03:24:44 INFO - 'MAIL': '/var/mail/cltbld', 03:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:44 INFO - 'MOZ_NO_REMOTE': '1', 03:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:44 INFO - 'NO_EM_RESTART': '1', 03:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:44 INFO - 'PWD': '/builds/slave/test', 03:24:44 INFO - 'SHELL': '/bin/bash', 03:24:44 INFO - 'SHLVL': '1', 03:24:44 INFO - 'TERM': 'linux', 03:24:44 INFO - 'TMOUT': '86400', 03:24:44 INFO - 'USER': 'cltbld', 03:24:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:44 INFO - '_': '/tools/buildbot/bin/python'} 03:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:45 INFO - Cleaning up... 03:24:45 INFO - Return code: 0 03:24:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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', '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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:24: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 blobuploader==1.2.4 03:24:45 INFO - Using env: {'DISPLAY': ':0', 03:24:45 INFO - 'HOME': '/home/cltbld', 03:24:45 INFO - 'LANG': 'en_US.UTF-8', 03:24:45 INFO - 'LANGUAGE': 'en_US:en', 03:24:45 INFO - 'LOGNAME': 'cltbld', 03:24:45 INFO - 'MAIL': '/var/mail/cltbld', 03:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:45 INFO - 'MOZ_NO_REMOTE': '1', 03:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:45 INFO - 'NO_EM_RESTART': '1', 03:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:45 INFO - 'PWD': '/builds/slave/test', 03:24:45 INFO - 'SHELL': '/bin/bash', 03:24:45 INFO - 'SHLVL': '1', 03:24:45 INFO - 'TERM': 'linux', 03:24:45 INFO - 'TMOUT': '86400', 03:24:45 INFO - 'USER': 'cltbld', 03:24:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:45 INFO - '_': '/tools/buildbot/bin/python'} 03:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:47 INFO - Downloading docopt-0.6.1.tar.gz 03:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:48 INFO - Running setup.py install for blobuploader 03:24:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:48 INFO - Running setup.py install for requests 03:24:48 INFO - Running setup.py install for docopt 03:24:48 INFO - Successfully installed blobuploader requests docopt 03:24:48 INFO - Cleaning up... 03:24:48 INFO - Return code: 0 03:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:48 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:48 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 03:24:48 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 03:24:48 INFO - Using env: {'DISPLAY': ':0', 03:24:48 INFO - 'HOME': '/home/cltbld', 03:24:48 INFO - 'LANG': 'en_US.UTF-8', 03:24:48 INFO - 'LANGUAGE': 'en_US:en', 03:24:48 INFO - 'LOGNAME': 'cltbld', 03:24:48 INFO - 'MAIL': '/var/mail/cltbld', 03:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:48 INFO - 'MOZ_NO_REMOTE': '1', 03:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:48 INFO - 'NO_EM_RESTART': '1', 03:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:48 INFO - 'PWD': '/builds/slave/test', 03:24:48 INFO - 'SHELL': '/bin/bash', 03:24:48 INFO - 'SHLVL': '1', 03:24:48 INFO - 'TERM': 'linux', 03:24:48 INFO - 'TMOUT': '86400', 03:24:48 INFO - 'USER': 'cltbld', 03:24:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:48 INFO - '_': '/tools/buildbot/bin/python'} 03:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:48 INFO - Running setup.py (path:/tmp/pip-zcbNVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:48 INFO - Running setup.py (path:/tmp/pip-p3vlep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:48 INFO - Running setup.py (path:/tmp/pip-gpFbo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:49 INFO - Running setup.py (path:/tmp/pip-Yglysy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:49 INFO - Running setup.py (path:/tmp/pip-K5NeBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:49 INFO - Running setup.py (path:/tmp/pip-UdAUcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:49 INFO - Running setup.py (path:/tmp/pip-rB1V5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:49 INFO - Running setup.py (path:/tmp/pip-JcBq4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:49 INFO - Running setup.py (path:/tmp/pip-ac9HWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:49 INFO - Running setup.py (path:/tmp/pip-xKmTu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:49 INFO - Running setup.py (path:/tmp/pip-8Fx0sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:49 INFO - Running setup.py (path:/tmp/pip-abA_8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:49 INFO - Running setup.py (path:/tmp/pip-pKh_PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:49 INFO - Running setup.py (path:/tmp/pip-enJb0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:49 INFO - Running setup.py (path:/tmp/pip-fLTMoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:49 INFO - Running setup.py (path:/tmp/pip-wGhCt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:50 INFO - Running setup.py (path:/tmp/pip-WqWmwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:50 INFO - Running setup.py install for manifestparser 03:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Running setup.py install for mozcrash 03:24:50 INFO - Running setup.py install for mozdebug 03:24:50 INFO - Running setup.py install for mozdevice 03:24:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Running setup.py install for mozfile 03:24:50 INFO - Running setup.py install for mozhttpd 03:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Running setup.py install for mozinfo 03:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Running setup.py install for mozInstall 03:24:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:50 INFO - Running setup.py install for mozleak 03:24:50 INFO - Running setup.py install for mozlog 03:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Running setup.py install for moznetwork 03:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Running setup.py install for mozprocess 03:24:51 INFO - Running setup.py install for mozprofile 03:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Running setup.py install for mozrunner 03:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Running setup.py install for mozscreenshot 03:24:51 INFO - Running setup.py install for moztest 03:24:51 INFO - Running setup.py install for mozversion 03:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:51 INFO - Cleaning up... 03:24:51 INFO - Return code: 0 03:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:51 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:51 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 03:24:51 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 03:24:51 INFO - Using env: {'DISPLAY': ':0', 03:24:51 INFO - 'HOME': '/home/cltbld', 03:24:51 INFO - 'LANG': 'en_US.UTF-8', 03:24:51 INFO - 'LANGUAGE': 'en_US:en', 03:24:51 INFO - 'LOGNAME': 'cltbld', 03:24:51 INFO - 'MAIL': '/var/mail/cltbld', 03:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:51 INFO - 'MOZ_NO_REMOTE': '1', 03:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:51 INFO - 'NO_EM_RESTART': '1', 03:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:51 INFO - 'PWD': '/builds/slave/test', 03:24:51 INFO - 'SHELL': '/bin/bash', 03:24:51 INFO - 'SHLVL': '1', 03:24:51 INFO - 'TERM': 'linux', 03:24:51 INFO - 'TMOUT': '86400', 03:24:51 INFO - 'USER': 'cltbld', 03:24:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:51 INFO - '_': '/tools/buildbot/bin/python'} 03:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:52 INFO - Running setup.py (path:/tmp/pip-dmvFX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:52 INFO - Running setup.py (path:/tmp/pip-wlupMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:52 INFO - Running setup.py (path:/tmp/pip-a4UzKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:52 INFO - Running setup.py (path:/tmp/pip-S3IFWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:52 INFO - Running setup.py (path:/tmp/pip-8PEC_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:52 INFO - Running setup.py (path:/tmp/pip-tZH_fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:52 INFO - Running setup.py (path:/tmp/pip-l6LZWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:52 INFO - Running setup.py (path:/tmp/pip-H5Uvqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:52 INFO - Running setup.py (path:/tmp/pip-Yi50pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:52 INFO - Running setup.py (path:/tmp/pip-x3B4L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:52 INFO - Running setup.py (path:/tmp/pip-SkdeBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:52 INFO - Running setup.py (path:/tmp/pip-w1ZKZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:52 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)) 03:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:52 INFO - Running setup.py (path:/tmp/pip-3F0gtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:53 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)) 03:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:53 INFO - Running setup.py (path:/tmp/pip-8Ptimy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:53 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)) 03:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:53 INFO - Running setup.py (path:/tmp/pip-3XknUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:53 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)) 03:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:53 INFO - Running setup.py (path:/tmp/pip-mIYVet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:53 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)) 03:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:53 INFO - Running setup.py (path:/tmp/pip-X3v5_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:53 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)) 03:24:53 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)) 03:24:53 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)) 03:24:53 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)) 03:24:53 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)) 03:24:53 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)) 03:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:53 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 03:24:53 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 03:24:53 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 03:24:53 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 03:24:53 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 03:24:53 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 03:24:55 INFO - Downloading blessings-1.6.tar.gz 03:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:55 INFO - Installing collected packages: blessings 03:24:55 INFO - Running setup.py install for blessings 03:24:55 INFO - Successfully installed blessings 03:24:55 INFO - Cleaning up... 03:24:55 INFO - Return code: 0 03:24:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:55 INFO - Reading from file tmpfile_stdout 03:24:55 INFO - Current package versions: 03:24:55 INFO - argparse == 1.2.1 03:24:55 INFO - blessings == 1.6 03:24:55 INFO - blobuploader == 1.2.4 03:24:55 INFO - docopt == 0.6.1 03:24:55 INFO - functools32 == 3.2.3-2 03:24:55 INFO - jsonschema == 2.5.1 03:24:55 INFO - manifestparser == 1.1 03:24:55 INFO - mozInstall == 1.12 03:24:55 INFO - mozcrash == 0.17 03:24:55 INFO - mozdebug == 0.1 03:24:55 INFO - mozdevice == 0.48 03:24:55 INFO - mozfile == 1.2 03:24:55 INFO - mozhttpd == 0.7 03:24:55 INFO - mozinfo == 0.9 03:24:55 INFO - mozleak == 0.1 03:24:55 INFO - mozlog == 3.4 03:24:55 INFO - moznetwork == 0.27 03:24:55 INFO - mozprocess == 0.23 03:24:55 INFO - mozprofile == 0.28 03:24:55 INFO - mozrunner == 6.12 03:24:55 INFO - mozscreenshot == 0.1 03:24:55 INFO - mozsystemmonitor == 0.3 03:24:55 INFO - moztest == 0.7 03:24:55 INFO - mozversion == 1.4 03:24:55 INFO - psutil == 3.1.1 03:24:55 INFO - requests == 1.2.3 03:24:55 INFO - wsgiref == 0.1.2 03:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:55 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 03:24:55 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 03:24:55 INFO - Using env: {'DISPLAY': ':0', 03:24:55 INFO - 'HOME': '/home/cltbld', 03:24:55 INFO - 'LANG': 'en_US.UTF-8', 03:24:55 INFO - 'LANGUAGE': 'en_US:en', 03:24:55 INFO - 'LOGNAME': 'cltbld', 03:24:55 INFO - 'MAIL': '/var/mail/cltbld', 03:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:55 INFO - 'MOZ_NO_REMOTE': '1', 03:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:55 INFO - 'NO_EM_RESTART': '1', 03:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:55 INFO - 'PWD': '/builds/slave/test', 03:24:55 INFO - 'SHELL': '/bin/bash', 03:24:55 INFO - 'SHLVL': '1', 03:24:55 INFO - 'TERM': 'linux', 03:24:55 INFO - 'TMOUT': '86400', 03:24:55 INFO - 'USER': 'cltbld', 03:24:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:55 INFO - '_': '/tools/buildbot/bin/python'} 03:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 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)) 03:24:55 INFO - Cleaning up... 03:24:55 INFO - Return code: 0 03:24:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 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 0x7f8725c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, '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': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', '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 03:24:55 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 03:24:55 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 03:24:55 INFO - Using env: {'DISPLAY': ':0', 03:24:55 INFO - 'HOME': '/home/cltbld', 03:24:55 INFO - 'LANG': 'en_US.UTF-8', 03:24:55 INFO - 'LANGUAGE': 'en_US:en', 03:24:55 INFO - 'LOGNAME': 'cltbld', 03:24:55 INFO - 'MAIL': '/var/mail/cltbld', 03:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:55 INFO - 'MOZ_NO_REMOTE': '1', 03:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:55 INFO - 'NO_EM_RESTART': '1', 03:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:55 INFO - 'PWD': '/builds/slave/test', 03:24:55 INFO - 'SHELL': '/bin/bash', 03:24:55 INFO - 'SHLVL': '1', 03:24:55 INFO - 'TERM': 'linux', 03:24:55 INFO - 'TMOUT': '86400', 03:24:55 INFO - 'USER': 'cltbld', 03:24:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:55 INFO - '_': '/tools/buildbot/bin/python'} 03:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:56 INFO - Cleaning up... 03:24:56 INFO - Return code: 0 03:24:56 INFO - Running post-action listener: _resource_record_post_action 03:24:56 INFO - Running post-action listener: _start_resource_monitoring 03:24:56 INFO - Starting resource monitoring. 03:24:56 INFO - [mozharness: 2016-10-01 10:24:56.168478Z] Finished create-virtualenv step (success) 03:24:56 INFO - [mozharness: 2016-10-01 10:24:56.168934Z] Running install step. 03:24:56 INFO - Running pre-action listener: _resource_record_pre_action 03:24:56 INFO - Running main action method: install 03:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:56 INFO - Reading from file tmpfile_stdout 03:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:56 INFO - Reading from file tmpfile_stdout 03:24:56 INFO - Output received: 03:24:56 INFO - Usage: mozinstall [options] installer 03:24:56 INFO - Options: 03:24:56 INFO - -h, --help show this help message and exit 03:24:56 INFO - -d DEST, --destination=DEST 03:24:56 INFO - Directory to install application into. [default: 03:24:56 INFO - "/builds/slave/test"] 03:24:56 INFO - --app=APP Application being installed. [default: firefox] 03:24:56 INFO - mkdir: /builds/slave/test/build/application 03:24:56 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'] 03:24:56 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 03:25:13 INFO - Reading from file tmpfile_stdout 03:25:13 INFO - Output received: 03:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:13 INFO - Running post-action listener: _resource_record_post_action 03:25:13 INFO - [mozharness: 2016-10-01 10:25:13.572204Z] Finished install step (success) 03:25:13 INFO - [mozharness: 2016-10-01 10:25:13.572452Z] Running run-tests step. 03:25:13 INFO - Running pre-action listener: _resource_record_pre_action 03:25:13 INFO - Running main action method: run_tests 03:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:13 INFO - Python 2.7.3 03:25:13 INFO - Return code: 0 03:25:13 INFO - grabbing minidump binary from tooltool 03:25:13 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')]} 03:25:13 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 0x2a78930>, '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 0x2a79830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a79cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:13 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 03:25:13 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 03:25:13 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 03:25:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:13 INFO - Return code: 0 03:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 03:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 03:25:13 INFO - Using env: {'DISPLAY': ':0', 03:25:13 INFO - 'HOME': '/home/cltbld', 03:25:13 INFO - 'LANG': 'en_US.UTF-8', 03:25:13 INFO - 'LANGUAGE': 'en_US:en', 03:25:13 INFO - 'LOGNAME': 'cltbld', 03:25:13 INFO - 'MAIL': '/var/mail/cltbld', 03:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:13 INFO - 'MOZ_NO_REMOTE': '1', 03:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:13 INFO - 'NO_EM_RESTART': '1', 03:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:13 INFO - 'PWD': '/builds/slave/test', 03:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:13 INFO - 'SHELL': '/bin/bash', 03:25:13 INFO - 'SHLVL': '1', 03:25:13 INFO - 'TERM': 'linux', 03:25:13 INFO - 'TMOUT': '86400', 03:25:13 INFO - 'USER': 'cltbld', 03:25:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1475296083.774900-724981943', 03:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:13 INFO - '_': '/tools/buildbot/bin/python'} 03:25:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 03:25:13 INFO - mozversion application_buildid: 20161001003005 03:25:13 INFO - mozversion application_changeset: 87cd291d2db621da6b3eb1057027cc0725b6eb1d 03:25:13 INFO - mozversion application_display_name: Nightly 03:25:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:13 INFO - mozversion application_name: Firefox 03:25:13 INFO - mozversion application_remotingname: firefox 03:25:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:25:13 INFO - mozversion application_vendor: Mozilla 03:25:13 INFO - mozversion application_version: 52.0a1 03:25:13 INFO - mozversion platform_buildid: 20161001003005 03:25:13 INFO - mozversion platform_changeset: 87cd291d2db621da6b3eb1057027cc0725b6eb1d 03:25:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:25:13 INFO - mozversion platform_version: 52.0a1 03:25:13 INFO - using testdate: 1475317513 03:25:13 INFO - actual date: 1475317513 03:25:13 INFO - starting webserver on 'localhost:52037' 03:25:13 INFO - SUITE-START | Running 2 tests 03:25:13 INFO - TEST-START | dromaeo_css 03:25:13 INFO - operating with platform_type : linux_ 03:25:13 INFO - Initialising browser for dromaeo_css test... 03:25:13 INFO - TEST-INFO | started process 24178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptaeYIh/profile http://localhost:52037/getInfo.html) 03:25:17 INFO - PROCESS | 24178 | __metrics Screen width/height:1600/1200 03:25:17 INFO - PROCESS | 24178 | colorDepth:24 03:25:17 INFO - PROCESS | 24178 | Browser inner width/height: 1024/697 03:25:17 INFO - PROCESS | 24178 | __metrics 03:25:18 INFO - PROCESS | 24178 | 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" 03:25:18 INFO - PROCESS | 24178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:19 INFO - PROCESS | 24178 | console.error: PushService: 03:25:19 INFO - PROCESS | 24178 | stateChangeProcessEnqueue: Error transitioning state 03:25:19 INFO - PROCESS | 24178 | UnknownError 03:25:19 INFO - TEST-INFO | 24178: exit 0 03:25:19 INFO - Browser initialized. 03:25:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:19 INFO - TEST-INFO | started process 24260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptaeYIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:31 INFO - PROCESS | 24260 | RSS: Main: 174059520 03:25:31 INFO - PROCESS | 24260 | 03:26:23 INFO - PROCESS | 24260 | 1475317583312 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] 03:28:32 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52037/tests/dromaeo/cssquery-ext.html) 03:28:35 INFO - PROCESS | 24260 | RSS: Main: 381784064 03:28:35 INFO - PROCESS | 24260 | 03:31:37 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-ext.html (next: http://localhost:52037/tests/dromaeo/cssquery-jquery.html) 03:31:38 INFO - PROCESS | 24260 | RSS: Main: 285474816 03:31:38 INFO - PROCESS | 24260 | 03:34:40 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52037/tests/dromaeo/cssquery-mootools.html) 03:34:40 INFO - PROCESS | 24260 | RSS: Main: 220532736 03:34:40 INFO - PROCESS | 24260 | 03:37:43 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52037/tests/dromaeo/cssquery-prototype.html) 03:37:43 INFO - PROCESS | 24260 | RSS: Main: 235991040 03:37:43 INFO - PROCESS | 24260 | 03:40:46 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52037/tests/dromaeo/cssquery-yui.html) 03:40:46 INFO - PROCESS | 24260 | RSS: Main: 220053504 03:40:46 INFO - PROCESS | 24260 | 03:43:49 INFO - PROCESS | 24260 | Cycle 1(1): loaded http://localhost:52037/tests/dromaeo/cssquery-yui.html (next: http://localhost:52037/tests/dromaeo/cssquery-dojo.html) 03:43:50 INFO - PROCESS | 24260 | RSS: Main: 309891072 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | __start_tp_report 03:43:50 INFO - PROCESS | 24260 | _x_x_mozilla_page_load 03:43:50 INFO - PROCESS | 24260 | _x_x_mozilla_page_load_details 03:43:50 INFO - PROCESS | 24260 | |i|pagename|runs| 03:43:50 INFO - PROCESS | 24260 | |0;dojo.html;2970.465316243076;2994.056872085293;2999.62504686914;3023.606931098957;3051.6948305169485;5108.770105345259;5180.378354597449;5213.348331458567;5269.525742683158;5307.6550024248445;5226.24219488174;5256.526912577867;5319.627626066177;5354.357477102753;5375.946240537593;4792.137415265251;4806.375171227735;4821.951780482185;4822.541858523435;4891.828785992491;4896.143174944388;4938.2098864181735;4944.802207911697;4947.925781113287;4976.576990955773;4709.481956984729;4759.952400475986;4827.975860120677;4893.559579637814;4925.458199598042;4752.762361881927;4786.138495070886;4799.712017278975;4816.20532612122;4868.391451068616;4737.597304229144;4743.620510359163;4754.334393184957;4767.928481072787;4871.8782030449165;5239.5546378557865;5268.92096618551;5273.419923808378;5278.155495120801;5288.8413347599635;5389.137737961946;5400;5474.7262636868;5475.890482190373;5631.577631677641;5492.670439773627;5498.560115190775;5503.064479038573;5523.475269849358;5587.413321601214;5137.768800403991;5141.074606570815;5142.820001299974;5155.9742201288755;5198.090334191577;5420.972895135578;5482.945170548323;5549.250851135045;5608.130739735266;5658;5443.891122177534;5445.673259604437;5458.836234912959;5495.587830912697;5519.254900588449;5523.171524271392;5524.1989911462615;5534.529564987021;5542;5544.417836127229;5293.047251494768;5423.4847689470225;5433.157860531624;5522.116461366242;5595.272614560081;5477.068898287301;5513.724313784295;5524.226608274845;5570.693611851387;5596.636218645775;4260.339647354665;4295.548967358445;4302.849400270976;4305.375720520569;4351.9564804352185;3803.581606023335;3805.257974694963;3846.576876543578;3860.729748917605;3902.1415288636454;5222.660527065805;5289.021531016697;5300.178472336794;5305.628605997543;5368.892622147613;5599.1041433370465;5611;5611.298587676541;5614.157876318585;5617.157426386075;5125.1799712045895;5280.841574752763;5294.708791016454;5302.761375738101;5368.651037682538;4720.645951553579;4776;4840.540148685869;4878.268259760993;4894.11905856942;5832.825015249549;5835.649861008353;5890.440408161217;5901.734421950937;5910.34986151523;5577.637453565505;5673.319201695823;5686.2607860977805;5688.914666279927;5690.459406356389;5551.444855514416;5581.49766521015;5838;5838.153467747068;5841.036229022164;5420.674759514442;5422.213779001943;5425.484578964992;5428.7014214217015;5429.972850135724;5509.393966663744;5510.338759348904;5517.089680202722;5521.089020311764;5525.889482210414;5367.114426119647;5386.461353864583;5391.892162156656;5394.811181608625;5397.244385786072;5375.758090885842;5385.084535628874;5387.3804512481565;5390.164524498709;5395.190721391823;5361.195820626781;5370;5377.354717433933;5380.596455265949;5381.165919282517;5466.070767969375;5480.232767412485;5495.175723641486;5500.972495137658;5505.697186654773;5389.8922021558565;5391.16436952273;5398.46015398457;5401.891962160814;5403.324584426947 03:43:50 INFO - PROCESS | 24260 | |1;ext.html;581.8981678206313;587.362711458068;604.9092636104587;608.7108623403884;611.4955161991359;31302.68697313026;40906.59093409065;41406.17187656249;41481.377779333336;46624.300635490494;44449.55550444494;44718.776406117926;44787.77606111965;44900.77549612247;44926.550734492645;8937.374383793122;9093.18161365477;9093.40892841963;9097.22673572747;9103.908960910405;8087.595620218965;8286.41995060346;10538.420386878719;10792.838107428395;10800.459977001157;10931.125509959184;10991.340519568852;11022.677278726564;11029;11029.393383363911;10819.350838949687;10888.183386246063;10889.945550272278;10898.400587967659;10905.127589792797;10623.25637205396;10691.679249622524;10694.41180735067;10703.571857125706;10704.250702450832;42971.35542966858;43323.13353732908;43360.783196084136;43379.783101084606;43413.34879976803;3326.600807903043;3480.2517458746493;3616.5117709109195;3871.1676989447124;4054.1756209705454;32390.02829915083;32443.837780810944;32487.51268730971;32643.6735632643;32996.1750956228;4307.719998200107;4472.888177795581;4534.41052663155;4581.1753884300815;4666.953330466686;322206;323599;324948;326562.9999999976;329320;34137.658623413445;35075.29849402998;35094.47358289628;57845.13232301519;58128;35929;36074.819625901706;36125;36139.81930090385;36227.456588151195;12639;12694.174878632859;12740.80888786669;12757.362131893367;12762.553310634083;9261.629534818667;9472.810543789086;10432.269741118049;10496.055355018085;10508.894911050944;8076.798080048045;8151.714689985941;8154.266116049584;8460.8730869037;8695.478271303742;3329.3674201901563;3356.781809182395;3420.3843308204764;3452.879149229815;3455.550778398792;891.8171774786283;974.9853752193723;975.2149519636619;998.2313618513704;1061.713337398898;31789.364212715616;31937.84031079876;31999.36001280008;32114.518282225785;32511.837440812644;1040.765827688764;1063.5214153630898;1076.8923107689325;1096.4353358020626;1119.6137332620397;16166.35334586627;16907.830921690627;16927.661446770995;16941;17005.82994170067;483131;537805;544010;544704.6354437493;545418;49067;54710;55510;55603;60817.69591152016;1280.6798300424894;1294.3398866578113;1296.0862591872708;1298.3573131300068;1308.5943357559188;30413.239669008453;32684.836575816968;32934.34131317312;33078.50382244316;33238.50142247917;51023.74488127536;51509.48490515047;51590.484095158565;51629.48370516397;51774.741126294124;446617;446950;448369;448399;449306.5346732585;28854;28930.515770055674;29348.413031739674;29352.85323573454;29378.85310573519;45676;46996;47033.76483117563;47164.76417618027;47376.28935566038;39551;39810.60189398069;39902;41091;41334.1733165341;38960.61039389683;39570.208595827346;40536.391954120125;40558.59441405548;41060.79469602633;39711;40926.59073409228;41070.58929410668;41159.588404116774;41190.1761964765;34753.65246347504;36043.27913441769;36161.63838361583;36745.816270918476;37050.81474592718;27947.860260698566;28047.43905121927;28104.71895281103;28165;28493 03:43:50 INFO - PROCESS | 24260 | |2;jquery.html;371.20932413958263;385.7666112002237;395.1642276585023;399.6523024968277;425.2855203258524;13064.542741004067;15345.616359591002;16304.657545203248;19386.903065484654;19844;19119.52201194971;19263.903680481613;19729.506762330948;19771.505712357197;19837.90081049593;4941.925871111918;5716.857078573038;5972.611780234271;5974.4324289192455;5977.073553599199;5801.883962320751;5817.389174136718;5829.242198514187;5835.620684655484;5865.970670146643;5598.356189038252;5783.392743761908;5816.447437493432;5817.970910145444;5821.068629019358;5738.3687794342795;5764.16419619157;5784.508316793078;5784.652920824764;5792.884142317151;5042.823501177441;5227.869303267411;5231.843044708627;5247.793007608271;5291.126964050927;12535.686607834787;12766.936165319206;12783;13133.671658208621;21916.780832191635;2118.5127420693325;2166.7724888886596;2319.22306027481;2402.8318017738766;2860.4851126797166;9576.90423095767;9672.951635241849;10022.749431264203;10120.94939525305;13220.86779132206;1844.9907750461161;1867.8318951294448;1873.082189727024;1884.1709647754944;1898.506388339028;70648.2935170652;73616;76790.23209767943;77011.99999999943;78349;10813;11023.559057637765;11042.558297668164;11211.159163062803;11636.825447618292;15897.920510397375;15900.443484477988;15907.761383579023;15922.68154636924;15929.123898185479;7533.698652053857;7590.316871481593;7729.884051739228;7741.419393545507;7821.960890195513;6881.621510816853;6958.321046397073;6988.650567471606;7106.182788979334;7169.89245161323;4422.823087076546;4451.532589078165;4528.5245049270015;4592.816287348535;4856.514348565115;1958.588696373749;2003.6894281386408;2029.147757941668;2034.3490083173242;2051.302557130553;713.6859781696037;790.2611058660171;927.8608208768603;928.3919033033374;1021.9284650074572;18756.343527976456;19336.613267734847;19481.805181948283;19553.902230488755;19912.303069392503;871.6818361298081;947.6588428165854;955.5795450002116;1009.9242556808268;1068.257560995101;10228.386296822215;10574.841377379345;10613;10791.244612877023;10929.071028962468;432139;432918;434545;435401;436827;84468;89144.07410925509;89595.55202223947;89959;90063.54968225247;1019.97450063749;1045.4354648489882;1056.3820165203288;1057.4131357096885;1060.3955745225148;16363.918180409499;16594.917025415278;17230.827691723425;17274.740878887078;17435.72824657967;38163.236735265695;38354.61645383511;38548.42177367285;38654;39015.41476877906;53120;53653.731731342654;54109.45890541044;54457.45542544524;56128.15807762805;8162.551059691774;8387.245147936716;8557.871631925402;8724.171203735636;8812.118788121394;11445.599404020819;12721.872781272068;12795.296258705861;13019.153755005895;13024.54414095502;10769.784604308026;11323.886761132613;11362.94318528402;11535.480903359537;11765.294082355085;8134.698448248252;10891.292066015683;11014.724631884266;11183.776324473627;11314.264572802742;10761.623343182951;10983.066439352744;11303.491342889754;11481.311121332747;11487.36819474937;8027.678892844221;8148.429609927485;8542.82914341722;8610.311175106102;8619.094995025684;8602.311815054905;8874.890638670166;11412.543498259976;11633.476493557979;11841.171118022 03:43:50 INFO - PROCESS | 24260 | |3;mootools.html;1443.1557538839782;1453.4331610671836;1602.8958117722348;1745.5025317784434;1780.261191605483;7558.924410755891;7774.727884524043;8126.309263712584;8818.647254109836;8826.426282291655;8158;8384.790380240496;8410.411271211018;8742.300615950724;8743.519106449143;2260.2993072147606;2268.2288022072494;2285.725712914444;2287.2109122352763;2288.0733303012225;1894.3748562974185;1957.0214892553722;2186.223890518867;2194.7476040255415;2267.455810605451;2233.698450709158;2283.2807665585287;2285.337252196869;2286.0855657736956;2287.63397856343;2196.7473740519804;2206.8124209442217;2209.3482422685347;2212.214663794346;2212.4358288636454;2210.933671989843;2221.4002219400672;2226.899789509476;2230.8996095175758;2252.9436764080865;8529;8592.269657079156;8594.828103437896;8596.097409772008;8597.613107410181;4681.5318468153255;4858.611311095104;4867.318575399447;4878.146324393252;4885.584725298354;3055.9694403055905;3230.628477725045;3287.4575695010535;3290.8190049547266;3304.3391321735508;1087.7933192693442;1118.6364431559693;1126.5887950897945;1143.6111722014555;1151.424287856072;11586.131040171937;11623.360715160663;11641.883581164164;11644.6506604802;11664.708382290426;4058.1477889642915;4225.936610950838;4377.9781101094295;4380.737155770664;4434.201843668171;9930.404175749478;9938.354006989523;9954.651587194414;9955;9957.601695932226;4970.627202959792;4978.352814134139;4993.076280888047;4995.9500404996215;4996.4254110777;4430.424044874146;4541.114482675846;4557.361969324297;4564.452265728134;4575;3733.8133093345223;3785.2240290740333;3927.9018024549046;3943.901402464904;4093.9385909211387;1072;1106.0985296982933;1202.9578964736193;1219.408586835384;1268.1693490763564;784.2432053068816;934.8270569944582;938.0759951447818;943.5612440215333;977.9315447918577;5725.5133313667975;5771.105478650816;5834.329052159056;5856.765729370863;5985.25184351956;943.1087622196958;954.2842867849113;956.6556039825657;957.7414098193449;980.1521683743653;3758.969138714392;3857.96142038576;4084.326086195804;4216.873493795191;4252.447181866338;10433.9478302608;10657.573697052187;10708.08981236588;10774.676759697064;10882.61910833117;10600.893991059991;10603.94698026505;10663.680089597325;10744.194185436123;10778.29941053829;7530.887036694454;7984.800379990546;8068.273855352929;8076.353891688651;8081.111077781439;5307.416184219655;5551.2228288040515;5588.133839254922;5643.1535269709875;5816.941830581809;8743.825123497621;8768.517731524827;8940.418872773249;9009.27925765924;9026.368154229403;8902.243309318781;9130.680426185052;9169.724908252763;9228.630854766003;9249.768755781159;7396.223396543285;7442.62786860644;7547.886781698169;7617.352525035434;7810.843783124419;8365;8388.245057944814;8411.495310281403;8472.661093556435;8485.321174306164;7209.71161153548;7222.566646001257;7428.442866784904;7516.624168791429;7745.070591529053;7242.89135662955;7356.190819010012;7360.742374016883;7523.059617547807;7586.848263034819;6734.855074637421;6851.3491218334175;6852.074969879002;6853.657317134023;6856.725730970905;4740.549647783455;4762.809487620457;4893.804247830047;4896.902061958812;4902.117618828645;4747.240441529339;4765.404324459442;4853;4865.56209941107;4880.459689779229 03:43:50 INFO - PROCESS | 24260 | |4;prototype.html;325.2573765424761;335.2540597171294;343.08225496796064;345.86165533786465;346.7867261634096;5188.844334669957;5319.228711836791;5319.78720851166;5399.217113518543;5433.972830135844;5150.562202212807;5300.496452836984;5301.390340110879;5315.787368505265;5320.4679532046775;4195.580441955811;4223.282042052859;4240.851570195044;4247.893802654935;4256;4146.626803587692;4235.174141042498;4258.361245813137;4264.808083636229;4266.445362102922;4169.833206671745;4208.410822484854;4208.463910672598;4214.199302132601;4216.861447409197;4166.64583510402;4177.519585247705;4211.010182770222;4214.115035842461;4233.153369326147;3514.0687717754818;3643.599204087548;3654.4152935530187;3670.1742108025746;3756.793376364299;5146.536811686966;5148.6910785353;5168.53483186515;5171.5862730981435;5178.818741344073;4720.409948756405;4755.191617425046;4780.880477988043;4800.231962885957;4822.879428014293;5290.444503327172;5504.357908204084;5510.118381059051;5557.638753481051;5647.8588035299035;4033.97983010086;4054.7161698681102;4057.6348128668265;4062.9187416251807;4062.939055914164;5718.885622287573;5747.885042299131;5756.510696590794;5792.160136780143;5797.942020579782;4060.26915155269;4151.522574903925;4152.941000044969;4157.251694694984;4186.099988502487;4203.26442872496;4217.852375166915;4218.8523401680795;4222.282212023963;4237.533871274158;4752.215884379108;4768.165571025057;4804.73573953429;4806.351142595775;4820;5401.648892822032;5564.944350556523;5603.066941905117;5625.961980530549;5631.352394474606;1327.9601611951657;1349.305107869448;1419.6734751007325;1440.9783853242209;1441.654003039263;983.1839573154265;998.9900100998897;1012.1548506996741;1014.8021135878433;1016.537475448669;5241.488202904064;5281.313429254173;5285.471452854684;5292.576593872558;5346.1713434417725;5591.9720401397735;5623.775048998076;5630.0991841305195;5630.592351912022;5666.291713535808;5225.451327610622;5294.549963253166;5326.523166727413;5333.386660534088;5373.7581808818695;2639.6700412448445;2649.986750066276;2654.0492737837676;2669.079167687145;2682.611021401925;5111.463296353903;5115.258287548285;5115.820946266937;5206.583473322201;5212.64471237481;4918.827841025547;5183.300254465675;5197.324347834833;5198.870028249324;5239.476052394806;5167.534921857051;5195.246689229964;5241.790328386822;5245.763940622604;5259.368875735013;5018.4981501849525;5041.941192349647;5042.672226305279;5071.340725705634;5076.289174678487;4783.832565860178;4899.534544218293;4940.160172770709;4958.578520825626;4970.763156579482;5072.873178170576;5107.182850743863;5130.51260130287;5139.124219659872;5165.93362654941;3764.3788774852937;3780.3573392522785;3780.603036681219;3786.1670432504807;3791.0711875590655;4915.91849793045;4964.2128833619145;5005.7997680092385;5391.59563032782;5526.972365138148;5390.164524498709;5499.697516636464;5526.47498487643;5532.474414930575;5542.69515176653;5568.610197286313;5584.329880414376;5615.494605485526;5626.521745651666;5628.802991895264;5267.947320526899;5536.307961504812;5558.44415558441;5564.638298510746;5582.609217354746;5649.717514124195;5672;5675.404082571271;5675.631083979528;5680.261565996394;5451.291332126798;5523.613347065667;5564.19319198722;5590.189422533791;5594.776208951596 03:43:50 INFO - PROCESS | 24260 | |5;yui.html;725.7750097469785;729.3363039633931;729.6643543969774;753.9321461068503;792.8810678398236;15429.691406171869;16835;16873.66252674949;16928.576785580368;16995.490135295946;14282.642933926658;14452.494162704308;14472.5658230253;14479.420823167087;14543;648.9059086432464;662.0268205737558;775.9689612415497;777.9727709530167;795.9801004974864;809.6842231529708;810.068421315489;810.8662070758318;813.8128230506958;817.1909809288791;863.6329559937033;863.6718047142077;864.6541383446609;865.7359505350897;870.3472395703222;691.0394551573318;708.6315116139605;711.7971378157253;720.6937051753036;860.1355637584251;610.8137018209444;619.3218425823716;619.6653806944245;628.1927722876128;628.7139351595059;14474.131552106906;14501.492447764384;14542.27288635564;14549.127052376785;14562.126272423688;12961.740765184644;13150.868491315061;13219.537316193888;13715.314234288246;13810.790273556182;10999.890001099966;11200.439978001068;11239.60661376848;12673.302968336739;12842.550510732079;4383.342498625232;4404.823807047715;4514.525974772667;4594.885127871797;4608.032313214229;68244.31755682429;68919.3108068918;70735;70996.29003709949;71442.64278678625;10680.946595266974;10794.190435717353;11001.449927503592;11125.72185695348;11409.144314176305;20970.47573810667;21156.682649760267;21268.149274029176;21310.467238318855;21355.78644213538;8185.508869467851;8387.329013678891;8413.831723365498;8656.350773691873;8696.521691307038;4537.8411755588395;4552.044070745114;4666.043461090469;4706.952930470651;4741.668083234141;3524.0661224775454;3665.816709164531;3668.926621467556;3674.797886116289;3676.338259113332;592.5822295281816;606.2119244981507;615.0743131586933;616.6793267500874;618.5886385553647;556.3546286307864;578.7858492357855;645.1065274594627;654.2410803467955;654.2868273581819;8814.250788682906;9166.770830729285;9183.984185856174;9278.443293402417;9354.20489258407;562.9971850140723;615.5291202230297;678.2043919922448;705.8694141583824;707.7098389660215;4379.167958087953;4511.932321015187;4550.863474095782;4622.6301895848255;4745.786439610157;76457.23542764613;89032;122006.3899680496;122060;122538;58344.4165558339;81344;99824.50087749514;101611;101951.4121864518;79569.60215198887;88345.55827220694;88907.55546222227;89593.55203223941;94716.52641736747;8379.95810020946;8479;8914.8042110735;9712.562934667816;9948.303618746619;35267.29465410729;38045.619543804205;50232.24651630155;51473;54895.72552137214;49262.753686232776;50740.418553959775;71644.64177679078;79265;79487.52515191172;12320.691982700504;12431.440585173508;12958.546450874173;13008.609741707764;13297.66755831112;14529.927350363181;14587.562373128823;14901.552953411416;14916.552503424915;16168.757468637745;9006.549672516217;11620.128490363426;11985;12166.57416990401;13374;12894.742105158031;13337.466501340226;13459;13629.522966696515;14170.858291417366;11675.299482031105;11877.346745929057;11926;11972.341521216069;12593.433295501542;11096.112311014938;11262.887371126511;11397.658070257905;11510.194286400207;11912.52349905994;9888.357256778287;9942.204623630238;10206.183505319408;10256.230782691477;10363.378197308186 03:43:50 INFO - PROCESS | 24260 | __end_tp_report 03:43:50 INFO - PROCESS | 24260 | __start_cc_report 03:43:50 INFO - PROCESS | 24260 | _x_x_mozilla_cycle_collect,2507 03:43:50 INFO - PROCESS | 24260 | __end_cc_report 03:43:50 INFO - PROCESS | 24260 | __startTimestamp1475318630198__endTimestamp 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | ------- Summary: start ------- 03:43:50 INFO - PROCESS | 24260 | Number of tests: 6 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#0] dojo.html Cycles:165 Average:5183.54 Median:5381.17 stddev:566.92 (10.5%) stddev-sans-first:541.42 03:43:50 INFO - PROCESS | 24260 | Values: 2970.5 2994.1 2999.6 3023.6 3051.7 5108.8 5180.4 5213.3 5269.5 5307.7 5226.2 5256.5 5319.6 5354.4 5375.9 4792.1 4806.4 4822.0 4822.5 4891.8 4896.1 4938.2 4944.8 4947.9 4976.6 4709.5 4760.0 4828.0 4893.6 4925.5 4752.8 4786.1 4799.7 4816.2 4868.4 4737.6 4743.6 4754.3 4767.9 4871.9 5239.6 5268.9 5273.4 5278.2 5288.8 5389.1 5400.0 5474.7 5475.9 5631.6 5492.7 5498.6 5503.1 5523.5 5587.4 5137.8 5141.1 5142.8 5156.0 5198.1 5421.0 5482.9 5549.3 5608.1 5658.0 5443.9 5445.7 5458.8 5495.6 5519.3 5523.2 5524.2 5534.5 5542.0 5544.4 5293.0 5423.5 5433.2 5522.1 5595.3 5477.1 5513.7 5524.2 5570.7 5596.6 4260.3 4295.5 4302.8 4305.4 4352.0 3803.6 3805.3 3846.6 3860.7 3902.1 5222.7 5289.0 5300.2 5305.6 5368.9 5599.1 5611.0 5611.3 5614.2 5617.2 5125.2 5280.8 5294.7 5302.8 5368.7 4720.6 4776.0 4840.5 4878.3 4894.1 5832.8 5835.6 5890.4 5901.7 5910.3 5577.6 5673.3 5686.3 5688.9 5690.5 5551.4 5581.5 5838.0 5838.2 5841.0 5420.7 5422.2 5425.5 5428.7 5430.0 5509.4 5510.3 5517.1 5521.1 5525.9 5367.1 5386.5 5391.9 5394.8 5397.2 5375.8 5385.1 5387.4 5390.2 5395.2 5361.2 5370.0 5377.4 5380.6 5381.2 5466.1 5480.2 5495.2 5501.0 5505.7 5389.9 5391.2 5398.5 5401.9 5403.3 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#1] ext.html Cycles:180 Average:58136.87 Median:36194.55 stddev:117749.83 (325.3%) stddev-sans-first:118000.86 03:43:50 INFO - PROCESS | 24260 | Values: 581.9 587.4 604.9 608.7 611.5 31302.7 40906.6 41406.2 41481.4 46624.3 44449.6 44718.8 44787.8 44900.8 44926.6 8937.4 9093.2 9093.4 9097.2 9103.9 8087.6 8286.4 10538.4 10792.8 10800.5 10931.1 10991.3 11022.7 11029.0 11029.4 10819.4 10888.2 10889.9 10898.4 10905.1 10623.3 10691.7 10694.4 10703.6 10704.3 42971.4 43323.1 43360.8 43379.8 43413.3 3326.6 3480.3 3616.5 3871.2 4054.2 32390.0 32443.8 32487.5 32643.7 32996.2 4307.7 4472.9 4534.4 4581.2 4667.0 322206.0 323599.0 324948.0 326563.0 329320.0 34137.7 35075.3 35094.5 57845.1 58128.0 35929.0 36074.8 36125.0 36139.8 36227.5 12639.0 12694.2 12740.8 12757.4 12762.6 9261.6 9472.8 10432.3 10496.1 10508.9 8076.8 8151.7 8154.3 8460.9 8695.5 3329.4 3356.8 3420.4 3452.9 3455.6 891.8 975.0 975.2 998.2 1061.7 31789.4 31937.8 31999.4 32114.5 32511.8 1040.8 1063.5 1076.9 1096.4 1119.6 16166.4 16907.8 16927.7 16941.0 17005.8 483131.0 537805.0 544010.0 544704.6 545418.0 49067.0 54710.0 55510.0 55603.0 60817.7 1280.7 1294.3 1296.1 1298.4 1308.6 30413.2 32684.8 32934.3 33078.5 33238.5 51023.7 51509.5 51590.5 51629.5 51774.7 446617.0 446950.0 448369.0 448399.0 449306.5 28854.0 28930.5 29348.4 29352.9 29378.9 45676.0 46996.0 47033.8 47164.8 47376.3 39551.0 39810.6 39902.0 41091.0 41334.2 38960.6 39570.2 40536.4 40558.6 41060.8 39711.0 40926.6 41070.6 41159.6 41190.2 34753.7 36043.3 36161.6 36745.8 37050.8 27947.9 28047.4 28104.7 28165.0 28493.0 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#2] jquery.html Cycles:180 Average:26579.74 Median:19370.19 stddev:71782.70 (370.6%) stddev-sans-first:71957.10 03:43:50 INFO - PROCESS | 24260 | Values: 371.2 385.8 395.2 399.7 425.3 13064.5 15345.6 16304.7 19386.9 19844.0 19119.5 19263.9 19729.5 19771.5 19837.9 4941.9 5716.9 5972.6 5974.4 5977.1 5801.9 5817.4 5829.2 5835.6 5866.0 5598.4 5783.4 5816.4 5818.0 5821.1 5738.4 5764.2 5784.5 5784.7 5792.9 5042.8 5227.9 5231.8 5247.8 5291.1 12535.7 12766.9 12783.0 13133.7 21916.8 2118.5 2166.8 2319.2 2402.8 2860.5 9576.9 9673.0 10022.7 10120.9 13220.9 1845.0 1867.8 1873.1 1884.2 1898.5 70648.3 73616.0 76790.2 77012.0 78349.0 10813.0 11023.6 11042.6 11211.2 11636.8 15897.9 15900.4 15907.8 15922.7 15929.1 7533.7 7590.3 7729.9 7741.4 7822.0 6881.6 6958.3 6988.7 7106.2 7169.9 4422.8 4451.5 4528.5 4592.8 4856.5 1958.6 2003.7 2029.1 2034.3 2051.3 713.7 790.3 927.9 928.4 1021.9 18756.3 19336.6 19481.8 19553.9 19912.3 871.7 947.7 955.6 1009.9 1068.3 10228.4 10574.8 10613.0 10791.2 10929.1 432139.0 432918.0 434545.0 435401.0 436827.0 84468.0 89144.1 89595.6 89959.0 90063.5 1020.0 1045.4 1056.4 1057.4 1060.4 16363.9 16594.9 17230.8 17274.7 17435.7 38163.2 38354.6 38548.4 38654.0 39015.4 53120.0 53653.7 54109.5 54457.5 56128.2 8162.6 8387.2 8557.9 8724.2 8812.1 11445.6 12721.9 12795.3 13019.2 13024.5 10769.8 11323.9 11362.9 11535.5 11765.3 8134.7 10891.3 11014.7 11183.8 11314.3 10761.6 10983.1 11303.5 11481.3 11487.4 8027.7 8148.4 8542.8 8610.3 8619.1 8602.3 8874.9 11412.5 11633.5 11841.2 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#3] mootools.html Cycles:180 Average:5545.50 Median:4883.02 stddev:3139.26 (64.3%) stddev-sans-first:3132.93 03:43:50 INFO - PROCESS | 24260 | Values: 1443.2 1453.4 1602.9 1745.5 1780.3 7558.9 7774.7 8126.3 8818.6 8826.4 8158.0 8384.8 8410.4 8742.3 8743.5 2260.3 2268.2 2285.7 2287.2 2288.1 1894.4 1957.0 2186.2 2194.7 2267.5 2233.7 2283.3 2285.3 2286.1 2287.6 2196.7 2206.8 2209.3 2212.2 2212.4 2210.9 2221.4 2226.9 2230.9 2252.9 8529.0 8592.3 8594.8 8596.1 8597.6 4681.5 4858.6 4867.3 4878.1 4885.6 3056.0 3230.6 3287.5 3290.8 3304.3 1087.8 1118.6 1126.6 1143.6 1151.4 11586.1 11623.4 11641.9 11644.7 11664.7 4058.1 4225.9 4378.0 4380.7 4434.2 9930.4 9938.4 9954.7 9955.0 9957.6 4970.6 4978.4 4993.1 4996.0 4996.4 4430.4 4541.1 4557.4 4564.5 4575.0 3733.8 3785.2 3927.9 3943.9 4093.9 1072.0 1106.1 1203.0 1219.4 1268.2 784.2 934.8 938.1 943.6 977.9 5725.5 5771.1 5834.3 5856.8 5985.3 943.1 954.3 956.7 957.7 980.2 3759.0 3858.0 4084.3 4216.9 4252.4 10433.9 10657.6 10708.1 10774.7 10882.6 10600.9 10603.9 10663.7 10744.2 10778.3 7530.9 7984.8 8068.3 8076.4 8081.1 5307.4 5551.2 5588.1 5643.2 5816.9 8743.8 8768.5 8940.4 9009.3 9026.4 8902.2 9130.7 9169.7 9228.6 9249.8 7396.2 7442.6 7547.9 7617.4 7810.8 8365.0 8388.2 8411.5 8472.7 8485.3 7209.7 7222.6 7428.4 7516.6 7745.1 7242.9 7356.2 7360.7 7523.1 7586.8 6734.9 6851.3 6852.1 6853.7 6856.7 4740.5 4762.8 4893.8 4896.9 4902.1 4747.2 4765.4 4853.0 4865.6 4880.5 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#4] prototype.html Cycles:180 Average:4558.32 Median:5115.54 stddev:1306.26 (25.5%) stddev-sans-first:1270.70 03:43:50 INFO - PROCESS | 24260 | Values: 325.3 335.3 343.1 345.9 346.8 5188.8 5319.2 5319.8 5399.2 5434.0 5150.6 5300.5 5301.4 5315.8 5320.5 4195.6 4223.3 4240.9 4247.9 4256.0 4146.6 4235.2 4258.4 4264.8 4266.4 4169.8 4208.4 4208.5 4214.2 4216.9 4166.6 4177.5 4211.0 4214.1 4233.2 3514.1 3643.6 3654.4 3670.2 3756.8 5146.5 5148.7 5168.5 5171.6 5178.8 4720.4 4755.2 4780.9 4800.2 4822.9 5290.4 5504.4 5510.1 5557.6 5647.9 4034.0 4054.7 4057.6 4062.9 4062.9 5718.9 5747.9 5756.5 5792.2 5797.9 4060.3 4151.5 4152.9 4157.3 4186.1 4203.3 4217.9 4218.9 4222.3 4237.5 4752.2 4768.2 4804.7 4806.4 4820.0 5401.6 5564.9 5603.1 5626.0 5631.4 1328.0 1349.3 1419.7 1441.0 1441.7 983.2 999.0 1012.2 1014.8 1016.5 5241.5 5281.3 5285.5 5292.6 5346.2 5592.0 5623.8 5630.1 5630.6 5666.3 5225.5 5294.5 5326.5 5333.4 5373.8 2639.7 2650.0 2654.0 2669.1 2682.6 5111.5 5115.3 5115.8 5206.6 5212.6 4918.8 5183.3 5197.3 5198.9 5239.5 5167.5 5195.2 5241.8 5245.8 5259.4 5018.5 5041.9 5042.7 5071.3 5076.3 4783.8 4899.5 4940.2 4958.6 4970.8 5072.9 5107.2 5130.5 5139.1 5165.9 3764.4 3780.4 3780.6 3786.2 3791.1 4915.9 4964.2 5005.8 5391.6 5527.0 5390.2 5499.7 5526.5 5532.5 5542.7 5568.6 5584.3 5615.5 5626.5 5628.8 5267.9 5536.3 5558.4 5564.6 5582.6 5649.7 5672.0 5675.4 5675.6 5680.3 5451.3 5523.6 5564.2 5590.2 5594.8 03:43:50 INFO - PROCESS | 24260 | 03:43:50 INFO - PROCESS | 24260 | [#5] yui.html Cycles:180 Average:19592.77 Median:4686.50 stddev:28200.08 (601.7%) stddev-sans-first:28243.60 03:43:50 INFO - PROCESS | 24260 | Values: 725.8 729.3 729.7 753.9 792.9 15429.7 16835.0 16873.7 16928.6 16995.5 14282.6 14452.5 14472.6 14479.4 14543.0 648.9 662.0 776.0 778.0 796.0 809.7 810.1 810.9 813.8 817.2 863.6 863.7 864.7 865.7 870.3 691.0 708.6 711.8 720.7 860.1 610.8 619.3 619.7 628.2 628.7 14474.1 14501.5 14542.3 14549.1 14562.1 12961.7 13150.9 13219.5 13715.3 13810.8 10999.9 11200.4 11239.6 12673.3 12842.6 4383.3 4404.8 4514.5 4594.9 4608.0 68244.3 68919.3 70735.0 70996.3 71442.6 10680.9 10794.2 11001.4 11125.7 11409.1 20970.5 21156.7 21268.1 21310.5 21355.8 8185.5 8387.3 8413.8 8656.4 8696.5 4537.8 4552.0 4666.0 4707.0 4741.7 3524.1 3665.8 3668.9 3674.8 3676.3 592.6 606.2 615.1 616.7 618.6 556.4 578.8 645.1 654.2 654.3 8814.3 9166.8 9184.0 9278.4 9354.2 563.0 615.5 678.2 705.9 707.7 4379.2 4511.9 4550.9 4622.6 4745.8 76457.2 89032.0 122006.4 122060.0 122538.0 58344.4 81344.0 99824.5 101611.0 101951.4 79569.6 88345.6 88907.6 89593.6 94716.5 8380.0 8479.0 8914.8 9712.6 9948.3 35267.3 38045.6 50232.2 51473.0 54895.7 49262.8 50740.4 71644.6 79265.0 79487.5 12320.7 12431.4 12958.5 13008.6 13297.7 14529.9 14587.6 14901.6 14916.6 16168.8 9006.5 11620.1 11985.0 12166.6 13374.0 12894.7 13337.5 13459.0 13629.5 14170.9 11675.3 11877.3 11926.0 11972.3 12593.4 11096.1 11262.9 11397.7 11510.2 11912.5 9888.4 9942.2 10206.2 10256.2 10363.4 03:43:50 INFO - PROCESS | 24260 | -------- Summary: end -------- 03:43:50 INFO - PROCESS | 24260 | 03:43:51 INFO - TEST-INFO | 24260: exit 0 03:43:51 INFO - TEST-OK | dromaeo_css | took 1117305ms 03:43:51 INFO - TEST-START | kraken 03:43:51 INFO - operating with platform_type : linux_ 03:43:51 INFO - Initialising browser for kraken test... 03:43:51 INFO - TEST-INFO | started process 24567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCMTSvF/profile http://localhost:52037/getInfo.html) 03:43:55 INFO - PROCESS | 24567 | __metrics Screen width/height:1600/1200 03:43:55 INFO - PROCESS | 24567 | colorDepth:24 03:43:55 INFO - PROCESS | 24567 | Browser inner width/height: 1024/697 03:43:55 INFO - PROCESS | 24567 | __metrics 03:43:55 INFO - PROCESS | 24567 | 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" 03:43:55 INFO - PROCESS | 24567 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:43:56 INFO - PROCESS | 24567 | console.error: PushService: 03:43:56 INFO - PROCESS | 24567 | stateChangeProcessEnqueue: Error transitioning state 03:43:56 INFO - PROCESS | 24567 | UnknownError 03:43:56 INFO - TEST-INFO | 24567: exit 0 03:43:56 INFO - Browser initialized. 03:43:56 INFO - Running cycle 1/1 for kraken test... 03:43:56 INFO - TEST-INFO | started process 24649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCMTSvF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:08 INFO - PROCESS | 24649 | RSS: Main: 173092864 03:44:08 INFO - PROCESS | 24649 | 03:44:11 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52037/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:12 INFO - PROCESS | 24649 | RSS: Main: 232656896 03:44:12 INFO - PROCESS | 24649 | 03:44:14 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52037/tests/kraken/driver.html?testName=audio-dft) 03:44:15 INFO - PROCESS | 24649 | RSS: Main: 216805376 03:44:15 INFO - PROCESS | 24649 | 03:44:18 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52037/tests/kraken/driver.html?testName=audio-fft) 03:44:19 INFO - PROCESS | 24649 | RSS: Main: 298782720 03:44:19 INFO - PROCESS | 24649 | 03:44:21 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52037/tests/kraken/driver.html?testName=audio-oscillator) 03:44:21 INFO - PROCESS | 24649 | RSS: Main: 208498688 03:44:21 INFO - PROCESS | 24649 | 03:44:24 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:24 INFO - PROCESS | 24649 | RSS: Main: 211775488 03:44:24 INFO - PROCESS | 24649 | 03:44:27 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52037/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:28 INFO - PROCESS | 24649 | RSS: Main: 249241600 03:44:28 INFO - PROCESS | 24649 | 03:44:31 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52037/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:32 INFO - PROCESS | 24649 | RSS: Main: 247672832 03:44:32 INFO - PROCESS | 24649 | 03:44:35 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52037/tests/kraken/driver.html?testName=json-parse-financial) 03:44:35 INFO - PROCESS | 24649 | RSS: Main: 248328192 03:44:35 INFO - PROCESS | 24649 | 03:44:37 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:37 INFO - PROCESS | 24649 | RSS: Main: 211103744 03:44:37 INFO - PROCESS | 24649 | 03:44:39 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:40 INFO - PROCESS | 24649 | RSS: Main: 217944064 03:44:40 INFO - PROCESS | 24649 | 03:44:42 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:42 INFO - PROCESS | 24649 | RSS: Main: 222203904 03:44:42 INFO - PROCESS | 24649 | 03:44:45 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:46 INFO - PROCESS | 24649 | RSS: Main: 222703616 03:44:46 INFO - PROCESS | 24649 | 03:44:49 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:49 INFO - PROCESS | 24649 | RSS: Main: 221855744 03:44:49 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | Cycle 1(1): loaded http://localhost:52037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52037/tests/kraken/driver.html?testName=ai-astar) 03:44:51 INFO - PROCESS | 24649 | RSS: Main: 272818176 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | __start_tp_report 03:44:51 INFO - PROCESS | 24649 | _x_x_mozilla_page_load 03:44:51 INFO - PROCESS | 24649 | _x_x_mozilla_page_load_details 03:44:51 INFO - PROCESS | 24649 | |i|pagename|runs| 03:44:51 INFO - PROCESS | 24649 | |0;ai-astar;109;109;110;110;110;109;108;109;111;108 03:44:51 INFO - PROCESS | 24649 | |1;audio-beat-detection;164;127;122;170;123;123;122;120;151;124 03:44:51 INFO - PROCESS | 24649 | |2;audio-dft;162;161;162;161;162;163;163;163;161;162 03:44:51 INFO - PROCESS | 24649 | |3;audio-fft;75;75;76;103;76;76;76;75;112;77 03:44:51 INFO - PROCESS | 24649 | |4;audio-oscillator;83;82;113;82;84;83;103;83;82;116 03:44:51 INFO - PROCESS | 24649 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;116;116 03:44:51 INFO - PROCESS | 24649 | |6;imaging-darkroom;146;147;145;146;146;147;148;147;147;147 03:44:51 INFO - PROCESS | 24649 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:44:51 INFO - PROCESS | 24649 | |8;json-parse-financial;53;57;52;52;53;53;53;53;53;53 03:44:51 INFO - PROCESS | 24649 | |9;json-stringify-tinderbox;60;62;61;61;61;61;61;60;61;63 03:44:51 INFO - PROCESS | 24649 | |10;stanford-crypto-aes;80;80;80;80;79;79;81;80;80;88 03:44:51 INFO - PROCESS | 24649 | |11;stanford-crypto-ccm;137;139;128;130;128;134;141;133;167;140 03:44:51 INFO - PROCESS | 24649 | |12;stanford-crypto-pbkdf2;172;178;171;166;168;170;169;167;171;169 03:44:51 INFO - PROCESS | 24649 | |13;stanford-crypto-sha256-iterative;67;66;68;66;67;69;65;66;64;65 03:44:51 INFO - PROCESS | 24649 | __end_tp_report 03:44:51 INFO - PROCESS | 24649 | __start_cc_report 03:44:51 INFO - PROCESS | 24649 | _x_x_mozilla_cycle_collect,1625 03:44:51 INFO - PROCESS | 24649 | __end_cc_report 03:44:51 INFO - PROCESS | 24649 | __startTimestamp1475318691612__endTimestamp 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | ------- Summary: start ------- 03:44:51 INFO - PROCESS | 24649 | Number of tests: 14 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.50 stddev:0.95 (0.9%) stddev-sans-first:1.00 03:44:51 INFO - PROCESS | 24649 | Values: 109.0 109.0 110.0 110.0 110.0 109.0 108.0 109.0 111.0 108.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:125.50 stddev:19.31 (15.4%) stddev-sans-first:17.31 03:44:51 INFO - PROCESS | 24649 | Values: 164.0 127.0 122.0 170.0 123.0 123.0 122.0 120.0 151.0 124.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:44:51 INFO - PROCESS | 24649 | Values: 162.0 161.0 162.0 161.0 162.0 163.0 163.0 163.0 161.0 162.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.57 (17.9%) stddev-sans-first:14.15 03:44:51 INFO - PROCESS | 24649 | Values: 75.0 75.0 76.0 103.0 76.0 76.0 76.0 75.0 112.0 77.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.50 stddev:13.89 (16.8%) stddev-sans-first:14.42 03:44:51 INFO - PROCESS | 24649 | Values: 83.0 82.0 113.0 82.0 84.0 83.0 103.0 83.0 82.0 116.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:44:51 INFO - PROCESS | 24649 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 03:44:51 INFO - PROCESS | 24649 | Values: 146.0 147.0 145.0 146.0 146.0 147.0 148.0 147.0 147.0 147.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:44:51 INFO - PROCESS | 24649 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.40 (2.6%) stddev-sans-first:1.48 03:44:51 INFO - PROCESS | 24649 | Values: 53.0 57.0 52.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 03:44:51 INFO - PROCESS | 24649 | Values: 60.0 62.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 63.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.63 (3.3%) stddev-sans-first:2.77 03:44:51 INFO - PROCESS | 24649 | Values: 80.0 80.0 80.0 80.0 79.0 79.0 81.0 80.0 80.0 88.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:138.00 stddev:11.35 (8.2%) stddev-sans-first:12.04 03:44:51 INFO - PROCESS | 24649 | Values: 137.0 139.0 128.0 130.0 128.0 134.0 141.0 133.0 167.0 140.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:3.35 (2.0%) stddev-sans-first:3.48 03:44:51 INFO - PROCESS | 24649 | Values: 172.0 178.0 171.0 166.0 168.0 170.0 169.0 167.0 171.0 169.0 03:44:51 INFO - PROCESS | 24649 | 03:44:51 INFO - PROCESS | 24649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.49 (2.2%) stddev-sans-first:1.56 03:44:51 INFO - PROCESS | 24649 | Values: 67.0 66.0 68.0 66.0 67.0 69.0 65.0 66.0 64.0 65.0 03:44:51 INFO - PROCESS | 24649 | -------- Summary: end -------- 03:44:51 INFO - PROCESS | 24649 | 03:44:52 INFO - TEST-INFO | 24649: exit 0 03:44:52 INFO - TEST-OK | kraken | took 61602ms 03:44:52 INFO - SUITE-END | took 1178s 03:44:52 INFO - Completed test suite (00:19:38) 03:44:52 INFO - javascript benchmark 03:44:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2970.465316243076, 2994.056872085293, 2999.62504686914, 3023.606931098957, 3051.6948305169485, 5108.770105345259, 5180.378354597449, 5213.348331458567, 5269.525742683158, 5307.6550024248445, 5226.24219488174, 5256.526912577867, 5319.627626066177, 5354.357477102753, 5375.946240537593, 4792.137415265251, 4806.375171227735, 4821.951780482185, 4822.541858523435, 4891.828785992491, 4896.143174944388, 4938.2098864181735, 4944.802207911697, 4947.925781113287, 4976.576990955773, 4709.481956984729, 4759.952400475986, 4827.975860120677, 4893.559579637814, 4925.458199598042, 4752.762361881927, 4786.138495070886, 4799.712017278975, 4816.20532612122, 4868.391451068616, 4737.597304229144, 4743.620510359163, 4754.334393184957, 4767.928481072787, 4871.8782030449165, 5239.5546378557865, 5268.92096618551, 5273.419923808378, 5278.155495120801, 5288.8413347599635, 5389.137737961946, 5400.0, 5474.7262636868, 5475.890482190373, 5631.577631677641, 5492.670439773627, 5498.560115190775, 5503.064479038573, 5523.475269849358, 5587.413321601214, 5137.768800403991, 5141.074606570815, 5142.820001299974, 5155.9742201288755, 5198.090334191577, 5420.972895135578, 5482.945170548323, 5549.250851135045, 5608.130739735266, 5658.0, 5443.891122177534, 5445.673259604437, 5458.836234912959, 5495.587830912697, 5519.254900588449, 5523.171524271392, 5524.1989911462615, 5534.529564987021, 5542.0, 5544.417836127229, 5293.047251494768, 5423.4847689470225, 5433.157860531624, 5522.116461366242, 5595.272614560081, 5477.068898287301, 5513.724313784295, 5524.226608274845, 5570.693611851387, 5596.636218645775, 4260.339647354665, 4295.548967358445, 4302.849400270976, 4305.375720520569, 4351.9564804352185, 3803.581606023335, 3805.257974694963, 3846.576876543578, 3860.729748917605, 3902.1415288636454, 5222.660527065805, 5289.021531016697, 5300.178472336794, 5305.628605997543, 5368.892622147613, 5599.1041433370465, 5611.0, 5611.298587676541, 5614.157876318585, 5617.157426386075, 5125.1799712045895, 5280.841574752763, 5294.708791016454, 5302.761375738101, 5368.651037682538, 4720.645951553579, 4776.0, 4840.540148685869, 4878.268259760993, 4894.11905856942, 5832.825015249549, 5835.649861008353, 5890.440408161217, 5901.734421950937, 5910.34986151523, 5577.637453565505, 5673.319201695823, 5686.2607860977805, 5688.914666279927, 5690.459406356389, 5551.444855514416, 5581.49766521015, 5838.0, 5838.153467747068, 5841.036229022164, 5420.674759514442, 5422.213779001943, 5425.484578964992, 5428.7014214217015, 5429.972850135724, 5509.393966663744, 5510.338759348904, 5517.089680202722, 5521.089020311764, 5525.889482210414, 5367.114426119647, 5386.461353864583, 5391.892162156656, 5394.811181608625, 5397.244385786072, 5375.758090885842, 5385.084535628874, 5387.3804512481565, 5390.164524498709, 5395.190721391823, 5361.195820626781, 5370.0, 5377.354717433933, 5380.596455265949, 5381.165919282517, 5466.070767969375, 5480.232767412485, 5495.175723641486, 5500.972495137658, 5505.697186654773, 5389.8922021558565, 5391.16436952273, 5398.46015398457, 5401.891962160814, 5403.324584426947], "value": 5146.240669472074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.8981678206313, 587.362711458068, 604.9092636104587, 608.7108623403884, 611.4955161991359, 31302.68697313026, 40906.59093409065, 41406.17187656249, 41481.377779333336, 46624.300635490494, 44449.55550444494, 44718.776406117926, 44787.77606111965, 44900.77549612247, 44926.550734492645, 8937.374383793122, 9093.18161365477, 9093.40892841963, 9097.22673572747, 9103.908960910405, 8087.595620218965, 8286.41995060346, 10538.420386878719, 10792.838107428395, 10800.459977001157, 10931.125509959184, 10991.340519568852, 11022.677278726564, 11029.0, 11029.393383363911, 10819.350838949687, 10888.183386246063, 10889.945550272278, 10898.400587967659, 10905.127589792797, 10623.25637205396, 10691.679249622524, 10694.41180735067, 10703.571857125706, 10704.250702450832, 42971.35542966858, 43323.13353732908, 43360.783196084136, 43379.783101084606, 43413.34879976803, 3326.600807903043, 3480.2517458746493, 3616.5117709109195, 3871.1676989447124, 4054.1756209705454, 32390.02829915083, 32443.837780810944, 32487.51268730971, 32643.6735632643, 32996.1750956228, 4307.719998200107, 4472.888177795581, 4534.41052663155, 4581.1753884300815, 4666.953330466686, 322206.0, 323599.0, 324948.0, 326562.9999999976, 329320.0, 34137.658623413445, 35075.29849402998, 35094.47358289628, 57845.13232301519, 58128.0, 35929.0, 36074.819625901706, 36125.0, 36139.81930090385, 36227.456588151195, 12639.0, 12694.174878632859, 12740.80888786669, 12757.362131893367, 12762.553310634083, 9261.629534818667, 9472.810543789086, 10432.269741118049, 10496.055355018085, 10508.894911050944, 8076.798080048045, 8151.714689985941, 8154.266116049584, 8460.8730869037, 8695.478271303742, 3329.3674201901563, 3356.781809182395, 3420.3843308204764, 3452.879149229815, 3455.550778398792, 891.8171774786283, 974.9853752193723, 975.2149519636619, 998.2313618513704, 1061.713337398898, 31789.364212715616, 31937.84031079876, 31999.36001280008, 32114.518282225785, 32511.837440812644, 1040.765827688764, 1063.5214153630898, 1076.8923107689325, 1096.4353358020626, 1119.6137332620397, 16166.35334586627, 16907.830921690627, 16927.661446770995, 16941.0, 17005.82994170067, 483131.0, 537805.0, 544010.0, 544704.6354437493, 545418.0, 49067.0, 54710.0, 55510.0, 55603.0, 60817.69591152016, 1280.6798300424894, 1294.3398866578113, 1296.0862591872708, 1298.3573131300068, 1308.5943357559188, 30413.239669008453, 32684.836575816968, 32934.34131317312, 33078.50382244316, 33238.50142247917, 51023.74488127536, 51509.48490515047, 51590.484095158565, 51629.48370516397, 51774.741126294124, 446617.0, 446950.0, 448369.0, 448399.0, 449306.5346732585, 28854.0, 28930.515770055674, 29348.413031739674, 29352.85323573454, 29378.85310573519, 45676.0, 46996.0, 47033.76483117563, 47164.76417618027, 47376.28935566038, 39551.0, 39810.60189398069, 39902.0, 41091.0, 41334.1733165341, 38960.61039389683, 39570.208595827346, 40536.391954120125, 40558.59441405548, 41060.79469602633, 39711.0, 40926.59073409228, 41070.58929410668, 41159.588404116774, 41190.1761964765, 34753.65246347504, 36043.27913441769, 36161.63838361583, 36745.816270918476, 37050.81474592718, 27947.860260698566, 28047.43905121927, 28104.71895281103, 28165.0, 28493.0], "value": 18835.639230128232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.20932413958263, 385.7666112002237, 395.1642276585023, 399.6523024968277, 425.2855203258524, 13064.542741004067, 15345.616359591002, 16304.657545203248, 19386.903065484654, 19844.0, 19119.52201194971, 19263.903680481613, 19729.506762330948, 19771.505712357197, 19837.90081049593, 4941.925871111918, 5716.857078573038, 5972.611780234271, 5974.4324289192455, 5977.073553599199, 5801.883962320751, 5817.389174136718, 5829.242198514187, 5835.620684655484, 5865.970670146643, 5598.356189038252, 5783.392743761908, 5816.447437493432, 5817.970910145444, 5821.068629019358, 5738.3687794342795, 5764.16419619157, 5784.508316793078, 5784.652920824764, 5792.884142317151, 5042.823501177441, 5227.869303267411, 5231.843044708627, 5247.793007608271, 5291.126964050927, 12535.686607834787, 12766.936165319206, 12783.0, 13133.671658208621, 21916.780832191635, 2118.5127420693325, 2166.7724888886596, 2319.22306027481, 2402.8318017738766, 2860.4851126797166, 9576.90423095767, 9672.951635241849, 10022.749431264203, 10120.94939525305, 13220.86779132206, 1844.9907750461161, 1867.8318951294448, 1873.082189727024, 1884.1709647754944, 1898.506388339028, 70648.2935170652, 73616.0, 76790.23209767943, 77011.99999999943, 78349.0, 10813.0, 11023.559057637765, 11042.558297668164, 11211.159163062803, 11636.825447618292, 15897.920510397375, 15900.443484477988, 15907.761383579023, 15922.68154636924, 15929.123898185479, 7533.698652053857, 7590.316871481593, 7729.884051739228, 7741.419393545507, 7821.960890195513, 6881.621510816853, 6958.321046397073, 6988.650567471606, 7106.182788979334, 7169.89245161323, 4422.823087076546, 4451.532589078165, 4528.5245049270015, 4592.816287348535, 4856.514348565115, 1958.588696373749, 2003.6894281386408, 2029.147757941668, 2034.3490083173242, 2051.302557130553, 713.6859781696037, 790.2611058660171, 927.8608208768603, 928.3919033033374, 1021.9284650074572, 18756.343527976456, 19336.613267734847, 19481.805181948283, 19553.902230488755, 19912.303069392503, 871.6818361298081, 947.6588428165854, 955.5795450002116, 1009.9242556808268, 1068.257560995101, 10228.386296822215, 10574.841377379345, 10613.0, 10791.244612877023, 10929.071028962468, 432139.0, 432918.0, 434545.0, 435401.0, 436827.0, 84468.0, 89144.07410925509, 89595.55202223947, 89959.0, 90063.54968225247, 1019.97450063749, 1045.4354648489882, 1056.3820165203288, 1057.4131357096885, 1060.3955745225148, 16363.918180409499, 16594.917025415278, 17230.827691723425, 17274.740878887078, 17435.72824657967, 38163.236735265695, 38354.61645383511, 38548.42177367285, 38654.0, 39015.41476877906, 53120.0, 53653.731731342654, 54109.45890541044, 54457.45542544524, 56128.15807762805, 8162.551059691774, 8387.245147936716, 8557.871631925402, 8724.171203735636, 8812.118788121394, 11445.599404020819, 12721.872781272068, 12795.296258705861, 13019.153755005895, 13024.54414095502, 10769.784604308026, 11323.886761132613, 11362.94318528402, 11535.480903359537, 11765.294082355085, 8134.698448248252, 10891.292066015683, 11014.724631884266, 11183.776324473627, 11314.264572802742, 10761.623343182951, 10983.066439352744, 11303.491342889754, 11481.311121332747, 11487.36819474937, 8027.678892844221, 8148.429609927485, 8542.82914341722, 8610.311175106102, 8619.094995025684, 8602.311815054905, 8874.890638670166, 11412.543498259976, 11633.476493557979, 11841.171118022], "value": 8819.736471910419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.1557538839782, 1453.4331610671836, 1602.8958117722348, 1745.5025317784434, 1780.261191605483, 7558.924410755891, 7774.727884524043, 8126.309263712584, 8818.647254109836, 8826.426282291655, 8158.0, 8384.790380240496, 8410.411271211018, 8742.300615950724, 8743.519106449143, 2260.2993072147606, 2268.2288022072494, 2285.725712914444, 2287.2109122352763, 2288.0733303012225, 1894.3748562974185, 1957.0214892553722, 2186.223890518867, 2194.7476040255415, 2267.455810605451, 2233.698450709158, 2283.2807665585287, 2285.337252196869, 2286.0855657736956, 2287.63397856343, 2196.7473740519804, 2206.8124209442217, 2209.3482422685347, 2212.214663794346, 2212.4358288636454, 2210.933671989843, 2221.4002219400672, 2226.899789509476, 2230.8996095175758, 2252.9436764080865, 8529.0, 8592.269657079156, 8594.828103437896, 8596.097409772008, 8597.613107410181, 4681.5318468153255, 4858.611311095104, 4867.318575399447, 4878.146324393252, 4885.584725298354, 3055.9694403055905, 3230.628477725045, 3287.4575695010535, 3290.8190049547266, 3304.3391321735508, 1087.7933192693442, 1118.6364431559693, 1126.5887950897945, 1143.6111722014555, 1151.424287856072, 11586.131040171937, 11623.360715160663, 11641.883581164164, 11644.6506604802, 11664.708382290426, 4058.1477889642915, 4225.936610950838, 4377.9781101094295, 4380.737155770664, 4434.201843668171, 9930.404175749478, 9938.354006989523, 9954.651587194414, 9955.0, 9957.601695932226, 4970.627202959792, 4978.352814134139, 4993.076280888047, 4995.9500404996215, 4996.4254110777, 4430.424044874146, 4541.114482675846, 4557.361969324297, 4564.452265728134, 4575.0, 3733.8133093345223, 3785.2240290740333, 3927.9018024549046, 3943.901402464904, 4093.9385909211387, 1072.0, 1106.0985296982933, 1202.9578964736193, 1219.408586835384, 1268.1693490763564, 784.2432053068816, 934.8270569944582, 938.0759951447818, 943.5612440215333, 977.9315447918577, 5725.5133313667975, 5771.105478650816, 5834.329052159056, 5856.765729370863, 5985.25184351956, 943.1087622196958, 954.2842867849113, 956.6556039825657, 957.7414098193449, 980.1521683743653, 3758.969138714392, 3857.96142038576, 4084.326086195804, 4216.873493795191, 4252.447181866338, 10433.9478302608, 10657.573697052187, 10708.08981236588, 10774.676759697064, 10882.61910833117, 10600.893991059991, 10603.94698026505, 10663.680089597325, 10744.194185436123, 10778.29941053829, 7530.887036694454, 7984.800379990546, 8068.273855352929, 8076.353891688651, 8081.111077781439, 5307.416184219655, 5551.2228288040515, 5588.133839254922, 5643.1535269709875, 5816.941830581809, 8743.825123497621, 8768.517731524827, 8940.418872773249, 9009.27925765924, 9026.368154229403, 8902.243309318781, 9130.680426185052, 9169.724908252763, 9228.630854766003, 9249.768755781159, 7396.223396543285, 7442.62786860644, 7547.886781698169, 7617.352525035434, 7810.843783124419, 8365.0, 8388.245057944814, 8411.495310281403, 8472.661093556435, 8485.321174306164, 7209.71161153548, 7222.566646001257, 7428.442866784904, 7516.624168791429, 7745.070591529053, 7242.89135662955, 7356.190819010012, 7360.742374016883, 7523.059617547807, 7586.848263034819, 6734.855074637421, 6851.3491218334175, 6852.074969879002, 6853.657317134023, 6856.725730970905, 4740.549647783455, 4762.809487620457, 4893.804247830047, 4896.902061958812, 4902.117618828645, 4747.240441529339, 4765.404324459442, 4853.0, 4865.56209941107, 4880.459689779229], "value": 4451.480550489926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2573765424761, 335.2540597171294, 343.08225496796064, 345.86165533786465, 346.7867261634096, 5188.844334669957, 5319.228711836791, 5319.78720851166, 5399.217113518543, 5433.972830135844, 5150.562202212807, 5300.496452836984, 5301.390340110879, 5315.787368505265, 5320.4679532046775, 4195.580441955811, 4223.282042052859, 4240.851570195044, 4247.893802654935, 4256.0, 4146.626803587692, 4235.174141042498, 4258.361245813137, 4264.808083636229, 4266.445362102922, 4169.833206671745, 4208.410822484854, 4208.463910672598, 4214.199302132601, 4216.861447409197, 4166.64583510402, 4177.519585247705, 4211.010182770222, 4214.115035842461, 4233.153369326147, 3514.0687717754818, 3643.599204087548, 3654.4152935530187, 3670.1742108025746, 3756.793376364299, 5146.536811686966, 5148.6910785353, 5168.53483186515, 5171.5862730981435, 5178.818741344073, 4720.409948756405, 4755.191617425046, 4780.880477988043, 4800.231962885957, 4822.879428014293, 5290.444503327172, 5504.357908204084, 5510.118381059051, 5557.638753481051, 5647.8588035299035, 4033.97983010086, 4054.7161698681102, 4057.6348128668265, 4062.9187416251807, 4062.939055914164, 5718.885622287573, 5747.885042299131, 5756.510696590794, 5792.160136780143, 5797.942020579782, 4060.26915155269, 4151.522574903925, 4152.941000044969, 4157.251694694984, 4186.099988502487, 4203.26442872496, 4217.852375166915, 4218.8523401680795, 4222.282212023963, 4237.533871274158, 4752.215884379108, 4768.165571025057, 4804.73573953429, 4806.351142595775, 4820.0, 5401.648892822032, 5564.944350556523, 5603.066941905117, 5625.961980530549, 5631.352394474606, 1327.9601611951657, 1349.305107869448, 1419.6734751007325, 1440.9783853242209, 1441.654003039263, 983.1839573154265, 998.9900100998897, 1012.1548506996741, 1014.8021135878433, 1016.537475448669, 5241.488202904064, 5281.313429254173, 5285.471452854684, 5292.576593872558, 5346.1713434417725, 5591.9720401397735, 5623.775048998076, 5630.0991841305195, 5630.592351912022, 5666.291713535808, 5225.451327610622, 5294.549963253166, 5326.523166727413, 5333.386660534088, 5373.7581808818695, 2639.6700412448445, 2649.986750066276, 2654.0492737837676, 2669.079167687145, 2682.611021401925, 5111.463296353903, 5115.258287548285, 5115.820946266937, 5206.583473322201, 5212.64471237481, 4918.827841025547, 5183.300254465675, 5197.324347834833, 5198.870028249324, 5239.476052394806, 5167.534921857051, 5195.246689229964, 5241.790328386822, 5245.763940622604, 5259.368875735013, 5018.4981501849525, 5041.941192349647, 5042.672226305279, 5071.340725705634, 5076.289174678487, 4783.832565860178, 4899.534544218293, 4940.160172770709, 4958.578520825626, 4970.763156579482, 5072.873178170576, 5107.182850743863, 5130.51260130287, 5139.124219659872, 5165.93362654941, 3764.3788774852937, 3780.3573392522785, 3780.603036681219, 3786.1670432504807, 3791.0711875590655, 4915.91849793045, 4964.2128833619145, 5005.7997680092385, 5391.59563032782, 5526.972365138148, 5390.164524498709, 5499.697516636464, 5526.47498487643, 5532.474414930575, 5542.69515176653, 5568.610197286313, 5584.329880414376, 5615.494605485526, 5626.521745651666, 5628.802991895264, 5267.947320526899, 5536.307961504812, 5558.44415558441, 5564.638298510746, 5582.609217354746, 5649.717514124195, 5672.0, 5675.404082571271, 5675.631083979528, 5680.261565996394, 5451.291332126798, 5523.613347065667, 5564.19319198722, 5590.189422533791, 5594.776208951596], "value": 4149.043879253276, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.7750097469785, 729.3363039633931, 729.6643543969774, 753.9321461068503, 792.8810678398236, 15429.691406171869, 16835.0, 16873.66252674949, 16928.576785580368, 16995.490135295946, 14282.642933926658, 14452.494162704308, 14472.5658230253, 14479.420823167087, 14543.0, 648.9059086432464, 662.0268205737558, 775.9689612415497, 777.9727709530167, 795.9801004974864, 809.6842231529708, 810.068421315489, 810.8662070758318, 813.8128230506958, 817.1909809288791, 863.6329559937033, 863.6718047142077, 864.6541383446609, 865.7359505350897, 870.3472395703222, 691.0394551573318, 708.6315116139605, 711.7971378157253, 720.6937051753036, 860.1355637584251, 610.8137018209444, 619.3218425823716, 619.6653806944245, 628.1927722876128, 628.7139351595059, 14474.131552106906, 14501.492447764384, 14542.27288635564, 14549.127052376785, 14562.126272423688, 12961.740765184644, 13150.868491315061, 13219.537316193888, 13715.314234288246, 13810.790273556182, 10999.890001099966, 11200.439978001068, 11239.60661376848, 12673.302968336739, 12842.550510732079, 4383.342498625232, 4404.823807047715, 4514.525974772667, 4594.885127871797, 4608.032313214229, 68244.31755682429, 68919.3108068918, 70735.0, 70996.29003709949, 71442.64278678625, 10680.946595266974, 10794.190435717353, 11001.449927503592, 11125.72185695348, 11409.144314176305, 20970.47573810667, 21156.682649760267, 21268.149274029176, 21310.467238318855, 21355.78644213538, 8185.508869467851, 8387.329013678891, 8413.831723365498, 8656.350773691873, 8696.521691307038, 4537.8411755588395, 4552.044070745114, 4666.043461090469, 4706.952930470651, 4741.668083234141, 3524.0661224775454, 3665.816709164531, 3668.926621467556, 3674.797886116289, 3676.338259113332, 592.5822295281816, 606.2119244981507, 615.0743131586933, 616.6793267500874, 618.5886385553647, 556.3546286307864, 578.7858492357855, 645.1065274594627, 654.2410803467955, 654.2868273581819, 8814.250788682906, 9166.770830729285, 9183.984185856174, 9278.443293402417, 9354.20489258407, 562.9971850140723, 615.5291202230297, 678.2043919922448, 705.8694141583824, 707.7098389660215, 4379.167958087953, 4511.932321015187, 4550.863474095782, 4622.6301895848255, 4745.786439610157, 76457.23542764613, 89032.0, 122006.3899680496, 122060.0, 122538.0, 58344.4165558339, 81344.0, 99824.50087749514, 101611.0, 101951.4121864518, 79569.60215198887, 88345.55827220694, 88907.55546222227, 89593.55203223941, 94716.52641736747, 8379.95810020946, 8479.0, 8914.8042110735, 9712.562934667816, 9948.303618746619, 35267.29465410729, 38045.619543804205, 50232.24651630155, 51473.0, 54895.72552137214, 49262.753686232776, 50740.418553959775, 71644.64177679078, 79265.0, 79487.52515191172, 12320.691982700504, 12431.440585173508, 12958.546450874173, 13008.609741707764, 13297.66755831112, 14529.927350363181, 14587.562373128823, 14901.552953411416, 14916.552503424915, 16168.757468637745, 9006.549672516217, 11620.128490363426, 11985.0, 12166.57416990401, 13374.0, 12894.742105158031, 13337.466501340226, 13459.0, 13629.522966696515, 14170.858291417366, 11675.299482031105, 11877.346745929057, 11926.0, 11972.341521216069, 12593.433295501542, 11096.112311014938, 11262.887371126511, 11397.658070257905, 11510.194286400207, 11912.52349905994, 9888.357256778287, 9942.204623630238, 10206.183505319408, 10256.230782691477, 10363.378197308186], "value": 7267.8564602718525, "unit": "score"}], "name": "dromaeo_css", "value": 6971.158622825752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 108.0, 109.0, 111.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 122.0, 170.0, 123.0, 123.0, 122.0, 120.0, 151.0, 124.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 163.0, 163.0, 163.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 103.0, 76.0, 76.0, 76.0, 75.0, 112.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 113.0, 82.0, 84.0, 83.0, 103.0, 83.0, 82.0, 116.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 63.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, 81.0, 80.0, 80.0, 88.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 128.0, 130.0, 128.0, 134.0, 141.0, 133.0, 167.0, 140.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 171.0, 166.0, 168.0, 170.0, 169.0, 167.0, 171.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 67.0, 69.0, 65.0, 66.0, 64.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1506.3, "alertThreshold": 2.0}]} 03:44:52 INFO - Return code: 0 03:44:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:52 INFO - # TBPL SUCCESS # 03:44:52 INFO - Running post-action listener: _resource_record_post_action 03:44:52 INFO - [mozharness: 2016-10-01 10:44:52.903306Z] Finished run-tests step (success) 03:44:52 INFO - Running post-run listener: _resource_record_post_run 03:44:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 393191424; Read time: 0; Write time: 284552 03:44:52 INFO - TinderboxPrint: CPU usage
13.1% 03:44:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:44:52 INFO - TinderboxPrint: I/O write bytes / time
393,191,424 / 284,552 03:44:52 INFO - TinderboxPrint: CPU idle
8,296.2 (86.9%) 03:44:52 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 03:44:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:44:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102993920; Read time: 0; Write time: 64060 03:44:53 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289243136; Read time: 0; Write time: 220440 03:44:53 INFO - Running post-run listener: _upload_blobber_files 03:44:53 INFO - Blob upload gear active. 03:44:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:53 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 03:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:54 INFO - (blobuploader) - INFO - Done attempting. 03:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:59 INFO - (blobuploader) - INFO - Done attempting. 03:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:00 INFO - (blobuploader) - INFO - Done attempting. 03:45:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:00 INFO - Return code: 0 03:45:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a7d485c4acc660b47c5d44da3950d870338d1acd051b677f149dea0a35e10c6040c1fcbf7f09b2a25dabd9252a7aeec438c461cca4c5c13632e04aa8fe1a8d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/528a88fff0733d3aff0fddf93533d7f67fd5db39862a85a83e482de442d75e4ca44959cbb08bd57475ae48d57e9a342441ca154717756865df881b5fddb62e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68092024369a6dde9eb14f7da8288c9820e927362c6b2c1dc684026899f1d43484b76b3df2aa8b87e50dc9a486218cdd9ed3af217658a30ab3024059ba5e2aab"} 03:45:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:00 INFO - Contents: 03:45:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a7d485c4acc660b47c5d44da3950d870338d1acd051b677f149dea0a35e10c6040c1fcbf7f09b2a25dabd9252a7aeec438c461cca4c5c13632e04aa8fe1a8d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/528a88fff0733d3aff0fddf93533d7f67fd5db39862a85a83e482de442d75e4ca44959cbb08bd57475ae48d57e9a342441ca154717756865df881b5fddb62e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68092024369a6dde9eb14f7da8288c9820e927362c6b2c1dc684026899f1d43484b76b3df2aa8b87e50dc9a486218cdd9ed3af217658a30ab3024059ba5e2aab"} 03:45:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:00 INFO - Copying logs to upload dir... 03:45:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.632964 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-01 03:45:00.225246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 03:45:00.229072) ========= 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=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a7d485c4acc660b47c5d44da3950d870338d1acd051b677f149dea0a35e10c6040c1fcbf7f09b2a25dabd9252a7aeec438c461cca4c5c13632e04aa8fe1a8d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/528a88fff0733d3aff0fddf93533d7f67fd5db39862a85a83e482de442d75e4ca44959cbb08bd57475ae48d57e9a342441ca154717756865df881b5fddb62e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68092024369a6dde9eb14f7da8288c9820e927362c6b2c1dc684026899f1d43484b76b3df2aa8b87e50dc9a486218cdd9ed3af217658a30ab3024059ba5e2aab"} build_url:https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/PStcsO0_RbaNWtF6YFWvJg/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/Fx-Team/sha512/9a7d485c4acc660b47c5d44da3950d870338d1acd051b677f149dea0a35e10c6040c1fcbf7f09b2a25dabd9252a7aeec438c461cca4c5c13632e04aa8fe1a8d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/528a88fff0733d3aff0fddf93533d7f67fd5db39862a85a83e482de442d75e4ca44959cbb08bd57475ae48d57e9a342441ca154717756865df881b5fddb62e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68092024369a6dde9eb14f7da8288c9820e927362c6b2c1dc684026899f1d43484b76b3df2aa8b87e50dc9a486218cdd9ed3af217658a30ab3024059ba5e2aab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 03:45:00.254203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:45:00.254500) ========= 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=923d835db2ba3686ebe126b700000192-1475296083.774900-724981943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 03:45:00.338498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 03:45:00.338825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 03:45:00.339109) ========= ========= Total master_lag: 0.17 =========