builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1476116323.74 results: success (0) buildid: 20161010063001 builduid: af0c1a2f18e64729b1181c50e09406cb revision: e70b480ce6c24db5f13e1c5f402592d1ef0922ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.735418) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.735796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.736211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.769054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.769318) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 09:18:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 227M=0s 2016-10-10 09:18:44 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.910180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.910453) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017379 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.958959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:43.959273) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e70b480ce6c24db5f13e1c5f402592d1ef0922ab --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 e70b480ce6c24db5f13e1c5f402592d1ef0922ab --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 09:18:44,607 truncating revision to first 12 chars 2016-10-10 09:18:44,607 Setting DEBUG logging. 2016-10-10 09:18:44,607 attempt 1/10 2016-10-10 09:18:44,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e70b480ce6c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 09:18:44,898 unpacking tar archive at: fx-team-e70b480ce6c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:44.603682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:44.603969) ========= script_repo_revision: e70b480ce6c24db5f13e1c5f402592d1ef0922ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:44.604329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:44.604586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 09:18:44.621554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-10 09:18:44.621824) ========= /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=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:45 INFO - MultiFileLogger online at 20161010 09:18:45 in /builds/slave/test 09:18:45 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 09:18:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:45 INFO - {'append_to_log': False, 09:18:45 INFO - 'base_work_dir': '/builds/slave/test', 09:18:45 INFO - 'blob_upload_branch': 'Fx-Team', 09:18:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:45 INFO - 'branch': 'Fx-Team', 09:18:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:45 INFO - 'config_files': ('talos/linux_config.py',), 09:18:45 INFO - 'default_actions': ('clobber', 09:18:45 INFO - 'read-buildbot-config', 09:18:45 INFO - 'download-and-extract', 09:18:45 INFO - 'populate-webroot', 09:18:45 INFO - 'create-virtualenv', 09:18:45 INFO - 'install', 09:18:45 INFO - 'run-tests'), 09:18:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:45 INFO - 'download_minidump_stackwalk': True, 09:18:45 INFO - 'download_symbols': 'ondemand', 09:18:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:45 INFO - 'installer_path': 'installer.exe', 09:18:45 INFO - 'log_level': 'info', 09:18:45 INFO - 'log_name': 'talos', 09:18:45 INFO - 'log_to_console': True, 09:18:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:45 INFO - 'opt_config_files': (), 09:18:45 INFO - 'pip_index': False, 09:18:45 INFO - 'sps_profile': False, 09:18:45 INFO - 'sps_profile_interval': 0, 09:18:45 INFO - 'suite': 'dromaeojs', 09:18:45 INFO - 'system_bits': '32', 09:18:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:45 INFO - 'title': 'talos-linux64-ix-053', 09:18:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:45 INFO - 'use_talos_json': True, 09:18:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:45 INFO - 'work_dir': 'build'} 09:18:45 INFO - [mozharness: 2016-10-10 16:18:45.383260Z] Running clobber step. 09:18:45 INFO - Running pre-action listener: _resource_record_pre_action 09:18:45 INFO - Running main action method: clobber 09:18:45 INFO - rmtree: /builds/slave/test/build 09:18:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:45 INFO - Running post-action listener: _resource_record_post_action 09:18:45 INFO - [mozharness: 2016-10-10 16:18:45.844464Z] Finished clobber step (success) 09:18:45 INFO - [mozharness: 2016-10-10 16:18:45.844563Z] Running read-buildbot-config step. 09:18:45 INFO - Running pre-action listener: _resource_record_pre_action 09:18:45 INFO - Running main action method: read_buildbot_config 09:18:45 INFO - Using buildbot properties: 09:18:45 INFO - { 09:18:45 INFO - "project": "", 09:18:45 INFO - "product": "firefox", 09:18:45 INFO - "script_repo_revision": "production", 09:18:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:18:45 INFO - "repository": "", 09:18:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:18:45 INFO - "buildid": "20161010063001", 09:18:45 INFO - "pgo_build": "True", 09:18:45 INFO - "basedir": "/builds/slave/test", 09:18:45 INFO - "buildnumber": 1629, 09:18:45 INFO - "slavename": "talos-linux64-ix-053", 09:18:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:18:45 INFO - "platform": "ubuntu64_hw", 09:18:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:18:45 INFO - "branch": "fx-team", 09:18:45 INFO - "repo_path": "integration/fx-team", 09:18:45 INFO - "revision": "e70b480ce6c24db5f13e1c5f402592d1ef0922ab", 09:18:45 INFO - "stage_platform": "linux64-pgo", 09:18:45 INFO - "builduid": "af0c1a2f18e64729b1181c50e09406cb", 09:18:45 INFO - "slavebuilddir": "test" 09:18:45 INFO - } 09:18:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:18:45 INFO - Running post-action listener: _resource_record_post_action 09:18:45 INFO - [mozharness: 2016-10-10 16:18:45.847013Z] Finished read-buildbot-config step (success) 09:18:45 INFO - [mozharness: 2016-10-10 16:18:45.847101Z] Running download-and-extract step. 09:18:45 INFO - Running pre-action listener: _resource_record_pre_action 09:18:45 INFO - Running main action method: download_and_extract 09:18:45 INFO - mkdir: /builds/slave/test/build/tests 09:18: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')]} 09:18:45 INFO - trying https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/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 09:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/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 09:18:46 INFO - Downloaded 1361 bytes. 09:18:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:46 INFO - Using the following test package requirements: 09:18:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:18:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:18:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'jsshell-linux-x86_64.zip'], 09:18:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:18:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:18:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:18:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:18:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:18:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:18:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:46 INFO - Http code: 200 09:18:46 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:18:46 INFO - x-amz-cf-id: R-dtFOC9Znt56fPkUPp_ZK36wjJsRmwkBZP1Q1VZoIIexDZkmvgSAA== 09:18:46 INFO - x-amz-version-id: Ez4BFrjzLkOmpr1bOZ8FpHvUjQu.Jz.8 09:18:47 INFO - Expected file size: 22089418 09:18:47 INFO - Obtained file size: 22089418 09:18:52 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 09:18:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:52 INFO - Http code: 200 09:18:52 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 09:18:52 INFO - x-amz-cf-id: B-F7DIH-5-x2eZn0rovcTwtkt6d3FbLNuSTd-tV1c7_3Nz-6j8MLqA== 09:18:52 INFO - x-amz-version-id: Ez4BFrjzLkOmpr1bOZ8FpHvUjQu.Jz.8 09:18:52 INFO - Expected file size: 22089418 09:18:52 INFO - Obtained file size: 22089418 09:18:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:18:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:18:58 INFO - Http code: 200 09:18:58 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:18:58 INFO - x-amz-cf-id: G2uPBg36lauZczdr5t_CtCXtkpudeIYqkfjBvfIdQarWEOI40pMEZg== 09:18:58 INFO - x-amz-version-id: H6lAnDtpRO4wHIgAo.yLN6GWEJsfzz8r 09:18:58 INFO - Expected file size: 14409006 09:18:58 INFO - Obtained file size: 14409006 09:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:58 INFO - trying https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/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 09:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/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 09:19:01 INFO - Downloaded 59728256 bytes. 09:19:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:19:01 INFO - mkdir: /builds/slave/test/properties 09:19:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:01 INFO - Contents: 09:19:01 INFO - build_url:https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:19:01 INFO - Running post-action listener: _resource_record_post_action 09:19:01 INFO - Running post-action listener: set_extra_try_arguments 09:19:01 INFO - [mozharness: 2016-10-10 16:19:01.724376Z] Finished download-and-extract step (success) 09:19:01 INFO - [mozharness: 2016-10-10 16:19:01.724602Z] Running populate-webroot step. 09:19:01 INFO - Running pre-action listener: _resource_record_pre_action 09:19:01 INFO - Running main action method: populate_webroot 09:19:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:01 INFO - '--tppagecycles', 09:19:01 INFO - '7'], 09:19:01 INFO - 'tests': ['tsvgm']}}, 09:19:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['damp', 'tps']}, 09:19:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'tests': ['damp', 'tps']}, 09:19:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['dromaeo_dom']}, 09:19:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['basic_compositor_video']}, 09:19:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['a11yr', 09:19:01 INFO - 'ts_paint', 09:19:01 INFO - 'tpaint', 09:19:01 INFO - 'sessionrestore', 09:19:01 INFO - 'sessionrestore_no_auto_restore', 09:19:01 INFO - 'tabpaint']}, 09:19:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['tsvgx', 09:19:01 INFO - 'tsvgr_opacity', 09:19:01 INFO - 'tart', 09:19:01 INFO - 'tscrollx', 09:19:01 INFO - 'cart']}, 09:19:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:01 INFO - 'tsvgr_opacity', 09:19:01 INFO - 'tart', 09:19:01 INFO - 'tscrollx', 09:19:01 INFO - 'cart']}, 09:19:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'talos_options': ['--disable-e10s'], 09:19:01 INFO - 'tests': ['tp5o']}, 09:19:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'tests': ['tp5o']}, 09:19:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'talos_options': ['--disable-e10s', 09:19:01 INFO - '--xperf_path', 09:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:01 INFO - 'tests': ['tp5n']}, 09:19:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:01 INFO - 'talos_options': ['--xperf_path', 09:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:01 INFO - 'tests': ['tp5n']}}, 09:19:01 INFO - 'talos.zip': {'path': '', 09:19:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:01 INFO - Running post-action listener: _resource_record_post_action 09:19:01 INFO - [mozharness: 2016-10-10 16:19:01.741819Z] Finished populate-webroot step (success) 09:19:01 INFO - [mozharness: 2016-10-10 16:19:01.741907Z] Running create-virtualenv step. 09:19:01 INFO - Running pre-action listener: _resource_record_pre_action 09:19:01 INFO - Running main action method: create_virtualenv 09:19:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:01 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 09:19:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:01 INFO - Using real prefix '/usr' 09:19:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:04 INFO - Installing pip.................done. 09:19:04 INFO - Return code: 0 09:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:04 INFO - Reading from file tmpfile_stdout 09:19:04 INFO - Output received: 09:19:04 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) 09:19:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:19:04 INFO - Using env: {'DISPLAY': ':0', 09:19:04 INFO - 'HOME': '/home/cltbld', 09:19:04 INFO - 'LANG': 'en_US.UTF-8', 09:19:04 INFO - 'LANGUAGE': 'en_US:en', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MAIL': '/var/mail/cltbld', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SHLVL': '1', 09:19:04 INFO - 'TERM': 'linux', 09:19:04 INFO - 'TMOUT': '86400', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - '_': '/tools/buildbot/bin/python'} 09:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:04 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 09:19:04 INFO - Cleaning up... 09:19:04 INFO - Return code: 0 09:19:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:19:04 INFO - Using env: {'DISPLAY': ':0', 09:19:04 INFO - 'HOME': '/home/cltbld', 09:19:04 INFO - 'LANG': 'en_US.UTF-8', 09:19:04 INFO - 'LANGUAGE': 'en_US:en', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MAIL': '/var/mail/cltbld', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SHLVL': '1', 09:19:04 INFO - 'TERM': 'linux', 09:19:04 INFO - 'TMOUT': '86400', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - '_': '/tools/buildbot/bin/python'} 09:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:04 INFO - Downloading/unpacking psutil>=3.1.1 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:07 INFO - Installing collected packages: psutil 09:19:07 INFO - Running setup.py install for psutil 09:19:07 INFO - building 'psutil._psutil_linux' extension 09:19:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:19:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:19:07 INFO - building 'psutil._psutil_posix' extension 09:19:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:19:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:19:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:07 INFO - Successfully installed psutil 09:19:07 INFO - Cleaning up... 09:19:07 INFO - Return code: 0 09:19:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:07 INFO - Using env: {'DISPLAY': ':0', 09:19:07 INFO - 'HOME': '/home/cltbld', 09:19:07 INFO - 'LANG': 'en_US.UTF-8', 09:19:07 INFO - 'LANGUAGE': 'en_US:en', 09:19:07 INFO - 'LOGNAME': 'cltbld', 09:19:07 INFO - 'MAIL': '/var/mail/cltbld', 09:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:07 INFO - 'MOZ_NO_REMOTE': '1', 09:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:07 INFO - 'NO_EM_RESTART': '1', 09:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:07 INFO - 'PWD': '/builds/slave/test', 09:19:07 INFO - 'SHELL': '/bin/bash', 09:19:07 INFO - 'SHLVL': '1', 09:19:07 INFO - 'TERM': 'linux', 09:19:07 INFO - 'TMOUT': '86400', 09:19:07 INFO - 'USER': 'cltbld', 09:19:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:07 INFO - '_': '/tools/buildbot/bin/python'} 09:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:09 INFO - Installing collected packages: mozsystemmonitor 09:19:09 INFO - Running setup.py install for mozsystemmonitor 09:19:09 INFO - Successfully installed mozsystemmonitor 09:19:09 INFO - Cleaning up... 09:19:09 INFO - Return code: 0 09:19:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:09 INFO - Using env: {'DISPLAY': ':0', 09:19:09 INFO - 'HOME': '/home/cltbld', 09:19:09 INFO - 'LANG': 'en_US.UTF-8', 09:19:09 INFO - 'LANGUAGE': 'en_US:en', 09:19:09 INFO - 'LOGNAME': 'cltbld', 09:19:09 INFO - 'MAIL': '/var/mail/cltbld', 09:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:09 INFO - 'MOZ_NO_REMOTE': '1', 09:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:09 INFO - 'NO_EM_RESTART': '1', 09:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:09 INFO - 'PWD': '/builds/slave/test', 09:19:09 INFO - 'SHELL': '/bin/bash', 09:19:09 INFO - 'SHLVL': '1', 09:19:09 INFO - 'TERM': 'linux', 09:19:09 INFO - 'TMOUT': '86400', 09:19:09 INFO - 'USER': 'cltbld', 09:19:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:09 INFO - '_': '/tools/buildbot/bin/python'} 09:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:12 INFO - warning: no files found matching '*.txt' 09:19:12 INFO - no previously-included directories found matching 'build' 09:19:12 INFO - no previously-included directories found matching 'dist' 09:19:12 INFO - no previously-included directories found matching '.git*' 09:19:12 INFO - Installing collected packages: jsonschema, functools32 09:19:12 INFO - Running setup.py install for functools32 09:19:12 INFO - warning: no files found matching '*.txt' 09:19:12 INFO - no previously-included directories found matching 'build' 09:19:12 INFO - no previously-included directories found matching 'dist' 09:19:12 INFO - no previously-included directories found matching '.git*' 09:19:12 INFO - Successfully installed jsonschema functools32 09:19:12 INFO - Cleaning up... 09:19:12 INFO - Return code: 0 09:19:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:19:12 INFO - Using env: {'DISPLAY': ':0', 09:19:12 INFO - 'HOME': '/home/cltbld', 09:19:12 INFO - 'LANG': 'en_US.UTF-8', 09:19:12 INFO - 'LANGUAGE': 'en_US:en', 09:19:12 INFO - 'LOGNAME': 'cltbld', 09:19:12 INFO - 'MAIL': '/var/mail/cltbld', 09:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:12 INFO - 'MOZ_NO_REMOTE': '1', 09:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:12 INFO - 'NO_EM_RESTART': '1', 09:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:12 INFO - 'PWD': '/builds/slave/test', 09:19:12 INFO - 'SHELL': '/bin/bash', 09:19:12 INFO - 'SHLVL': '1', 09:19:12 INFO - 'TERM': 'linux', 09:19:12 INFO - 'TMOUT': '86400', 09:19:12 INFO - 'USER': 'cltbld', 09:19:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:12 INFO - '_': '/tools/buildbot/bin/python'} 09:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:12 INFO - Cleaning up... 09:19:12 INFO - Return code: 0 09:19:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:19:12 INFO - Using env: {'DISPLAY': ':0', 09:19:12 INFO - 'HOME': '/home/cltbld', 09:19:12 INFO - 'LANG': 'en_US.UTF-8', 09:19:12 INFO - 'LANGUAGE': 'en_US:en', 09:19:12 INFO - 'LOGNAME': 'cltbld', 09:19:12 INFO - 'MAIL': '/var/mail/cltbld', 09:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:12 INFO - 'MOZ_NO_REMOTE': '1', 09:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:12 INFO - 'NO_EM_RESTART': '1', 09:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:12 INFO - 'PWD': '/builds/slave/test', 09:19:12 INFO - 'SHELL': '/bin/bash', 09:19:12 INFO - 'SHLVL': '1', 09:19:12 INFO - 'TERM': 'linux', 09:19:12 INFO - 'TMOUT': '86400', 09:19:12 INFO - 'USER': 'cltbld', 09:19:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:12 INFO - '_': '/tools/buildbot/bin/python'} 09:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:15 INFO - Downloading docopt-0.6.1.tar.gz 09:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:15 INFO - Running setup.py install for blobuploader 09:19:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:15 INFO - Running setup.py install for requests 09:19:16 INFO - Running setup.py install for docopt 09:19:16 INFO - Successfully installed blobuploader requests docopt 09:19:16 INFO - Cleaning up... 09:19:16 INFO - Return code: 0 09:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:16 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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:16 INFO - Using env: {'DISPLAY': ':0', 09:19:16 INFO - 'HOME': '/home/cltbld', 09:19:16 INFO - 'LANG': 'en_US.UTF-8', 09:19:16 INFO - 'LANGUAGE': 'en_US:en', 09:19:16 INFO - 'LOGNAME': 'cltbld', 09:19:16 INFO - 'MAIL': '/var/mail/cltbld', 09:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:16 INFO - 'MOZ_NO_REMOTE': '1', 09:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:16 INFO - 'NO_EM_RESTART': '1', 09:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:16 INFO - 'PWD': '/builds/slave/test', 09:19:16 INFO - 'SHELL': '/bin/bash', 09:19:16 INFO - 'SHLVL': '1', 09:19:16 INFO - 'TERM': 'linux', 09:19:16 INFO - 'TMOUT': '86400', 09:19:16 INFO - 'USER': 'cltbld', 09:19:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:16 INFO - '_': '/tools/buildbot/bin/python'} 09:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:16 INFO - Running setup.py (path:/tmp/pip-e6028L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:16 INFO - Running setup.py (path:/tmp/pip-W_GcuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:16 INFO - Running setup.py (path:/tmp/pip-7Us4iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:16 INFO - Running setup.py (path:/tmp/pip-67sZKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:16 INFO - Running setup.py (path:/tmp/pip-NIqMgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:16 INFO - Running setup.py (path:/tmp/pip-InP4N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:16 INFO - Running setup.py (path:/tmp/pip-wBKYpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:16 INFO - Running setup.py (path:/tmp/pip-EyTRLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:17 INFO - Running setup.py (path:/tmp/pip-qfKbA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:17 INFO - Running setup.py (path:/tmp/pip-5d0bXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:17 INFO - Running setup.py (path:/tmp/pip-wvtKcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:17 INFO - Running setup.py (path:/tmp/pip-wPfukX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:17 INFO - Running setup.py (path:/tmp/pip-zYmQmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:17 INFO - Running setup.py (path:/tmp/pip-piyeiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:17 INFO - Running setup.py (path:/tmp/pip-i0klkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:17 INFO - Running setup.py (path:/tmp/pip-3ps1FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:17 INFO - Running setup.py (path:/tmp/pip-UKlwq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:17 INFO - Running setup.py install for manifestparser 09:19:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:17 INFO - Running setup.py install for mozcrash 09:19:17 INFO - Running setup.py install for mozdebug 09:19:17 INFO - Running setup.py install for mozdevice 09:19:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for mozfile 09:19:18 INFO - Running setup.py install for mozhttpd 09:19:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for mozinfo 09:19:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for mozInstall 09:19:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for mozleak 09:19:18 INFO - Running setup.py install for mozlog 09:19:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for moznetwork 09:19:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:18 INFO - Running setup.py install for mozprocess 09:19:18 INFO - Running setup.py install for mozprofile 09:19:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:19 INFO - Running setup.py install for mozrunner 09:19:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:19 INFO - Running setup.py install for mozscreenshot 09:19:19 INFO - Running setup.py install for moztest 09:19:19 INFO - Running setup.py install for mozversion 09:19:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:19 INFO - Cleaning up... 09:19:19 INFO - Return code: 0 09:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:19 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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:19 INFO - Using env: {'DISPLAY': ':0', 09:19:19 INFO - 'HOME': '/home/cltbld', 09:19:19 INFO - 'LANG': 'en_US.UTF-8', 09:19:19 INFO - 'LANGUAGE': 'en_US:en', 09:19:19 INFO - 'LOGNAME': 'cltbld', 09:19:19 INFO - 'MAIL': '/var/mail/cltbld', 09:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:19 INFO - 'MOZ_NO_REMOTE': '1', 09:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:19 INFO - 'NO_EM_RESTART': '1', 09:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:19 INFO - 'PWD': '/builds/slave/test', 09:19:19 INFO - 'SHELL': '/bin/bash', 09:19:19 INFO - 'SHLVL': '1', 09:19:19 INFO - 'TERM': 'linux', 09:19:19 INFO - 'TMOUT': '86400', 09:19:19 INFO - 'USER': 'cltbld', 09:19:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:19 INFO - '_': '/tools/buildbot/bin/python'} 09:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:19 INFO - Running setup.py (path:/tmp/pip-sDnrhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:19 INFO - Running setup.py (path:/tmp/pip-MZVzwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:19 INFO - Running setup.py (path:/tmp/pip-o4eCxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:19 INFO - Running setup.py (path:/tmp/pip-iqX4YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:20 INFO - Running setup.py (path:/tmp/pip-ADk5zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:20 INFO - Running setup.py (path:/tmp/pip-mVX1dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:20 INFO - Running setup.py (path:/tmp/pip-a_LKkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:20 INFO - Running setup.py (path:/tmp/pip-UC3bzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:20 INFO - Running setup.py (path:/tmp/pip-R7cJUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:20 INFO - Running setup.py (path:/tmp/pip-_5LpB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:20 INFO - Running setup.py (path:/tmp/pip-DwLa9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:20 INFO - Running setup.py (path:/tmp/pip-QVxkps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:20 INFO - Running setup.py (path:/tmp/pip-pDSUoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:20 INFO - Running setup.py (path:/tmp/pip-ytq9Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:20 INFO - Running setup.py (path:/tmp/pip-7dshSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:20 INFO - Running setup.py (path:/tmp/pip-f6SStp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:20 INFO - Running setup.py (path:/tmp/pip-NCLO5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:22 INFO - Downloading blessings-1.6.tar.gz 09:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:23 INFO - Installing collected packages: blessings 09:19:23 INFO - Running setup.py install for blessings 09:19:23 INFO - Successfully installed blessings 09:19:23 INFO - Cleaning up... 09:19:23 INFO - Return code: 0 09:19:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:23 INFO - Reading from file tmpfile_stdout 09:19:23 INFO - Current package versions: 09:19:23 INFO - argparse == 1.2.1 09:19:23 INFO - blessings == 1.6 09:19:23 INFO - blobuploader == 1.2.4 09:19:23 INFO - docopt == 0.6.1 09:19:23 INFO - functools32 == 3.2.3-2 09:19:23 INFO - jsonschema == 2.5.1 09:19:23 INFO - manifestparser == 1.1 09:19:23 INFO - mozInstall == 1.12 09:19:23 INFO - mozcrash == 0.17 09:19:23 INFO - mozdebug == 0.1 09:19:23 INFO - mozdevice == 0.48 09:19:23 INFO - mozfile == 1.2 09:19:23 INFO - mozhttpd == 0.7 09:19:23 INFO - mozinfo == 0.9 09:19:23 INFO - mozleak == 0.1 09:19:23 INFO - mozlog == 3.4 09:19:23 INFO - moznetwork == 0.27 09:19:23 INFO - mozprocess == 0.23 09:19:23 INFO - mozprofile == 0.28 09:19:23 INFO - mozrunner == 6.12 09:19:23 INFO - mozscreenshot == 0.1 09:19:23 INFO - mozsystemmonitor == 0.3 09:19:23 INFO - moztest == 0.7 09:19:23 INFO - mozversion == 1.4 09:19:23 INFO - psutil == 3.1.1 09:19:23 INFO - requests == 1.2.3 09:19:23 INFO - wsgiref == 0.1.2 09:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:23 INFO - Using env: {'DISPLAY': ':0', 09:19:23 INFO - 'HOME': '/home/cltbld', 09:19:23 INFO - 'LANG': 'en_US.UTF-8', 09:19:23 INFO - 'LANGUAGE': 'en_US:en', 09:19:23 INFO - 'LOGNAME': 'cltbld', 09:19:23 INFO - 'MAIL': '/var/mail/cltbld', 09:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:23 INFO - 'MOZ_NO_REMOTE': '1', 09:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:23 INFO - 'NO_EM_RESTART': '1', 09:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:23 INFO - 'PWD': '/builds/slave/test', 09:19:23 INFO - 'SHELL': '/bin/bash', 09:19:23 INFO - 'SHLVL': '1', 09:19:23 INFO - 'TERM': 'linux', 09:19:23 INFO - 'TMOUT': '86400', 09:19:23 INFO - 'USER': 'cltbld', 09:19:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:23 INFO - '_': '/tools/buildbot/bin/python'} 09:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:19:23 INFO - Cleaning up... 09:19:23 INFO - Return code: 0 09:19:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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 0x7fcd592c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2820790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:23 INFO - Using env: {'DISPLAY': ':0', 09:19:23 INFO - 'HOME': '/home/cltbld', 09:19:23 INFO - 'LANG': 'en_US.UTF-8', 09:19:23 INFO - 'LANGUAGE': 'en_US:en', 09:19:23 INFO - 'LOGNAME': 'cltbld', 09:19:23 INFO - 'MAIL': '/var/mail/cltbld', 09:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:23 INFO - 'MOZ_NO_REMOTE': '1', 09:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:23 INFO - 'NO_EM_RESTART': '1', 09:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:23 INFO - 'PWD': '/builds/slave/test', 09:19:23 INFO - 'SHELL': '/bin/bash', 09:19:23 INFO - 'SHLVL': '1', 09:19:23 INFO - 'TERM': 'linux', 09:19:23 INFO - 'TMOUT': '86400', 09:19:23 INFO - 'USER': 'cltbld', 09:19:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:23 INFO - '_': '/tools/buildbot/bin/python'} 09:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:23 INFO - Cleaning up... 09:19:23 INFO - Return code: 0 09:19:23 INFO - Running post-action listener: _resource_record_post_action 09:19:23 INFO - Running post-action listener: _start_resource_monitoring 09:19:23 INFO - Starting resource monitoring. 09:19:23 INFO - [mozharness: 2016-10-10 16:19:23.888577Z] Finished create-virtualenv step (success) 09:19:23 INFO - [mozharness: 2016-10-10 16:19:23.889050Z] Running install step. 09:19:23 INFO - Running pre-action listener: _resource_record_pre_action 09:19:23 INFO - Running main action method: install 09:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:24 INFO - Reading from file tmpfile_stdout 09:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:24 INFO - Reading from file tmpfile_stdout 09:19:24 INFO - Output received: 09:19:24 INFO - Usage: mozinstall [options] installer 09:19:24 INFO - Options: 09:19:24 INFO - -h, --help show this help message and exit 09:19:24 INFO - -d DEST, --destination=DEST 09:19:24 INFO - Directory to install application into. [default: 09:19:24 INFO - "/builds/slave/test"] 09:19:24 INFO - --app=APP Application being installed. [default: firefox] 09:19:24 INFO - mkdir: /builds/slave/test/build/application 09:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:19:41 INFO - Reading from file tmpfile_stdout 09:19:41 INFO - Output received: 09:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:41 INFO - Running post-action listener: _resource_record_post_action 09:19:41 INFO - [mozharness: 2016-10-10 16:19:41.207755Z] Finished install step (success) 09:19:41 INFO - [mozharness: 2016-10-10 16:19:41.208002Z] Running run-tests step. 09:19:41 INFO - Running pre-action listener: _resource_record_pre_action 09:19:41 INFO - Running main action method: run_tests 09:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:41 INFO - Python 2.7.3 09:19:41 INFO - Return code: 0 09:19:41 INFO - grabbing minidump binary from tooltool 09:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:41 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 0x281d930>, '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 0x281e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281ecc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:19:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:19:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:41 INFO - Return code: 0 09:19:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:41 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/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:19:41 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/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:19:41 INFO - Using env: {'DISPLAY': ':0', 09:19:41 INFO - 'HOME': '/home/cltbld', 09:19:41 INFO - 'LANG': 'en_US.UTF-8', 09:19:41 INFO - 'LANGUAGE': 'en_US:en', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MAIL': '/var/mail/cltbld', 09:19:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SHLVL': '1', 09:19:41 INFO - 'TERM': 'linux', 09:19:41 INFO - 'TMOUT': '86400', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - '_': '/tools/buildbot/bin/python'} 09:19:41 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/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:19:41 INFO - mozversion application_buildid: 20161010063001 09:19:41 INFO - mozversion application_changeset: e70b480ce6c24db5f13e1c5f402592d1ef0922ab 09:19:41 INFO - mozversion application_display_name: Nightly 09:19:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:41 INFO - mozversion application_name: Firefox 09:19:41 INFO - mozversion application_remotingname: firefox 09:19:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:19:41 INFO - mozversion application_vendor: Mozilla 09:19:41 INFO - mozversion application_version: 52.0a1 09:19:41 INFO - mozversion platform_buildid: 20161010063001 09:19:41 INFO - mozversion platform_changeset: e70b480ce6c24db5f13e1c5f402592d1ef0922ab 09:19:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:19:41 INFO - mozversion platform_version: 52.0a1 09:19:41 INFO - using testdate: 1476116381 09:19:41 INFO - actual date: 1476116381 09:19:41 INFO - starting webserver on 'localhost:60207' 09:19:41 INFO - SUITE-START | Running 2 tests 09:19:41 INFO - TEST-START | dromaeo_css 09:19:41 INFO - operating with platform_type : linux_ 09:19:41 INFO - Initialising browser for dromaeo_css test... 09:19:41 INFO - TEST-INFO | started process 1850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQfMsN/profile http://localhost:60207/getInfo.html) 09:19:45 INFO - PROCESS | 1850 | __metrics Screen width/height:1600/1200 09:19:45 INFO - PROCESS | 1850 | colorDepth:24 09:19:45 INFO - PROCESS | 1850 | Browser inner width/height: 1024/697 09:19:45 INFO - PROCESS | 1850 | __metrics 09:19:46 INFO - PROCESS | 1850 | 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" 09:19:46 INFO - PROCESS | 1850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:47 INFO - PROCESS | 1850 | console.error: PushService: 09:19:47 INFO - PROCESS | 1850 | stateChangeProcessEnqueue: Error transitioning state 09:19:47 INFO - PROCESS | 1850 | UnknownError 09:19:47 INFO - TEST-INFO | 1850: exit 0 09:19:47 INFO - Browser initialized. 09:19:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:47 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQfMsN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:59 INFO - PROCESS | 1933 | RSS: Main: 172601344 09:19:59 INFO - PROCESS | 1933 | 09:20:51 INFO - PROCESS | 1933 | 1476116451176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:23:00 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60207/tests/dromaeo/cssquery-ext.html) 09:23:03 INFO - PROCESS | 1933 | RSS: Main: 410513408 09:23:03 INFO - PROCESS | 1933 | 09:26:05 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-ext.html (next: http://localhost:60207/tests/dromaeo/cssquery-jquery.html) 09:26:06 INFO - PROCESS | 1933 | RSS: Main: 286097408 09:26:06 INFO - PROCESS | 1933 | 09:29:08 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60207/tests/dromaeo/cssquery-mootools.html) 09:29:09 INFO - PROCESS | 1933 | RSS: Main: 219893760 09:29:09 INFO - PROCESS | 1933 | 09:32:11 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60207/tests/dromaeo/cssquery-prototype.html) 09:32:11 INFO - PROCESS | 1933 | RSS: Main: 245846016 09:32:11 INFO - PROCESS | 1933 | 09:35:14 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60207/tests/dromaeo/cssquery-yui.html) 09:35:14 INFO - PROCESS | 1933 | RSS: Main: 222433280 09:35:14 INFO - PROCESS | 1933 | 09:38:17 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:60207/tests/dromaeo/cssquery-yui.html (next: http://localhost:60207/tests/dromaeo/cssquery-dojo.html) 09:38:18 INFO - PROCESS | 1933 | RSS: Main: 310386688 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | __start_tp_report 09:38:18 INFO - PROCESS | 1933 | _x_x_mozilla_page_load 09:38:18 INFO - PROCESS | 1933 | _x_x_mozilla_page_load_details 09:38:18 INFO - PROCESS | 1933 | |i|pagename|runs| 09:38:18 INFO - PROCESS | 1933 | |0;dojo.html;2977.285451491642;3005.3688725367665;3011.2471882029495;3032.9545056824136;3059.6634370219285;5094.184930411135;5130.15352466843;5163.974180129104;5184.53339199472;5185.014847179038;5119.6672216305915;5186.0665080285535;5200.791968321262;5205.869853253671;5220.608454365928;4731.716097034189;4764.285357196413;4783.115123702109;4801.8079276828885;4805.279208118775;4754.342332624184;4796.520347965193;4804.615630749549;4838.733869637169;4878.390201224847;4437.378766972626;4829.975850120744;4835.443923948738;4862.513748625144;4891.021795640886;4616.676832621718;4782.808687652525;4793.32893394925;4824.614030877557;4837.419509658864;4658.487566367697;4670;4703.600193983515;4720;4738.123447162286;5161.096808058574;5169.043726910496;5179.482051794828;5191.766370513336;5235.162374020177;5554.944450555524;5555.749991250404;5556.777728890839;5562.694051827148;5563.944360556383;5403.7027963462;5437;5443.074677304828;5467;5488.25908502355;5127.564157046618;5136.332276803992;5142.228665700175;5145.30538377318;5147.356580427447;5598.048331783607;5607.130894711327;5610.186522954149;5612.5229355504425;5659.462351076641;5251.264822924793;5306.92039619406;5385.569154467633;5449.1826226066405;5454.236406902957;5554.86112847174;5555.638883472561;5613.186088017214;5615.578831587647;5617.073182924772;5525.336959564797;5528.226048353234;5533.723313834373;5539.113741801373;5545.584081193927;5284;5330.413654498002;5471.480209380103;5544.528715059265;5608.46719561641;4276.358546218092;4298.742075475481;4327.913441731148;4337.392765012901;4390.604845563851;3870.3613903705573;3871.4386413969814;3874.380099184117;3885.805709714503;3906.0430194601936;5295.443978382292;5301.204819277063;5304.708241046702;5310.256564081032;5311.176767601028;5409.350877894599;5456.508914197662;5456.781728730806;5467.808626698046;5495.065838807413;5229.869253268699;5288.286081379041;5302.443243459381;5373.785048598091;5378.596605254622;4832.661713680009;4836.419629644395;4846.297286893451;4872.561469467765;4894.2169252920075;5764.423557644202;5773.566982476331;5774.220480235114;5780.132980052942;5791.0734282514595;5367.543758780547;5369.6509726867625;5426.294581704511;5515.145152501208;5515.641483303572;5686.829395117988;5759.913601296068;5761.07822748375;5766.365699772938;5767.711614419179;5438.592105592175;5452.863678407913;5455.727213639381;5459.481349271813;5462.399136095106;5533.667979921218;5556.027695153412;5557.472040156179;5560.221568980265;5563.527100196528;5392.137258038695;5407.486288802557;5410.540104091197;5412.215228791882;5435.537979271806;5410.540104091039;5420.674759514284;5421.891562168814;5423.186522021729;5423.29497165366;5375.892482150413;5376.489233522809;5380.650257733235;5415.160650099241;5446.210299506629;5433.972830135824;5448.455154484678;5478.91781623284;5483.095289277225;5549.056660367666;5175.689458632494;5207.843764686914;5218.504242096995;5370.785168593213;5377.623566350474 09:38:18 INFO - PROCESS | 1933 | |1;ext.html;595.2618752746595;611.8470382404399;611.8990366589513;616.4667562558388;626.3454689849107;31689;34628.96113116608;34704.826475867616;41515.37726934091;43073.138537229235;44160.3375949361;44507.3323900141;44511.77441127947;44514;44522.55477445225;8676.956615216915;8857.379983401164;8860.158284962918;8864.468131912074;8865.157810008039;8025;8232.753017409488;8719.694810681627;10329.328593641427;10631;10729.409882456463;10795.568177272939;10795.892041079567;10800.189985751062;10802.351858888453;10608.469576521182;10683;10684.679459616224;10687.412192329419;10701.732456688567;7934.44458887878;8161.387895907771;10113.64602238918;10444;10452.268341216119;41304.38043429351;41582.58417415847;41648.58351416478;41684;41694.79152604248;3415.453527435623;3676.650718181795;3829.2341531693496;3837.808109594509;3964.207158568298;31500;31576.526352104738;31864;31936.361272774648;33114.6688533114;3911.941320880189;4018.839246430139;4027.456293400383;4155.605217504362;4209.158168366339;322684;323207;323704;324335;325217;53203.201951970754;53527;53543.322833858154;53578.464215357344;53595.464045359826;57039.14441283384;57137.42862571404;57169.714151428976;57188.14217786737;57200;14655.85344146545;15051.774223386657;15065.623359415884;15076.698466030617;15084.773728394082;10495.10791582724;11394.601188958513;11415.60045398407;11423.942880285711;11431.828522572168;13677.179369237678;15077.54767356981;15202.695946081016;15362.923185384001;15913.283902224428;6253.937460625427;6347.619142851444;6405.188912596997;6417.582857114273;6541.411272985454;896.4666023715879;973.6105557776805;1018.8217062014267;1060.3213943076437;1077.789830982951;31331.216719582193;31477.527837082464;31553.211169720482;31767;32103.357932841212;1062.2564205056492;1090.231386872253;1145.9427028648533;1158.247139359423;1187.7446349034826;15483.12339549896;16635.16824158787;16646.16769161537;16702.749458758128;16765;483602;485424;485700;487059;487602;55415.445845541835;55648;55664;55754.72122639361;55861.44138558643;1183.7857228267396;1213.8179273109104;1234.0497816681284;1281.878221568968;1324.9403776829872;26865.865670672305;30498.390032199677;31550.211244719067;33811.661883381836;33905.83047084749;51157.7442112787;51785.22322165246;51826.740866295426;51898;51949.22076168936;436914;438972;441063;442168;442698;26584.601230981163;27395.178144655692;27475;38235.23529529449;38585.614143858205;45793.313100304185;46790.532094678616;46916.06167876691;47042.29436558523;47188;38528.2294354117;39063.41404878872;39099.804500978455;40218.39672404975;40685;38095;38365;38390.23219535538;39851.80074099611;40169.79915100406;39558.40662390009;39715.60284397119;40090;40146.1970760589;40183.397249041875;33159.33681326408;34876;35205.647943520235;35371.29257414786;35382.646173537934;26649.200523984313;27151;27177;27269.318267043484;27324.863375682995 09:38:18 INFO - PROCESS | 1933 | |2;jquery.html;367.6084969507476;369.7781331201278;393.87986664067466;398.9786147462496;416.8686863637954;14027.01810873238;14838.777418338721;17025.574360641007;19701.802981970177;19867.20531178751;17772.555686107855;17981.82018179818;18034.368797092106;18158.273669053255;19189.424317270503;5557.166425036256;5783.334916484616;5785.681787501686;5787.189793428924;5795.652260864362;4811.687240329385;5324.574034077284;5690.857728556778;5719.742611582489;5722.170285308628;5644.125160600093;5645.125005624135;5651.2935883014625;5652.463016013472;5660;5510.228568000483;5753.395893431192;5784.190213370152;5837.387074357174;5874.236349274567;5448.509634132907;5562.3881373049335;5633.887322253573;5643;5651.604387692863;13217.73564528704;13430.462781488728;13441.932790336083;13467.057305988585;13676.65808354789;2203.162798136698;2261.604219261623;2290.8281878858984;2401.771831675988;2878.5250433678416;9886.307958442912;9888.802223955481;10067.89932100677;10406.115480184193;10597.576096956112;1857.823506766855;1870.0462763990326;1900.631545287391;1905.1617288393063;1926.1717461491553;81643.71235033845;83505.58247208786;85465;86229;87978.12021879763;9198.862017069749;9644.565994530263;9730.318877678636;10584.417857017937;10868.130549556017;12995.28525931083;13019.349032548334;13096.279704616147;13128.474861005452;13141.737165256642;6912.654367281716;7018.508704390643;7130.108736407949;7141.82145446368;7152.785416437515;6744.359285867835;6745.12313399255;6768.898466523006;6817.318268173143;6955.6869940852785;3988;4032.6169013944213;4073.287174744408;4101.077257617012;4145.336746120606;1846.8180364566688;1936.7482227310359;1942.990285048594;1944.397236856579;1955.0908827395328;877.5305211711703;950.7337945375306;1004.8342023566175;1017.5471914997755;1081.534939975818;19139.904300478407;19540.70688939667;19725.802741972395;19757;19837.30569430063;901.1754244865874;951.6859436385976;953.4041224234853;957.2937850305017;975.23444096384;10391.324563903323;10685.305455145392;10746.623868164734;10778.245522813484;10807.891921080845;471235;477653;478400;478411;481377;82929.58535207406;93635.53182234181;93994;94790;95531;937.0769791755116;962.3744566031995;972.6644307713827;975.9414435133915;989.1098011789447;16427.425040123537;16577.50267491977;17211.827881721023;17412.216450259515;17676;40709;41544.58455415528;41646.58353416427;42096.579034209266;42569.148617028106;53543;56116.71941640429;57841.4215857836;58813;61616;8077.434579579373;8244.979979904962;8437.451565648213;8471;8563.272121869712;10563.419011954416;12679.161521579505;12729.363531823557;12943.158694684815;13270.27013514266;10816.621418250637;10879.1840611956;10995.890041099487;11073.778524429305;11529.82705259405;10696.572137114428;10732.08777253911;10912.890871091187;11115.277506962022;11132.554697811996;10946.945265273622;11013.229073964745;11225.326480411202;11321.71695707614;11745.29528228309;7380.889286660597;7480.279535706927;7641.617919104134;7937;8388.748337549883;10391.844122338322;11051.83422248683;11229.606963756229;11293.491792869505;11743.706407339885 09:38:18 INFO - PROCESS | 1933 | |3;mootools.html;1339.530615705323;1431.6420894776302;1496.4463148635004;1578.2976575423934;1787.0528619831493;7922.286994170524;8784.297256219503;9081;9107.271418286538;9327.533623318841;9175.908240917588;9239.260859131271;9239.584218710157;9241.49171795551;9247.352685312031;2318.559473699996;2346.530693861226;2346.77705617966;2349.7180338359335;2355.316958082154;2281.8060464860505;2287.1880482428664;2320.9419764505856;2335;2343.039353864916;2325.104834638668;2335.9182428615004;2348.412896775806;2354.5526349993534;2357.3752955466816;2229.6544035674497;2235.3517479930965;2237.339984704508;2241.8542794718373;2278.612635851909;2267.3764714703425;2282.201229569654;2284.862908225512;2290.599145149592;2301.643245296965;8940.68707595231;9019.639214431414;9077.228435582918;9086.86369704455;9092.181703646704;5049.469805670426;5245.86885327866;5258.3689957205;5259.474052594748;5260.342457192851;3192.090254277543;3385.86456541738;3400.4559270516597;3422.7261819054415;3425.2293234022395;1083.56657337065;1103.0458653264948;1919.9904000479908;1955.5502234486005;2004.1482369992696;12157.878421215852;12170.087243456775;12249;12272.509099635914;12308.323042232674;4343.630791382705;4536.274196128604;4633.907321853544;4660.347551342815;4709.1994360958715;9838.803223935623;9868.555914983843;9876.45679487635;9877.456739879231;9881.308308418342;5075.111855425286;5098.337216161875;5102.107131252016;5102.770375333119;5176.792928282902;4123.402106694512;4259.297215959394;4492.483364413134;4578.153041687232;4774.761261936889;3560.857565697395;3600.8199590020395;3634.2913131939545;3712.2389910068373;3719.739618226698;1023.0485648347109;1030.8711411073616;1045.095991966943;1046.2571574182416;1053.4522048534718;804.3484777330381;921.9677311294207;957.4925289596525;957.8898426680881;961.1781926452783;5917.46742793142;5978.910316345258;6042.39576042401;6045.758169673164;6059.515238780887;439.5275079289776;439.83945859760956;444.5154781288411;456.4727739460928;463.33742747870866;3927.1752931884052;3990.880273591797;4012.117334186474;4041.81811818463;4133.379993001014;10881.23831331815;11202.775944481065;11303.660890173143;11317.660470185907;11323.490442930088;11248.775024499464;11252.49363778632;11254;11270.21108522412;11283;8144.552049637208;8239.258466738022;8360.331173506105;8377.49735015901;8381.706640267439;5606.24315717373;5612.102063669793;5641.379448260606;5689.487946084872;5815.738291776965;10059.647912323033;10142.087212150942;10203.03071208234;10230.181585473294;10389;10076.193904487476;10360.637377691744;10609.734756631146;10610.151187904794;10617.893821062;6889.242183359726;7086.043384143075;7097.787066388017;7532.133804612539;7613.124490683642;7938;8052.154523775153;8113.7565873023905;8117.715879944174;8225.465344752572;7399.926000739923;7481.70073197066;7484.214157513383;7664.961675191588;7682.6926922924695;7479.58862262559;7521.285477879593;7567.848643027219;7577.810554736176;7744.612769361397;6578.934210657832;6709.597424154566;6714.563553369016;6717.731290748316;6725.697343619647;5007.37407824022;5078.822241221687;5092.567131793839;5180;5181.093308670892;4866.099771542276;4968.776405061709;5090.694558326512;5179.559737422362;5398.865028374322 09:38:18 INFO - PROCESS | 1933 | |4;prototype.html;329.7147967008538;333.0956453229482;337.9003194057753;338.78487160652986;346.3523211594319;5009.774560144793;5115.411727651316;5150.613703972198;5213.035588416141;5217.295665085212;4996.7751451184695;5023.3469648945675;5095.496828435611;5122.462141475138;5135.383753949522;4069.6540794032544;4086.5300490443606;4091.713580049398;4094.651954583864;4096.365063415175;3967.8016099194924;4087.6321131098193;4092.3656833190903;4095.1809638072355;4095.672346212296;4022.5172979242384;4056.9797151014204;4058.1883623275316;4062.1469491406842;4063.2889244382263;4025.5571887092397;4031.9596804031876;4037.676985841155;4046.271671099201;4046.6964977626794;3621.6016238213774;3623.691986181178;3624.7643903146477;3632.654897784706;3643.544556930384;4842.612590992712;4977.303177555145;4985.227289770091;5003.149464591028;5055;4626.768661566942;4637.2116740153915;4644.373009643688;4647;4652.185867473178;5323.627346085776;5332.626716129873;5345.812896548602;5364.383095943938;5380.865478363033;3721.5906250312446;3900.258950799339;3918.7060970427333;3946.605339466059;3950.308695978192;5530.225768392428;5566.332040155166;5572.2974357436615;5574.832755017356;5579.944200558024;4002.199560087936;4003.7597744135446;4006.3790112532606;4014.5182578090817;4021;3967.7941382134454;4038.7076135636316;4065.3901914712437;4071.89820254496;4081.6122468365456;4611.371518234574;4612.884677883079;4614.330922016289;4628.9537104628525;4630.930536041962;5389.407165211824;5401.811601447754;5416.918746218731;5419.485148910847;5441.918371224435;1310.6395741171254;1321.8678132186703;1342.174562643967;1357.6605848537865;1390.4716207840956;924.8150369926042;934.1732566678538;956.2302346610905;961.3847137831793;965.3725078698761;5189.896202075937;5190.792368305226;5200.713960732196;5202.609804264695;5216.686998780086;5427.6472029317965;5430.239766432703;5439.374471935699;5442.673439593637;5448.863778405493;5038.84883453497;5183.948160518422;5200.869978250498;5207.453217412193;5218.321618189687;2536.9238922832346;2542.6186072088963;2552.8468291902545;2562.141682536334;2573.961390579143;4952.851414457572;4978.551930326288;4980;5016.398032236155;5017.397912250553;4665.533446655308;4890.266460030953;4909.926351104737;4917.262410638433;4929.053024055478;4999.075171093359;5023.899522009539;5025.899482010339;5090.516400941905;5103.234514822806;4880.536349046835;4895.118878601886;4897.216445368724;4897.9510204898925;4905.8904670991815;4427.955720442755;4717.72621392229;4834.5890599298045;4845.41854977405;4871.293662419001;5070.2141168119;5070.797168113234;5076.82231121909;5090.618203634816;5094.5669618082875;3643.562772467321;3660.2313514162324;3665.908352291214;3668.4680721295795;3675.7243206760136;4562.58936695699;4858.720363754523;4895.4370247422;4904.58311043551;4916.254729571094;4649.279361698942;4678.602318802804;4753.857384278477;4774.350235619265;4799.496052914394;4699.660596729916;4725.574698277172;4734.810607575659;4738.578426472113;4760.047990402003;4697.624190064718;4708.234412095464;4734.33719279308;4749.453812811433;5045.31888195089;5443.836684899459;5459.481349271813;5460.099083651312;5464.316960379952;5467.49643847945;5310.734463276744;5366.838994830161;5383.892322153613;5386.299781028441;5394.298741163623 09:38:18 INFO - PROCESS | 1933 | |5;yui.html;714.7355478472963;746.4998451037804;749.6963729689476;778.2606523802389;830.2361827119051;14979.625509362259;16565.66868662626;16609.750853737205;16609.916950415245;16623;14682.486112986047;14835.480758173466;15002.174880381575;15006;15020.399184032625;636.2841802971657;654.2084078265304;654.5745265577365;757.7726681995393;778.634042000259;661.5832025823725;770.0259172147238;795.1293333799509;798.1659166171365;802.6909639788694;845.0619812008696;847.4364547575855;857.3998201259112;857.6140736668493;857.6569372251087;844.6368061733452;845.5053793530792;845.6194712379423;845.7758693946109;845.8773477845677;500.7321083220496;507.1074908161662;624.9218847644045;625.1841347042108;625.5433533520555;12798.936005319914;13252.536161234408;13286.800697989538;13691.315434228249;13716.931415342959;14702.191379474125;15346.693066138614;15533.689326213413;15607.687846243125;15679.843201567952;11650.291954801789;11820.645380638594;11911.702207444796;11988.28070315775;12329.876701232963;3829.4064420014943;3854.9421758673643;3890.455336252927;3919.333713268751;3939.468171796799;78332.60833695852;78589;78844.60577697132;79423;80027.5998620009;11287.470907292898;11313.691025908442;11624.302541847515;11728.179027467995;11771.705707357385;23136.4215894604;23285.76714232836;23414.531709365718;23506.294811155694;23564.882175589013;8354.164583541597;8579.914200858037;8591.548595822538;8701.30389568833;8743.606537705818;4473.776311184428;4516.4292290786125;4591.77041147948;4638.95361046392;4661.440627124699;3567.8572857085946;3626.2747450510005;3641.362761516777;3643.799591022519;3692.3538380783257;594.5006194796392;596.2100217212211;600.4115966352998;617.0189398855841;618.712298781069;693.1578132568953;698.9930100698928;707.9964600176966;731.1701219116342;736.576468530597;9118.817623647623;9483.288753343526;9652.855207171899;9787.070228328297;10062.849057264148;620.8323752586776;649.227419370947;649.5388274325283;655.7214423887685;684.7397988764237;4389.495208051115;4524.457065152137;4723.716577005391;4732;4751.572358487752;68401.65799170973;68879.31120688829;73948;124441.37779311046;124547;100601.49699251603;101755.49122254341;101950;102400.97599023914;104328.47835760773;56177;76373;90031.09968900357;93301.5334923321;96079.51960240155;8717.476951382938;8948.418352807046;8980.46117232942;9028.539518557605;9038.811023425973;49590.50409495859;53094.73452632712;54071.45928540664;55226.44773552213;55767.721161393936;77598;78507.21492784999;79119.60440197762;79707.20292796998;82745.58627206825;12176.817347739614;12266.938665306616;12271.325077120488;12562.685932851751;12965.675858103623;13197.868021319664;13241.735165296448;13488.662783430493;13693.657658558615;13803.654908627364;11404.641735882167;11693.356865372147;11957.940210298893;12045.397730113635;12272.140950133406;12195.817062744243;12388.442520086797;12472.376381181086;12747.553835615709;12914.547990820276;13147.14543554666;13321.26733029654;13569.728605428034;13585.932070339584;13928.442862285801;9980.301378903407;10353.223508237063;10663.840042399526;10835.945820270848;10839.349639021684;11142.108631309638;11365.147613929154;11542;11705.765884682429;11752.412379380825 09:38:18 INFO - PROCESS | 1933 | __end_tp_report 09:38:18 INFO - PROCESS | 1933 | __start_cc_report 09:38:18 INFO - PROCESS | 1933 | _x_x_mozilla_cycle_collect,2424 09:38:18 INFO - PROCESS | 1933 | __end_cc_report 09:38:18 INFO - PROCESS | 1933 | __startTimestamp1476117498000__endTimestamp 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | ------- Summary: start ------- 09:38:18 INFO - PROCESS | 1933 | Number of tests: 6 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#0] dojo.html Cycles:165 Average:5156.76 Median:5370.79 stddev:559.52 (10.4%) stddev-sans-first:534.47 09:38:18 INFO - PROCESS | 1933 | Values: 2977.3 3005.4 3011.2 3033.0 3059.7 5094.2 5130.2 5164.0 5184.5 5185.0 5119.7 5186.1 5200.8 5205.9 5220.6 4731.7 4764.3 4783.1 4801.8 4805.3 4754.3 4796.5 4804.6 4838.7 4878.4 4437.4 4830.0 4835.4 4862.5 4891.0 4616.7 4782.8 4793.3 4824.6 4837.4 4658.5 4670.0 4703.6 4720.0 4738.1 5161.1 5169.0 5179.5 5191.8 5235.2 5554.9 5555.7 5556.8 5562.7 5563.9 5403.7 5437.0 5443.1 5467.0 5488.3 5127.6 5136.3 5142.2 5145.3 5147.4 5598.0 5607.1 5610.2 5612.5 5659.5 5251.3 5306.9 5385.6 5449.2 5454.2 5554.9 5555.6 5613.2 5615.6 5617.1 5525.3 5528.2 5533.7 5539.1 5545.6 5284.0 5330.4 5471.5 5544.5 5608.5 4276.4 4298.7 4327.9 4337.4 4390.6 3870.4 3871.4 3874.4 3885.8 3906.0 5295.4 5301.2 5304.7 5310.3 5311.2 5409.4 5456.5 5456.8 5467.8 5495.1 5229.9 5288.3 5302.4 5373.8 5378.6 4832.7 4836.4 4846.3 4872.6 4894.2 5764.4 5773.6 5774.2 5780.1 5791.1 5367.5 5369.7 5426.3 5515.1 5515.6 5686.8 5759.9 5761.1 5766.4 5767.7 5438.6 5452.9 5455.7 5459.5 5462.4 5533.7 5556.0 5557.5 5560.2 5563.5 5392.1 5407.5 5410.5 5412.2 5435.5 5410.5 5420.7 5421.9 5423.2 5423.3 5375.9 5376.5 5380.7 5415.2 5446.2 5434.0 5448.5 5478.9 5483.1 5549.1 5175.7 5207.8 5218.5 5370.8 5377.6 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#1] ext.html Cycles:180 Average:57493.46 Median:21114.02 stddev:111758.22 (529.3%) stddev-sans-first:111990.09 09:38:18 INFO - PROCESS | 1933 | Values: 595.3 611.8 611.9 616.5 626.3 31689.0 34629.0 34704.8 41515.4 43073.1 44160.3 44507.3 44511.8 44514.0 44522.6 8677.0 8857.4 8860.2 8864.5 8865.2 8025.0 8232.8 8719.7 10329.3 10631.0 10729.4 10795.6 10795.9 10800.2 10802.4 10608.5 10683.0 10684.7 10687.4 10701.7 7934.4 8161.4 10113.6 10444.0 10452.3 41304.4 41582.6 41648.6 41684.0 41694.8 3415.5 3676.7 3829.2 3837.8 3964.2 31500.0 31576.5 31864.0 31936.4 33114.7 3911.9 4018.8 4027.5 4155.6 4209.2 322684.0 323207.0 323704.0 324335.0 325217.0 53203.2 53527.0 53543.3 53578.5 53595.5 57039.1 57137.4 57169.7 57188.1 57200.0 14655.9 15051.8 15065.6 15076.7 15084.8 10495.1 11394.6 11415.6 11423.9 11431.8 13677.2 15077.5 15202.7 15362.9 15913.3 6253.9 6347.6 6405.2 6417.6 6541.4 896.5 973.6 1018.8 1060.3 1077.8 31331.2 31477.5 31553.2 31767.0 32103.4 1062.3 1090.2 1145.9 1158.2 1187.7 15483.1 16635.2 16646.2 16702.7 16765.0 483602.0 485424.0 485700.0 487059.0 487602.0 55415.4 55648.0 55664.0 55754.7 55861.4 1183.8 1213.8 1234.0 1281.9 1324.9 26865.9 30498.4 31550.2 33811.7 33905.8 51157.7 51785.2 51826.7 51898.0 51949.2 436914.0 438972.0 441063.0 442168.0 442698.0 26584.6 27395.2 27475.0 38235.2 38585.6 45793.3 46790.5 46916.1 47042.3 47188.0 38528.2 39063.4 39099.8 40218.4 40685.0 38095.0 38365.0 38390.2 39851.8 40169.8 39558.4 39715.6 40090.0 40146.2 40183.4 33159.3 34876.0 35205.6 35371.3 35382.6 26649.2 27151.0 27177.0 27269.3 27324.9 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#2] jquery.html Cycles:180 Average:28105.35 Median:4087.18 stddev:78985.88 (1932.5%) stddev-sans-first:79180.00 09:38:18 INFO - PROCESS | 1933 | Values: 367.6 369.8 393.9 399.0 416.9 14027.0 14838.8 17025.6 19701.8 19867.2 17772.6 17981.8 18034.4 18158.3 19189.4 5557.2 5783.3 5785.7 5787.2 5795.7 4811.7 5324.6 5690.9 5719.7 5722.2 5644.1 5645.1 5651.3 5652.5 5660.0 5510.2 5753.4 5784.2 5837.4 5874.2 5448.5 5562.4 5633.9 5643.0 5651.6 13217.7 13430.5 13441.9 13467.1 13676.7 2203.2 2261.6 2290.8 2401.8 2878.5 9886.3 9888.8 10067.9 10406.1 10597.6 1857.8 1870.0 1900.6 1905.2 1926.2 81643.7 83505.6 85465.0 86229.0 87978.1 9198.9 9644.6 9730.3 10584.4 10868.1 12995.3 13019.3 13096.3 13128.5 13141.7 6912.7 7018.5 7130.1 7141.8 7152.8 6744.4 6745.1 6768.9 6817.3 6955.7 3988.0 4032.6 4073.3 4101.1 4145.3 1846.8 1936.7 1943.0 1944.4 1955.1 877.5 950.7 1004.8 1017.5 1081.5 19139.9 19540.7 19725.8 19757.0 19837.3 901.2 951.7 953.4 957.3 975.2 10391.3 10685.3 10746.6 10778.2 10807.9 471235.0 477653.0 478400.0 478411.0 481377.0 82929.6 93635.5 93994.0 94790.0 95531.0 937.1 962.4 972.7 975.9 989.1 16427.4 16577.5 17211.8 17412.2 17676.0 40709.0 41544.6 41646.6 42096.6 42569.1 53543.0 56116.7 57841.4 58813.0 61616.0 8077.4 8245.0 8437.5 8471.0 8563.3 10563.4 12679.2 12729.4 12943.2 13270.3 10816.6 10879.2 10995.9 11073.8 11529.8 10696.6 10732.1 10912.9 11115.3 11132.6 10946.9 11013.2 11225.3 11321.7 11745.3 7380.9 7480.3 7641.6 7937.0 8388.7 10391.8 11051.8 11229.6 11293.5 11743.7 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#3] mootools.html Cycles:180 Average:5753.84 Median:2548.62 stddev:3349.84 (131.4%) stddev-sans-first:3342.81 09:38:18 INFO - PROCESS | 1933 | Values: 1339.5 1431.6 1496.4 1578.3 1787.1 7922.3 8784.3 9081.0 9107.3 9327.5 9175.9 9239.3 9239.6 9241.5 9247.4 2318.6 2346.5 2346.8 2349.7 2355.3 2281.8 2287.2 2320.9 2335.0 2343.0 2325.1 2335.9 2348.4 2354.6 2357.4 2229.7 2235.4 2237.3 2241.9 2278.6 2267.4 2282.2 2284.9 2290.6 2301.6 8940.7 9019.6 9077.2 9086.9 9092.2 5049.5 5245.9 5258.4 5259.5 5260.3 3192.1 3385.9 3400.5 3422.7 3425.2 1083.6 1103.0 1920.0 1955.6 2004.1 12157.9 12170.1 12249.0 12272.5 12308.3 4343.6 4536.3 4633.9 4660.3 4709.2 9838.8 9868.6 9876.5 9877.5 9881.3 5075.1 5098.3 5102.1 5102.8 5176.8 4123.4 4259.3 4492.5 4578.2 4774.8 3560.9 3600.8 3634.3 3712.2 3719.7 1023.0 1030.9 1045.1 1046.3 1053.5 804.3 922.0 957.5 957.9 961.2 5917.5 5978.9 6042.4 6045.8 6059.5 439.5 439.8 444.5 456.5 463.3 3927.2 3990.9 4012.1 4041.8 4133.4 10881.2 11202.8 11303.7 11317.7 11323.5 11248.8 11252.5 11254.0 11270.2 11283.0 8144.6 8239.3 8360.3 8377.5 8381.7 5606.2 5612.1 5641.4 5689.5 5815.7 10059.6 10142.1 10203.0 10230.2 10389.0 10076.2 10360.6 10609.7 10610.2 10617.9 6889.2 7086.0 7097.8 7532.1 7613.1 7938.0 8052.2 8113.8 8117.7 8225.5 7399.9 7481.7 7484.2 7665.0 7682.7 7479.6 7521.3 7567.8 7577.8 7744.6 6578.9 6709.6 6714.6 6717.7 6725.7 5007.4 5078.8 5092.6 5180.0 5181.1 4866.1 4968.8 5090.7 5179.6 5398.9 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#4] prototype.html Cycles:180 Average:4354.71 Median:4852.07 stddev:1237.15 (25.5%) stddev-sans-first:1203.17 09:38:18 INFO - PROCESS | 1933 | Values: 329.7 333.1 337.9 338.8 346.4 5009.8 5115.4 5150.6 5213.0 5217.3 4996.8 5023.3 5095.5 5122.5 5135.4 4069.7 4086.5 4091.7 4094.7 4096.4 3967.8 4087.6 4092.4 4095.2 4095.7 4022.5 4057.0 4058.2 4062.1 4063.3 4025.6 4032.0 4037.7 4046.3 4046.7 3621.6 3623.7 3624.8 3632.7 3643.5 4842.6 4977.3 4985.2 5003.1 5055.0 4626.8 4637.2 4644.4 4647.0 4652.2 5323.6 5332.6 5345.8 5364.4 5380.9 3721.6 3900.3 3918.7 3946.6 3950.3 5530.2 5566.3 5572.3 5574.8 5579.9 4002.2 4003.8 4006.4 4014.5 4021.0 3967.8 4038.7 4065.4 4071.9 4081.6 4611.4 4612.9 4614.3 4629.0 4630.9 5389.4 5401.8 5416.9 5419.5 5441.9 1310.6 1321.9 1342.2 1357.7 1390.5 924.8 934.2 956.2 961.4 965.4 5189.9 5190.8 5200.7 5202.6 5216.7 5427.6 5430.2 5439.4 5442.7 5448.9 5038.8 5183.9 5200.9 5207.5 5218.3 2536.9 2542.6 2552.8 2562.1 2574.0 4952.9 4978.6 4980.0 5016.4 5017.4 4665.5 4890.3 4909.9 4917.3 4929.1 4999.1 5023.9 5025.9 5090.5 5103.2 4880.5 4895.1 4897.2 4898.0 4905.9 4428.0 4717.7 4834.6 4845.4 4871.3 5070.2 5070.8 5076.8 5090.6 5094.6 3643.6 3660.2 3665.9 3668.5 3675.7 4562.6 4858.7 4895.4 4904.6 4916.3 4649.3 4678.6 4753.9 4774.4 4799.5 4699.7 4725.6 4734.8 4738.6 4760.0 4697.6 4708.2 4734.3 4749.5 5045.3 5443.8 5459.5 5460.1 5464.3 5467.5 5310.7 5366.8 5383.9 5386.3 5394.3 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - PROCESS | 1933 | [#5] yui.html Cycles:180 Average:20327.76 Median:4558.11 stddev:29099.18 (638.4%) stddev-sans-first:29143.55 09:38:18 INFO - PROCESS | 1933 | Values: 714.7 746.5 749.7 778.3 830.2 14979.6 16565.7 16609.8 16609.9 16623.0 14682.5 14835.5 15002.2 15006.0 15020.4 636.3 654.2 654.6 757.8 778.6 661.6 770.0 795.1 798.2 802.7 845.1 847.4 857.4 857.6 857.7 844.6 845.5 845.6 845.8 845.9 500.7 507.1 624.9 625.2 625.5 12798.9 13252.5 13286.8 13691.3 13716.9 14702.2 15346.7 15533.7 15607.7 15679.8 11650.3 11820.6 11911.7 11988.3 12329.9 3829.4 3854.9 3890.5 3919.3 3939.5 78332.6 78589.0 78844.6 79423.0 80027.6 11287.5 11313.7 11624.3 11728.2 11771.7 23136.4 23285.8 23414.5 23506.3 23564.9 8354.2 8579.9 8591.5 8701.3 8743.6 4473.8 4516.4 4591.8 4639.0 4661.4 3567.9 3626.3 3641.4 3643.8 3692.4 594.5 596.2 600.4 617.0 618.7 693.2 699.0 708.0 731.2 736.6 9118.8 9483.3 9652.9 9787.1 10062.8 620.8 649.2 649.5 655.7 684.7 4389.5 4524.5 4723.7 4732.0 4751.6 68401.7 68879.3 73948.0 124441.4 124547.0 100601.5 101755.5 101950.0 102401.0 104328.5 56177.0 76373.0 90031.1 93301.5 96079.5 8717.5 8948.4 8980.5 9028.5 9038.8 49590.5 53094.7 54071.5 55226.4 55767.7 77598.0 78507.2 79119.6 79707.2 82745.6 12176.8 12266.9 12271.3 12562.7 12965.7 13197.9 13241.7 13488.7 13693.7 13803.7 11404.6 11693.4 11957.9 12045.4 12272.1 12195.8 12388.4 12472.4 12747.6 12914.5 13147.1 13321.3 13569.7 13585.9 13928.4 9980.3 10353.2 10663.8 10835.9 10839.3 11142.1 11365.1 11542.0 11705.8 11752.4 09:38:18 INFO - PROCESS | 1933 | -------- Summary: end -------- 09:38:18 INFO - PROCESS | 1933 | 09:38:18 INFO - TEST-INFO | 1933: exit 0 09:38:18 INFO - TEST-OK | dromaeo_css | took 1117435ms 09:38:18 INFO - TEST-START | kraken 09:38:18 INFO - operating with platform_type : linux_ 09:38:18 INFO - Initialising browser for kraken test... 09:38:18 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4x97Y/profile http://localhost:60207/getInfo.html) 09:38:23 INFO - PROCESS | 2242 | __metrics Screen width/height:1600/1200 09:38:23 INFO - PROCESS | 2242 | colorDepth:24 09:38:23 INFO - PROCESS | 2242 | Browser inner width/height: 1024/697 09:38:23 INFO - PROCESS | 2242 | __metrics 09:38:24 INFO - PROCESS | 2242 | 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" 09:38:24 INFO - PROCESS | 2242 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:24 INFO - PROCESS | 2242 | console.error: PushService: 09:38:24 INFO - PROCESS | 2242 | stateChangeProcessEnqueue: Error transitioning state 09:38:24 INFO - PROCESS | 2242 | UnknownError 09:38:25 INFO - TEST-INFO | 2242: exit 0 09:38:25 INFO - Browser initialized. 09:38:25 INFO - Running cycle 1/1 for kraken test... 09:38:25 INFO - TEST-INFO | started process 2327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4x97Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:37 INFO - PROCESS | 2327 | RSS: Main: 173244416 09:38:37 INFO - PROCESS | 2327 | 09:38:39 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60207/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:40 INFO - PROCESS | 2327 | RSS: Main: 232468480 09:38:40 INFO - PROCESS | 2327 | 09:38:43 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60207/tests/kraken/driver.html?testName=audio-dft) 09:38:44 INFO - PROCESS | 2327 | RSS: Main: 216911872 09:38:44 INFO - PROCESS | 2327 | 09:38:47 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60207/tests/kraken/driver.html?testName=audio-fft) 09:38:47 INFO - PROCESS | 2327 | RSS: Main: 298840064 09:38:47 INFO - PROCESS | 2327 | 09:38:49 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60207/tests/kraken/driver.html?testName=audio-oscillator) 09:38:50 INFO - PROCESS | 2327 | RSS: Main: 207306752 09:38:50 INFO - PROCESS | 2327 | 09:38:52 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60207/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:53 INFO - PROCESS | 2327 | RSS: Main: 212619264 09:38:53 INFO - PROCESS | 2327 | 09:38:56 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60207/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:56 INFO - PROCESS | 2327 | RSS: Main: 248807424 09:38:56 INFO - PROCESS | 2327 | 09:39:00 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60207/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:00 INFO - PROCESS | 2327 | RSS: Main: 247697408 09:39:00 INFO - PROCESS | 2327 | 09:39:03 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60207/tests/kraken/driver.html?testName=json-parse-financial) 09:39:04 INFO - PROCESS | 2327 | RSS: Main: 247218176 09:39:04 INFO - PROCESS | 2327 | 09:39:05 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60207/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:06 INFO - PROCESS | 2327 | RSS: Main: 209555456 09:39:06 INFO - PROCESS | 2327 | 09:39:08 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:08 INFO - PROCESS | 2327 | RSS: Main: 217346048 09:39:08 INFO - PROCESS | 2327 | 09:39:10 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:11 INFO - PROCESS | 2327 | RSS: Main: 225935360 09:39:11 INFO - PROCESS | 2327 | 09:39:14 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:14 INFO - PROCESS | 2327 | RSS: Main: 235839488 09:39:14 INFO - PROCESS | 2327 | 09:39:17 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:18 INFO - PROCESS | 2327 | RSS: Main: 231849984 09:39:18 INFO - PROCESS | 2327 | 09:39:19 INFO - PROCESS | 2327 | Cycle 1(1): loaded http://localhost:60207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60207/tests/kraken/driver.html?testName=ai-astar) 09:39:20 INFO - PROCESS | 2327 | RSS: Main: 283484160 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | __start_tp_report 09:39:20 INFO - PROCESS | 2327 | _x_x_mozilla_page_load 09:39:20 INFO - PROCESS | 2327 | _x_x_mozilla_page_load_details 09:39:20 INFO - PROCESS | 2327 | |i|pagename|runs| 09:39:20 INFO - PROCESS | 2327 | |0;ai-astar;111;113;111;111;111;111;112;111;111;110 09:39:20 INFO - PROCESS | 2327 | |1;audio-beat-detection;146;122;124;159;123;122;121;122;148;124 09:39:20 INFO - PROCESS | 2327 | |2;audio-dft;162;163;163;163;162;162;162;163;162;162 09:39:20 INFO - PROCESS | 2327 | |3;audio-fft;75;76;75;117;77;76;77;76;98;75 09:39:20 INFO - PROCESS | 2327 | |4;audio-oscillator;82;82;124;82;81;82;101;81;81;110 09:39:20 INFO - PROCESS | 2327 | |5;imaging-gaussian-blur;116;116;116;117;117;117;117;116;117;117 09:39:20 INFO - PROCESS | 2327 | |6;imaging-darkroom;149;148;149;148;149;149;150;148;149;145 09:39:20 INFO - PROCESS | 2327 | |7;imaging-desaturate;95;95;96;94;95;95;95;95;96;95 09:39:20 INFO - PROCESS | 2327 | |8;json-parse-financial;51;54;53;52;52;52;53;53;53;61 09:39:20 INFO - PROCESS | 2327 | |9;json-stringify-tinderbox;61;62;61;61;61;61;62;62;60;62 09:39:20 INFO - PROCESS | 2327 | |10;stanford-crypto-aes;80;80;89;84;81;81;80;80;90;79 09:39:20 INFO - PROCESS | 2327 | |11;stanford-crypto-ccm;130;129;129;139;129;131;129;137;174;128 09:39:20 INFO - PROCESS | 2327 | |12;stanford-crypto-pbkdf2;170;166;168;169;167;165;167;167;169;167 09:39:20 INFO - PROCESS | 2327 | |13;stanford-crypto-sha256-iterative;68;68;66;66;64;67;65;65;64;64 09:39:20 INFO - PROCESS | 2327 | __end_tp_report 09:39:20 INFO - PROCESS | 2327 | __start_cc_report 09:39:20 INFO - PROCESS | 2327 | _x_x_mozilla_cycle_collect,1628 09:39:20 INFO - PROCESS | 2327 | __end_cc_report 09:39:20 INFO - PROCESS | 2327 | __startTimestamp1476117560146__endTimestamp 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | ------- Summary: start ------- 09:39:20 INFO - PROCESS | 2327 | Number of tests: 14 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:39:20 INFO - PROCESS | 2327 | Values: 111.0 113.0 111.0 111.0 111.0 111.0 112.0 111.0 111.0 110.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:124.00 stddev:14.15 (11.4%) stddev-sans-first:13.95 09:39:20 INFO - PROCESS | 2327 | Values: 146.0 122.0 124.0 159.0 123.0 122.0 121.0 122.0 148.0 124.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 09:39:20 INFO - PROCESS | 2327 | Values: 162.0 163.0 163.0 163.0 162.0 162.0 162.0 163.0 162.0 162.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:14.09 (18.5%) stddev-sans-first:14.70 09:39:20 INFO - PROCESS | 2327 | Values: 75.0 76.0 75.0 117.0 77.0 76.0 77.0 76.0 98.0 75.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.54 (19.1%) stddev-sans-first:16.16 09:39:20 INFO - PROCESS | 2327 | Values: 82.0 82.0 124.0 82.0 81.0 82.0 101.0 81.0 81.0 110.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:39:20 INFO - PROCESS | 2327 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.35 (0.9%) stddev-sans-first:1.41 09:39:20 INFO - PROCESS | 2327 | Values: 149.0 148.0 149.0 148.0 149.0 149.0 150.0 148.0 149.0 145.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:39:20 INFO - PROCESS | 2327 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.80 (5.3%) stddev-sans-first:2.83 09:39:20 INFO - PROCESS | 2327 | Values: 51.0 54.0 53.0 52.0 52.0 52.0 53.0 53.0 53.0 61.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:39:20 INFO - PROCESS | 2327 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 60.0 62.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:3.98 (4.9%) stddev-sans-first:4.12 09:39:20 INFO - PROCESS | 2327 | Values: 80.0 80.0 89.0 84.0 81.0 81.0 80.0 80.0 90.0 79.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:130.50 stddev:14.03 (10.8%) stddev-sans-first:14.74 09:39:20 INFO - PROCESS | 2327 | Values: 130.0 129.0 129.0 139.0 129.0 131.0 129.0 137.0 174.0 128.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:1.51 (0.9%) stddev-sans-first:1.30 09:39:20 INFO - PROCESS | 2327 | Values: 170.0 166.0 168.0 169.0 167.0 165.0 167.0 167.0 169.0 167.0 09:39:20 INFO - PROCESS | 2327 | 09:39:20 INFO - PROCESS | 2327 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.42 09:39:20 INFO - PROCESS | 2327 | Values: 68.0 68.0 66.0 66.0 64.0 67.0 65.0 65.0 64.0 64.0 09:39:20 INFO - PROCESS | 2327 | -------- Summary: end -------- 09:39:20 INFO - PROCESS | 2327 | 09:39:21 INFO - TEST-INFO | 2327: exit 0 09:39:21 INFO - TEST-OK | kraken | took 62465ms 09:39:21 INFO - SUITE-END | took 1179s 09:39:21 INFO - Completed test suite (00:19:40) 09:39:21 INFO - javascript benchmark 09:39:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2977.285451491642, 3005.3688725367665, 3011.2471882029495, 3032.9545056824136, 3059.6634370219285, 5094.184930411135, 5130.15352466843, 5163.974180129104, 5184.53339199472, 5185.014847179038, 5119.6672216305915, 5186.0665080285535, 5200.791968321262, 5205.869853253671, 5220.608454365928, 4731.716097034189, 4764.285357196413, 4783.115123702109, 4801.8079276828885, 4805.279208118775, 4754.342332624184, 4796.520347965193, 4804.615630749549, 4838.733869637169, 4878.390201224847, 4437.378766972626, 4829.975850120744, 4835.443923948738, 4862.513748625144, 4891.021795640886, 4616.676832621718, 4782.808687652525, 4793.32893394925, 4824.614030877557, 4837.419509658864, 4658.487566367697, 4670.0, 4703.600193983515, 4720.0, 4738.123447162286, 5161.096808058574, 5169.043726910496, 5179.482051794828, 5191.766370513336, 5235.162374020177, 5554.944450555524, 5555.749991250404, 5556.777728890839, 5562.694051827148, 5563.944360556383, 5403.7027963462, 5437.0, 5443.074677304828, 5467.0, 5488.25908502355, 5127.564157046618, 5136.332276803992, 5142.228665700175, 5145.30538377318, 5147.356580427447, 5598.048331783607, 5607.130894711327, 5610.186522954149, 5612.5229355504425, 5659.462351076641, 5251.264822924793, 5306.92039619406, 5385.569154467633, 5449.1826226066405, 5454.236406902957, 5554.86112847174, 5555.638883472561, 5613.186088017214, 5615.578831587647, 5617.073182924772, 5525.336959564797, 5528.226048353234, 5533.723313834373, 5539.113741801373, 5545.584081193927, 5284.0, 5330.413654498002, 5471.480209380103, 5544.528715059265, 5608.46719561641, 4276.358546218092, 4298.742075475481, 4327.913441731148, 4337.392765012901, 4390.604845563851, 3870.3613903705573, 3871.4386413969814, 3874.380099184117, 3885.805709714503, 3906.0430194601936, 5295.443978382292, 5301.204819277063, 5304.708241046702, 5310.256564081032, 5311.176767601028, 5409.350877894599, 5456.508914197662, 5456.781728730806, 5467.808626698046, 5495.065838807413, 5229.869253268699, 5288.286081379041, 5302.443243459381, 5373.785048598091, 5378.596605254622, 4832.661713680009, 4836.419629644395, 4846.297286893451, 4872.561469467765, 4894.2169252920075, 5764.423557644202, 5773.566982476331, 5774.220480235114, 5780.132980052942, 5791.0734282514595, 5367.543758780547, 5369.6509726867625, 5426.294581704511, 5515.145152501208, 5515.641483303572, 5686.829395117988, 5759.913601296068, 5761.07822748375, 5766.365699772938, 5767.711614419179, 5438.592105592175, 5452.863678407913, 5455.727213639381, 5459.481349271813, 5462.399136095106, 5533.667979921218, 5556.027695153412, 5557.472040156179, 5560.221568980265, 5563.527100196528, 5392.137258038695, 5407.486288802557, 5410.540104091197, 5412.215228791882, 5435.537979271806, 5410.540104091039, 5420.674759514284, 5421.891562168814, 5423.186522021729, 5423.29497165366, 5375.892482150413, 5376.489233522809, 5380.650257733235, 5415.160650099241, 5446.210299506629, 5433.972830135824, 5448.455154484678, 5478.91781623284, 5483.095289277225, 5549.056660367666, 5175.689458632494, 5207.843764686914, 5218.504242096995, 5370.785168593213, 5377.623566350474], "value": 5120.531958605647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.2618752746595, 611.8470382404399, 611.8990366589513, 616.4667562558388, 626.3454689849107, 31689.0, 34628.96113116608, 34704.826475867616, 41515.37726934091, 43073.138537229235, 44160.3375949361, 44507.3323900141, 44511.77441127947, 44514.0, 44522.55477445225, 8676.956615216915, 8857.379983401164, 8860.158284962918, 8864.468131912074, 8865.157810008039, 8025.0, 8232.753017409488, 8719.694810681627, 10329.328593641427, 10631.0, 10729.409882456463, 10795.568177272939, 10795.892041079567, 10800.189985751062, 10802.351858888453, 10608.469576521182, 10683.0, 10684.679459616224, 10687.412192329419, 10701.732456688567, 7934.44458887878, 8161.387895907771, 10113.64602238918, 10444.0, 10452.268341216119, 41304.38043429351, 41582.58417415847, 41648.58351416478, 41684.0, 41694.79152604248, 3415.453527435623, 3676.650718181795, 3829.2341531693496, 3837.808109594509, 3964.207158568298, 31500.0, 31576.526352104738, 31864.0, 31936.361272774648, 33114.6688533114, 3911.941320880189, 4018.839246430139, 4027.456293400383, 4155.605217504362, 4209.158168366339, 322684.0, 323207.0, 323704.0, 324335.0, 325217.0, 53203.201951970754, 53527.0, 53543.322833858154, 53578.464215357344, 53595.464045359826, 57039.14441283384, 57137.42862571404, 57169.714151428976, 57188.14217786737, 57200.0, 14655.85344146545, 15051.774223386657, 15065.623359415884, 15076.698466030617, 15084.773728394082, 10495.10791582724, 11394.601188958513, 11415.60045398407, 11423.942880285711, 11431.828522572168, 13677.179369237678, 15077.54767356981, 15202.695946081016, 15362.923185384001, 15913.283902224428, 6253.937460625427, 6347.619142851444, 6405.188912596997, 6417.582857114273, 6541.411272985454, 896.4666023715879, 973.6105557776805, 1018.8217062014267, 1060.3213943076437, 1077.789830982951, 31331.216719582193, 31477.527837082464, 31553.211169720482, 31767.0, 32103.357932841212, 1062.2564205056492, 1090.231386872253, 1145.9427028648533, 1158.247139359423, 1187.7446349034826, 15483.12339549896, 16635.16824158787, 16646.16769161537, 16702.749458758128, 16765.0, 483602.0, 485424.0, 485700.0, 487059.0, 487602.0, 55415.445845541835, 55648.0, 55664.0, 55754.72122639361, 55861.44138558643, 1183.7857228267396, 1213.8179273109104, 1234.0497816681284, 1281.878221568968, 1324.9403776829872, 26865.865670672305, 30498.390032199677, 31550.211244719067, 33811.661883381836, 33905.83047084749, 51157.7442112787, 51785.22322165246, 51826.740866295426, 51898.0, 51949.22076168936, 436914.0, 438972.0, 441063.0, 442168.0, 442698.0, 26584.601230981163, 27395.178144655692, 27475.0, 38235.23529529449, 38585.614143858205, 45793.313100304185, 46790.532094678616, 46916.06167876691, 47042.29436558523, 47188.0, 38528.2294354117, 39063.41404878872, 39099.804500978455, 40218.39672404975, 40685.0, 38095.0, 38365.0, 38390.23219535538, 39851.80074099611, 40169.79915100406, 39558.40662390009, 39715.60284397119, 40090.0, 40146.1970760589, 40183.397249041875, 33159.33681326408, 34876.0, 35205.647943520235, 35371.29257414786, 35382.646173537934, 26649.200523984313, 27151.0, 27177.0, 27269.318267043484, 27324.863375682995], "value": 19634.63332268132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.6084969507476, 369.7781331201278, 393.87986664067466, 398.9786147462496, 416.8686863637954, 14027.01810873238, 14838.777418338721, 17025.574360641007, 19701.802981970177, 19867.20531178751, 17772.555686107855, 17981.82018179818, 18034.368797092106, 18158.273669053255, 19189.424317270503, 5557.166425036256, 5783.334916484616, 5785.681787501686, 5787.189793428924, 5795.652260864362, 4811.687240329385, 5324.574034077284, 5690.857728556778, 5719.742611582489, 5722.170285308628, 5644.125160600093, 5645.125005624135, 5651.2935883014625, 5652.463016013472, 5660.0, 5510.228568000483, 5753.395893431192, 5784.190213370152, 5837.387074357174, 5874.236349274567, 5448.509634132907, 5562.3881373049335, 5633.887322253573, 5643.0, 5651.604387692863, 13217.73564528704, 13430.462781488728, 13441.932790336083, 13467.057305988585, 13676.65808354789, 2203.162798136698, 2261.604219261623, 2290.8281878858984, 2401.771831675988, 2878.5250433678416, 9886.307958442912, 9888.802223955481, 10067.89932100677, 10406.115480184193, 10597.576096956112, 1857.823506766855, 1870.0462763990326, 1900.631545287391, 1905.1617288393063, 1926.1717461491553, 81643.71235033845, 83505.58247208786, 85465.0, 86229.0, 87978.12021879763, 9198.862017069749, 9644.565994530263, 9730.318877678636, 10584.417857017937, 10868.130549556017, 12995.28525931083, 13019.349032548334, 13096.279704616147, 13128.474861005452, 13141.737165256642, 6912.654367281716, 7018.508704390643, 7130.108736407949, 7141.82145446368, 7152.785416437515, 6744.359285867835, 6745.12313399255, 6768.898466523006, 6817.318268173143, 6955.6869940852785, 3988.0, 4032.6169013944213, 4073.287174744408, 4101.077257617012, 4145.336746120606, 1846.8180364566688, 1936.7482227310359, 1942.990285048594, 1944.397236856579, 1955.0908827395328, 877.5305211711703, 950.7337945375306, 1004.8342023566175, 1017.5471914997755, 1081.534939975818, 19139.904300478407, 19540.70688939667, 19725.802741972395, 19757.0, 19837.30569430063, 901.1754244865874, 951.6859436385976, 953.4041224234853, 957.2937850305017, 975.23444096384, 10391.324563903323, 10685.305455145392, 10746.623868164734, 10778.245522813484, 10807.891921080845, 471235.0, 477653.0, 478400.0, 478411.0, 481377.0, 82929.58535207406, 93635.53182234181, 93994.0, 94790.0, 95531.0, 937.0769791755116, 962.3744566031995, 972.6644307713827, 975.9414435133915, 989.1098011789447, 16427.425040123537, 16577.50267491977, 17211.827881721023, 17412.216450259515, 17676.0, 40709.0, 41544.58455415528, 41646.58353416427, 42096.579034209266, 42569.148617028106, 53543.0, 56116.71941640429, 57841.4215857836, 58813.0, 61616.0, 8077.434579579373, 8244.979979904962, 8437.451565648213, 8471.0, 8563.272121869712, 10563.419011954416, 12679.161521579505, 12729.363531823557, 12943.158694684815, 13270.27013514266, 10816.621418250637, 10879.1840611956, 10995.890041099487, 11073.778524429305, 11529.82705259405, 10696.572137114428, 10732.08777253911, 10912.890871091187, 11115.277506962022, 11132.554697811996, 10946.945265273622, 11013.229073964745, 11225.326480411202, 11321.71695707614, 11745.29528228309, 7380.889286660597, 7480.279535706927, 7641.617919104134, 7937.0, 8388.748337549883, 10391.844122338322, 11051.83422248683, 11229.606963756229, 11293.491792869505, 11743.706407339885], "value": 8731.03612648314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.530615705323, 1431.6420894776302, 1496.4463148635004, 1578.2976575423934, 1787.0528619831493, 7922.286994170524, 8784.297256219503, 9081.0, 9107.271418286538, 9327.533623318841, 9175.908240917588, 9239.260859131271, 9239.584218710157, 9241.49171795551, 9247.352685312031, 2318.559473699996, 2346.530693861226, 2346.77705617966, 2349.7180338359335, 2355.316958082154, 2281.8060464860505, 2287.1880482428664, 2320.9419764505856, 2335.0, 2343.039353864916, 2325.104834638668, 2335.9182428615004, 2348.412896775806, 2354.5526349993534, 2357.3752955466816, 2229.6544035674497, 2235.3517479930965, 2237.339984704508, 2241.8542794718373, 2278.612635851909, 2267.3764714703425, 2282.201229569654, 2284.862908225512, 2290.599145149592, 2301.643245296965, 8940.68707595231, 9019.639214431414, 9077.228435582918, 9086.86369704455, 9092.181703646704, 5049.469805670426, 5245.86885327866, 5258.3689957205, 5259.474052594748, 5260.342457192851, 3192.090254277543, 3385.86456541738, 3400.4559270516597, 3422.7261819054415, 3425.2293234022395, 1083.56657337065, 1103.0458653264948, 1919.9904000479908, 1955.5502234486005, 2004.1482369992696, 12157.878421215852, 12170.087243456775, 12249.0, 12272.509099635914, 12308.323042232674, 4343.630791382705, 4536.274196128604, 4633.907321853544, 4660.347551342815, 4709.1994360958715, 9838.803223935623, 9868.555914983843, 9876.45679487635, 9877.456739879231, 9881.308308418342, 5075.111855425286, 5098.337216161875, 5102.107131252016, 5102.770375333119, 5176.792928282902, 4123.402106694512, 4259.297215959394, 4492.483364413134, 4578.153041687232, 4774.761261936889, 3560.857565697395, 3600.8199590020395, 3634.2913131939545, 3712.2389910068373, 3719.739618226698, 1023.0485648347109, 1030.8711411073616, 1045.095991966943, 1046.2571574182416, 1053.4522048534718, 804.3484777330381, 921.9677311294207, 957.4925289596525, 957.8898426680881, 961.1781926452783, 5917.46742793142, 5978.910316345258, 6042.39576042401, 6045.758169673164, 6059.515238780887, 439.5275079289776, 439.83945859760956, 444.5154781288411, 456.4727739460928, 463.33742747870866, 3927.1752931884052, 3990.880273591797, 4012.117334186474, 4041.81811818463, 4133.379993001014, 10881.23831331815, 11202.775944481065, 11303.660890173143, 11317.660470185907, 11323.490442930088, 11248.775024499464, 11252.49363778632, 11254.0, 11270.21108522412, 11283.0, 8144.552049637208, 8239.258466738022, 8360.331173506105, 8377.49735015901, 8381.706640267439, 5606.24315717373, 5612.102063669793, 5641.379448260606, 5689.487946084872, 5815.738291776965, 10059.647912323033, 10142.087212150942, 10203.03071208234, 10230.181585473294, 10389.0, 10076.193904487476, 10360.637377691744, 10609.734756631146, 10610.151187904794, 10617.893821062, 6889.242183359726, 7086.043384143075, 7097.787066388017, 7532.133804612539, 7613.124490683642, 7938.0, 8052.154523775153, 8113.7565873023905, 8117.715879944174, 8225.465344752572, 7399.926000739923, 7481.70073197066, 7484.214157513383, 7664.961675191588, 7682.6926922924695, 7479.58862262559, 7521.285477879593, 7567.848643027219, 7577.810554736176, 7744.612769361397, 6578.934210657832, 6709.597424154566, 6714.563553369016, 6717.731290748316, 6725.697343619647, 5007.37407824022, 5078.822241221687, 5092.567131793839, 5180.0, 5181.093308670892, 4866.099771542276, 4968.776405061709, 5090.694558326512, 5179.559737422362, 5398.865028374322], "value": 4514.119244973333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.7147967008538, 333.0956453229482, 337.9003194057753, 338.78487160652986, 346.3523211594319, 5009.774560144793, 5115.411727651316, 5150.613703972198, 5213.035588416141, 5217.295665085212, 4996.7751451184695, 5023.3469648945675, 5095.496828435611, 5122.462141475138, 5135.383753949522, 4069.6540794032544, 4086.5300490443606, 4091.713580049398, 4094.651954583864, 4096.365063415175, 3967.8016099194924, 4087.6321131098193, 4092.3656833190903, 4095.1809638072355, 4095.672346212296, 4022.5172979242384, 4056.9797151014204, 4058.1883623275316, 4062.1469491406842, 4063.2889244382263, 4025.5571887092397, 4031.9596804031876, 4037.676985841155, 4046.271671099201, 4046.6964977626794, 3621.6016238213774, 3623.691986181178, 3624.7643903146477, 3632.654897784706, 3643.544556930384, 4842.612590992712, 4977.303177555145, 4985.227289770091, 5003.149464591028, 5055.0, 4626.768661566942, 4637.2116740153915, 4644.373009643688, 4647.0, 4652.185867473178, 5323.627346085776, 5332.626716129873, 5345.812896548602, 5364.383095943938, 5380.865478363033, 3721.5906250312446, 3900.258950799339, 3918.7060970427333, 3946.605339466059, 3950.308695978192, 5530.225768392428, 5566.332040155166, 5572.2974357436615, 5574.832755017356, 5579.944200558024, 4002.199560087936, 4003.7597744135446, 4006.3790112532606, 4014.5182578090817, 4021.0, 3967.7941382134454, 4038.7076135636316, 4065.3901914712437, 4071.89820254496, 4081.6122468365456, 4611.371518234574, 4612.884677883079, 4614.330922016289, 4628.9537104628525, 4630.930536041962, 5389.407165211824, 5401.811601447754, 5416.918746218731, 5419.485148910847, 5441.918371224435, 1310.6395741171254, 1321.8678132186703, 1342.174562643967, 1357.6605848537865, 1390.4716207840956, 924.8150369926042, 934.1732566678538, 956.2302346610905, 961.3847137831793, 965.3725078698761, 5189.896202075937, 5190.792368305226, 5200.713960732196, 5202.609804264695, 5216.686998780086, 5427.6472029317965, 5430.239766432703, 5439.374471935699, 5442.673439593637, 5448.863778405493, 5038.84883453497, 5183.948160518422, 5200.869978250498, 5207.453217412193, 5218.321618189687, 2536.9238922832346, 2542.6186072088963, 2552.8468291902545, 2562.141682536334, 2573.961390579143, 4952.851414457572, 4978.551930326288, 4980.0, 5016.398032236155, 5017.397912250553, 4665.533446655308, 4890.266460030953, 4909.926351104737, 4917.262410638433, 4929.053024055478, 4999.075171093359, 5023.899522009539, 5025.899482010339, 5090.516400941905, 5103.234514822806, 4880.536349046835, 4895.118878601886, 4897.216445368724, 4897.9510204898925, 4905.8904670991815, 4427.955720442755, 4717.72621392229, 4834.5890599298045, 4845.41854977405, 4871.293662419001, 5070.2141168119, 5070.797168113234, 5076.82231121909, 5090.618203634816, 5094.5669618082875, 3643.562772467321, 3660.2313514162324, 3665.908352291214, 3668.4680721295795, 3675.7243206760136, 4562.58936695699, 4858.720363754523, 4895.4370247422, 4904.58311043551, 4916.254729571094, 4649.279361698942, 4678.602318802804, 4753.857384278477, 4774.350235619265, 4799.496052914394, 4699.660596729916, 4725.574698277172, 4734.810607575659, 4738.578426472113, 4760.047990402003, 4697.624190064718, 4708.234412095464, 4734.33719279308, 4749.453812811433, 5045.31888195089, 5443.836684899459, 5459.481349271813, 5460.099083651312, 5464.316960379952, 5467.49643847945, 5310.734463276744, 5366.838994830161, 5383.892322153613, 5386.299781028441, 5394.298741163623], "value": 3970.035330347647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.7355478472963, 746.4998451037804, 749.6963729689476, 778.2606523802389, 830.2361827119051, 14979.625509362259, 16565.66868662626, 16609.750853737205, 16609.916950415245, 16623.0, 14682.486112986047, 14835.480758173466, 15002.174880381575, 15006.0, 15020.399184032625, 636.2841802971657, 654.2084078265304, 654.5745265577365, 757.7726681995393, 778.634042000259, 661.5832025823725, 770.0259172147238, 795.1293333799509, 798.1659166171365, 802.6909639788694, 845.0619812008696, 847.4364547575855, 857.3998201259112, 857.6140736668493, 857.6569372251087, 844.6368061733452, 845.5053793530792, 845.6194712379423, 845.7758693946109, 845.8773477845677, 500.7321083220496, 507.1074908161662, 624.9218847644045, 625.1841347042108, 625.5433533520555, 12798.936005319914, 13252.536161234408, 13286.800697989538, 13691.315434228249, 13716.931415342959, 14702.191379474125, 15346.693066138614, 15533.689326213413, 15607.687846243125, 15679.843201567952, 11650.291954801789, 11820.645380638594, 11911.702207444796, 11988.28070315775, 12329.876701232963, 3829.4064420014943, 3854.9421758673643, 3890.455336252927, 3919.333713268751, 3939.468171796799, 78332.60833695852, 78589.0, 78844.60577697132, 79423.0, 80027.5998620009, 11287.470907292898, 11313.691025908442, 11624.302541847515, 11728.179027467995, 11771.705707357385, 23136.4215894604, 23285.76714232836, 23414.531709365718, 23506.294811155694, 23564.882175589013, 8354.164583541597, 8579.914200858037, 8591.548595822538, 8701.30389568833, 8743.606537705818, 4473.776311184428, 4516.4292290786125, 4591.77041147948, 4638.95361046392, 4661.440627124699, 3567.8572857085946, 3626.2747450510005, 3641.362761516777, 3643.799591022519, 3692.3538380783257, 594.5006194796392, 596.2100217212211, 600.4115966352998, 617.0189398855841, 618.712298781069, 693.1578132568953, 698.9930100698928, 707.9964600176966, 731.1701219116342, 736.576468530597, 9118.817623647623, 9483.288753343526, 9652.855207171899, 9787.070228328297, 10062.849057264148, 620.8323752586776, 649.227419370947, 649.5388274325283, 655.7214423887685, 684.7397988764237, 4389.495208051115, 4524.457065152137, 4723.716577005391, 4732.0, 4751.572358487752, 68401.65799170973, 68879.31120688829, 73948.0, 124441.37779311046, 124547.0, 100601.49699251603, 101755.49122254341, 101950.0, 102400.97599023914, 104328.47835760773, 56177.0, 76373.0, 90031.09968900357, 93301.5334923321, 96079.51960240155, 8717.476951382938, 8948.418352807046, 8980.46117232942, 9028.539518557605, 9038.811023425973, 49590.50409495859, 53094.73452632712, 54071.45928540664, 55226.44773552213, 55767.721161393936, 77598.0, 78507.21492784999, 79119.60440197762, 79707.20292796998, 82745.58627206825, 12176.817347739614, 12266.938665306616, 12271.325077120488, 12562.685932851751, 12965.675858103623, 13197.868021319664, 13241.735165296448, 13488.662783430493, 13693.657658558615, 13803.654908627364, 11404.641735882167, 11693.356865372147, 11957.940210298893, 12045.397730113635, 12272.140950133406, 12195.817062744243, 12388.442520086797, 12472.376381181086, 12747.553835615709, 12914.547990820276, 13147.14543554666, 13321.26733029654, 13569.728605428034, 13585.932070339584, 13928.442862285801, 9980.301378903407, 10353.223508237063, 10663.840042399526, 10835.945820270848, 10839.349639021684, 11142.108631309638, 11365.147613929154, 11542.0, 11705.765884682429, 11752.412379380825], "value": 7385.483634294695, "unit": "score"}], "name": "dromaeo_css", "value": 6985.535014885301, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 124.0, 159.0, 123.0, 122.0, 121.0, 122.0, 148.0, 124.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 117.0, 77.0, 76.0, 77.0, 76.0, 98.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 124.0, 82.0, 81.0, 82.0, 101.0, 81.0, 81.0, 110.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 149.0, 150.0, 148.0, 149.0, 145.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 53.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 61.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 60.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 89.0, 84.0, 81.0, 81.0, 80.0, 80.0, 90.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 129.0, 139.0, 129.0, 131.0, 129.0, 137.0, 174.0, 128.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 168.0, 169.0, 167.0, 165.0, 167.0, 167.0, 169.0, 167.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 64.0, 67.0, 65.0, 65.0, 64.0, 64.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1503.4, "alertThreshold": 2.0}]} 09:39:21 INFO - Return code: 0 09:39:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:21 INFO - # TBPL SUCCESS # 09:39:21 INFO - Running post-action listener: _resource_record_post_action 09:39:21 INFO - [mozharness: 2016-10-10 16:39:21.944152Z] Finished run-tests step (success) 09:39:21 INFO - Running post-run listener: _resource_record_post_run 09:39:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403914752; Read time: 12; Write time: 320520 09:39:22 INFO - TinderboxPrint: CPU usage
13.1% 09:39:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:39:22 INFO - TinderboxPrint: I/O write bytes / time
403,914,752 / 320,520 09:39:22 INFO - TinderboxPrint: CPU idle
8,295.3 (86.8%) 09:39:22 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 09:39:22 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103858176; Read time: 0; Write time: 101372 09:39:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288612352; Read time: 0; Write time: 216864 09:39:22 INFO - Running post-run listener: _upload_blobber_files 09:39:22 INFO - Blob upload gear active. 09:39:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:39:22 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'] 09:39:22 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 09:39:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:23 INFO - (blobuploader) - INFO - Done attempting. 09:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:30 INFO - (blobuploader) - INFO - Done attempting. 09:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:31 INFO - (blobuploader) - INFO - Done attempting. 09:39:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:31 INFO - Return code: 0 09:39:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4946f549195d1206c5316ed418cbfcf81cc0d685e311aed803313dffab0fdb997bedbe480a0a1269d81f631324f29cf22bd6e40a3a6c5e178e699faca9adcdfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58c1eb1be8683ded4c1c88ea39b0db831fc8440c7c0d1e172b546900e12874d1cd9510456b5d21a058f7d9a6303a6ef27cd37b7caf2dfa5c2caf674e7de8dcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46c35039653c501bd969520b3d893e3caf13ec499284f2f0358760d47a179f0b8b905d55253904cefae50639b91b26e61723eb0a379cd17418c4e66e64b9199b"} 09:39:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:31 INFO - Contents: 09:39:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4946f549195d1206c5316ed418cbfcf81cc0d685e311aed803313dffab0fdb997bedbe480a0a1269d81f631324f29cf22bd6e40a3a6c5e178e699faca9adcdfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58c1eb1be8683ded4c1c88ea39b0db831fc8440c7c0d1e172b546900e12874d1cd9510456b5d21a058f7d9a6303a6ef27cd37b7caf2dfa5c2caf674e7de8dcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46c35039653c501bd969520b3d893e3caf13ec499284f2f0358760d47a179f0b8b905d55253904cefae50639b91b26e61723eb0a379cd17418c4e66e64b9199b"} 09:39:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:31 INFO - Copying logs to upload dir... 09:39:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.502137 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-10 09:39:31.129944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 09:39:31.133071) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 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/4946f549195d1206c5316ed418cbfcf81cc0d685e311aed803313dffab0fdb997bedbe480a0a1269d81f631324f29cf22bd6e40a3a6c5e178e699faca9adcdfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58c1eb1be8683ded4c1c88ea39b0db831fc8440c7c0d1e172b546900e12874d1cd9510456b5d21a058f7d9a6303a6ef27cd37b7caf2dfa5c2caf674e7de8dcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46c35039653c501bd969520b3d893e3caf13ec499284f2f0358760d47a179f0b8b905d55253904cefae50639b91b26e61723eb0a379cd17418c4e66e64b9199b"} build_url:https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/BPqmM9z3QMyB0yljqvIZKQ/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/4946f549195d1206c5316ed418cbfcf81cc0d685e311aed803313dffab0fdb997bedbe480a0a1269d81f631324f29cf22bd6e40a3a6c5e178e699faca9adcdfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58c1eb1be8683ded4c1c88ea39b0db831fc8440c7c0d1e172b546900e12874d1cd9510456b5d21a058f7d9a6303a6ef27cd37b7caf2dfa5c2caf674e7de8dcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46c35039653c501bd969520b3d893e3caf13ec499284f2f0358760d47a179f0b8b905d55253904cefae50639b91b26e61723eb0a379cd17418c4e66e64b9199b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 09:39:31.159137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:39:31.159578) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476116068.101521-1555613393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 09:39:31.242890) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 09:39:31.243193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 09:39:31.243609) ========= ========= Total master_lag: 0.17 =========