builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1475580069.53 results: success (0) buildid: 20161004030300 builduid: a700502d30934cc984001824f126098c revision: 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.533704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.534157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.534448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.548938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.549201) ========= 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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 04:21:09-- 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% 51.0M=0s 2016-10-04 04:21:10 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.654483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.654833) ========= 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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018739 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.704883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:09.705238) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b --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 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b --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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 04:21:10,152 truncating revision to first 12 chars 2016-10-04 04:21:10,152 Setting DEBUG logging. 2016-10-04 04:21:10,152 attempt 1/10 2016-10-04 04:21:10,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c203b9d559e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 04:21:10,476 unpacking tar archive at: fx-team-2c203b9d559e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:10.355234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:10.355559) ========= script_repo_revision: 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:10.355973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:10.356242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 04:21:10.366872) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 04:21:10.367205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:10 INFO - MultiFileLogger online at 20161004 04:21:10 in /builds/slave/test 04:21:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:21:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:10 INFO - {'append_to_log': False, 04:21:10 INFO - 'base_work_dir': '/builds/slave/test', 04:21:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:21:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:10 INFO - 'branch': 'Fx-Team-Non-PGO', 04:21:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:10 INFO - 'config_files': ('talos/linux_config.py',), 04:21:10 INFO - 'default_actions': ('clobber', 04:21:10 INFO - 'read-buildbot-config', 04:21:10 INFO - 'download-and-extract', 04:21:10 INFO - 'populate-webroot', 04:21:10 INFO - 'create-virtualenv', 04:21:10 INFO - 'install', 04:21:10 INFO - 'run-tests'), 04:21:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:10 INFO - 'download_minidump_stackwalk': True, 04:21:10 INFO - 'download_symbols': 'ondemand', 04:21:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:10 INFO - 'installer_path': 'installer.exe', 04:21:10 INFO - 'log_level': 'info', 04:21:10 INFO - 'log_name': 'talos', 04:21:10 INFO - 'log_to_console': True, 04:21:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:10 INFO - 'opt_config_files': (), 04:21:10 INFO - 'pip_index': False, 04:21:10 INFO - 'sps_profile': False, 04:21:10 INFO - 'sps_profile_interval': 0, 04:21:10 INFO - 'suite': 'dromaeojs', 04:21:10 INFO - 'system_bits': '32', 04:21:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:10 INFO - 'title': 'talos-linux64-ix-018', 04:21:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:10 INFO - 'use_talos_json': True, 04:21:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:10 INFO - 'work_dir': 'build'} 04:21:10 INFO - [mozharness: 2016-10-04 11:21:10.906630Z] Running clobber step. 04:21:10 INFO - Running pre-action listener: _resource_record_pre_action 04:21:10 INFO - Running main action method: clobber 04:21:10 INFO - rmtree: /builds/slave/test/build 04:21:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:11 INFO - Running post-action listener: _resource_record_post_action 04:21:11 INFO - [mozharness: 2016-10-04 11:21:11.397852Z] Finished clobber step (success) 04:21:11 INFO - [mozharness: 2016-10-04 11:21:11.397952Z] Running read-buildbot-config step. 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: read_buildbot_config 04:21:11 INFO - Using buildbot properties: 04:21:11 INFO - { 04:21:11 INFO - "project": "", 04:21:11 INFO - "product": "firefox", 04:21:11 INFO - "script_repo_revision": "production", 04:21:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:21:11 INFO - "repository": "", 04:21:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:21:11 INFO - "buildid": "20161004030300", 04:21:11 INFO - "pgo_build": "False", 04:21:11 INFO - "basedir": "/builds/slave/test", 04:21:11 INFO - "buildnumber": 1963, 04:21:11 INFO - "slavename": "talos-linux64-ix-018", 04:21:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:21:11 INFO - "platform": "ubuntu64_hw", 04:21:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:21:11 INFO - "branch": "fx-team", 04:21:11 INFO - "repo_path": "integration/fx-team", 04:21:11 INFO - "revision": "2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b", 04:21:11 INFO - "stage_platform": "linux64", 04:21:11 INFO - "builduid": "a700502d30934cc984001824f126098c", 04:21:11 INFO - "slavebuilddir": "test" 04:21:11 INFO - } 04:21:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:21:11 INFO - Running post-action listener: _resource_record_post_action 04:21:11 INFO - [mozharness: 2016-10-04 11:21:11.400395Z] Finished read-buildbot-config step (success) 04:21:11 INFO - [mozharness: 2016-10-04 11:21:11.400484Z] Running download-and-extract step. 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: download_and_extract 04:21:11 INFO - mkdir: /builds/slave/test/build/tests 04:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:11 INFO - trying https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:21:11 INFO - Downloading https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/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 04:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/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 04:21:12 INFO - Downloaded 1361 bytes. 04:21:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:21:12 INFO - Using the following test package requirements: 04:21:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:21:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'jsshell-linux-x86_64.zip'], 04:21:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:21:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:21:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:21:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:12 INFO - Fetch https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:21:12 INFO - Http code: 200 04:21:12 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 04:21:12 INFO - x-amz-cf-id: 3-BgZuUJWXJX5zzIFYn0I8KjgrN2X1T5Z5ar2Wg4MGt-uk_kp-Um5w== 04:21:12 INFO - x-amz-version-id: huiSfpD4ZY3PLtB0_huSst_yQk9mfLw5 04:21:13 INFO - Expected file size: 20421126 04:21:13 INFO - Obtained file size: 20421126 04:21:17 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 04:21:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:21:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:17 INFO - Fetch https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:21:17 INFO - Http code: 200 04:21:17 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 04:21:17 INFO - x-amz-cf-id: U_zi-Iq3Lr38uUmOCAjsOSSVwjZ1QIJKs4G6SFTuC-K97rabuK5svA== 04:21:17 INFO - x-amz-version-id: huiSfpD4ZY3PLtB0_huSst_yQk9mfLw5 04:21:18 INFO - Expected file size: 20421126 04:21:18 INFO - Obtained file size: 20421126 04:21:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:21:22 INFO - Fetch https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:21:23 INFO - Http code: 200 04:21:23 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 04:21:23 INFO - x-amz-cf-id: coiyp0h2i41Q5GvMTxJjXtEuO8KNTNBak-JepMePkuvhxrKul96P9A== 04:21:23 INFO - x-amz-version-id: FSp0COos7IGrk4JkiXxn0An4ZxGIVqfI 04:21:23 INFO - Expected file size: 14409006 04:21:23 INFO - Obtained file size: 14409006 04:21: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')]} 04:21:23 INFO - trying https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:23 INFO - Downloading https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/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 04:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/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 04:21:24 INFO - Downloaded 55791982 bytes. 04:21:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:24 INFO - mkdir: /builds/slave/test/properties 04:21:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:24 INFO - Contents: 04:21:24 INFO - build_url:https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:25 INFO - Running post-action listener: _resource_record_post_action 04:21:25 INFO - Running post-action listener: set_extra_try_arguments 04:21:25 INFO - [mozharness: 2016-10-04 11:21:25.697023Z] Finished download-and-extract step (success) 04:21:25 INFO - [mozharness: 2016-10-04 11:21:25.697251Z] Running populate-webroot step. 04:21:25 INFO - Running pre-action listener: _resource_record_pre_action 04:21:25 INFO - Running main action method: populate_webroot 04:21:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:25 INFO - '--tppagecycles', 04:21:25 INFO - '7'], 04:21:25 INFO - 'tests': ['tsvgm']}}, 04:21:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['damp', 'tps']}, 04:21:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'tests': ['damp', 'tps']}, 04:21:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['dromaeo_dom']}, 04:21:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['basic_compositor_video']}, 04:21:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:21:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['a11yr', 04:21:25 INFO - 'ts_paint', 04:21:25 INFO - 'tpaint', 04:21:25 INFO - 'sessionrestore', 04:21:25 INFO - 'sessionrestore_no_auto_restore', 04:21:25 INFO - 'tabpaint']}, 04:21:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['tsvgx', 04:21:25 INFO - 'tsvgr_opacity', 04:21:25 INFO - 'tart', 04:21:25 INFO - 'tscrollx', 04:21:25 INFO - 'cart']}, 04:21:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:25 INFO - 'tsvgr_opacity', 04:21:25 INFO - 'tart', 04:21:25 INFO - 'tscrollx', 04:21:25 INFO - 'cart']}, 04:21:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'talos_options': ['--disable-e10s'], 04:21:25 INFO - 'tests': ['tp5o']}, 04:21:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'tests': ['tp5o']}, 04:21:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'talos_options': ['--disable-e10s', 04:21:25 INFO - '--xperf_path', 04:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:25 INFO - 'tests': ['tp5n']}, 04:21:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:25 INFO - 'talos_options': ['--xperf_path', 04:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:25 INFO - 'tests': ['tp5n']}}, 04:21:25 INFO - 'talos.zip': {'path': '', 04:21:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:25 INFO - Running post-action listener: _resource_record_post_action 04:21:25 INFO - [mozharness: 2016-10-04 11:21:25.719362Z] Finished populate-webroot step (success) 04:21:25 INFO - [mozharness: 2016-10-04 11:21:25.719451Z] Running create-virtualenv step. 04:21:25 INFO - Running pre-action listener: _resource_record_pre_action 04:21:25 INFO - Running main action method: create_virtualenv 04:21:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:25 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 04:21:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:25 INFO - Using real prefix '/usr' 04:21:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:28 INFO - Installing pip.................done. 04:21:28 INFO - Return code: 0 04:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:21:28 INFO - Reading from file tmpfile_stdout 04:21:28 INFO - Output received: 04:21:28 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) 04:21:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:28 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')]} 04:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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')]} 04:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:28 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 04:21:28 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 04:21:28 INFO - Using env: {'DISPLAY': ':0', 04:21:28 INFO - 'HOME': '/home/cltbld', 04:21:28 INFO - 'LANG': 'en_US.UTF-8', 04:21:28 INFO - 'LANGUAGE': 'en_US:en', 04:21:28 INFO - 'LOGNAME': 'cltbld', 04:21:28 INFO - 'MAIL': '/var/mail/cltbld', 04:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:28 INFO - 'MOZ_NO_REMOTE': '1', 04:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:28 INFO - 'NO_EM_RESTART': '1', 04:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:28 INFO - 'PWD': '/builds/slave/test', 04:21:28 INFO - 'SHELL': '/bin/bash', 04:21:28 INFO - 'SHLVL': '1', 04:21:28 INFO - 'TERM': 'linux', 04:21:28 INFO - 'TMOUT': '86400', 04:21:28 INFO - 'USER': 'cltbld', 04:21:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:28 INFO - '_': '/tools/buildbot/bin/python'} 04:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:28 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 04:21:28 INFO - Cleaning up... 04:21:28 INFO - Return code: 0 04:21:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:21:28 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')]} 04:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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')]} 04:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:28 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 04:21:28 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 04:21:28 INFO - Using env: {'DISPLAY': ':0', 04:21:28 INFO - 'HOME': '/home/cltbld', 04:21:28 INFO - 'LANG': 'en_US.UTF-8', 04:21:28 INFO - 'LANGUAGE': 'en_US:en', 04:21:28 INFO - 'LOGNAME': 'cltbld', 04:21:28 INFO - 'MAIL': '/var/mail/cltbld', 04:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:28 INFO - 'MOZ_NO_REMOTE': '1', 04:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:28 INFO - 'NO_EM_RESTART': '1', 04:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:28 INFO - 'PWD': '/builds/slave/test', 04:21:28 INFO - 'SHELL': '/bin/bash', 04:21:28 INFO - 'SHLVL': '1', 04:21:28 INFO - 'TERM': 'linux', 04:21:28 INFO - 'TMOUT': '86400', 04:21:28 INFO - 'USER': 'cltbld', 04:21:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:28 INFO - '_': '/tools/buildbot/bin/python'} 04:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:28 INFO - Downloading/unpacking psutil>=3.1.1 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:30 INFO - Installing collected packages: psutil 04:21:30 INFO - Running setup.py install for psutil 04:21:31 INFO - building 'psutil._psutil_linux' extension 04:21:31 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 04:21:31 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 04:21:31 INFO - building 'psutil._psutil_posix' extension 04:21:31 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 04:21:31 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 04:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:31 INFO - Successfully installed psutil 04:21:31 INFO - Cleaning up... 04:21:31 INFO - Return code: 0 04:21:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:31 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:31 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 04:21:31 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 04:21:31 INFO - Using env: {'DISPLAY': ':0', 04:21:31 INFO - 'HOME': '/home/cltbld', 04:21:31 INFO - 'LANG': 'en_US.UTF-8', 04:21:31 INFO - 'LANGUAGE': 'en_US:en', 04:21:31 INFO - 'LOGNAME': 'cltbld', 04:21:31 INFO - 'MAIL': '/var/mail/cltbld', 04:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:31 INFO - 'MOZ_NO_REMOTE': '1', 04:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:31 INFO - 'NO_EM_RESTART': '1', 04:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:31 INFO - 'PWD': '/builds/slave/test', 04:21:31 INFO - 'SHELL': '/bin/bash', 04:21:31 INFO - 'SHLVL': '1', 04:21:31 INFO - 'TERM': 'linux', 04:21:31 INFO - 'TMOUT': '86400', 04:21:31 INFO - 'USER': 'cltbld', 04:21:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:31 INFO - '_': '/tools/buildbot/bin/python'} 04:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:21:31 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 04:21:31 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 04:21:31 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 04:21:31 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 04:21:31 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 04:21:31 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 04:21:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:21:33 INFO - Installing collected packages: mozsystemmonitor 04:21:33 INFO - Running setup.py install for mozsystemmonitor 04:21:33 INFO - Successfully installed mozsystemmonitor 04:21:33 INFO - Cleaning up... 04:21:33 INFO - Return code: 0 04:21:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:21:33 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')]} 04:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 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')]} 04:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:33 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 04:21:33 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 04:21:33 INFO - Using env: {'DISPLAY': ':0', 04:21:33 INFO - 'HOME': '/home/cltbld', 04:21:33 INFO - 'LANG': 'en_US.UTF-8', 04:21:33 INFO - 'LANGUAGE': 'en_US:en', 04:21:33 INFO - 'LOGNAME': 'cltbld', 04:21:33 INFO - 'MAIL': '/var/mail/cltbld', 04:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:33 INFO - 'MOZ_NO_REMOTE': '1', 04:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:33 INFO - 'NO_EM_RESTART': '1', 04:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:33 INFO - 'PWD': '/builds/slave/test', 04:21:33 INFO - 'SHELL': '/bin/bash', 04:21:33 INFO - 'SHLVL': '1', 04:21:33 INFO - 'TERM': 'linux', 04:21:33 INFO - 'TMOUT': '86400', 04:21:33 INFO - 'USER': 'cltbld', 04:21:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:33 INFO - '_': '/tools/buildbot/bin/python'} 04:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:36 INFO - warning: no files found matching '*.txt' 04:21:36 INFO - no previously-included directories found matching 'build' 04:21:36 INFO - no previously-included directories found matching 'dist' 04:21:36 INFO - no previously-included directories found matching '.git*' 04:21:36 INFO - Installing collected packages: jsonschema, functools32 04:21:36 INFO - Running setup.py install for functools32 04:21:36 INFO - warning: no files found matching '*.txt' 04:21:36 INFO - no previously-included directories found matching 'build' 04:21:36 INFO - no previously-included directories found matching 'dist' 04:21:36 INFO - no previously-included directories found matching '.git*' 04:21:36 INFO - Successfully installed jsonschema functools32 04:21:36 INFO - Cleaning up... 04:21:36 INFO - Return code: 0 04:21:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:36 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 04:21:36 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 04:21:36 INFO - Using env: {'DISPLAY': ':0', 04:21:36 INFO - 'HOME': '/home/cltbld', 04:21:36 INFO - 'LANG': 'en_US.UTF-8', 04:21:36 INFO - 'LANGUAGE': 'en_US:en', 04:21:36 INFO - 'LOGNAME': 'cltbld', 04:21:36 INFO - 'MAIL': '/var/mail/cltbld', 04:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:36 INFO - 'MOZ_NO_REMOTE': '1', 04:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:36 INFO - 'NO_EM_RESTART': '1', 04:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:36 INFO - 'PWD': '/builds/slave/test', 04:21:36 INFO - 'SHELL': '/bin/bash', 04:21:36 INFO - 'SHLVL': '1', 04:21:36 INFO - 'TERM': 'linux', 04:21:36 INFO - 'TMOUT': '86400', 04:21:36 INFO - 'USER': 'cltbld', 04:21:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:36 INFO - '_': '/tools/buildbot/bin/python'} 04:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:21:36 INFO - Cleaning up... 04:21:36 INFO - Return code: 0 04:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:36 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 04:21:36 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 04:21:36 INFO - Using env: {'DISPLAY': ':0', 04:21:36 INFO - 'HOME': '/home/cltbld', 04:21:36 INFO - 'LANG': 'en_US.UTF-8', 04:21:36 INFO - 'LANGUAGE': 'en_US:en', 04:21:36 INFO - 'LOGNAME': 'cltbld', 04:21:36 INFO - 'MAIL': '/var/mail/cltbld', 04:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:36 INFO - 'MOZ_NO_REMOTE': '1', 04:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:36 INFO - 'NO_EM_RESTART': '1', 04:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:36 INFO - 'PWD': '/builds/slave/test', 04:21:36 INFO - 'SHELL': '/bin/bash', 04:21:36 INFO - 'SHLVL': '1', 04:21:36 INFO - 'TERM': 'linux', 04:21:36 INFO - 'TMOUT': '86400', 04:21:36 INFO - 'USER': 'cltbld', 04:21:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:36 INFO - '_': '/tools/buildbot/bin/python'} 04:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:38 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 04:21:38 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 04:21:38 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 04:21:38 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 04:21:38 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 04:21:38 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 04:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:39 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 04:21:39 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 04:21:39 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 04:21:39 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 04:21:39 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 04:21:39 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 04:21:39 INFO - Downloading docopt-0.6.1.tar.gz 04:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:39 INFO - Running setup.py install for blobuploader 04:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:39 INFO - Running setup.py install for requests 04:21:39 INFO - Running setup.py install for docopt 04:21:40 INFO - Successfully installed blobuploader requests docopt 04:21:40 INFO - Cleaning up... 04:21:40 INFO - Return code: 0 04:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:40 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 04:21:40 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 04:21:40 INFO - Using env: {'DISPLAY': ':0', 04:21:40 INFO - 'HOME': '/home/cltbld', 04:21:40 INFO - 'LANG': 'en_US.UTF-8', 04:21:40 INFO - 'LANGUAGE': 'en_US:en', 04:21:40 INFO - 'LOGNAME': 'cltbld', 04:21:40 INFO - 'MAIL': '/var/mail/cltbld', 04:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:40 INFO - 'MOZ_NO_REMOTE': '1', 04:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:40 INFO - 'NO_EM_RESTART': '1', 04:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:40 INFO - 'PWD': '/builds/slave/test', 04:21:40 INFO - 'SHELL': '/bin/bash', 04:21:40 INFO - 'SHLVL': '1', 04:21:40 INFO - 'TERM': 'linux', 04:21:40 INFO - 'TMOUT': '86400', 04:21:40 INFO - 'USER': 'cltbld', 04:21:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:40 INFO - '_': '/tools/buildbot/bin/python'} 04:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:40 INFO - Running setup.py (path:/tmp/pip-hsUUYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:40 INFO - Running setup.py (path:/tmp/pip-P8Ungj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:40 INFO - Running setup.py (path:/tmp/pip-FQncsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:40 INFO - Running setup.py (path:/tmp/pip-NFuFoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:40 INFO - Running setup.py (path:/tmp/pip-oiR5IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:40 INFO - Running setup.py (path:/tmp/pip-C_eDio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:40 INFO - Running setup.py (path:/tmp/pip-Ye9Fai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:40 INFO - Running setup.py (path:/tmp/pip-_C8HQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:40 INFO - Running setup.py (path:/tmp/pip-DIirkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:41 INFO - Running setup.py (path:/tmp/pip-1Ryhl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:41 INFO - Running setup.py (path:/tmp/pip-f6NPww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:41 INFO - Running setup.py (path:/tmp/pip-L9WqkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:41 INFO - Running setup.py (path:/tmp/pip-lu2KdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:41 INFO - Running setup.py (path:/tmp/pip-HOPL8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:41 INFO - Running setup.py (path:/tmp/pip-pFWlxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:41 INFO - Running setup.py (path:/tmp/pip-1wOA0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:41 INFO - Running setup.py (path:/tmp/pip-aXDvkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:41 INFO - Running setup.py install for manifestparser 04:21:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozcrash 04:21:41 INFO - Running setup.py install for mozdebug 04:21:41 INFO - Running setup.py install for mozdevice 04:21:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozfile 04:21:42 INFO - Running setup.py install for mozhttpd 04:21:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozinfo 04:21:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozInstall 04:21:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozleak 04:21:42 INFO - Running setup.py install for mozlog 04:21:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for moznetwork 04:21:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozprocess 04:21:42 INFO - Running setup.py install for mozprofile 04:21:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozrunner 04:21:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:43 INFO - Running setup.py install for mozscreenshot 04:21:43 INFO - Running setup.py install for moztest 04:21:43 INFO - Running setup.py install for mozversion 04:21:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:43 INFO - Cleaning up... 04:21:43 INFO - Return code: 0 04:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:43 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:43 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 04:21:43 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 04:21:43 INFO - Using env: {'DISPLAY': ':0', 04:21:43 INFO - 'HOME': '/home/cltbld', 04:21:43 INFO - 'LANG': 'en_US.UTF-8', 04:21:43 INFO - 'LANGUAGE': 'en_US:en', 04:21:43 INFO - 'LOGNAME': 'cltbld', 04:21:43 INFO - 'MAIL': '/var/mail/cltbld', 04:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:43 INFO - 'MOZ_NO_REMOTE': '1', 04:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:43 INFO - 'NO_EM_RESTART': '1', 04:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:43 INFO - 'PWD': '/builds/slave/test', 04:21:43 INFO - 'SHELL': '/bin/bash', 04:21:43 INFO - 'SHLVL': '1', 04:21:43 INFO - 'TERM': 'linux', 04:21:43 INFO - 'TMOUT': '86400', 04:21:43 INFO - 'USER': 'cltbld', 04:21:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:43 INFO - '_': '/tools/buildbot/bin/python'} 04:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:43 INFO - Running setup.py (path:/tmp/pip-KYVyOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:43 INFO - Running setup.py (path:/tmp/pip-pOsSqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:43 INFO - Running setup.py (path:/tmp/pip-mf3ndb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:43 INFO - Running setup.py (path:/tmp/pip-SmlTTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:43 INFO - Running setup.py (path:/tmp/pip-GSd3sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:43 INFO - Running setup.py (path:/tmp/pip-OKiLZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:44 INFO - Running setup.py (path:/tmp/pip-cw409h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:44 INFO - Running setup.py (path:/tmp/pip-7a2nqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:44 INFO - Running setup.py (path:/tmp/pip-auRBRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:44 INFO - Running setup.py (path:/tmp/pip-YClUlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:44 INFO - Running setup.py (path:/tmp/pip-KzmLtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:44 INFO - Running setup.py (path:/tmp/pip-hAbtT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:44 INFO - Running setup.py (path:/tmp/pip-5k2J4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:44 INFO - Running setup.py (path:/tmp/pip-t9caqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:44 INFO - Running setup.py (path:/tmp/pip-RxQI7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:44 INFO - Running setup.py (path:/tmp/pip-Z22nHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:44 INFO - Running setup.py (path:/tmp/pip-z5jdvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:44 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)) 04:21:44 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)) 04:21:44 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)) 04:21:44 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)) 04:21:44 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)) 04:21:44 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)) 04:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:46 INFO - Downloading blessings-1.6.tar.gz 04:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:46 INFO - Installing collected packages: blessings 04:21:46 INFO - Running setup.py install for blessings 04:21:46 INFO - Successfully installed blessings 04:21:46 INFO - Cleaning up... 04:21:46 INFO - Return code: 0 04:21:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:47 INFO - Reading from file tmpfile_stdout 04:21:47 INFO - Current package versions: 04:21:47 INFO - argparse == 1.2.1 04:21:47 INFO - blessings == 1.6 04:21:47 INFO - blobuploader == 1.2.4 04:21:47 INFO - docopt == 0.6.1 04:21:47 INFO - functools32 == 3.2.3-2 04:21:47 INFO - jsonschema == 2.5.1 04:21:47 INFO - manifestparser == 1.1 04:21:47 INFO - mozInstall == 1.12 04:21:47 INFO - mozcrash == 0.17 04:21:47 INFO - mozdebug == 0.1 04:21:47 INFO - mozdevice == 0.48 04:21:47 INFO - mozfile == 1.2 04:21:47 INFO - mozhttpd == 0.7 04:21:47 INFO - mozinfo == 0.9 04:21:47 INFO - mozleak == 0.1 04:21:47 INFO - mozlog == 3.4 04:21:47 INFO - moznetwork == 0.27 04:21:47 INFO - mozprocess == 0.23 04:21:47 INFO - mozprofile == 0.28 04:21:47 INFO - mozrunner == 6.12 04:21:47 INFO - mozscreenshot == 0.1 04:21:47 INFO - mozsystemmonitor == 0.3 04:21:47 INFO - moztest == 0.7 04:21:47 INFO - mozversion == 1.4 04:21:47 INFO - psutil == 3.1.1 04:21:47 INFO - requests == 1.2.3 04:21:47 INFO - wsgiref == 0.1.2 04:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:47 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')]} 04:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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')]} 04:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:47 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 04:21:47 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 04:21:47 INFO - Using env: {'DISPLAY': ':0', 04:21:47 INFO - 'HOME': '/home/cltbld', 04:21:47 INFO - 'LANG': 'en_US.UTF-8', 04:21:47 INFO - 'LANGUAGE': 'en_US:en', 04:21:47 INFO - 'LOGNAME': 'cltbld', 04:21:47 INFO - 'MAIL': '/var/mail/cltbld', 04:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:47 INFO - 'MOZ_NO_REMOTE': '1', 04:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:47 INFO - 'NO_EM_RESTART': '1', 04:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:47 INFO - 'PWD': '/builds/slave/test', 04:21:47 INFO - 'SHELL': '/bin/bash', 04:21:47 INFO - 'SHLVL': '1', 04:21:47 INFO - 'TERM': 'linux', 04:21:47 INFO - 'TMOUT': '86400', 04:21:47 INFO - 'USER': 'cltbld', 04:21:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:47 INFO - '_': '/tools/buildbot/bin/python'} 04:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 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)) 04:21:47 INFO - Cleaning up... 04:21:47 INFO - Return code: 0 04:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:47 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')]} 04:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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')]} 04:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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 0x7f20face9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1111ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', '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 04:21:47 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 04:21:47 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 04:21:47 INFO - Using env: {'DISPLAY': ':0', 04:21:47 INFO - 'HOME': '/home/cltbld', 04:21:47 INFO - 'LANG': 'en_US.UTF-8', 04:21:47 INFO - 'LANGUAGE': 'en_US:en', 04:21:47 INFO - 'LOGNAME': 'cltbld', 04:21:47 INFO - 'MAIL': '/var/mail/cltbld', 04:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:47 INFO - 'MOZ_NO_REMOTE': '1', 04:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:47 INFO - 'NO_EM_RESTART': '1', 04:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:47 INFO - 'PWD': '/builds/slave/test', 04:21:47 INFO - 'SHELL': '/bin/bash', 04:21:47 INFO - 'SHLVL': '1', 04:21:47 INFO - 'TERM': 'linux', 04:21:47 INFO - 'TMOUT': '86400', 04:21:47 INFO - 'USER': 'cltbld', 04:21:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:47 INFO - '_': '/tools/buildbot/bin/python'} 04:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:47 INFO - Cleaning up... 04:21:47 INFO - Return code: 0 04:21:47 INFO - Running post-action listener: _resource_record_post_action 04:21:47 INFO - Running post-action listener: _start_resource_monitoring 04:21:47 INFO - Starting resource monitoring. 04:21:47 INFO - [mozharness: 2016-10-04 11:21:47.675864Z] Finished create-virtualenv step (success) 04:21:47 INFO - [mozharness: 2016-10-04 11:21:47.676324Z] Running install step. 04:21:47 INFO - Running pre-action listener: _resource_record_pre_action 04:21:47 INFO - Running main action method: install 04:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:47 INFO - Reading from file tmpfile_stdout 04:21:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:47 INFO - Reading from file tmpfile_stdout 04:21:47 INFO - Output received: 04:21:47 INFO - Usage: mozinstall [options] installer 04:21:47 INFO - Options: 04:21:47 INFO - -h, --help show this help message and exit 04:21:47 INFO - -d DEST, --destination=DEST 04:21:47 INFO - Directory to install application into. [default: 04:21:47 INFO - "/builds/slave/test"] 04:21:47 INFO - --app=APP Application being installed. [default: firefox] 04:21:47 INFO - mkdir: /builds/slave/test/build/application 04:21:47 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'] 04:21:47 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 04:22:04 INFO - Reading from file tmpfile_stdout 04:22:04 INFO - Output received: 04:22:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:04 INFO - Running post-action listener: _resource_record_post_action 04:22:04 INFO - [mozharness: 2016-10-04 11:22:04.122337Z] Finished install step (success) 04:22:04 INFO - [mozharness: 2016-10-04 11:22:04.122583Z] Running run-tests step. 04:22:04 INFO - Running pre-action listener: _resource_record_pre_action 04:22:04 INFO - Running main action method: run_tests 04:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:04 INFO - Python 2.7.3 04:22:04 INFO - Return code: 0 04:22:04 INFO - grabbing minidump binary from tooltool 04:22: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')]} 04:22:04 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 0x110ef60>, '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 0x110fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11101d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:04 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 04:22:04 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 04:22:04 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 04:22:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:04 INFO - Return code: 0 04:22:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 04:22:04 INFO - Using env: {'DISPLAY': ':0', 04:22:04 INFO - 'HOME': '/home/cltbld', 04:22:04 INFO - 'LANG': 'en_US.UTF-8', 04:22:04 INFO - 'LANGUAGE': 'en_US:en', 04:22:04 INFO - 'LOGNAME': 'cltbld', 04:22:04 INFO - 'MAIL': '/var/mail/cltbld', 04:22:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:04 INFO - 'MOZ_NO_REMOTE': '1', 04:22:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:04 INFO - 'NO_EM_RESTART': '1', 04:22:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:04 INFO - 'PWD': '/builds/slave/test', 04:22:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:04 INFO - 'SHELL': '/bin/bash', 04:22:04 INFO - 'SHLVL': '1', 04:22:04 INFO - 'TERM': 'linux', 04:22:04 INFO - 'TMOUT': '86400', 04:22:04 INFO - 'USER': 'cltbld', 04:22:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264', 04:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:04 INFO - '_': '/tools/buildbot/bin/python'} 04:22:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:22:04 INFO - mozversion application_buildid: 20161004030300 04:22:04 INFO - mozversion application_changeset: 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b 04:22:04 INFO - mozversion application_display_name: Nightly 04:22:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:04 INFO - mozversion application_name: Firefox 04:22:04 INFO - mozversion application_remotingname: firefox 04:22:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:22:04 INFO - mozversion application_vendor: Mozilla 04:22:04 INFO - mozversion application_version: 52.0a1 04:22:04 INFO - mozversion platform_buildid: 20161004030300 04:22:04 INFO - mozversion platform_changeset: 2c203b9d559e09a5bb1f798ea5aa3bb7f477df1b 04:22:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:22:04 INFO - mozversion platform_version: 52.0a1 04:22:04 INFO - using testdate: 1475580124 04:22:04 INFO - actual date: 1475580124 04:22:04 INFO - starting webserver on 'localhost:60928' 04:22:04 INFO - SUITE-START | Running 2 tests 04:22:04 INFO - TEST-START | dromaeo_css 04:22:04 INFO - operating with platform_type : linux_ 04:22:04 INFO - Initialising browser for dromaeo_css test... 04:22:04 INFO - TEST-INFO | started process 4810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrC6Rh/profile http://localhost:60928/getInfo.html) 04:22:08 INFO - PROCESS | 4810 | __metrics Screen width/height:1600/1200 04:22:08 INFO - PROCESS | 4810 | colorDepth:24 04:22:08 INFO - PROCESS | 4810 | Browser inner width/height: 1024/697 04:22:08 INFO - PROCESS | 4810 | __metrics 04:22:09 INFO - PROCESS | 4810 | 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" 04:22:09 INFO - PROCESS | 4810 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:09 INFO - PROCESS | 4810 | console.error: PushService: 04:22:09 INFO - PROCESS | 4810 | stateChangeProcessEnqueue: Error transitioning state 04:22:09 INFO - PROCESS | 4810 | UnknownError 04:22:10 INFO - TEST-INFO | 4810: exit 0 04:22:10 INFO - Browser initialized. 04:22:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:10 INFO - TEST-INFO | started process 4889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrC6Rh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:22 INFO - PROCESS | 4889 | RSS: Main: 175767552 04:22:22 INFO - PROCESS | 4889 | 04:23:13 INFO - PROCESS | 4889 | 1475580193928 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] 04:25:27 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60928/tests/dromaeo/cssquery-ext.html) 04:25:28 INFO - PROCESS | 4889 | RSS: Main: 267513856 04:25:28 INFO - PROCESS | 4889 | 04:28:31 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-ext.html (next: http://localhost:60928/tests/dromaeo/cssquery-jquery.html) 04:28:31 INFO - PROCESS | 4889 | RSS: Main: 273178624 04:28:31 INFO - PROCESS | 4889 | 04:31:33 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60928/tests/dromaeo/cssquery-mootools.html) 04:31:34 INFO - PROCESS | 4889 | RSS: Main: 218595328 04:31:34 INFO - PROCESS | 4889 | 04:34:36 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60928/tests/dromaeo/cssquery-prototype.html) 04:34:37 INFO - PROCESS | 4889 | RSS: Main: 219623424 04:34:37 INFO - PROCESS | 4889 | 04:37:40 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60928/tests/dromaeo/cssquery-yui.html) 04:37:41 INFO - PROCESS | 4889 | RSS: Main: 219459584 04:37:41 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | Cycle 1(1): loaded http://localhost:60928/tests/dromaeo/cssquery-yui.html (next: http://localhost:60928/tests/dromaeo/cssquery-dojo.html) 04:40:44 INFO - PROCESS | 4889 | RSS: Main: 314187776 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | __start_tp_report 04:40:44 INFO - PROCESS | 4889 | _x_x_mozilla_page_load 04:40:44 INFO - PROCESS | 4889 | _x_x_mozilla_page_load_details 04:40:44 INFO - PROCESS | 4889 | |i|pagename|runs| 04:40:44 INFO - PROCESS | 4889 | |0;dojo.html;2553.3744232663;2571.3700143464853;2599.545079611068;2610.229982155264;2621.593652983788;4573.13110509003;4575.519570445105;4622.976885115574;4629.143608432442;4646.094011667727;4658.813647454106;4669.089527542131;4676.228422310323;4681.110588988098;4682.321063445806;4270.551592082833;4297.05464797744;4305.418768466248;4323.610875021263;4329.653627709791;4374;4390.2317094508335;4396.032872767986;4399.252127138394;4446.333050042487;4284.314509678452;4294.334378171373;4333.934990975138;4345.3047512398025;4390.912181756363;4283.571642835723;4329.588689074533;4346.217680817467;4381.956180438218;4405.251107311765;4289.6353809926195;4317.071829556629;4330.220560299145;4350.58669426404;4357.825686972549;4509.954900450986;4546.318052292149;4558.954410455886;4638.8608341749805;4655.045715628288;4926.655134140576;4928.457869634337;4929.531694489054;4995.050940321327;5062.493750624945;4982;5008.424031236382;5015.423226328982;5024.095662780698;5073;4566.70316429431;4579.175748365326;4615.838445654386;4692.483826779017;4744.95255047452;5053.140966035783;5089.491050894881;5093.490650934877;5094.61790365724;5157.149070403341;4834.516548345207;4894.241392584155;4899.485554016848;4904.730239836843;4953.529414705597;4848.539388758062;4900.411950565955;4926.531979461945;4955.380577427822;5036.219385995177;4899.730514821647;4928.334674818925;4954.5540901319055;4963.776630051656;4980.377452818398;4902.926456103161;4906.852794416173;4915.459299477055;4922.064807686528;4989.600831933437;4147.129102888367;4178.979105104516;4184.205001049791;4195.958040419557;4255.170241802881;3668.3396988541786;3674.963250367462;3727.0309719473134;3734.215814678948;3736.7010639148803;4325.632321252666;4329.696921215547;4365.869023929224;4382.320740285261;4384.758838263862;4998.775055122528;5002.249662550574;5002.724850133278;5006.374203224597;5065.670731402447;4153.335466325373;4199.643030342394;4301.05376817106;4314.913701726011;4318.157959197989;4489.304157855538;4514;4515.254982927846;4563.771811409416;4569.1547063793305;4686.648501362343;4716.3632909557455;4719.858404247878;4722.150012997693;4791.209450440708;4877.975610121926;4925.655204135676;5044.4451110377095;5044.445111037856;5046;4407.713498622579;4644.373009643655;4688.320193571844;4691.648126390603;4734.55021772931;4901.240307752304;4909.950900491092;4912.1649319615035;4914.778834952507;4964.702117872939;4849.466558678472;4905.5094490550655;4984.601231901512;5000.049990501793;5058.570021548209;4777.665563410528;4781.354517140142;4781.808727650855;4835.95164048369;4867.683600565952;4803.639727020557;4810.230363142021;4812.037592481448;4817.084753896748;4869.513048695244;4631.073785243032;4728.31439441286;4761.071591039714;4788.497207793271;4846.660733748604;4759.7858096386435;4863.756812159449;4899.1426500363;4908.680935739166;4985.825496107619;4765.69023013503;4771.950170962383;4775.140474714584;4787.593054590398;4842.564169224786 04:40:44 INFO - PROCESS | 4889 | |1;ext.html;558.2240685447227;559.9328080630326;565.6577770448876;570.480862415202;574.1903915479174;27315.72684273157;37765.62234377655;38817.41773873387;38935;42390.36414453786;39080;39441.40837887434;39482.60517394825;39498.21003579934;39498.8025059875;7686.961565192166;7847.215278472164;7850.568218747967;7852.764417067498;7858.449908506407;7688.1927397623285;7776.416768742339;7784.727534536292;7784.727534536292;7785.649645765954;7766.45634805561;7805.063392392921;7807.375409967218;7808.60956952153;7810.765677029698;7738.651760670755;7818.843623127505;7828.217178282183;7834.490758100762;7840.568768717718;7661.042369703787;7725.111612164616;7726.729564465273;7727.034120734908;7731.497452665559;37972.81013594942;38294.42558361627;38327.23345533074;38329.42505862414;38343.12426567991;2934.7358737713494;3050.4814181588963;3087.1356020314347;3234.4663130583426;3308.718758905496;27889.442211155663;28091.57862632062;28151.577726334122;28783.56824647632;29327.560086598718;3304.867805287786;3364.2598628301735;3369.8146601936883;3393.100828280508;3396.932061358759;241592;243249;243648.99999999822;243832;244885;30567.235819104255;31593.36813263768;50030.74984625054;50490.95090490995;50522.49477505252;33197.3360532788;33368.3326333472;33409.331813364086;33416.49875251873;33418.665813341555;12944.482220711254;13072.869271307356;13076.28080455565;13081.542146024844;13086.08397412172;10454.477276136162;10499.317544359592;10501;10506;10506.317089389166;7817.960910195413;7826.2173782621285;7866.960665196638;7917.881231781528;7936.880946785803;3036.16505461;3039.9392012159633;3050.3746731920346;3084.78406511542;3101.8914337998513;794.2494342846071;879.2394578689515;905.1943770044666;906.6826610686207;946.3990366117565;26813.329666758487;27123.321916951838;27300.180994570193;27681.584776228374;27895.581566276524;821.7863355527486;942.5146049784366;961.1589858873485;1005.1203302538175;1040.484959944832;13955.511557095453;14784.11295322284;14917.179555124572;14981.70036599262;15070.698586028218;391550;392138;393359;395244;395979;47545;47936.5206347939;47978;47985.28022079672;47996;1063.8085144674033;1088.8856670049688;1128.8871112888646;1149.2013050929525;1177.473466966441;26641.7335826647;27951.301217469725;28763.85618071896;29225.70774292315;29273;40223.396649049704;40569.089027639326;40753.38869916894;40779;40787.184256315304;285384;286749;287113;287227;287272;24022.27933162008;25154;25185;26066.86966565231;26128.085517006813;40109.1978160441;40458.595414045485;40797;40985;41640.375394369716;34391;34636.82681586576;34765.47851782276;34891.65108348884;34909.476357854146;34216.06515250679;34448.65551344555;34560.65439345574;34845.651543484244;34848.82575587106;33477.497837532945;34256.82871585726;34294.828525857214;34624.480632791034;34801.82599086988;29845.55231671483;31277.636255776037;31527.088678360262;31830.204244894063;31876.840615796773;24478.87760561186;24565.263042108767;24723.514625114203;24957.75042249627;25068.749312506643 04:40:44 INFO - PROCESS | 4889 | |2;jquery.html;340.9710174635156;362.0748986339901;365.4025668032767;368.8063766522576;386.3895045827593;12032.278063316207;15493.690126197469;15725.135117568543;15785.921070394632;16780.83219167808;15664.921675391635;15753.684926301466;16145.515634530982;16280.104594247312;16422.67154656906;4605.539446055401;4607.331936869152;4697.78859951303;4755.833545825897;4779.187538118511;3445.707114895237;3633.4368172933237;4585.060062687157;4655.4646215685125;4661.930071048937;5283.656562323456;5529.889402211953;5540.695261760601;5544.722763861811;5552.194931734896;5421.268128802601;5517.69652669103;5537.695426751527;6052.485538729169;6086.573939824214;5406.243125962368;5407.107827208506;5414.458554144554;5416.404195538487;5420.214068959979;12017.278963262232;12290.446929888176;12336.321502317369;12432.502699891993;18160.636787264313;1748.7464317673866;1826.3607737291975;1843.6220574782137;2060.1965233558926;2221.0227499899993;13780.310984450838;14299.285035748171;14841.406343746237;14890.553283401516;15307.31117099722;1808.7739032620923;1809.5204770735766;1821.1895706410653;1860.9534761631066;1896.3836753055175;78626.6068669653;79262;79515.62468880079;80068;85217.99999999937;16352.34590616362;16420.507384778237;16509.91745041291;16683.329667473135;16685.49943501697;29357.706422935924;29368.118956431343;29469.852650736608;29541.113766587037;29675.806733821493;8764.123587641312;8787.824243515093;8891.066438023914;8998.415103018282;9140.771480713036;7252.963735181291;7283.2716728327805;7365.705371785069;7543.358814500719;7572.318491335696;7959.721409750631;8170.918290817134;8190.713325033715;8197.631106600098;8321.542315172723;3045.4822680143984;3052.0080973683644;3226.9838650806596;3245.6105267367593;3248.6588908164777;773.3928865840401;840.5083026429485;886.4504007515382;917.4266083697689;927.2211342472356;16392.918035409984;16525.6694866102;16560.089195094144;16788.412405565745;17024.319027238773;849.9107593702696;856.8671855862351;876.6230520875957;878.433410450256;906.3202598051462;9124.361294709306;9388.812223755487;9690.56392462341;9701.514924253901;9721.125098741148;369869;372956;375717;384604.46186613885;384715;71954.28045719476;74075;75795;76226.23773762191;76500;873.6760217820694;881.3654168998311;902.7066203483894;904.2675432899373;904.452806052342;11384.715382115513;16090.919545402197;16491.887071623623;16507.66984660276;16744.49766506958;37025.629743702215;37240.25519489649;37569.62430375661;37663.81168094142;38035;47427.525724742314;47566.28650570314;47587.762061189474;47734;47789.52210477851;7656.234376562299;7658.042744656918;7741.264579864904;7802;8120.269175774209;8933.508657023925;11608.477618507019;11675.591354302558;11692;11708.180427370002;9216.447013178962;9855.605775768889;9982.550785214828;10294.639687610897;11079.390633515233;10617.946910265708;10623.628173013907;10687.061058209054;10915.836262456229;10947.616833410792;10348.327358721659;10649;10828;10926.50830712604;11436.085113190758;7718.807029824299;7799.766007019798;7811.843763124819;8077.474964127313;8100.379924015103;8158.4289099762445;10451.843222351823;10611.787764244518;10828.296160749525;10927.45362731876 04:40:44 INFO - PROCESS | 4889 | |3;mootools.html;1297.870212978702;1333.4066340478485;1378.6966867289193;1655.470249520154;1665.8417450342213;6880;7123.145222573298;7429.219931907146;8027.598620068995;8037.8392432151395;7338.486305958585;7608.847823043536;7656.885146722803;7884.448088633798;7887.408444366681;2105.49468127649;2124.798144176301;2135.6155891939443;2135.7010018597407;2135.8398120140973;1709.734991076385;2108.4939614492564;2138.850280480367;2140.882251476168;2147.9248226312084;1677.2033284190034;2033.3899830050925;2100.2754049852774;2115.6509175985943;2130.6910497977783;2056.5269987902716;2062.7318448601736;2064.948376290597;2066.442060643633;2074.3051077889;2060.2994981706142;2060.9381718548466;2061.5773766377856;2064.865783724068;2064.989675051615;7792.181820908836;7948.602569871541;7949.841003179904;7958.363330933512;7959.522428654299;4427.46870375557;4575.267957126844;4576.496585375606;4578.130155270488;4582.221022426163;2600.3239157819103;2814.4652516022097;2816.3240822202524;2818.0841226601437;2826.025021367625;842.6839935024366;885.2608072259671;900.6937641202023;900.9909900900973;908.4594666173682;10796.67609971702;10835.295705779099;10877.347359158475;10878.292910960841;10883.292585981886;3758.379867321861;3919.6080391960577;4056.675465962775;4089.9386509202386;4102.2821006323775;9153.038930912291;9170.724878253663;9170.95414522923;9179.58691858868;9184.173424391836;4530.501644819067;4532.342810292489;4545.409096817392;4550.317452382169;4555.430571178603;4122.711410201257;4182.623563879265;4195.91608167835;4197.097624010791;4198.055437526593;3322.1528510229737;3363.545921300642;3390.3727810355163;3427.2802711430877;3430.2624935638955;1021.933574317667;1112.3770688414513;1131.2872890079198;1152.5793085523892;1159.6984783956232;676.9458443324522;793.3375631347889;831.2228066757601;831.9584020798936;835.4026870787416;4978.6763860348965;4989.501049894981;5170.121079416508;5170.3278573785165;5247.737613119329;871.6774793326383;875.5228400521731;905.3345790843724;945.522511131874;961.240619910277;3368.528406023159;3452.085197422685;3466.791992480459;3512.1921957949303;3568.7680300780366;9424.528773561295;9574;9680.419174849532;9681.806363872824;9705.951470242604;9559.856602150974;9564.713058608113;9566.378185417925;9567.138957493858;9570.760730981781;6664.266930637626;6949.82625434358;6952.721891124298;7086.433085353159;7092.5389849659605;5083.593312534915;5175.896482070262;5239.764210610608;5240.764165612481;5263.947360526346;8286.70996515119;8532.530710810965;8594.226519613265;8607.311415086653;8642.141939483041;8513.106123857153;8776.736697898818;8814.60334284946;8862.601182946653;8881.822363552821;6807.353301436356;6884.345987131214;6921.688524016331;6956.826079348057;6970.372666460043;7409.296116868889;7538.3215510604305;7543.47195696296;7553.886691699519;7561.886571701319;6490.253620833664;6780.220274668279;6843.8973415399805;6918.584884906922;7068.71725130989;6753.932460675331;6780.593164410151;6857.382835544825;6977.79066628002;6996.650167491707;6377;6441.259255185526;6444.162258906312;6450.258220304725;6456.386643268882;4350.630196433339;4513.932291015703;4577.153226653079;4591.104734576726;4618.422697162855;4454.086912183059;4568.725876447424;4620.94368006234;4652.767361631837;4760.285957106462 04:40:44 INFO - PROCESS | 4889 | |4;prototype.html;287.3964674184213;295.27068141690023;298.4285094044904;306.1321154526916;308.74374269356434;4781;4807.591354734847;4835.564799168074;4841.644339584913;4848.660593758438;4782.7608619569055;4784.282357646355;4799.5680388765;4803.447603525596;4817.807287708488;3550.6981906537912;3647.781133132007;3661.1945372018113;3718.869839555616;3768.981155094221;3731.9440208396895;3741.30785804627;3757.28611563802;3760.9435858462143;3764.5294338207723;3705.666490015898;3711.109333759892;3714.1086139326503;3714.349988751971;3716.9256614867822;3550.7336949728747;3602.621724718893;3666.926661466782;3743.1765011697385;3752.1182522107283;3295.785773924711;3304.7025767680784;3313.155145437922;3326.916827079318;3329.1510664780567;4629.58797566742;4640.814367425299;4651.093036857814;4668.5564871337165;4693.6949098308505;4163.792500174945;4252.532221455637;4269.551697071794;4271.974726065753;4274.786260686984;4975.950240497585;4989.201727723546;4997.85006449807;5005.124103281911;5007.624428167902;3612.5123108380294;3614.259076889258;3617.8293024185277;3625.274945011008;3627.5308500057254;4977.950220497821;5253.842384728464;5258.290130832365;5259.2899958505495;5260.473952604747;3573.857045718142;3613.9638603614153;3616.6744992950235;3630.3283892479976;3638.3632864248652;3674.706023518112;3681.8711345102793;3682.3187710273687;3686.4654625079215;3686.7972261525338;4230;4231.703780735319;4240.1307731914885;4242.61816436516;4246.214450326699;4792.688475249098;5017;5059.544640982329;5061.6962982221185;5075.720835354091;1278.8849003589721;1290.2774446310095;1290.664427248922;1291.7792685911722;1293.6636474516692;796.4862663581957;820.7660816667221;829.4442723375353;829.4815740162398;838.304207507767;4326.783660816946;4437.933430998538;4441.311596702516;4442.666799990014;4444.6666500012625;5097.317885097908;5197.24639927216;5204.635675502678;5212.609054320941;5212.696825793551;4481;4533.9319910201375;4539.5460453955;4540.318952157203;4542.3413605027745;2627.090751324006;2734.9589756153673;2735.7811375089946;2741.752502611347;2755.3524921643398;4853.174960256765;4856.975715121402;4870.683405578626;4883.536064073907;4890.951090489049;5033.47148549397;5284.286621306074;5302.681839089667;5308.46915308466;5324.520793128637;4777.593904518155;4787.4494433139935;4801.399825021803;4810.776779557705;4842.7336496493035;5109.872253193551;5111.46329635383;5125.410577783603;5140.794368225229;5142.537171654569;4855.320255164209;5047.6214283929585;5057.282897070577;5068.923966140437;5079.92380114306;4794.760261986817;4794.897173650011;4816.133096042746;4816.410584507034;4833.178359678934;3566.8038257896064;3567.5362202913457;3570.7143428526174;3574.7140228781113;3582.874599389009;5084.805070808283;5117.744112794271;5124.7950081996305;5130.871208334161;5140.254663073908;4787.066522028171;5028.798848046184;5035.697858128524;5060.1903695408555;5071.721055341992;5015.147424937696;5032.094223039888;5043.747812609428;5044.722540260321;5068.26510156018;4839.790052486878;4989.276554899447;4997.025580011863;4998.1503144464805;5001.449840517613;4854.344663470386;4982.302477653059;5080.009398167322;5082.288479612931;5104.566111880532;4837.564619184291;4997.125503037027;5002.524760147926;5005.749712514287;5009.499050094962 04:40:44 INFO - PROCESS | 4889 | |5;yui.html;621.9004959206528;649.1755470552398;671.8891382921821;709.6948312225741;712.5688958180299;13174.934125329371;13863.93068034661;13911.44354225831;13912.304384780746;13938;13166.407511661975;13347.866521334809;13370.59888203353;13397.330133493335;13406.59780206593;618.6937465954359;633.1326083265932;743.9888401673979;749.24700675821;771.3983093187322;774.2025713515088;776.1966364812421;776.7553220735479;777.0558771093121;777.2577188784697;826.8801023851538;828.2380210206594;828.6519661742053;829.3489610655637;829.7178959153887;660.1582981698349;675.5811396933883;676.137924146712;677.9796606101776;824.1099612418574;496.1936852614501;576.9826905192851;583.3787016827066;588.9146073819315;592.3691268798716;12768;12775.552855650008;12785.552505662257;12795.104342696015;12805.039622028293;11549.711257218552;11904.642860714192;12334.691632709164;12619.116661833676;13064.085514014023;9774.755631109208;9798.363106398061;10000.849987250198;10364.32631878933;10946.890531094747;3763.266163098197;3767.566729826078;3819.4461803038403;3898.8245528950983;3909.139989202371;63564;63929.36070639327;64942;64964;65056;9376.812463750686;9412.15290623847;9532.094451027142;9535.952320238355;9599.568019439143;18368.908155459405;18427.355042573712;18438.35465758692;18523.35168269104;18900.905495472434;6508.837279068061;6635.203775546869;6645.568038077509;6670.733170673118;6819.971571069826;3441.6558344165883;3447.8620855165514;3462.1344663834043;3557.128503516655;3612.0066981580276;2830.3914658348554;2935.6036935013926;2936.3246453315855;2947.292649764041;3332.7833690810503;559.0356634804929;565.2171742137169;569;572.2817863581262;579.739117397173;520.786477544205;527.1354977836352;593.7061154728351;603.4960807725598;604.4499505450019;7943.24539168778;8173.427860049739;8309.6676132954;8377.748667539983;8387.077421483631;567.5998421113105;588.0649766870696;590.7577893063823;599.3946114424463;605.9363766804511;4247.97876010618;4450.154470650566;4533.410656614685;4560.566746159109;4583.449986001701;75479;96461;97900;99705;102434.48782756038;60089.982003599456;86228;88590;88753;88985;44950.77524612356;54492.45507544953;75086;76901;77572.61213693896;8731.650733970824;9063.864042039242;9064.365494415328;9148.908510915071;9150.908490915006;31083.78324335097;36423.453648194765;43393.56606433895;43462;44614.77692611516;65963.34036659572;66154;66867.66566167137;67554.66222668855;68811;10912.78174436491;11003.119750420108;11153.163512736415;11563.132765042823;11823.349715765715;12364.381780910739;12687.365631718192;12700.491980321054;13104.672383190496;13129.409176586885;9840.071520810456;11843.46704398287;11902.523899044287;12766.808497872353;12785.744285114431;11463.713407164887;11610.76778464443;11691.766164676488;12031.15781895259;12421.75156496847;11712.063034957353;11744.882551174378;11819.409029548317;12217.389130543615;12221.633350999484;9698.660546880825;9774.413535187912;10461.26771126014;10778.191635627203;10954.39750813681;9034.367594268339;9179.357444978787;9274.526989220114;10175.49122543855;10286.537105830106 04:40:44 INFO - PROCESS | 4889 | __end_tp_report 04:40:44 INFO - PROCESS | 4889 | __start_cc_report 04:40:44 INFO - PROCESS | 4889 | _x_x_mozilla_cycle_collect,1334 04:40:44 INFO - PROCESS | 4889 | __end_cc_report 04:40:44 INFO - PROCESS | 4889 | __startTimestamp1475581244437__endTimestamp 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | ------- Summary: start ------- 04:40:44 INFO - PROCESS | 4889 | Number of tests: 6 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#0] dojo.html Cycles:165 Average:4604.38 Median:4722.15 stddev:474.49 (10.0%) stddev-sans-first:447.83 04:40:44 INFO - PROCESS | 4889 | Values: 2553.4 2571.4 2599.5 2610.2 2621.6 4573.1 4575.5 4623.0 4629.1 4646.1 4658.8 4669.1 4676.2 4681.1 4682.3 4270.6 4297.1 4305.4 4323.6 4329.7 4374.0 4390.2 4396.0 4399.3 4446.3 4284.3 4294.3 4333.9 4345.3 4390.9 4283.6 4329.6 4346.2 4382.0 4405.3 4289.6 4317.1 4330.2 4350.6 4357.8 4510.0 4546.3 4559.0 4638.9 4655.0 4926.7 4928.5 4929.5 4995.1 5062.5 4982.0 5008.4 5015.4 5024.1 5073.0 4566.7 4579.2 4615.8 4692.5 4745.0 5053.1 5089.5 5093.5 5094.6 5157.1 4834.5 4894.2 4899.5 4904.7 4953.5 4848.5 4900.4 4926.5 4955.4 5036.2 4899.7 4928.3 4954.6 4963.8 4980.4 4902.9 4906.9 4915.5 4922.1 4989.6 4147.1 4179.0 4184.2 4196.0 4255.2 3668.3 3675.0 3727.0 3734.2 3736.7 4325.6 4329.7 4365.9 4382.3 4384.8 4998.8 5002.2 5002.7 5006.4 5065.7 4153.3 4199.6 4301.1 4314.9 4318.2 4489.3 4514.0 4515.3 4563.8 4569.2 4686.6 4716.4 4719.9 4722.2 4791.2 4878.0 4925.7 5044.4 5044.4 5046.0 4407.7 4644.4 4688.3 4691.6 4734.6 4901.2 4910.0 4912.2 4914.8 4964.7 4849.5 4905.5 4984.6 5000.0 5058.6 4777.7 4781.4 4781.8 4836.0 4867.7 4803.6 4810.2 4812.0 4817.1 4869.5 4631.1 4728.3 4761.1 4788.5 4846.7 4759.8 4863.8 4899.1 4908.7 4985.8 4765.7 4772.0 4775.1 4787.6 4842.6 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#1] ext.html Cycles:180 Average:44753.39 Median:34504.65 stddev:82973.35 (240.5%) stddev-sans-first:83139.76 04:40:44 INFO - PROCESS | 4889 | Values: 558.2 559.9 565.7 570.5 574.2 27315.7 37765.6 38817.4 38935.0 42390.4 39080.0 39441.4 39482.6 39498.2 39498.8 7687.0 7847.2 7850.6 7852.8 7858.4 7688.2 7776.4 7784.7 7784.7 7785.6 7766.5 7805.1 7807.4 7808.6 7810.8 7738.7 7818.8 7828.2 7834.5 7840.6 7661.0 7725.1 7726.7 7727.0 7731.5 37972.8 38294.4 38327.2 38329.4 38343.1 2934.7 3050.5 3087.1 3234.5 3308.7 27889.4 28091.6 28151.6 28783.6 29327.6 3304.9 3364.3 3369.8 3393.1 3396.9 241592.0 243249.0 243649.0 243832.0 244885.0 30567.2 31593.4 50030.7 50491.0 50522.5 33197.3 33368.3 33409.3 33416.5 33418.7 12944.5 13072.9 13076.3 13081.5 13086.1 10454.5 10499.3 10501.0 10506.0 10506.3 7818.0 7826.2 7867.0 7917.9 7936.9 3036.2 3039.9 3050.4 3084.8 3101.9 794.2 879.2 905.2 906.7 946.4 26813.3 27123.3 27300.2 27681.6 27895.6 821.8 942.5 961.2 1005.1 1040.5 13955.5 14784.1 14917.2 14981.7 15070.7 391550.0 392138.0 393359.0 395244.0 395979.0 47545.0 47936.5 47978.0 47985.3 47996.0 1063.8 1088.9 1128.9 1149.2 1177.5 26641.7 27951.3 28763.9 29225.7 29273.0 40223.4 40569.1 40753.4 40779.0 40787.2 285384.0 286749.0 287113.0 287227.0 287272.0 24022.3 25154.0 25185.0 26066.9 26128.1 40109.2 40458.6 40797.0 40985.0 41640.4 34391.0 34636.8 34765.5 34891.7 34909.5 34216.1 34448.7 34560.7 34845.7 34848.8 33477.5 34256.8 34294.8 34624.5 34801.8 29845.6 31277.6 31527.1 31830.2 31876.8 24478.9 24565.3 24723.5 24957.8 25068.7 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#2] jquery.html Cycles:180 Average:24825.51 Median:192550.69 stddev:62507.63 (32.5%) stddev-sans-first:62655.94 04:40:44 INFO - PROCESS | 4889 | Values: 341.0 362.1 365.4 368.8 386.4 12032.3 15493.7 15725.1 15785.9 16780.8 15664.9 15753.7 16145.5 16280.1 16422.7 4605.5 4607.3 4697.8 4755.8 4779.2 3445.7 3633.4 4585.1 4655.5 4661.9 5283.7 5529.9 5540.7 5544.7 5552.2 5421.3 5517.7 5537.7 6052.5 6086.6 5406.2 5407.1 5414.5 5416.4 5420.2 12017.3 12290.4 12336.3 12432.5 18160.6 1748.7 1826.4 1843.6 2060.2 2221.0 13780.3 14299.3 14841.4 14890.6 15307.3 1808.8 1809.5 1821.2 1861.0 1896.4 78626.6 79262.0 79515.6 80068.0 85218.0 16352.3 16420.5 16509.9 16683.3 16685.5 29357.7 29368.1 29469.9 29541.1 29675.8 8764.1 8787.8 8891.1 8998.4 9140.8 7253.0 7283.3 7365.7 7543.4 7572.3 7959.7 8170.9 8190.7 8197.6 8321.5 3045.5 3052.0 3227.0 3245.6 3248.7 773.4 840.5 886.5 917.4 927.2 16392.9 16525.7 16560.1 16788.4 17024.3 849.9 856.9 876.6 878.4 906.3 9124.4 9388.8 9690.6 9701.5 9721.1 369869.0 372956.0 375717.0 384604.5 384715.0 71954.3 74075.0 75795.0 76226.2 76500.0 873.7 881.4 902.7 904.3 904.5 11384.7 16090.9 16491.9 16507.7 16744.5 37025.6 37240.3 37569.6 37663.8 38035.0 47427.5 47566.3 47587.8 47734.0 47789.5 7656.2 7658.0 7741.3 7802.0 8120.3 8933.5 11608.5 11675.6 11692.0 11708.2 9216.4 9855.6 9982.6 10294.6 11079.4 10617.9 10623.6 10687.1 10915.8 10947.6 10348.3 10649.0 10828.0 10926.5 11436.1 7718.8 7799.8 7811.8 8077.5 8100.4 8158.4 10451.8 10611.8 10828.3 10927.5 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#3] mootools.html Cycles:180 Average:5081.81 Median:5207.83 stddev:2894.19 (55.6%) stddev-sans-first:2888.34 04:40:44 INFO - PROCESS | 4889 | Values: 1297.9 1333.4 1378.7 1655.5 1665.8 6880.0 7123.1 7429.2 8027.6 8037.8 7338.5 7608.8 7656.9 7884.4 7887.4 2105.5 2124.8 2135.6 2135.7 2135.8 1709.7 2108.5 2138.9 2140.9 2147.9 1677.2 2033.4 2100.3 2115.7 2130.7 2056.5 2062.7 2064.9 2066.4 2074.3 2060.3 2060.9 2061.6 2064.9 2065.0 7792.2 7948.6 7949.8 7958.4 7959.5 4427.5 4575.3 4576.5 4578.1 4582.2 2600.3 2814.5 2816.3 2818.1 2826.0 842.7 885.3 900.7 901.0 908.5 10796.7 10835.3 10877.3 10878.3 10883.3 3758.4 3919.6 4056.7 4089.9 4102.3 9153.0 9170.7 9171.0 9179.6 9184.2 4530.5 4532.3 4545.4 4550.3 4555.4 4122.7 4182.6 4195.9 4197.1 4198.1 3322.2 3363.5 3390.4 3427.3 3430.3 1021.9 1112.4 1131.3 1152.6 1159.7 676.9 793.3 831.2 832.0 835.4 4978.7 4989.5 5170.1 5170.3 5247.7 871.7 875.5 905.3 945.5 961.2 3368.5 3452.1 3466.8 3512.2 3568.8 9424.5 9574.0 9680.4 9681.8 9706.0 9559.9 9564.7 9566.4 9567.1 9570.8 6664.3 6949.8 6952.7 7086.4 7092.5 5083.6 5175.9 5239.8 5240.8 5263.9 8286.7 8532.5 8594.2 8607.3 8642.1 8513.1 8776.7 8814.6 8862.6 8881.8 6807.4 6884.3 6921.7 6956.8 6970.4 7409.3 7538.3 7543.5 7553.9 7561.9 6490.3 6780.2 6843.9 6918.6 7068.7 6753.9 6780.6 6857.4 6977.8 6996.7 6377.0 6441.3 6444.2 6450.3 6456.4 4350.6 4513.9 4577.2 4591.1 4618.4 4454.1 4568.7 4620.9 4652.8 4760.3 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#4] prototype.html Cycles:180 Average:4161.64 Median:4790.07 stddev:1213.20 (25.3%) stddev-sans-first:1181.24 04:40:44 INFO - PROCESS | 4889 | Values: 287.4 295.3 298.4 306.1 308.7 4781.0 4807.6 4835.6 4841.6 4848.7 4782.8 4784.3 4799.6 4803.4 4817.8 3550.7 3647.8 3661.2 3718.9 3769.0 3731.9 3741.3 3757.3 3760.9 3764.5 3705.7 3711.1 3714.1 3714.3 3716.9 3550.7 3602.6 3666.9 3743.2 3752.1 3295.8 3304.7 3313.2 3326.9 3329.2 4629.6 4640.8 4651.1 4668.6 4693.7 4163.8 4252.5 4269.6 4272.0 4274.8 4976.0 4989.2 4997.9 5005.1 5007.6 3612.5 3614.3 3617.8 3625.3 3627.5 4978.0 5253.8 5258.3 5259.3 5260.5 3573.9 3614.0 3616.7 3630.3 3638.4 3674.7 3681.9 3682.3 3686.5 3686.8 4230.0 4231.7 4240.1 4242.6 4246.2 4792.7 5017.0 5059.5 5061.7 5075.7 1278.9 1290.3 1290.7 1291.8 1293.7 796.5 820.8 829.4 829.5 838.3 4326.8 4437.9 4441.3 4442.7 4444.7 5097.3 5197.2 5204.6 5212.6 5212.7 4481.0 4533.9 4539.5 4540.3 4542.3 2627.1 2735.0 2735.8 2741.8 2755.4 4853.2 4857.0 4870.7 4883.5 4891.0 5033.5 5284.3 5302.7 5308.5 5324.5 4777.6 4787.4 4801.4 4810.8 4842.7 5109.9 5111.5 5125.4 5140.8 5142.5 4855.3 5047.6 5057.3 5068.9 5079.9 4794.8 4794.9 4816.1 4816.4 4833.2 3566.8 3567.5 3570.7 3574.7 3582.9 5084.8 5117.7 5124.8 5130.9 5140.3 4787.1 5028.8 5035.7 5060.2 5071.7 5015.1 5032.1 5043.7 5044.7 5068.3 4839.8 4989.3 4997.0 4998.2 5001.4 4854.3 4982.3 5080.0 5082.3 5104.6 4837.6 4997.1 5002.5 5005.7 5009.5 04:40:44 INFO - PROCESS | 4889 | 04:40:44 INFO - PROCESS | 4889 | [#5] yui.html Cycles:180 Average:17466.71 Median:568.30 stddev:24862.22 (4374.8%) stddev-sans-first:24899.79 04:40:44 INFO - PROCESS | 4889 | Values: 621.9 649.2 671.9 709.7 712.6 13174.9 13863.9 13911.4 13912.3 13938.0 13166.4 13347.9 13370.6 13397.3 13406.6 618.7 633.1 744.0 749.2 771.4 774.2 776.2 776.8 777.1 777.3 826.9 828.2 828.7 829.3 829.7 660.2 675.6 676.1 678.0 824.1 496.2 577.0 583.4 588.9 592.4 12768.0 12775.6 12785.6 12795.1 12805.0 11549.7 11904.6 12334.7 12619.1 13064.1 9774.8 9798.4 10000.8 10364.3 10946.9 3763.3 3767.6 3819.4 3898.8 3909.1 63564.0 63929.4 64942.0 64964.0 65056.0 9376.8 9412.2 9532.1 9536.0 9599.6 18368.9 18427.4 18438.4 18523.4 18900.9 6508.8 6635.2 6645.6 6670.7 6820.0 3441.7 3447.9 3462.1 3557.1 3612.0 2830.4 2935.6 2936.3 2947.3 3332.8 559.0 565.2 569.0 572.3 579.7 520.8 527.1 593.7 603.5 604.4 7943.2 8173.4 8309.7 8377.7 8387.1 567.6 588.1 590.8 599.4 605.9 4248.0 4450.2 4533.4 4560.6 4583.4 75479.0 96461.0 97900.0 99705.0 102434.5 60090.0 86228.0 88590.0 88753.0 88985.0 44950.8 54492.5 75086.0 76901.0 77572.6 8731.7 9063.9 9064.4 9148.9 9150.9 31083.8 36423.5 43393.6 43462.0 44614.8 65963.3 66154.0 66867.7 67554.7 68811.0 10912.8 11003.1 11153.2 11563.1 11823.3 12364.4 12687.4 12700.5 13104.7 13129.4 9840.1 11843.5 11902.5 12766.8 12785.7 11463.7 11610.8 11691.8 12031.2 12421.8 11712.1 11744.9 11819.4 12217.4 12221.6 9698.7 9774.4 10461.3 10778.2 10954.4 9034.4 9179.4 9274.5 10175.5 10286.5 04:40:44 INFO - PROCESS | 4889 | -------- Summary: end -------- 04:40:44 INFO - PROCESS | 4889 | 04:40:45 INFO - TEST-INFO | 4889: exit 0 04:40:45 INFO - TEST-OK | dromaeo_css | took 1121047ms 04:40:45 INFO - TEST-START | kraken 04:40:45 INFO - operating with platform_type : linux_ 04:40:45 INFO - Initialising browser for kraken test... 04:40:45 INFO - TEST-INFO | started process 5196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVyYw85/profile http://localhost:60928/getInfo.html) 04:40:49 INFO - PROCESS | 5196 | __metrics Screen width/height:1600/1200 04:40:49 INFO - PROCESS | 5196 | colorDepth:24 04:40:49 INFO - PROCESS | 5196 | Browser inner width/height: 1024/697 04:40:49 INFO - PROCESS | 5196 | __metrics 04:40:50 INFO - PROCESS | 5196 | 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" 04:40:50 INFO - PROCESS | 5196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:50 INFO - PROCESS | 5196 | console.error: PushService: 04:40:50 INFO - PROCESS | 5196 | stateChangeProcessEnqueue: Error transitioning state 04:40:50 INFO - PROCESS | 5196 | UnknownError 04:40:51 INFO - TEST-INFO | 5196: exit 0 04:40:51 INFO - Browser initialized. 04:40:51 INFO - Running cycle 1/1 for kraken test... 04:40:51 INFO - TEST-INFO | started process 5274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVyYw85/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:03 INFO - PROCESS | 5274 | RSS: Main: 175370240 04:41:03 INFO - PROCESS | 5274 | 04:41:06 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60928/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:07 INFO - PROCESS | 5274 | RSS: Main: 238706688 04:41:07 INFO - PROCESS | 5274 | 04:41:10 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60928/tests/kraken/driver.html?testName=audio-dft) 04:41:10 INFO - PROCESS | 5274 | RSS: Main: 218955776 04:41:10 INFO - PROCESS | 5274 | 04:41:13 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60928/tests/kraken/driver.html?testName=audio-fft) 04:41:14 INFO - PROCESS | 5274 | RSS: Main: 301486080 04:41:14 INFO - PROCESS | 5274 | 04:41:16 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60928/tests/kraken/driver.html?testName=audio-oscillator) 04:41:17 INFO - PROCESS | 5274 | RSS: Main: 211931136 04:41:17 INFO - PROCESS | 5274 | 04:41:19 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:20 INFO - PROCESS | 5274 | RSS: Main: 214384640 04:41:20 INFO - PROCESS | 5274 | 04:41:23 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60928/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:24 INFO - PROCESS | 5274 | RSS: Main: 251318272 04:41:24 INFO - PROCESS | 5274 | 04:41:27 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60928/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:28 INFO - PROCESS | 5274 | RSS: Main: 244572160 04:41:28 INFO - PROCESS | 5274 | 04:41:31 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60928/tests/kraken/driver.html?testName=json-parse-financial) 04:41:31 INFO - PROCESS | 5274 | RSS: Main: 248594432 04:41:31 INFO - PROCESS | 5274 | 04:41:33 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:33 INFO - PROCESS | 5274 | RSS: Main: 211464192 04:41:33 INFO - PROCESS | 5274 | 04:41:35 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:36 INFO - PROCESS | 5274 | RSS: Main: 219594752 04:41:36 INFO - PROCESS | 5274 | 04:41:38 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:39 INFO - PROCESS | 5274 | RSS: Main: 227520512 04:41:39 INFO - PROCESS | 5274 | 04:41:42 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:42 INFO - PROCESS | 5274 | RSS: Main: 235737088 04:41:42 INFO - PROCESS | 5274 | 04:41:45 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:46 INFO - PROCESS | 5274 | RSS: Main: 233635840 04:41:46 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | Cycle 1(1): loaded http://localhost:60928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60928/tests/kraken/driver.html?testName=ai-astar) 04:41:48 INFO - PROCESS | 5274 | RSS: Main: 284004352 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | __start_tp_report 04:41:48 INFO - PROCESS | 5274 | _x_x_mozilla_page_load 04:41:48 INFO - PROCESS | 5274 | _x_x_mozilla_page_load_details 04:41:48 INFO - PROCESS | 5274 | |i|pagename|runs| 04:41:48 INFO - PROCESS | 5274 | |0;ai-astar;114;113;115;115;114;114;115;115;114;114 04:41:48 INFO - PROCESS | 5274 | |1;audio-beat-detection;154;133;126;164;131;128;127;129;163;128 04:41:48 INFO - PROCESS | 5274 | |2;audio-dft;161;160;161;162;161;161;162;161;164;162 04:41:48 INFO - PROCESS | 5274 | |3;audio-fft;76;76;78;107;77;77;76;76;97;76 04:41:48 INFO - PROCESS | 5274 | |4;audio-oscillator;84;83;124;83;85;84;111;83;83;114 04:41:48 INFO - PROCESS | 5274 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;118;116;116 04:41:48 INFO - PROCESS | 5274 | |6;imaging-darkroom;147;146;147;148;146;147;146;149;147;146 04:41:48 INFO - PROCESS | 5274 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 04:41:48 INFO - PROCESS | 5274 | |8;json-parse-financial;66;63;64;63;65;66;65;64;65;64 04:41:48 INFO - PROCESS | 5274 | |9;json-stringify-tinderbox;65;66;66;66;67;66;65;66;67;67 04:41:48 INFO - PROCESS | 5274 | |10;stanford-crypto-aes;86;84;84;83;93;83;84;92;83;84 04:41:48 INFO - PROCESS | 5274 | |11;stanford-crypto-ccm;140;140;144;139;143;159;139;138;177;149 04:41:48 INFO - PROCESS | 5274 | |12;stanford-crypto-pbkdf2;179;178;177;179;177;186;177;183;177;179 04:41:48 INFO - PROCESS | 5274 | |13;stanford-crypto-sha256-iterative;71;72;72;71;71;72;73;70;70;69 04:41:48 INFO - PROCESS | 5274 | __end_tp_report 04:41:48 INFO - PROCESS | 5274 | __start_cc_report 04:41:48 INFO - PROCESS | 5274 | _x_x_mozilla_cycle_collect,1940 04:41:48 INFO - PROCESS | 5274 | __end_cc_report 04:41:48 INFO - PROCESS | 5274 | __startTimestamp1475581308593__endTimestamp 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | ------- Summary: start ------- 04:41:48 INFO - PROCESS | 5274 | Number of tests: 14 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:41:48 INFO - PROCESS | 5274 | Values: 114.0 113.0 115.0 115.0 114.0 114.0 115.0 115.0 114.0 114.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:132.00 stddev:15.55 (11.8%) stddev-sans-first:15.42 04:41:48 INFO - PROCESS | 5274 | Values: 154.0 133.0 126.0 164.0 131.0 128.0 127.0 129.0 163.0 128.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 04:41:48 INFO - PROCESS | 5274 | Values: 161.0 160.0 161.0 162.0 161.0 161.0 162.0 161.0 164.0 162.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.50 stddev:11.03 (14.4%) stddev-sans-first:11.51 04:41:48 INFO - PROCESS | 5274 | Values: 76.0 76.0 78.0 107.0 77.0 77.0 76.0 76.0 97.0 76.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.00 stddev:16.16 (19.5%) stddev-sans-first:16.78 04:41:48 INFO - PROCESS | 5274 | Values: 84.0 83.0 124.0 83.0 85.0 84.0 111.0 83.0 83.0 114.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:41:48 INFO - PROCESS | 5274 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 118.0 116.0 116.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 04:41:48 INFO - PROCESS | 5274 | Values: 147.0 146.0 147.0 148.0 146.0 147.0 146.0 149.0 147.0 146.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:41:48 INFO - PROCESS | 5274 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 04:41:48 INFO - PROCESS | 5274 | Values: 66.0 63.0 64.0 63.0 65.0 66.0 65.0 64.0 65.0 64.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 04:41:48 INFO - PROCESS | 5274 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 67.0 67.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.00 stddev:3.75 (4.5%) stddev-sans-first:3.97 04:41:48 INFO - PROCESS | 5274 | Values: 86.0 84.0 84.0 83.0 93.0 83.0 84.0 92.0 83.0 84.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:143.50 stddev:12.38 (8.6%) stddev-sans-first:12.89 04:41:48 INFO - PROCESS | 5274 | Values: 140.0 140.0 144.0 139.0 143.0 159.0 139.0 138.0 177.0 149.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:179.00 stddev:3.01 (1.7%) stddev-sans-first:3.19 04:41:48 INFO - PROCESS | 5274 | Values: 179.0 178.0 177.0 179.0 177.0 186.0 177.0 183.0 177.0 179.0 04:41:48 INFO - PROCESS | 5274 | 04:41:48 INFO - PROCESS | 5274 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.20 (1.7%) stddev-sans-first:1.27 04:41:48 INFO - PROCESS | 5274 | Values: 71.0 72.0 72.0 71.0 71.0 72.0 73.0 70.0 70.0 69.0 04:41:48 INFO - PROCESS | 5274 | -------- Summary: end -------- 04:41:48 INFO - PROCESS | 5274 | 04:41:49 INFO - TEST-INFO | 5274: exit 0 04:41:49 INFO - TEST-OK | kraken | took 64511ms 04:41:49 INFO - SUITE-END | took 1185s 04:41:50 INFO - Completed test suite (00:19:45) 04:41:50 INFO - javascript benchmark 04:41:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.3744232663, 2571.3700143464853, 2599.545079611068, 2610.229982155264, 2621.593652983788, 4573.13110509003, 4575.519570445105, 4622.976885115574, 4629.143608432442, 4646.094011667727, 4658.813647454106, 4669.089527542131, 4676.228422310323, 4681.110588988098, 4682.321063445806, 4270.551592082833, 4297.05464797744, 4305.418768466248, 4323.610875021263, 4329.653627709791, 4374.0, 4390.2317094508335, 4396.032872767986, 4399.252127138394, 4446.333050042487, 4284.314509678452, 4294.334378171373, 4333.934990975138, 4345.3047512398025, 4390.912181756363, 4283.571642835723, 4329.588689074533, 4346.217680817467, 4381.956180438218, 4405.251107311765, 4289.6353809926195, 4317.071829556629, 4330.220560299145, 4350.58669426404, 4357.825686972549, 4509.954900450986, 4546.318052292149, 4558.954410455886, 4638.8608341749805, 4655.045715628288, 4926.655134140576, 4928.457869634337, 4929.531694489054, 4995.050940321327, 5062.493750624945, 4982.0, 5008.424031236382, 5015.423226328982, 5024.095662780698, 5073.0, 4566.70316429431, 4579.175748365326, 4615.838445654386, 4692.483826779017, 4744.95255047452, 5053.140966035783, 5089.491050894881, 5093.490650934877, 5094.61790365724, 5157.149070403341, 4834.516548345207, 4894.241392584155, 4899.485554016848, 4904.730239836843, 4953.529414705597, 4848.539388758062, 4900.411950565955, 4926.531979461945, 4955.380577427822, 5036.219385995177, 4899.730514821647, 4928.334674818925, 4954.5540901319055, 4963.776630051656, 4980.377452818398, 4902.926456103161, 4906.852794416173, 4915.459299477055, 4922.064807686528, 4989.600831933437, 4147.129102888367, 4178.979105104516, 4184.205001049791, 4195.958040419557, 4255.170241802881, 3668.3396988541786, 3674.963250367462, 3727.0309719473134, 3734.215814678948, 3736.7010639148803, 4325.632321252666, 4329.696921215547, 4365.869023929224, 4382.320740285261, 4384.758838263862, 4998.775055122528, 5002.249662550574, 5002.724850133278, 5006.374203224597, 5065.670731402447, 4153.335466325373, 4199.643030342394, 4301.05376817106, 4314.913701726011, 4318.157959197989, 4489.304157855538, 4514.0, 4515.254982927846, 4563.771811409416, 4569.1547063793305, 4686.648501362343, 4716.3632909557455, 4719.858404247878, 4722.150012997693, 4791.209450440708, 4877.975610121926, 4925.655204135676, 5044.4451110377095, 5044.445111037856, 5046.0, 4407.713498622579, 4644.373009643655, 4688.320193571844, 4691.648126390603, 4734.55021772931, 4901.240307752304, 4909.950900491092, 4912.1649319615035, 4914.778834952507, 4964.702117872939, 4849.466558678472, 4905.5094490550655, 4984.601231901512, 5000.049990501793, 5058.570021548209, 4777.665563410528, 4781.354517140142, 4781.808727650855, 4835.95164048369, 4867.683600565952, 4803.639727020557, 4810.230363142021, 4812.037592481448, 4817.084753896748, 4869.513048695244, 4631.073785243032, 4728.31439441286, 4761.071591039714, 4788.497207793271, 4846.660733748604, 4759.7858096386435, 4863.756812159449, 4899.1426500363, 4908.680935739166, 4985.825496107619, 4765.69023013503, 4771.950170962383, 4775.140474714584, 4787.593054590398, 4842.564169224786], "value": 4574.3293013814055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.2240685447227, 559.9328080630326, 565.6577770448876, 570.480862415202, 574.1903915479174, 27315.72684273157, 37765.62234377655, 38817.41773873387, 38935.0, 42390.36414453786, 39080.0, 39441.40837887434, 39482.60517394825, 39498.21003579934, 39498.8025059875, 7686.961565192166, 7847.215278472164, 7850.568218747967, 7852.764417067498, 7858.449908506407, 7688.1927397623285, 7776.416768742339, 7784.727534536292, 7784.727534536292, 7785.649645765954, 7766.45634805561, 7805.063392392921, 7807.375409967218, 7808.60956952153, 7810.765677029698, 7738.651760670755, 7818.843623127505, 7828.217178282183, 7834.490758100762, 7840.568768717718, 7661.042369703787, 7725.111612164616, 7726.729564465273, 7727.034120734908, 7731.497452665559, 37972.81013594942, 38294.42558361627, 38327.23345533074, 38329.42505862414, 38343.12426567991, 2934.7358737713494, 3050.4814181588963, 3087.1356020314347, 3234.4663130583426, 3308.718758905496, 27889.442211155663, 28091.57862632062, 28151.577726334122, 28783.56824647632, 29327.560086598718, 3304.867805287786, 3364.2598628301735, 3369.8146601936883, 3393.100828280508, 3396.932061358759, 241592.0, 243249.0, 243648.99999999822, 243832.0, 244885.0, 30567.235819104255, 31593.36813263768, 50030.74984625054, 50490.95090490995, 50522.49477505252, 33197.3360532788, 33368.3326333472, 33409.331813364086, 33416.49875251873, 33418.665813341555, 12944.482220711254, 13072.869271307356, 13076.28080455565, 13081.542146024844, 13086.08397412172, 10454.477276136162, 10499.317544359592, 10501.0, 10506.0, 10506.317089389166, 7817.960910195413, 7826.2173782621285, 7866.960665196638, 7917.881231781528, 7936.880946785803, 3036.16505461, 3039.9392012159633, 3050.3746731920346, 3084.78406511542, 3101.8914337998513, 794.2494342846071, 879.2394578689515, 905.1943770044666, 906.6826610686207, 946.3990366117565, 26813.329666758487, 27123.321916951838, 27300.180994570193, 27681.584776228374, 27895.581566276524, 821.7863355527486, 942.5146049784366, 961.1589858873485, 1005.1203302538175, 1040.484959944832, 13955.511557095453, 14784.11295322284, 14917.179555124572, 14981.70036599262, 15070.698586028218, 391550.0, 392138.0, 393359.0, 395244.0, 395979.0, 47545.0, 47936.5206347939, 47978.0, 47985.28022079672, 47996.0, 1063.8085144674033, 1088.8856670049688, 1128.8871112888646, 1149.2013050929525, 1177.473466966441, 26641.7335826647, 27951.301217469725, 28763.85618071896, 29225.70774292315, 29273.0, 40223.396649049704, 40569.089027639326, 40753.38869916894, 40779.0, 40787.184256315304, 285384.0, 286749.0, 287113.0, 287227.0, 287272.0, 24022.27933162008, 25154.0, 25185.0, 26066.86966565231, 26128.085517006813, 40109.1978160441, 40458.595414045485, 40797.0, 40985.0, 41640.375394369716, 34391.0, 34636.82681586576, 34765.47851782276, 34891.65108348884, 34909.476357854146, 34216.06515250679, 34448.65551344555, 34560.65439345574, 34845.651543484244, 34848.82575587106, 33477.497837532945, 34256.82871585726, 34294.828525857214, 34624.480632791034, 34801.82599086988, 29845.55231671483, 31277.636255776037, 31527.088678360262, 31830.204244894063, 31876.840615796773, 24478.87760561186, 24565.263042108767, 24723.514625114203, 24957.75042249627, 25068.749312506643], "value": 16038.488957737609, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.9710174635156, 362.0748986339901, 365.4025668032767, 368.8063766522576, 386.3895045827593, 12032.278063316207, 15493.690126197469, 15725.135117568543, 15785.921070394632, 16780.83219167808, 15664.921675391635, 15753.684926301466, 16145.515634530982, 16280.104594247312, 16422.67154656906, 4605.539446055401, 4607.331936869152, 4697.78859951303, 4755.833545825897, 4779.187538118511, 3445.707114895237, 3633.4368172933237, 4585.060062687157, 4655.4646215685125, 4661.930071048937, 5283.656562323456, 5529.889402211953, 5540.695261760601, 5544.722763861811, 5552.194931734896, 5421.268128802601, 5517.69652669103, 5537.695426751527, 6052.485538729169, 6086.573939824214, 5406.243125962368, 5407.107827208506, 5414.458554144554, 5416.404195538487, 5420.214068959979, 12017.278963262232, 12290.446929888176, 12336.321502317369, 12432.502699891993, 18160.636787264313, 1748.7464317673866, 1826.3607737291975, 1843.6220574782137, 2060.1965233558926, 2221.0227499899993, 13780.310984450838, 14299.285035748171, 14841.406343746237, 14890.553283401516, 15307.31117099722, 1808.7739032620923, 1809.5204770735766, 1821.1895706410653, 1860.9534761631066, 1896.3836753055175, 78626.6068669653, 79262.0, 79515.62468880079, 80068.0, 85217.99999999937, 16352.34590616362, 16420.507384778237, 16509.91745041291, 16683.329667473135, 16685.49943501697, 29357.706422935924, 29368.118956431343, 29469.852650736608, 29541.113766587037, 29675.806733821493, 8764.123587641312, 8787.824243515093, 8891.066438023914, 8998.415103018282, 9140.771480713036, 7252.963735181291, 7283.2716728327805, 7365.705371785069, 7543.358814500719, 7572.318491335696, 7959.721409750631, 8170.918290817134, 8190.713325033715, 8197.631106600098, 8321.542315172723, 3045.4822680143984, 3052.0080973683644, 3226.9838650806596, 3245.6105267367593, 3248.6588908164777, 773.3928865840401, 840.5083026429485, 886.4504007515382, 917.4266083697689, 927.2211342472356, 16392.918035409984, 16525.6694866102, 16560.089195094144, 16788.412405565745, 17024.319027238773, 849.9107593702696, 856.8671855862351, 876.6230520875957, 878.433410450256, 906.3202598051462, 9124.361294709306, 9388.812223755487, 9690.56392462341, 9701.514924253901, 9721.125098741148, 369869.0, 372956.0, 375717.0, 384604.46186613885, 384715.0, 71954.28045719476, 74075.0, 75795.0, 76226.23773762191, 76500.0, 873.6760217820694, 881.3654168998311, 902.7066203483894, 904.2675432899373, 904.452806052342, 11384.715382115513, 16090.919545402197, 16491.887071623623, 16507.66984660276, 16744.49766506958, 37025.629743702215, 37240.25519489649, 37569.62430375661, 37663.81168094142, 38035.0, 47427.525724742314, 47566.28650570314, 47587.762061189474, 47734.0, 47789.52210477851, 7656.234376562299, 7658.042744656918, 7741.264579864904, 7802.0, 8120.269175774209, 8933.508657023925, 11608.477618507019, 11675.591354302558, 11692.0, 11708.180427370002, 9216.447013178962, 9855.605775768889, 9982.550785214828, 10294.639687610897, 11079.390633515233, 10617.946910265708, 10623.628173013907, 10687.061058209054, 10915.836262456229, 10947.616833410792, 10348.327358721659, 10649.0, 10828.0, 10926.50830712604, 11436.085113190758, 7718.807029824299, 7799.766007019798, 7811.843763124819, 8077.474964127313, 8100.379924015103, 8158.4289099762445, 10451.843222351823, 10611.787764244518, 10828.296160749525, 10927.45362731876], "value": 8791.504486085862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.870212978702, 1333.4066340478485, 1378.6966867289193, 1655.470249520154, 1665.8417450342213, 6880.0, 7123.145222573298, 7429.219931907146, 8027.598620068995, 8037.8392432151395, 7338.486305958585, 7608.847823043536, 7656.885146722803, 7884.448088633798, 7887.408444366681, 2105.49468127649, 2124.798144176301, 2135.6155891939443, 2135.7010018597407, 2135.8398120140973, 1709.734991076385, 2108.4939614492564, 2138.850280480367, 2140.882251476168, 2147.9248226312084, 1677.2033284190034, 2033.3899830050925, 2100.2754049852774, 2115.6509175985943, 2130.6910497977783, 2056.5269987902716, 2062.7318448601736, 2064.948376290597, 2066.442060643633, 2074.3051077889, 2060.2994981706142, 2060.9381718548466, 2061.5773766377856, 2064.865783724068, 2064.989675051615, 7792.181820908836, 7948.602569871541, 7949.841003179904, 7958.363330933512, 7959.522428654299, 4427.46870375557, 4575.267957126844, 4576.496585375606, 4578.130155270488, 4582.221022426163, 2600.3239157819103, 2814.4652516022097, 2816.3240822202524, 2818.0841226601437, 2826.025021367625, 842.6839935024366, 885.2608072259671, 900.6937641202023, 900.9909900900973, 908.4594666173682, 10796.67609971702, 10835.295705779099, 10877.347359158475, 10878.292910960841, 10883.292585981886, 3758.379867321861, 3919.6080391960577, 4056.675465962775, 4089.9386509202386, 4102.2821006323775, 9153.038930912291, 9170.724878253663, 9170.95414522923, 9179.58691858868, 9184.173424391836, 4530.501644819067, 4532.342810292489, 4545.409096817392, 4550.317452382169, 4555.430571178603, 4122.711410201257, 4182.623563879265, 4195.91608167835, 4197.097624010791, 4198.055437526593, 3322.1528510229737, 3363.545921300642, 3390.3727810355163, 3427.2802711430877, 3430.2624935638955, 1021.933574317667, 1112.3770688414513, 1131.2872890079198, 1152.5793085523892, 1159.6984783956232, 676.9458443324522, 793.3375631347889, 831.2228066757601, 831.9584020798936, 835.4026870787416, 4978.6763860348965, 4989.501049894981, 5170.121079416508, 5170.3278573785165, 5247.737613119329, 871.6774793326383, 875.5228400521731, 905.3345790843724, 945.522511131874, 961.240619910277, 3368.528406023159, 3452.085197422685, 3466.791992480459, 3512.1921957949303, 3568.7680300780366, 9424.528773561295, 9574.0, 9680.419174849532, 9681.806363872824, 9705.951470242604, 9559.856602150974, 9564.713058608113, 9566.378185417925, 9567.138957493858, 9570.760730981781, 6664.266930637626, 6949.82625434358, 6952.721891124298, 7086.433085353159, 7092.5389849659605, 5083.593312534915, 5175.896482070262, 5239.764210610608, 5240.764165612481, 5263.947360526346, 8286.70996515119, 8532.530710810965, 8594.226519613265, 8607.311415086653, 8642.141939483041, 8513.106123857153, 8776.736697898818, 8814.60334284946, 8862.601182946653, 8881.822363552821, 6807.353301436356, 6884.345987131214, 6921.688524016331, 6956.826079348057, 6970.372666460043, 7409.296116868889, 7538.3215510604305, 7543.47195696296, 7553.886691699519, 7561.886571701319, 6490.253620833664, 6780.220274668279, 6843.8973415399805, 6918.584884906922, 7068.71725130989, 6753.932460675331, 6780.593164410151, 6857.382835544825, 6977.79066628002, 6996.650167491707, 6377.0, 6441.259255185526, 6444.162258906312, 6450.258220304725, 6456.386643268882, 4350.630196433339, 4513.932291015703, 4577.153226653079, 4591.104734576726, 4618.422697162855, 4454.086912183059, 4568.725876447424, 4620.94368006234, 4652.767361631837, 4760.285957106462], "value": 4063.916089836306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.3964674184213, 295.27068141690023, 298.4285094044904, 306.1321154526916, 308.74374269356434, 4781.0, 4807.591354734847, 4835.564799168074, 4841.644339584913, 4848.660593758438, 4782.7608619569055, 4784.282357646355, 4799.5680388765, 4803.447603525596, 4817.807287708488, 3550.6981906537912, 3647.781133132007, 3661.1945372018113, 3718.869839555616, 3768.981155094221, 3731.9440208396895, 3741.30785804627, 3757.28611563802, 3760.9435858462143, 3764.5294338207723, 3705.666490015898, 3711.109333759892, 3714.1086139326503, 3714.349988751971, 3716.9256614867822, 3550.7336949728747, 3602.621724718893, 3666.926661466782, 3743.1765011697385, 3752.1182522107283, 3295.785773924711, 3304.7025767680784, 3313.155145437922, 3326.916827079318, 3329.1510664780567, 4629.58797566742, 4640.814367425299, 4651.093036857814, 4668.5564871337165, 4693.6949098308505, 4163.792500174945, 4252.532221455637, 4269.551697071794, 4271.974726065753, 4274.786260686984, 4975.950240497585, 4989.201727723546, 4997.85006449807, 5005.124103281911, 5007.624428167902, 3612.5123108380294, 3614.259076889258, 3617.8293024185277, 3625.274945011008, 3627.5308500057254, 4977.950220497821, 5253.842384728464, 5258.290130832365, 5259.2899958505495, 5260.473952604747, 3573.857045718142, 3613.9638603614153, 3616.6744992950235, 3630.3283892479976, 3638.3632864248652, 3674.706023518112, 3681.8711345102793, 3682.3187710273687, 3686.4654625079215, 3686.7972261525338, 4230.0, 4231.703780735319, 4240.1307731914885, 4242.61816436516, 4246.214450326699, 4792.688475249098, 5017.0, 5059.544640982329, 5061.6962982221185, 5075.720835354091, 1278.8849003589721, 1290.2774446310095, 1290.664427248922, 1291.7792685911722, 1293.6636474516692, 796.4862663581957, 820.7660816667221, 829.4442723375353, 829.4815740162398, 838.304207507767, 4326.783660816946, 4437.933430998538, 4441.311596702516, 4442.666799990014, 4444.6666500012625, 5097.317885097908, 5197.24639927216, 5204.635675502678, 5212.609054320941, 5212.696825793551, 4481.0, 4533.9319910201375, 4539.5460453955, 4540.318952157203, 4542.3413605027745, 2627.090751324006, 2734.9589756153673, 2735.7811375089946, 2741.752502611347, 2755.3524921643398, 4853.174960256765, 4856.975715121402, 4870.683405578626, 4883.536064073907, 4890.951090489049, 5033.47148549397, 5284.286621306074, 5302.681839089667, 5308.46915308466, 5324.520793128637, 4777.593904518155, 4787.4494433139935, 4801.399825021803, 4810.776779557705, 4842.7336496493035, 5109.872253193551, 5111.46329635383, 5125.410577783603, 5140.794368225229, 5142.537171654569, 4855.320255164209, 5047.6214283929585, 5057.282897070577, 5068.923966140437, 5079.92380114306, 4794.760261986817, 4794.897173650011, 4816.133096042746, 4816.410584507034, 4833.178359678934, 3566.8038257896064, 3567.5362202913457, 3570.7143428526174, 3574.7140228781113, 3582.874599389009, 5084.805070808283, 5117.744112794271, 5124.7950081996305, 5130.871208334161, 5140.254663073908, 4787.066522028171, 5028.798848046184, 5035.697858128524, 5060.1903695408555, 5071.721055341992, 5015.147424937696, 5032.094223039888, 5043.747812609428, 5044.722540260321, 5068.26510156018, 4839.790052486878, 4989.276554899447, 4997.025580011863, 4998.1503144464805, 5001.449840517613, 4854.344663470386, 4982.302477653059, 5080.009398167322, 5082.288479612931, 5104.566111880532, 4837.564619184291, 4997.125503037027, 5002.524760147926, 5005.749712514287, 5009.499050094962], "value": 3775.0098847994773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.9004959206528, 649.1755470552398, 671.8891382921821, 709.6948312225741, 712.5688958180299, 13174.934125329371, 13863.93068034661, 13911.44354225831, 13912.304384780746, 13938.0, 13166.407511661975, 13347.866521334809, 13370.59888203353, 13397.330133493335, 13406.59780206593, 618.6937465954359, 633.1326083265932, 743.9888401673979, 749.24700675821, 771.3983093187322, 774.2025713515088, 776.1966364812421, 776.7553220735479, 777.0558771093121, 777.2577188784697, 826.8801023851538, 828.2380210206594, 828.6519661742053, 829.3489610655637, 829.7178959153887, 660.1582981698349, 675.5811396933883, 676.137924146712, 677.9796606101776, 824.1099612418574, 496.1936852614501, 576.9826905192851, 583.3787016827066, 588.9146073819315, 592.3691268798716, 12768.0, 12775.552855650008, 12785.552505662257, 12795.104342696015, 12805.039622028293, 11549.711257218552, 11904.642860714192, 12334.691632709164, 12619.116661833676, 13064.085514014023, 9774.755631109208, 9798.363106398061, 10000.849987250198, 10364.32631878933, 10946.890531094747, 3763.266163098197, 3767.566729826078, 3819.4461803038403, 3898.8245528950983, 3909.139989202371, 63564.0, 63929.36070639327, 64942.0, 64964.0, 65056.0, 9376.812463750686, 9412.15290623847, 9532.094451027142, 9535.952320238355, 9599.568019439143, 18368.908155459405, 18427.355042573712, 18438.35465758692, 18523.35168269104, 18900.905495472434, 6508.837279068061, 6635.203775546869, 6645.568038077509, 6670.733170673118, 6819.971571069826, 3441.6558344165883, 3447.8620855165514, 3462.1344663834043, 3557.128503516655, 3612.0066981580276, 2830.3914658348554, 2935.6036935013926, 2936.3246453315855, 2947.292649764041, 3332.7833690810503, 559.0356634804929, 565.2171742137169, 569.0, 572.2817863581262, 579.739117397173, 520.786477544205, 527.1354977836352, 593.7061154728351, 603.4960807725598, 604.4499505450019, 7943.24539168778, 8173.427860049739, 8309.6676132954, 8377.748667539983, 8387.077421483631, 567.5998421113105, 588.0649766870696, 590.7577893063823, 599.3946114424463, 605.9363766804511, 4247.97876010618, 4450.154470650566, 4533.410656614685, 4560.566746159109, 4583.449986001701, 75479.0, 96461.0, 97900.0, 99705.0, 102434.48782756038, 60089.982003599456, 86228.0, 88590.0, 88753.0, 88985.0, 44950.77524612356, 54492.45507544953, 75086.0, 76901.0, 77572.61213693896, 8731.650733970824, 9063.864042039242, 9064.365494415328, 9148.908510915071, 9150.908490915006, 31083.78324335097, 36423.453648194765, 43393.56606433895, 43462.0, 44614.77692611516, 65963.34036659572, 66154.0, 66867.66566167137, 67554.66222668855, 68811.0, 10912.78174436491, 11003.119750420108, 11153.163512736415, 11563.132765042823, 11823.349715765715, 12364.381780910739, 12687.365631718192, 12700.491980321054, 13104.672383190496, 13129.409176586885, 9840.071520810456, 11843.46704398287, 11902.523899044287, 12766.808497872353, 12785.744285114431, 11463.713407164887, 11610.76778464443, 11691.766164676488, 12031.15781895259, 12421.75156496847, 11712.063034957353, 11744.882551174378, 11819.409029548317, 12217.389130543615, 12221.633350999484, 9698.660546880825, 9774.413535187912, 10461.26771126014, 10778.191635627203, 10954.39750813681, 9034.367594268339, 9179.357444978787, 9274.526989220114, 10175.49122543855, 10286.537105830106], "value": 6539.479867505735, "unit": "score"}], "name": "dromaeo_css", "value": 6336.285903717934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 126.0, 164.0, 131.0, 128.0, 127.0, 129.0, 163.0, 128.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 164.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 107.0, 77.0, 77.0, 76.0, 76.0, 97.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 124.0, 83.0, 85.0, 84.0, 111.0, 83.0, 83.0, 114.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 118.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 149.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 63.0, 65.0, 66.0, 65.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 83.0, 93.0, 83.0, 84.0, 92.0, 83.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 144.0, 139.0, 143.0, 159.0, 139.0, 138.0, 177.0, 149.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 177.0, 179.0, 177.0, 186.0, 177.0, 183.0, 177.0, 179.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 71.0, 71.0, 72.0, 73.0, 70.0, 70.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1560.6999999999998, "alertThreshold": 2.0}]} 04:41:50 INFO - Return code: 0 04:41:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:50 INFO - # TBPL SUCCESS # 04:41:50 INFO - Running post-action listener: _resource_record_post_action 04:41:50 INFO - [mozharness: 2016-10-04 11:41:50.412235Z] Finished run-tests step (success) 04:41:50 INFO - Running post-run listener: _resource_record_post_run 04:41:50 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 16384; Write bytes: 399536128; Read time: 212; Write time: 251940 04:41:50 INFO - TinderboxPrint: CPU usage
13.0% 04:41:50 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 212 04:41:50 INFO - TinderboxPrint: I/O write bytes / time
399,536,128 / 251,940 04:41:50 INFO - TinderboxPrint: CPU idle
8,341.3 (87.0%) 04:41:50 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 04:41:50 INFO - TinderboxPrint: Swap in / out
0 / 0 04:41:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106536960; Read time: 0; Write time: 73512 04:41:50 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292999168; Read time: 200; Write time: 178428 04:41:51 INFO - Running post-run listener: _upload_blobber_files 04:41:51 INFO - Blob upload gear active. 04:41:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:51 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 04:41:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:41:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:52 INFO - (blobuploader) - INFO - Done attempting. 04:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:53 INFO - (blobuploader) - INFO - Done attempting. 04:41:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:57 INFO - (blobuploader) - INFO - Done attempting. 04:41:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:57 INFO - Return code: 0 04:41:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9dde7d2f91cba1dcabf0a054d2ab214f6c8da958f39e627d9b3296f3300c79552e815abd9433e49cfe492572fbf204e76288f86714b5ae95f17131f74115edeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12d9413aadb254a5544dd79af270cf32aac1adaca3d29d534bb0b9ff3d9742e5ec918245b81c667951ba6bfe99cab661a2252824033fc84ca42c10b32e63bfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78af0e90a7f0050596bbd1b97e4719046d1fb7bfdb097c23fb1366a5a2807d4e4ad05cd6755d239b11c5e1772a36aa3d95c359335d4b38c70e828e8fe1d647b3"} 04:41:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:57 INFO - Contents: 04:41:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9dde7d2f91cba1dcabf0a054d2ab214f6c8da958f39e627d9b3296f3300c79552e815abd9433e49cfe492572fbf204e76288f86714b5ae95f17131f74115edeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12d9413aadb254a5544dd79af270cf32aac1adaca3d29d534bb0b9ff3d9742e5ec918245b81c667951ba6bfe99cab661a2252824033fc84ca42c10b32e63bfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78af0e90a7f0050596bbd1b97e4719046d1fb7bfdb097c23fb1366a5a2807d4e4ad05cd6755d239b11c5e1772a36aa3d95c359335d4b38c70e828e8fe1d647b3"} 04:41:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:57 INFO - Copying logs to upload dir... 04:41:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.815834 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 04:41:57.209853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:41:57.213101) ========= 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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 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-Non-PGO/sha512/9dde7d2f91cba1dcabf0a054d2ab214f6c8da958f39e627d9b3296f3300c79552e815abd9433e49cfe492572fbf204e76288f86714b5ae95f17131f74115edeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12d9413aadb254a5544dd79af270cf32aac1adaca3d29d534bb0b9ff3d9742e5ec918245b81c667951ba6bfe99cab661a2252824033fc84ca42c10b32e63bfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78af0e90a7f0050596bbd1b97e4719046d1fb7bfdb097c23fb1366a5a2807d4e4ad05cd6755d239b11c5e1772a36aa3d95c359335d4b38c70e828e8fe1d647b3"} build_url:https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/a5lc0GiIRfK-R_7yclRM-A/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-Non-PGO/sha512/9dde7d2f91cba1dcabf0a054d2ab214f6c8da958f39e627d9b3296f3300c79552e815abd9433e49cfe492572fbf204e76288f86714b5ae95f17131f74115edeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12d9413aadb254a5544dd79af270cf32aac1adaca3d29d534bb0b9ff3d9742e5ec918245b81c667951ba6bfe99cab661a2252824033fc84ca42c10b32e63bfff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78af0e90a7f0050596bbd1b97e4719046d1fb7bfdb097c23fb1366a5a2807d4e4ad05cd6755d239b11c5e1772a36aa3d95c359335d4b38c70e828e8fe1d647b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:41:57.241949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:41:57.242722) ========= 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=62c568580acbfdaac3eec7be000001dc-1475580069.213999-707548264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:41:57.324944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:41:57.325299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:41:57.325620) ========= ========= Total master_lag: 0.18 =========