builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1477631829.13 results: success (0) buildid: 20161027204059 builduid: 2f3236c65ebc4b2c9e1688325cc65b49 revision: 71536044069576fc877bf7ef0ba13a4ada793706 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.134244) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.134741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.135020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.149675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.149993) ========= 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-1477631828.699976-852342624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 22:17: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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-27 22:17:09 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.281203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.281548) ========= 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-1477631828.699976-852342624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:09.331358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 22:17:09.331741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 71536044069576fc877bf7ef0ba13a4ada793706 --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 71536044069576fc877bf7ef0ba13a4ada793706 --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-1477631828.699976-852342624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 22:17:09,673 truncating revision to first 12 chars 2016-10-27 22:17:09,673 Setting DEBUG logging. 2016-10-27 22:17:09,673 attempt 1/10 2016-10-27 22:17:09,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/715360440695?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 22:17:10,459 unpacking tar archive at: fx-team-715360440695/testing/mozharness/ program finished with exit code 0 elapsedTime=1.118232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 22:17:10.463590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:10.463924) ========= script_repo_revision: 71536044069576fc877bf7ef0ba13a4ada793706 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:10.464321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:10.464608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 22:17:10.473263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-27 22:17:10.473585) ========= /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-1477631828.699976-852342624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:17:10 INFO - MultiFileLogger online at 20161027 22:17:10 in /builds/slave/test 22:17: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 22:17:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:17:10 INFO - {'append_to_log': False, 22:17:10 INFO - 'base_work_dir': '/builds/slave/test', 22:17:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:17:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:17:10 INFO - 'branch': 'Fx-Team-Non-PGO', 22:17:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:17:10 INFO - 'config_files': ('talos/linux_config.py',), 22:17:10 INFO - 'default_actions': ('clobber', 22:17:10 INFO - 'read-buildbot-config', 22:17:10 INFO - 'download-and-extract', 22:17:10 INFO - 'populate-webroot', 22:17:10 INFO - 'create-virtualenv', 22:17:10 INFO - 'install', 22:17:10 INFO - 'run-tests'), 22:17:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:17:10 INFO - 'download_minidump_stackwalk': True, 22:17:10 INFO - 'download_symbols': 'ondemand', 22:17:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:17:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:17:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:17:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:17:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:17:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:17:10 INFO - 'installer_path': 'installer.exe', 22:17:10 INFO - 'log_level': 'info', 22:17:10 INFO - 'log_name': 'talos', 22:17:10 INFO - 'log_to_console': True, 22:17:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:17:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:17:10 INFO - 'opt_config_files': (), 22:17:10 INFO - 'pip_index': False, 22:17:10 INFO - 'sps_profile': False, 22:17:10 INFO - 'sps_profile_interval': 0, 22:17:10 INFO - 'suite': 'dromaeojs', 22:17:10 INFO - 'system_bits': '32', 22:17:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:17:10 INFO - 'title': 'talos-linux64-ix-018', 22:17:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:17:10 INFO - 'use_talos_json': True, 22:17:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:17:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:17:10 INFO - 'work_dir': 'build'} 22:17:10 INFO - [mozharness: 2016-10-28 05:17:10.914951Z] Running clobber step. 22:17:10 INFO - Running pre-action listener: _resource_record_pre_action 22:17:10 INFO - Running main action method: clobber 22:17:10 INFO - rmtree: /builds/slave/test/build 22:17:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:17:11 INFO - Running post-action listener: _resource_record_post_action 22:17:11 INFO - [mozharness: 2016-10-28 05:17:11.374078Z] Finished clobber step (success) 22:17:11 INFO - [mozharness: 2016-10-28 05:17:11.374177Z] Running read-buildbot-config step. 22:17:11 INFO - Running pre-action listener: _resource_record_pre_action 22:17:11 INFO - Running main action method: read_buildbot_config 22:17:11 INFO - Using buildbot properties: 22:17:11 INFO - { 22:17:11 INFO - "project": "", 22:17:11 INFO - "product": "firefox", 22:17:11 INFO - "script_repo_revision": "production", 22:17:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:17:11 INFO - "repository": "", 22:17:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:17:11 INFO - "buildid": "20161027204059", 22:17:11 INFO - "pgo_build": "False", 22:17:11 INFO - "basedir": "/builds/slave/test", 22:17:11 INFO - "buildnumber": 1989, 22:17:11 INFO - "slavename": "talos-linux64-ix-018", 22:17:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:17:11 INFO - "platform": "ubuntu64_hw", 22:17:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:17:11 INFO - "branch": "fx-team", 22:17:11 INFO - "repo_path": "integration/fx-team", 22:17:11 INFO - "revision": "71536044069576fc877bf7ef0ba13a4ada793706", 22:17:11 INFO - "stage_platform": "linux64", 22:17:11 INFO - "builduid": "2f3236c65ebc4b2c9e1688325cc65b49", 22:17:11 INFO - "slavebuilddir": "test" 22:17:11 INFO - } 22:17:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:17:11 INFO - Running post-action listener: _resource_record_post_action 22:17:11 INFO - [mozharness: 2016-10-28 05:17:11.376587Z] Finished read-buildbot-config step (success) 22:17:11 INFO - [mozharness: 2016-10-28 05:17:11.376675Z] Running download-and-extract step. 22:17:11 INFO - Running pre-action listener: _resource_record_pre_action 22:17:11 INFO - Running main action method: download_and_extract 22:17:11 INFO - mkdir: /builds/slave/test/build/tests 22:17: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')]} 22:17:11 INFO - trying https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:17:11 INFO - Downloading https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/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 22:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/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 22:17:11 INFO - Downloaded 1361 bytes. 22:17:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:17:11 INFO - Using the following test package requirements: 22:17:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:17:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:17:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:17:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'jsshell-linux-x86_64.zip'], 22:17:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:17:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:17:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:17:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:17:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:17:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:17:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:17:12 INFO - Http code: 200 22:17:12 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 22:17:12 INFO - x-amz-cf-id: BZo6Yy1srGWlio_8fnmZe9mviyFJgrZWv_LTJ43PPsr1dGdLpCn24A== 22:17:12 INFO - x-amz-version-id: pgaNDneAQhtFd2H6Dz657CGN0TQnR5VO 22:17:12 INFO - Expected file size: 20424853 22:17:12 INFO - Obtained file size: 20424853 22:17:16 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 22:17:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:17:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:17:16 INFO - Fetch https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:17:17 INFO - Http code: 200 22:17:17 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 22:17:17 INFO - x-amz-cf-id: Qe0RcOYY-qHpj4zAN81xSKhN-u4nc4-GwsLTWF_Khgi7BtUOILVE4g== 22:17:17 INFO - x-amz-version-id: pgaNDneAQhtFd2H6Dz657CGN0TQnR5VO 22:17:17 INFO - Expected file size: 20424853 22:17:17 INFO - Obtained file size: 20424853 22:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:17:22 INFO - Http code: 200 22:17:22 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:17:22 INFO - x-amz-cf-id: SZRuMSXdFIlDe28BWSykLFQF7IH9YoCOTUHGZFlc2K1uAwaKS0Yicw== 22:17:22 INFO - x-amz-version-id: v6qU7Kd.OUdRCGIGNeSeA_Bbw_Rgzeiy 22:17:22 INFO - Expected file size: 14409028 22:17:22 INFO - Obtained file size: 14409028 22:17:22 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')]} 22:17:22 INFO - trying https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:17:22 INFO - Downloading https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/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 22:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/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 22:17:24 INFO - Downloaded 55464008 bytes. 22:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:17:24 INFO - mkdir: /builds/slave/test/properties 22:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 22:17:24 INFO - Contents: 22:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:17:24 INFO - Running post-action listener: _resource_record_post_action 22:17:24 INFO - Running post-action listener: set_extra_try_arguments 22:17:24 INFO - [mozharness: 2016-10-28 05:17:24.758470Z] Finished download-and-extract step (success) 22:17:24 INFO - [mozharness: 2016-10-28 05:17:24.758696Z] Running populate-webroot step. 22:17:24 INFO - Running pre-action listener: _resource_record_pre_action 22:17:24 INFO - Running main action method: populate_webroot 22:17:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:17:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:17:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:17:24 INFO - '--tppagecycles', 22:17:24 INFO - '7'], 22:17:24 INFO - 'tests': ['tsvgm']}}, 22:17:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:17:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:17:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:17:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:17:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:17:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:17:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['damp', 'tps']}, 22:17:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'tests': ['damp', 'tps']}, 22:17:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['dromaeo_dom']}, 22:17:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:17:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['basic_compositor_video']}, 22:17:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:17:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'other-e10s': {'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['a11yr', 22:17:24 INFO - 'ts_paint', 22:17:24 INFO - 'tpaint', 22:17:24 INFO - 'sessionrestore', 22:17:24 INFO - 'sessionrestore_no_auto_restore', 22:17:24 INFO - 'tabpaint']}, 22:17:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['tsvgx', 22:17:24 INFO - 'tsvgr_opacity', 22:17:24 INFO - 'tart', 22:17:24 INFO - 'tscrollx', 22:17:24 INFO - 'cart']}, 22:17:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:17:24 INFO - 'tsvgr_opacity', 22:17:24 INFO - 'tart', 22:17:24 INFO - 'tscrollx', 22:17:24 INFO - 'cart']}, 22:17:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'talos_options': ['--disable-e10s'], 22:17:24 INFO - 'tests': ['tp5o']}, 22:17:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'tests': ['tp5o']}, 22:17:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'talos_options': ['--disable-e10s', 22:17:24 INFO - '--xperf_path', 22:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:17:24 INFO - 'tests': ['tp5n']}, 22:17:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:24 INFO - 'talos_options': ['--xperf_path', 22:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:17:24 INFO - 'tests': ['tp5n']}}, 22:17:24 INFO - 'talos.zip': {'path': '', 22:17:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:17:24 INFO - Running post-action listener: _resource_record_post_action 22:17:24 INFO - [mozharness: 2016-10-28 05:17:24.778304Z] Finished populate-webroot step (success) 22:17:24 INFO - [mozharness: 2016-10-28 05:17:24.778392Z] Running create-virtualenv step. 22:17:24 INFO - Running pre-action listener: _resource_record_pre_action 22:17:24 INFO - Running main action method: create_virtualenv 22:17:24 INFO - Creating virtualenv /builds/slave/test/build/venv 22:17:24 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 22:17:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:17:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:17:24 INFO - Using real prefix '/usr' 22:17:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 22:17:27 INFO - Installing pip.................done. 22:17:27 INFO - Return code: 0 22:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:17:27 INFO - Reading from file tmpfile_stdout 22:17:27 INFO - Output received: 22:17:27 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) 22:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:17:27 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')]} 22:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:27 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')]} 22:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:27 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:27 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 22:17:27 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 22:17:27 INFO - Using env: {'DISPLAY': ':0', 22:17:27 INFO - 'HOME': '/home/cltbld', 22:17:27 INFO - 'LANG': 'en_US.UTF-8', 22:17:27 INFO - 'LANGUAGE': 'en_US:en', 22:17:27 INFO - 'LOGNAME': 'cltbld', 22:17:27 INFO - 'MAIL': '/var/mail/cltbld', 22:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:27 INFO - 'MOZ_NO_REMOTE': '1', 22:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:27 INFO - 'NO_EM_RESTART': '1', 22:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:27 INFO - 'PWD': '/builds/slave/test', 22:17:27 INFO - 'SHELL': '/bin/bash', 22:17:27 INFO - 'SHLVL': '1', 22:17:27 INFO - 'TERM': 'linux', 22:17:27 INFO - 'TMOUT': '86400', 22:17:27 INFO - 'USER': 'cltbld', 22:17:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:27 INFO - '_': '/tools/buildbot/bin/python'} 22:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:27 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 22:17:27 INFO - Cleaning up... 22:17:27 INFO - Return code: 0 22:17:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:17:27 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')]} 22:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:27 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')]} 22:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:27 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:27 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 22:17:27 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 22:17:27 INFO - Using env: {'DISPLAY': ':0', 22:17:27 INFO - 'HOME': '/home/cltbld', 22:17:27 INFO - 'LANG': 'en_US.UTF-8', 22:17:27 INFO - 'LANGUAGE': 'en_US:en', 22:17:27 INFO - 'LOGNAME': 'cltbld', 22:17:27 INFO - 'MAIL': '/var/mail/cltbld', 22:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:27 INFO - 'MOZ_NO_REMOTE': '1', 22:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:27 INFO - 'NO_EM_RESTART': '1', 22:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:27 INFO - 'PWD': '/builds/slave/test', 22:17:27 INFO - 'SHELL': '/bin/bash', 22:17:27 INFO - 'SHLVL': '1', 22:17:27 INFO - 'TERM': 'linux', 22:17:27 INFO - 'TMOUT': '86400', 22:17:27 INFO - 'USER': 'cltbld', 22:17:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:27 INFO - '_': '/tools/buildbot/bin/python'} 22:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:27 INFO - Downloading/unpacking psutil>=3.1.1 22:17:27 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 22:17:27 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 22:17:27 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 22:17:27 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 22:17:27 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 22:17:27 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 22:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:30 INFO - Installing collected packages: psutil 22:17:30 INFO - Running setup.py install for psutil 22:17:30 INFO - building 'psutil._psutil_linux' extension 22:17:30 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 22:17:30 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 22:17:30 INFO - building 'psutil._psutil_posix' extension 22:17:30 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 22:17:30 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 22:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:30 INFO - Successfully installed psutil 22:17:30 INFO - Cleaning up... 22:17:30 INFO - Return code: 0 22:17:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:17:30 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')]} 22:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:30 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')]} 22:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:30 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:30 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 22:17:30 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 22:17:30 INFO - Using env: {'DISPLAY': ':0', 22:17:30 INFO - 'HOME': '/home/cltbld', 22:17:30 INFO - 'LANG': 'en_US.UTF-8', 22:17:30 INFO - 'LANGUAGE': 'en_US:en', 22:17:30 INFO - 'LOGNAME': 'cltbld', 22:17:30 INFO - 'MAIL': '/var/mail/cltbld', 22:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:30 INFO - 'MOZ_NO_REMOTE': '1', 22:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:30 INFO - 'NO_EM_RESTART': '1', 22:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:30 INFO - 'PWD': '/builds/slave/test', 22:17:30 INFO - 'SHELL': '/bin/bash', 22:17:30 INFO - 'SHLVL': '1', 22:17:30 INFO - 'TERM': 'linux', 22:17:30 INFO - 'TMOUT': '86400', 22:17:30 INFO - 'USER': 'cltbld', 22:17:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:30 INFO - '_': '/tools/buildbot/bin/python'} 22:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:17:30 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 22:17:30 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 22:17:30 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 22:17:30 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 22:17:30 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 22:17:30 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 22:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:17:32 INFO - Installing collected packages: mozsystemmonitor 22:17:32 INFO - Running setup.py install for mozsystemmonitor 22:17:32 INFO - Successfully installed mozsystemmonitor 22:17:32 INFO - Cleaning up... 22:17:32 INFO - Return code: 0 22:17:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:32 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:32 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 22:17:32 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 22:17:32 INFO - Using env: {'DISPLAY': ':0', 22:17:32 INFO - 'HOME': '/home/cltbld', 22:17:32 INFO - 'LANG': 'en_US.UTF-8', 22:17:32 INFO - 'LANGUAGE': 'en_US:en', 22:17:32 INFO - 'LOGNAME': 'cltbld', 22:17:32 INFO - 'MAIL': '/var/mail/cltbld', 22:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:32 INFO - 'MOZ_NO_REMOTE': '1', 22:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:32 INFO - 'NO_EM_RESTART': '1', 22:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:32 INFO - 'PWD': '/builds/slave/test', 22:17:32 INFO - 'SHELL': '/bin/bash', 22:17:32 INFO - 'SHLVL': '1', 22:17:32 INFO - 'TERM': 'linux', 22:17:32 INFO - 'TMOUT': '86400', 22:17:32 INFO - 'USER': 'cltbld', 22:17:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:32 INFO - '_': '/tools/buildbot/bin/python'} 22:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:33 INFO - Downloading/unpacking jsonschema==2.5.1 22:17:33 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 22:17:33 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 22:17:33 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 22:17:33 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 22:17:33 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 22:17:33 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 22:17:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:17:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:35 INFO - Downloading functools32-3.2.3-2.tar.gz 22:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:17:35 INFO - warning: no files found matching '*.txt' 22:17:35 INFO - no previously-included directories found matching 'build' 22:17:35 INFO - no previously-included directories found matching 'dist' 22:17:35 INFO - no previously-included directories found matching '.git*' 22:17:35 INFO - Installing collected packages: jsonschema, functools32 22:17:35 INFO - Running setup.py install for functools32 22:17:35 INFO - warning: no files found matching '*.txt' 22:17:35 INFO - no previously-included directories found matching 'build' 22:17:35 INFO - no previously-included directories found matching 'dist' 22:17:35 INFO - no previously-included directories found matching '.git*' 22:17:35 INFO - Successfully installed jsonschema functools32 22:17:35 INFO - Cleaning up... 22:17:35 INFO - Return code: 0 22:17:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:17:35 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')]} 22:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:35 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')]} 22:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:35 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:35 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 22:17:35 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 22:17:35 INFO - Using env: {'DISPLAY': ':0', 22:17:35 INFO - 'HOME': '/home/cltbld', 22:17:35 INFO - 'LANG': 'en_US.UTF-8', 22:17:35 INFO - 'LANGUAGE': 'en_US:en', 22:17:35 INFO - 'LOGNAME': 'cltbld', 22:17:35 INFO - 'MAIL': '/var/mail/cltbld', 22:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:35 INFO - 'MOZ_NO_REMOTE': '1', 22:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:35 INFO - 'NO_EM_RESTART': '1', 22:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:35 INFO - 'PWD': '/builds/slave/test', 22:17:35 INFO - 'SHELL': '/bin/bash', 22:17:35 INFO - 'SHLVL': '1', 22:17:35 INFO - 'TERM': 'linux', 22:17:35 INFO - 'TMOUT': '86400', 22:17:35 INFO - 'USER': 'cltbld', 22:17:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:35 INFO - '_': '/tools/buildbot/bin/python'} 22:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:17:35 INFO - Cleaning up... 22:17:35 INFO - Return code: 0 22:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:17:35 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')]} 22:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:35 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')]} 22:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:35 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:35 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 22:17:35 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 22:17:35 INFO - Using env: {'DISPLAY': ':0', 22:17:35 INFO - 'HOME': '/home/cltbld', 22:17:35 INFO - 'LANG': 'en_US.UTF-8', 22:17:35 INFO - 'LANGUAGE': 'en_US:en', 22:17:35 INFO - 'LOGNAME': 'cltbld', 22:17:35 INFO - 'MAIL': '/var/mail/cltbld', 22:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:35 INFO - 'MOZ_NO_REMOTE': '1', 22:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:35 INFO - 'NO_EM_RESTART': '1', 22:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:35 INFO - 'PWD': '/builds/slave/test', 22:17:35 INFO - 'SHELL': '/bin/bash', 22:17:35 INFO - 'SHLVL': '1', 22:17:35 INFO - 'TERM': 'linux', 22:17:35 INFO - 'TMOUT': '86400', 22:17:35 INFO - 'USER': 'cltbld', 22:17:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:35 INFO - '_': '/tools/buildbot/bin/python'} 22:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:36 INFO - Downloading/unpacking blobuploader==1.2.4 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:17:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:17:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:38 INFO - Downloading docopt-0.6.1.tar.gz 22:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:17:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:17:38 INFO - Running setup.py install for blobuploader 22:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:17:38 INFO - Running setup.py install for requests 22:17:39 INFO - Running setup.py install for docopt 22:17:39 INFO - Successfully installed blobuploader requests docopt 22:17:39 INFO - Cleaning up... 22:17:39 INFO - Return code: 0 22:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:39 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')]} 22:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:39 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')]} 22:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:39 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:39 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 22:17:39 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 22:17:39 INFO - Using env: {'DISPLAY': ':0', 22:17:39 INFO - 'HOME': '/home/cltbld', 22:17:39 INFO - 'LANG': 'en_US.UTF-8', 22:17:39 INFO - 'LANGUAGE': 'en_US:en', 22:17:39 INFO - 'LOGNAME': 'cltbld', 22:17:39 INFO - 'MAIL': '/var/mail/cltbld', 22:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:39 INFO - 'MOZ_NO_REMOTE': '1', 22:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:39 INFO - 'NO_EM_RESTART': '1', 22:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:39 INFO - 'PWD': '/builds/slave/test', 22:17:39 INFO - 'SHELL': '/bin/bash', 22:17:39 INFO - 'SHLVL': '1', 22:17:39 INFO - 'TERM': 'linux', 22:17:39 INFO - 'TMOUT': '86400', 22:17:39 INFO - 'USER': 'cltbld', 22:17:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:39 INFO - '_': '/tools/buildbot/bin/python'} 22:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:39 INFO - Running setup.py (path:/tmp/pip-5zy6DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:39 INFO - Running setup.py (path:/tmp/pip-KQlo5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:39 INFO - Running setup.py (path:/tmp/pip-GTtcr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:39 INFO - Running setup.py (path:/tmp/pip-mvn6EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:39 INFO - Running setup.py (path:/tmp/pip-Y3nVR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:39 INFO - Running setup.py (path:/tmp/pip-nw47JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:40 INFO - Running setup.py (path:/tmp/pip-fkds77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:40 INFO - Running setup.py (path:/tmp/pip-rg3AsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:40 INFO - Running setup.py (path:/tmp/pip-fpVpkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:40 INFO - Running setup.py (path:/tmp/pip-eFRr5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:40 INFO - Running setup.py (path:/tmp/pip-lGLK94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:40 INFO - Running setup.py (path:/tmp/pip-FLMHit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:40 INFO - Running setup.py (path:/tmp/pip-8ryzlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:40 INFO - Running setup.py (path:/tmp/pip-OOAfGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:40 INFO - Running setup.py (path:/tmp/pip-x6sF3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:40 INFO - Running setup.py (path:/tmp/pip-OZv_sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:40 INFO - Running setup.py (path:/tmp/pip-EEoHRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:17:40 INFO - Running setup.py install for manifestparser 22:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:17:40 INFO - Running setup.py install for mozcrash 22:17:41 INFO - Running setup.py install for mozdebug 22:17:41 INFO - Running setup.py install for mozdevice 22:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for mozfile 22:17:41 INFO - Running setup.py install for mozhttpd 22:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for mozinfo 22:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for mozInstall 22:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for mozleak 22:17:41 INFO - Running setup.py install for mozlog 22:17:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for moznetwork 22:17:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:17:41 INFO - Running setup.py install for mozprocess 22:17:42 INFO - Running setup.py install for mozprofile 22:17:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:17:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:17:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:17:42 INFO - Running setup.py install for mozrunner 22:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:17:42 INFO - Running setup.py install for mozscreenshot 22:17:42 INFO - Running setup.py install for moztest 22:17:42 INFO - Running setup.py install for mozversion 22:17:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:17:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:17:42 INFO - Cleaning up... 22:17:42 INFO - Return code: 0 22:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:42 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:42 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 22:17:42 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 22:17:42 INFO - Using env: {'DISPLAY': ':0', 22:17:42 INFO - 'HOME': '/home/cltbld', 22:17:42 INFO - 'LANG': 'en_US.UTF-8', 22:17:42 INFO - 'LANGUAGE': 'en_US:en', 22:17:42 INFO - 'LOGNAME': 'cltbld', 22:17:42 INFO - 'MAIL': '/var/mail/cltbld', 22:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:42 INFO - 'MOZ_NO_REMOTE': '1', 22:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:42 INFO - 'NO_EM_RESTART': '1', 22:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:42 INFO - 'PWD': '/builds/slave/test', 22:17:42 INFO - 'SHELL': '/bin/bash', 22:17:42 INFO - 'SHLVL': '1', 22:17:42 INFO - 'TERM': 'linux', 22:17:42 INFO - 'TMOUT': '86400', 22:17:42 INFO - 'USER': 'cltbld', 22:17:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:42 INFO - '_': '/tools/buildbot/bin/python'} 22:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:42 INFO - Running setup.py (path:/tmp/pip-ypI35K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:42 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)) 22:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:42 INFO - Running setup.py (path:/tmp/pip-hqrjq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17: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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:43 INFO - Running setup.py (path:/tmp/pip-sQ7rFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17: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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:43 INFO - Running setup.py (path:/tmp/pip-b7SDXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17: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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:43 INFO - Running setup.py (path:/tmp/pip-3AvQSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17: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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:43 INFO - Running setup.py (path:/tmp/pip-WJiKCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:43 INFO - Running setup.py (path:/tmp/pip-aThxTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:43 INFO - Running setup.py (path:/tmp/pip-CWHav8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:43 INFO - Running setup.py (path:/tmp/pip-6IytrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:43 INFO - Running setup.py (path:/tmp/pip-hYUDHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:43 INFO - Running setup.py (path:/tmp/pip-7qo0Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:43 INFO - Running setup.py (path:/tmp/pip-R6aBDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:43 INFO - Running setup.py (path:/tmp/pip-vptzup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:43 INFO - Running setup.py (path:/tmp/pip-nZlhNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:43 INFO - Running setup.py (path:/tmp/pip-N4Lwes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:43 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)) 22:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:44 INFO - Running setup.py (path:/tmp/pip-iWvEki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17: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)) 22:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:44 INFO - Running setup.py (path:/tmp/pip-F90t3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:46 INFO - Downloading blessings-1.6.tar.gz 22:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:17:46 INFO - Installing collected packages: blessings 22:17:46 INFO - Running setup.py install for blessings 22:17:46 INFO - Successfully installed blessings 22:17:46 INFO - Cleaning up... 22:17:46 INFO - Return code: 0 22:17:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:46 INFO - Reading from file tmpfile_stdout 22:17:46 INFO - Current package versions: 22:17:46 INFO - argparse == 1.2.1 22:17:46 INFO - blessings == 1.6 22:17:46 INFO - blobuploader == 1.2.4 22:17:46 INFO - docopt == 0.6.1 22:17:46 INFO - functools32 == 3.2.3-2 22:17:46 INFO - jsonschema == 2.5.1 22:17:46 INFO - manifestparser == 1.1 22:17:46 INFO - mozInstall == 1.12 22:17:46 INFO - mozcrash == 0.17 22:17:46 INFO - mozdebug == 0.1 22:17:46 INFO - mozdevice == 0.48 22:17:46 INFO - mozfile == 1.2 22:17:46 INFO - mozhttpd == 0.7 22:17:46 INFO - mozinfo == 0.9 22:17:46 INFO - mozleak == 0.1 22:17:46 INFO - mozlog == 3.4 22:17:46 INFO - moznetwork == 0.27 22:17:46 INFO - mozprocess == 0.23 22:17:46 INFO - mozprofile == 0.28 22:17:46 INFO - mozrunner == 6.12 22:17:46 INFO - mozscreenshot == 0.1 22:17:46 INFO - mozsystemmonitor == 0.3 22:17:46 INFO - moztest == 0.7 22:17:46 INFO - mozversion == 1.4 22:17:46 INFO - psutil == 3.1.1 22:17:46 INFO - requests == 1.2.3 22:17:46 INFO - wsgiref == 0.1.2 22:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:46 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')]} 22:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:46 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')]} 22:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:46 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:46 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 22:17:46 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 22:17:46 INFO - Using env: {'DISPLAY': ':0', 22:17:46 INFO - 'HOME': '/home/cltbld', 22:17:46 INFO - 'LANG': 'en_US.UTF-8', 22:17:46 INFO - 'LANGUAGE': 'en_US:en', 22:17:46 INFO - 'LOGNAME': 'cltbld', 22:17:46 INFO - 'MAIL': '/var/mail/cltbld', 22:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:46 INFO - 'MOZ_NO_REMOTE': '1', 22:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:46 INFO - 'NO_EM_RESTART': '1', 22:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:46 INFO - 'PWD': '/builds/slave/test', 22:17:46 INFO - 'SHELL': '/bin/bash', 22:17:46 INFO - 'SHLVL': '1', 22:17:46 INFO - 'TERM': 'linux', 22:17:46 INFO - 'TMOUT': '86400', 22:17:46 INFO - 'USER': 'cltbld', 22:17:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:46 INFO - '_': '/tools/buildbot/bin/python'} 22:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 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)) 22:17:46 INFO - Cleaning up... 22:17:46 INFO - Return code: 0 22:17:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:17:46 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')]} 22:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:46 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')]} 22:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:46 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 0x7ffd41174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, '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-1477631828.699976-852342624', '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 22:17:46 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 22:17:46 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 22:17:46 INFO - Using env: {'DISPLAY': ':0', 22:17:46 INFO - 'HOME': '/home/cltbld', 22:17:46 INFO - 'LANG': 'en_US.UTF-8', 22:17:46 INFO - 'LANGUAGE': 'en_US:en', 22:17:46 INFO - 'LOGNAME': 'cltbld', 22:17:46 INFO - 'MAIL': '/var/mail/cltbld', 22:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:46 INFO - 'MOZ_NO_REMOTE': '1', 22:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:46 INFO - 'NO_EM_RESTART': '1', 22:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:46 INFO - 'PWD': '/builds/slave/test', 22:17:46 INFO - 'SHELL': '/bin/bash', 22:17:46 INFO - 'SHLVL': '1', 22:17:46 INFO - 'TERM': 'linux', 22:17:46 INFO - 'TMOUT': '86400', 22:17:46 INFO - 'USER': 'cltbld', 22:17:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:46 INFO - '_': '/tools/buildbot/bin/python'} 22:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:17:47 INFO - Cleaning up... 22:17:47 INFO - Return code: 0 22:17:47 INFO - Running post-action listener: _resource_record_post_action 22:17:47 INFO - Running post-action listener: _start_resource_monitoring 22:17:47 INFO - Starting resource monitoring. 22:17:47 INFO - [mozharness: 2016-10-28 05:17:47.077109Z] Finished create-virtualenv step (success) 22:17:47 INFO - [mozharness: 2016-10-28 05:17:47.077574Z] Running install step. 22:17:47 INFO - Running pre-action listener: _resource_record_pre_action 22:17:47 INFO - Running main action method: install 22:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:47 INFO - Reading from file tmpfile_stdout 22:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 22:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:17:47 INFO - Reading from file tmpfile_stdout 22:17:47 INFO - Output received: 22:17:47 INFO - Usage: mozinstall [options] installer 22:17:47 INFO - Options: 22:17:47 INFO - -h, --help show this help message and exit 22:17:47 INFO - -d DEST, --destination=DEST 22:17:47 INFO - Directory to install application into. [default: 22:17:47 INFO - "/builds/slave/test"] 22:17:47 INFO - --app=APP Application being installed. [default: firefox] 22:17:47 INFO - mkdir: /builds/slave/test/build/application 22:17: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'] 22:17: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 22:18:03 INFO - Reading from file tmpfile_stdout 22:18:03 INFO - Output received: 22:18:03 INFO - /builds/slave/test/build/application/firefox/firefox 22:18:03 INFO - Running post-action listener: _resource_record_post_action 22:18:03 INFO - [mozharness: 2016-10-28 05:18:03.374671Z] Finished install step (success) 22:18:03 INFO - [mozharness: 2016-10-28 05:18:03.374914Z] Running run-tests step. 22:18:03 INFO - Running pre-action listener: _resource_record_pre_action 22:18:03 INFO - Running main action method: run_tests 22:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:18:03 INFO - Python 2.7.3 22:18:03 INFO - Return code: 0 22:18:03 INFO - grabbing minidump binary from tooltool 22:18:03 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')]} 22:18:03 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 0x1420f60>, '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 0x1421d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14221d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:18:03 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 22:18:03 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 22:18:03 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 22:18:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:18:03 INFO - Return code: 0 22:18:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:18:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:18:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:18:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:18:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:18:03 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/POSfLdVTT8CBgw0GlrSZlA/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 22:18:03 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/POSfLdVTT8CBgw0GlrSZlA/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 22:18:03 INFO - Using env: {'DISPLAY': ':0', 22:18:03 INFO - 'HOME': '/home/cltbld', 22:18:03 INFO - 'LANG': 'en_US.UTF-8', 22:18:03 INFO - 'LANGUAGE': 'en_US:en', 22:18:03 INFO - 'LOGNAME': 'cltbld', 22:18:03 INFO - 'MAIL': '/var/mail/cltbld', 22:18:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:18:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:03 INFO - 'MOZ_NO_REMOTE': '1', 22:18:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:03 INFO - 'NO_EM_RESTART': '1', 22:18:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:18:03 INFO - 'PWD': '/builds/slave/test', 22:18:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:18:03 INFO - 'SHELL': '/bin/bash', 22:18:03 INFO - 'SHLVL': '1', 22:18:03 INFO - 'TERM': 'linux', 22:18:03 INFO - 'TMOUT': '86400', 22:18:03 INFO - 'USER': 'cltbld', 22:18:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477631828.699976-852342624', 22:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:03 INFO - '_': '/tools/buildbot/bin/python'} 22:18:03 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/POSfLdVTT8CBgw0GlrSZlA/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 22:18:03 INFO - mozversion application_buildid: 20161027204059 22:18:03 INFO - mozversion application_changeset: 71536044069576fc877bf7ef0ba13a4ada793706 22:18:03 INFO - mozversion application_display_name: Nightly 22:18:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:18:03 INFO - mozversion application_name: Firefox 22:18:03 INFO - mozversion application_remotingname: firefox 22:18:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:18:03 INFO - mozversion application_vendor: Mozilla 22:18:03 INFO - mozversion application_version: 52.0a1 22:18:03 INFO - mozversion platform_buildid: 20161027204059 22:18:03 INFO - mozversion platform_changeset: 71536044069576fc877bf7ef0ba13a4ada793706 22:18:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:18:03 INFO - mozversion platform_version: 52.0a1 22:18:03 INFO - using testdate: 1477631883 22:18:03 INFO - actual date: 1477631883 22:18:03 INFO - starting webserver on 'localhost:58651' 22:18:03 INFO - SUITE-START | Running 2 tests 22:18:03 INFO - TEST-START | dromaeo_css 22:18:03 INFO - operating with platform_type : linux_ 22:18:03 INFO - Initialising browser for dromaeo_css test... 22:18:03 INFO - TEST-INFO | started process 8758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_JuXL/profile http://localhost:58651/getInfo.html) 22:18:07 INFO - PROCESS | 8758 | __metrics Screen width/height:1600/1200 22:18:07 INFO - PROCESS | 8758 | colorDepth:24 22:18:07 INFO - PROCESS | 8758 | Browser inner width/height: 1024/697 22:18:07 INFO - PROCESS | 8758 | __metrics 22:18:08 INFO - PROCESS | 8758 | 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" 22:18:08 INFO - PROCESS | 8758 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:18:09 INFO - PROCESS | 8758 | console.error: PushService: 22:18:09 INFO - PROCESS | 8758 | stateChangeProcessEnqueue: Error transitioning state 22:18:09 INFO - PROCESS | 8758 | UnknownError 22:18:09 INFO - TEST-INFO | 8758: exit 0 22:18:09 INFO - Browser initialized. 22:18:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:18:09 INFO - TEST-INFO | started process 8841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_JuXL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:21 INFO - PROCESS | 8841 | RSS: Main: 173625344 22:18:21 INFO - PROCESS | 8841 | 22:19:13 INFO - PROCESS | 8841 | 1477631953186 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] 22:21:26 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58651/tests/dromaeo/cssquery-ext.html) 22:21:28 INFO - PROCESS | 8841 | RSS: Main: 292986880 22:21:28 INFO - PROCESS | 8841 | 22:24:31 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-ext.html (next: http://localhost:58651/tests/dromaeo/cssquery-jquery.html) 22:24:31 INFO - PROCESS | 8841 | RSS: Main: 275652608 22:24:31 INFO - PROCESS | 8841 | 22:27:33 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58651/tests/dromaeo/cssquery-mootools.html) 22:27:34 INFO - PROCESS | 8841 | RSS: Main: 218988544 22:27:34 INFO - PROCESS | 8841 | 22:30:36 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58651/tests/dromaeo/cssquery-prototype.html) 22:30:37 INFO - PROCESS | 8841 | RSS: Main: 218312704 22:30:37 INFO - PROCESS | 8841 | 22:33:40 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58651/tests/dromaeo/cssquery-yui.html) 22:33:41 INFO - PROCESS | 8841 | RSS: Main: 218357760 22:33:41 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-yui.html (next: http://localhost:58651/tests/dromaeo/cssquery-dojo.html) 22:36:44 INFO - PROCESS | 8841 | RSS: Main: 306016256 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | __start_tp_report 22:36:44 INFO - PROCESS | 8841 | _x_x_mozilla_page_load 22:36:44 INFO - PROCESS | 8841 | _x_x_mozilla_page_load_details 22:36:44 INFO - PROCESS | 8841 | |i|pagename|runs| 22:36:44 INFO - PROCESS | 8841 | |0;dojo.html;2536.1630661881577;2553.9616905746407;2591.9481610367798;2598.883050262738;2610.569256072748;4513.368128462018;4595.5634214749625;4610.6542009349305;4614.100250451163;4625.2137136686715;4471;4486.461624605044;4539.863804085874;4571.588557029875;4611.907761844761;4182.079942412664;4203.957960420387;4263;4279.486461624594;4375.9562404375865;3607.801570913599;4313.245182093121;4345.130973805236;4350.434443522354;4389.429374181352;4175.373693945902;4215.873523794291;4224.957750422487;4232.76719780412;4293.720908140961;4149.564295748964;4172.895677608054;4197.517285512175;4198.85304014358;4201.915961680749;4192.538820729717;4193.35003074524;4194.748315101104;4240.363945408182;4243.045314804175;4448.466184057901;4514.413126293593;4544.681872268942;4546.8863278417975;4604.861854144381;4924.60603151747;4938.851834444972;4947.604191664658;4959.107360675077;4972.254161875748;4924.532169443933;4928.802847886081;4936.284238785356;4941.407031156285;5000.799968001312;4414.448193975689;4603.240465323218;4612.74629895359;4613.261878099555;4671.883202919887;4828.975855120772;4888.9755551222015;4981.178105612534;5022.146235140035;5036.84889453317;4806.255030470283;4814.133455977958;4815.686980346266;4863.781129849165;4867.634927380461;4898.21628539432;4905.411350637875;4909.582685471775;4910.803567857317;4971.701697898137;4683.086798074411;4720.409948756405;4774.140654682121;4858.416989961157;4861.6353773467135;4792.376990991149;4834.154023045953;4843.24929635907;4869.14789911764;4872.4153101628035;3877.127646279621;3880.5149356330458;3891.5135608048995;3905.6875449963936;3922.490076290064;3452.913677158091;3454.7408944329277;3470.2076541954502;3488.651134886491;3500;4104.384342348611;4154.252234597741;4170.103427763045;4235.174141042467;4260.147970405931;4922.483139270325;4953.23224900141;4954.380702412199;5008.824691135793;5019.84940451787;4264.637505811978;4266.381374700651;4274.829006839754;4312.460942382202;4328.696991210585;4292.377605247221;4313.374560688745;4336.891577710582;4482.932756008662;4493.393391892053;4587.747673877969;4624.953750462452;4625.306204069417;4628.583427491542;4684.578387945101;4943.036107958914;4943.950560494349;4950.529699678525;4960.8759781005765;5017.222330538772;4436.26801577736;4608.608268297098;4621.722696638212;4623.190941585276;4682.836100736458;4772.856814295576;4813.9037219256115;4849.199882019428;4856.660033797601;4876.536729010738;4906.092372911023;4915.18899381598;4915.785253634144;4917.262410638433;4972.8508144755715;4776.402949631296;4778.689385189951;4782.641301902441;4784.904301913873;4837;4535.31970204472;4553.134904368159;4568.565986231302;4574;4718.598919091915;4678.181318269358;4736.100140973204;4736.621070314298;4738.028704115717;4738.4787673356595;4711.8350857719815;4725.385699858996;4726.338312636302;4759.50025247344;4808.110499557593;4545.2954792007295;4658.464276608233;4660.4174478190225;4668.253079507263;4715.952840471551 22:36:44 INFO - PROCESS | 8841 | |1;ext.html;538.3082738680795;542.8615702995736;557.0835974821422;558.0624550754733;559.5859064292425;28473.857630711842;38535.61464385355;39743.60256397435;40093;43844.78077609615;41092.17815643693;41676;41745.58254417455;41757.58242417575;41803.372949405704;7300.671469783846;7625.809354766134;7831.6475758591005;7854.7250846220395;7883.0934442539265;7331.376832969204;9941.602335906555;10237.539310731036;10237.795244095114;10486.528106235237;10266.076053155215;10329.225308101884;10333.741656458611;10336.948315258413;10356.637517686882;10013.799724005552;10055.446950417723;10087.94956025219;10092.39445633257;10163.44101074437;10042.497875106215;10104.848427273524;10112.140468060225;10118.08937195656;10125.443100629462;38180.80909595434;38479.691218526976;38533;38543;38544.61455385466;2962.9259268518244;3059.3728285701377;3131.812091274508;3207.3905957868164;3627.782333060025;29338.11985640434;29408.558871616944;29444.55833162504;29467.85266073656;29502.409951800844;3451.8274086295582;3506.3162683276773;3622.040159357772;3629.383004889175;3676.5955744868043;243766;244720.77639611866;245079;246290;246632;30655;51571.742141289804;51850.22224666633;51865;51881;31817.681823181472;33873.32253354919;33970.66029339675;33999.4900076499;34044.48933266003;11494.42527873603;11552.133589980785;11598.942005290088;11599.594014209462;11608.76782464346;8747.606357713918;8905.866412003825;9429.104235097655;9826.852597211047;9983;7668.194839541768;7756.922430775733;7832.569208693462;7852.725154619675;7858.724944626911;3027.5155975043886;3046.8019578727753;3094.3501864608234;3099.302656902224;3135.0751528299206;800.8078061265254;862.2369203255164;886.2068448738343;909.3679892474798;968.3221744778542;26765.464690706467;26799.330016749736;27717;27842.16473505798;28000.579991300147;823.6458322921202;844.5608283692445;867.2454964181203;876.640577363278;963.2679163835536;14045.227512486912;14392.280385980659;14570.927145364205;14617;14663.48677796272;362111;364153;364727;366122;366795;49395.50604493981;49817;49919.25121123186;49920.251196232086;50073.24890126651;873.4322690251388;956.9521523923776;994.5971881388194;1028.3624153025173;1063.2663462211049;24388.366210419965;28179.295517611405;28297;29019.564706528996;29334.55998160072;38401;39060.41409378805;39090.60909390869;39091.41362879616;39169;291115;293004;293235;293402;561130;37705.245895081396;37993.43009854799;38073.42889856599;38362.6163738359;38859;40715;40756.79621601992;40957;41919.580804191566;41948;35924.820375899;35985.280294393444;36038.4594231092;36045.45931810972;36475.27049459049;34808;36096.639033609325;36569.63430365769;36844.447333289485;36907.6309236915;35403.291934160654;35737.821310893276;36566;36731;36961.81519092495;30882.845585772826;32053.13889027637;33089.66910330866;33192.502112468814;33258.83370583132;25063.624045639695;25274.873625631753;25275.494490109726;25338.017991079363;25738.35654108662 22:36:44 INFO - PROCESS | 8841 | |2;jquery.html;340.3465346534653;365.33144345847086;372.12921763074405;375.6844250829304;394.21944549791414;12418.503259869594;12474.937625311872;13304.667383315435;14377.712445751078;17316.567085822862;16615.584610384747;17141.74287385687;17270;17432;17461.476155715318;4811.3264143019915;5112.693238405689;5142.717150556718;5149.588032957355;5149.639525233235;5045.697258164503;5138.640295179339;5141.0489059523925;5150.459201783796;5424.945750542503;5513.558915286788;5516.420775818541;5519.199716041172;5523.696196709199;5525.972370138164;5499.560035197194;5510.008198524264;5535.446455354432;5957.285125784891;6004.3395226525045;5349.277847490578;5356.9732151339385;5363.785448582052;5375.892482150374;5380.273663055476;12472.81290780639;21740.673889891663;22450;22471.438214044618;22534.211302604494;1850.4911149434013;1918.5779128591687;1937.1282922684848;1943.436403443014;1981.6532106881382;13285.335733213396;13966.650833729136;14300.070495417765;15125.621859453491;15360.155191464464;1823.7537932379225;1837.9448616541524;1850.5003649014825;1876.2401227502883;1877.2303355624265;78988;80202.59898700527;82599;83655.5817220916;85441.57279213626;15887.364505419884;15888;16058.75911861323;16415.671686566202;16433.753493697604;28782;28874.422511549652;28883.277918051797;28912.71087289142;29112;7385.8153546161775;7462.4776265660885;7506.635409845881;7670.501417407851;7833.451658383972;5999.370066143079;6078.574499785061;6242.937570624326;6262.373762623793;6284.5600807943;7896.289333959856;8264.504129752115;8386.87419688705;8508.829823403497;8542.871856922151;3031.9393612127633;3323.401787678241;3328.417526932777;3350.6015626168346;3391.253924136686;677.7119724117231;772.2817779465039;850.4174640371366;869.7216890595075;896.9058248883773;16131.193440327937;16288.185590720654;16616;16709.081000545088;17121.400750973655;746.1344839985591;758.8027112950673;760.6653072648018;761.7752762934947;771.1478815908453;8969.372143949991;9291.907080929239;9435.245180385553;9491.19324857381;9668.903310966942;338627;339307;340302;341749;345451;74942;77652;77896.22103779003;78408.60795695985;79809.60095199604;857.9699710510102;883.6597909804643;883.6951251818112;888.5424006636588;890.4212262029732;14658.560243192722;14691.485797997018;14903.701925961637;14933.328000240233;15342.23288835576;35302.47046294359;35821.82089089538;36143.19284035735;36405;36839.263214735016;48734;49287.75356123196;49327.50672493373;49598;49629;6491.772787952399;6697.2633010367845;6739.326067393222;7233.204347521873;7932.722354717557;11024.779504409706;11307;11740.882591173979;12255.387230638611;12283.877161228273;9911.157551608194;9961.601535938482;10204.387736735524;10275.537600807833;10803.783924321628;10134.138598219233;10221.43782091992;10433.843492347469;10478.738031549272;10571.524281407508;10123.088921997056;10231.28381013322;10262.076413122855;10527.420991845522;10726.51730672106;6968.675951569186;6998.2651821558;7031.226565077735;7065.682044307916;7267.600281984542;8947.19475247231;10091;10257.128144107834;10489.52797124116;10798.56805727762 22:36:44 INFO - PROCESS | 8841 | |3;mootools.html;1189.3696340939305;1344.9865501344987;1355.4374934402222;1414.9221792801397;1637.5333030086429;6147.385261473851;6874.346937040979;7088.929110708891;7091.361777440029;7291.453141014418;7072.115985501812;7131.0729605151255;7136.714531418737;7138.036365090711;7142.500024998252;2094.8952552372357;2123.437289118385;2124.362691192644;2124.3839286606867;2124.861883977544;2087.499000239947;2127.6595744680853;2129.2547608337113;2130.872147671145;2136.423165745248;2053.0966374795044;2065.101680768863;2065.1532871522677;2070.710100585919;2073.3365323096614;1993.3322337017116;2040.9285675001452;2041.5100375909824;2041.806028427297;2045.764737055228;1976.5453945592594;1994.371772891549;1995.281698588507;1998.5103649605794;1999.1103958738368;6975.511714180009;7009.12385951756;7049.189343225544;7163.820904477378;7230.313120253568;4261.786910654455;4437.711548749321;4438.977805110986;4439.445069366329;4442.155990361854;2648.1393547097077;2835.503786837295;2886.321714397115;2892.4938135826146;2893.2332931772885;863.7797361672733;871.7471933139382;876.0626130040858;885.0706757904239;889.3330002498126;9365.34442589019;9485.525723713787;9488.240940724725;9509.381890177116;9531.714048578553;3525.823708814549;3698.2973235085788;3773.660370566662;3774.301754175486;3796.65830075289;7583.62081895903;7664.425168112414;7677.692892284246;7680.654370553339;7688;4260.25445547028;4261.573842615714;4264.0832221072615;4266.701330906807;4266.743995360288;3496.4580490024086;3596;3691.6123806999876;3961.643452089326;3964.0684439156776;2906.3579077820964;3235.2397186661115;3275.3449310138067;3283.228441316289;3310.470324748029;949.1315446366498;974.8537719342014;976.1166144638971;979.2361957673027;990;579.4871538688207;611.7247238742494;778.9727359542388;785.7485604606471;815.0708192660372;4584.816607335736;4647.1635105680625;4723.7874295656775;4735.384400028043;4760.214564596872;398.7886420197242;400.95990400960255;402.26586479674125;405.52958568061496;855.1747563601031;3187.1713354527988;3288.2601414681503;3307.2393349529743;3314.6685331467143;3430.468277417004;8428.367872409593;8538.70114545988;8713.433626814236;8730.432521886058;8732.694355697648;8556.957215214008;8568.614412351459;8570.95714521436;8571.400001999926;8620.655173792979;6523.608583485006;6658.234303055114;6663.833404164838;6672.566283191674;6674.432673222734;4782.450018247946;4885.267209918541;5012.724300163526;5101.336826212569;5108.642395032312;7788.571628560484;7832.0601527817025;7915.920840791749;8031.83936321282;8039.316658084128;7606.847863042819;7817.5309481431295;7849.3328067114935;8053.879191812245;8054.8791768122355;5645.520130788929;5813.360530341574;5978;6113.388661134029;6140.692965351804;6839.042534045338;7055.18865330473;7058.435325173871;7060.188078371053;7068.081149450744;6236.906446403398;6310.05349197624;6312.305646378986;6332.936670633235;6493.512986525935;6182.319944805978;6208.068789681403;6236.875262494816;6245.96877015612;6366.490680745622;5754.079347304411;5770.480656740913;5819.447152520504;5832.737526811388;5866.970665146647;4064.7357921734992;4098;4107.9794601028;4214.915701685888;4243.215005224043;4156.771377574262;4302.870913872589;4334.501532323823;4353.934690979574;4387.561243875587 22:36:44 INFO - PROCESS | 8841 | |4;prototype.html;290.62073993438565;292.2037447954325;300.14159503819076;302.0756485155423;304.1802342686461;4806.255030470278;4807.807687692492;4828.155072862244;4837.975810120949;4870.7092620455605;4792.257200133976;4794.137055330039;4812.566868981791;4814.759262036901;4816.590589799863;3818.331791936407;3832.9650994231542;3837.884863454087;3843.8270277837564;3846.384578467446;3462.9480557791653;3838.3858582626785;3841.500604921356;3843.6540711335974;3849.615038496156;3650.7627004244773;3713;3716.4239542870896;3726.77639341639;3734.253149370123;3701.5002974598356;3702.5186725725753;3710.9814450927843;3711.8329675164546;3714.4428335749585;3067.1412004638737;3141.6387115481784;3141.937161256762;3239.838008099609;3263.3473305339026;4628.213203755336;4641.930371044403;4642.675012749109;4645.907081858378;4678.508756580578;4146.606072423115;4149.356849688304;4149.37759336102;4153.314703073989;4195.328747400401;4669.392978912753;4748.240281554935;4971;4979.6265280104135;4980.651354405193;3512.8243587820507;3527.3474407234744;3529.135361836341;3536.169000284931;3542.2384187399834;5149.742512874342;5186.740662966837;5193.68837869729;5227.843164705065;5231.973840130813;3483.4600636901323;3589.4795254687924;3605.152789094561;3605.1708107135505;3609.783412995229;3620.31214069326;3635.763675361093;3637.418013117888;3647.4164133739005;3657.6159503252306;4158.272302347077;4162.396452514368;4182.393552934807;4187.937180942288;4198.475190601175;4949.356583644103;4957.851264462072;4982.227754698028;4983.725895075806;4992.72540010303;1228.9631311060682;1255.3534929511309;1264.8166015927638;1270.9618711438673;1271.853736820259;762.9122650895107;785.2422412372089;789.5815217934504;790.5335851847437;790.5612385126195;3969.749528898388;3981;3983.960160398417;3984.7808370539897;3990.84036638537;4524.88687782808;4536.750478723702;4544.409226800561;4555.954440455619;4580.496145424001;3944.3097457944746;3950.4074388841905;3956.9010774730864;3958.7228893977144;3969.861054863066;2446.2172104926253;2455.1407007547214;2507.247825652297;2696.177665811907;2713.511567917794;4589.747563883951;4692.81228750853;4750.14497390473;4792.688475249098;4803.78382972767;5233.476652334813;5258.3463634683585;5264.815731449381;5265.8156964506825;5278.9208161877605;4742.549457801503;4770.809167633325;4784.282357646381;4795.328653988445;4803;4962.578180854668;5003.086481212267;5079;5102.566281866083;5116.541785591088;5017.222330538626;5019;5037.168867136881;5040.092783299041;5053.2420136979745;4781.187198176388;4789.161896668;4790.520947905321;4798.688085274446;4803.279508073677;3449.8102604357;3556.893293201208;3568.660977207161;3594.1194407370363;3599.460080987768;5155.2782610433815;5155.32980712505;5164.7934082636275;5168.9483105168465;5174.327337446259;5006.549410553068;5007.874803129951;5010.874728131826;5014.6991180529285;5046.747662616928;4798.592119669867;4954.182559877724;4978.576820970258;4991.700497970133;5023.422306434661;4905.264210368473;4909.3126962224605;4913.213885778401;4914.238293064581;4920.8769780755765;5003.724795136302;5009.173486374853;5011.4487406386;5019.447860735243;5034.974825125851;4672.556107169813;4909.729964851825;4910.705357678551;4950.6782059166035;4958.950410495849 22:36:44 INFO - PROCESS | 8841 | |5;yui.html;645.0968643898541;661.9338066193379;735.165587058688;737.959412232327;748.8202831320484;11762.588309409173;12311.138220324581;12409.441575129107;12455.501779928814;12513.249205047703;11647.475863586138;12255.203411778228;12348.753024939495;12357.135000549964;12445.06662000349;787.5904529644567;802.863513202757;804.2399932064202;804.3766081286991;804.6419343392192;616.7009000634689;639.1722719078804;773.7949443397504;793.9087004994412;795.0697683710073;842.873568964654;844.7634662294568;845.0746432656232;845.121074082953;845.3026253341018;838.0864857305505;838.1032295443878;838.1199740272689;838.2916435611928;838.7357982235576;475.85724282715046;487.73174753885223;590.6072461812932;605.1709158452948;617.1144407774813;12260;12262.141650084408;12269.877301226963;12286.13997020209;12289.69275768104;11677.70805729855;11812.40937953099;12134.271943683407;12410.875891241063;12681.365931703378;10785.730356741065;10872.836907446395;11126.499307531181;11204.383758893258;11590.71023224426;3892.902677433087;3901.9804900975596;3902.751119641716;3996.8800935971967;4004.179143275651;45543;46175.30737038947;46399;46444.53555464436;46587.30119048217;9112.453252804853;9233.261339092856;9233.445993240428;9283.814323713488;9730.172935300438;16368.345266189457;17013.979161250118;17286.308547658205;17318.567035823955;17483.125843707763;6403.327650596713;6405.19935008124;6459.063435801782;6459.321771214049;6476.481881449473;3524.506569080331;3531.346700860349;3554.413521768931;3571.982140089283;3634.254977729559;2619.5415802234534;2709.3091261728528;2719.5920611908373;2726.6591676040493;2733.658292713411;463.76348062488375;475.9952400475951;479.4007490636704;486.406583967559;486.4405933176875;543.736287900368;569.8034178208511;571.3058633760002;572.6134858970179;573.3635664412499;7042.914640114195;7673.923260767321;7732.149463559004;7743.225677432324;7952.045754509496;473.76311844077964;487.99756001219765;509.7986295413291;537.2129829799362;569.6553585080966;3352.2792599591203;3581.7850928944345;3908.355121404993;3969.186316805048;4077.55146933843;60217;67306.28855980132;68401;69256;69939;57942.710286448295;58702.706486467294;59295.40704592985;59549;59722;53305;54234.45765542294;55165.72417137888;56566.86866262652;57951;7673.079230492377;7723.150453450004;7829.686812527435;7894.802629934068;7942.722004729807;28524.429511409242;33021.50467742938;33056.338873222885;33515.497267540515;38244.17558244153;39178;46438.76780616075;47156.7642161787;47984.520154798;50022.49977500179;10143.949280253551;10355.741106472398;10358.689239322832;10436.895631043895;10566;11342.659720208407;11493.82759258595;11652.94173529127;12473.750524989267;12563.811542827048;10248.846267305848;10519.10587600032;10551.208659350734;10557.9472102639;10822.29640709644;10833.620823271147;10954.945225273823;10973.177011723992;11090.611828586283;11518.712032199262;10617.097546708615;10755.516001779783;10827.566897324019;11137.109031277316;11264.887351126385;9016;9033.928464322162;9165.404248723811;9740.75648108803;10194.796104078025;9486.166007905227;9564.95217523908;9804.754881127743;9847.113759761656;9889.901100988898 22:36:44 INFO - PROCESS | 8841 | __end_tp_report 22:36:44 INFO - PROCESS | 8841 | __start_cc_report 22:36:44 INFO - PROCESS | 8841 | _x_x_mozilla_cycle_collect,1164 22:36:44 INFO - PROCESS | 8841 | __end_cc_report 22:36:44 INFO - PROCESS | 8841 | __startTimestamp1477633004259__endTimestamp 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | ------- Summary: start ------- 22:36:44 INFO - PROCESS | 8841 | Number of tests: 6 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#0] dojo.html Cycles:165 Average:4508.44 Median:4623.19 stddev:491.27 (10.6%) stddev-sans-first:467.78 22:36:44 INFO - PROCESS | 8841 | Values: 2536.2 2554.0 2591.9 2598.9 2610.6 4513.4 4595.6 4610.7 4614.1 4625.2 4471.0 4486.5 4539.9 4571.6 4611.9 4182.1 4204.0 4263.0 4279.5 4376.0 3607.8 4313.2 4345.1 4350.4 4389.4 4175.4 4215.9 4225.0 4232.8 4293.7 4149.6 4172.9 4197.5 4198.9 4201.9 4192.5 4193.4 4194.7 4240.4 4243.0 4448.5 4514.4 4544.7 4546.9 4604.9 4924.6 4938.9 4947.6 4959.1 4972.3 4924.5 4928.8 4936.3 4941.4 5000.8 4414.4 4603.2 4612.7 4613.3 4671.9 4829.0 4889.0 4981.2 5022.1 5036.8 4806.3 4814.1 4815.7 4863.8 4867.6 4898.2 4905.4 4909.6 4910.8 4971.7 4683.1 4720.4 4774.1 4858.4 4861.6 4792.4 4834.2 4843.2 4869.1 4872.4 3877.1 3880.5 3891.5 3905.7 3922.5 3452.9 3454.7 3470.2 3488.7 3500.0 4104.4 4154.3 4170.1 4235.2 4260.1 4922.5 4953.2 4954.4 5008.8 5019.8 4264.6 4266.4 4274.8 4312.5 4328.7 4292.4 4313.4 4336.9 4482.9 4493.4 4587.7 4625.0 4625.3 4628.6 4684.6 4943.0 4944.0 4950.5 4960.9 5017.2 4436.3 4608.6 4621.7 4623.2 4682.8 4772.9 4813.9 4849.2 4856.7 4876.5 4906.1 4915.2 4915.8 4917.3 4972.9 4776.4 4778.7 4782.6 4784.9 4837.0 4535.3 4553.1 4568.6 4574.0 4718.6 4678.2 4736.1 4736.6 4738.0 4738.5 4711.8 4725.4 4726.3 4759.5 4808.1 4545.3 4658.5 4660.4 4668.3 4716.0 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#1] ext.html Cycles:180 Average:46649.33 Median:182866.52 stddev:86963.23 (47.6%) stddev-sans-first:87138.27 22:36:44 INFO - PROCESS | 8841 | Values: 538.3 542.9 557.1 558.1 559.6 28473.9 38535.6 39743.6 40093.0 43844.8 41092.2 41676.0 41745.6 41757.6 41803.4 7300.7 7625.8 7831.6 7854.7 7883.1 7331.4 9941.6 10237.5 10237.8 10486.5 10266.1 10329.2 10333.7 10336.9 10356.6 10013.8 10055.4 10087.9 10092.4 10163.4 10042.5 10104.8 10112.1 10118.1 10125.4 38180.8 38479.7 38533.0 38543.0 38544.6 2962.9 3059.4 3131.8 3207.4 3627.8 29338.1 29408.6 29444.6 29467.9 29502.4 3451.8 3506.3 3622.0 3629.4 3676.6 243766.0 244720.8 245079.0 246290.0 246632.0 30655.0 51571.7 51850.2 51865.0 51881.0 31817.7 33873.3 33970.7 33999.5 34044.5 11494.4 11552.1 11598.9 11599.6 11608.8 8747.6 8905.9 9429.1 9826.9 9983.0 7668.2 7756.9 7832.6 7852.7 7858.7 3027.5 3046.8 3094.4 3099.3 3135.1 800.8 862.2 886.2 909.4 968.3 26765.5 26799.3 27717.0 27842.2 28000.6 823.6 844.6 867.2 876.6 963.3 14045.2 14392.3 14570.9 14617.0 14663.5 362111.0 364153.0 364727.0 366122.0 366795.0 49395.5 49817.0 49919.3 49920.3 50073.2 873.4 957.0 994.6 1028.4 1063.3 24388.4 28179.3 28297.0 29019.6 29334.6 38401.0 39060.4 39090.6 39091.4 39169.0 291115.0 293004.0 293235.0 293402.0 561130.0 37705.2 37993.4 38073.4 38362.6 38859.0 40715.0 40756.8 40957.0 41919.6 41948.0 35924.8 35985.3 36038.5 36045.5 36475.3 34808.0 36096.6 36569.6 36844.4 36907.6 35403.3 35737.8 36566.0 36731.0 36961.8 30882.8 32053.1 33089.7 33192.5 33258.8 25063.6 25274.9 25275.5 25338.0 25738.4 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#2] jquery.html Cycles:180 Average:23997.73 Median:384.95 stddev:56912.30 (14784.3%) stddev-sans-first:57044.23 22:36:44 INFO - PROCESS | 8841 | Values: 340.3 365.3 372.1 375.7 394.2 12418.5 12474.9 13304.7 14377.7 17316.6 16615.6 17141.7 17270.0 17432.0 17461.5 4811.3 5112.7 5142.7 5149.6 5149.6 5045.7 5138.6 5141.0 5150.5 5424.9 5513.6 5516.4 5519.2 5523.7 5526.0 5499.6 5510.0 5535.4 5957.3 6004.3 5349.3 5357.0 5363.8 5375.9 5380.3 12472.8 21740.7 22450.0 22471.4 22534.2 1850.5 1918.6 1937.1 1943.4 1981.7 13285.3 13966.7 14300.1 15125.6 15360.2 1823.8 1837.9 1850.5 1876.2 1877.2 78988.0 80202.6 82599.0 83655.6 85441.6 15887.4 15888.0 16058.8 16415.7 16433.8 28782.0 28874.4 28883.3 28912.7 29112.0 7385.8 7462.5 7506.6 7670.5 7833.5 5999.4 6078.6 6242.9 6262.4 6284.6 7896.3 8264.5 8386.9 8508.8 8542.9 3031.9 3323.4 3328.4 3350.6 3391.3 677.7 772.3 850.4 869.7 896.9 16131.2 16288.2 16616.0 16709.1 17121.4 746.1 758.8 760.7 761.8 771.1 8969.4 9291.9 9435.2 9491.2 9668.9 338627.0 339307.0 340302.0 341749.0 345451.0 74942.0 77652.0 77896.2 78408.6 79809.6 858.0 883.7 883.7 888.5 890.4 14658.6 14691.5 14903.7 14933.3 15342.2 35302.5 35821.8 36143.2 36405.0 36839.3 48734.0 49287.8 49327.5 49598.0 49629.0 6491.8 6697.3 6739.3 7233.2 7932.7 11024.8 11307.0 11740.9 12255.4 12283.9 9911.2 9961.6 10204.4 10275.5 10803.8 10134.1 10221.4 10433.8 10478.7 10571.5 10123.1 10231.3 10262.1 10527.4 10726.5 6968.7 6998.3 7031.2 7065.7 7267.6 8947.2 10091.0 10257.1 10489.5 10798.6 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#3] mootools.html Cycles:180 Average:4655.45 Median:5762.28 stddev:2558.83 (44.4%) stddev-sans-first:2552.74 22:36:44 INFO - PROCESS | 8841 | Values: 1189.4 1345.0 1355.4 1414.9 1637.5 6147.4 6874.3 7088.9 7091.4 7291.5 7072.1 7131.1 7136.7 7138.0 7142.5 2094.9 2123.4 2124.4 2124.4 2124.9 2087.5 2127.7 2129.3 2130.9 2136.4 2053.1 2065.1 2065.2 2070.7 2073.3 1993.3 2040.9 2041.5 2041.8 2045.8 1976.5 1994.4 1995.3 1998.5 1999.1 6975.5 7009.1 7049.2 7163.8 7230.3 4261.8 4437.7 4439.0 4439.4 4442.2 2648.1 2835.5 2886.3 2892.5 2893.2 863.8 871.7 876.1 885.1 889.3 9365.3 9485.5 9488.2 9509.4 9531.7 3525.8 3698.3 3773.7 3774.3 3796.7 7583.6 7664.4 7677.7 7680.7 7688.0 4260.3 4261.6 4264.1 4266.7 4266.7 3496.5 3596.0 3691.6 3961.6 3964.1 2906.4 3235.2 3275.3 3283.2 3310.5 949.1 974.9 976.1 979.2 990.0 579.5 611.7 779.0 785.7 815.1 4584.8 4647.2 4723.8 4735.4 4760.2 398.8 401.0 402.3 405.5 855.2 3187.2 3288.3 3307.2 3314.7 3430.5 8428.4 8538.7 8713.4 8730.4 8732.7 8557.0 8568.6 8571.0 8571.4 8620.7 6523.6 6658.2 6663.8 6672.6 6674.4 4782.5 4885.3 5012.7 5101.3 5108.6 7788.6 7832.1 7915.9 8031.8 8039.3 7606.8 7817.5 7849.3 8053.9 8054.9 5645.5 5813.4 5978.0 6113.4 6140.7 6839.0 7055.2 7058.4 7060.2 7068.1 6236.9 6310.1 6312.3 6332.9 6493.5 6182.3 6208.1 6236.9 6246.0 6366.5 5754.1 5770.5 5819.4 5832.7 5867.0 4064.7 4098.0 4108.0 4214.9 4243.2 4156.8 4302.9 4334.5 4353.9 4387.6 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#4] prototype.html Cycles:180 Average:4086.86 Median:4670.97 stddev:1203.31 (25.8%) stddev-sans-first:1172.47 22:36:44 INFO - PROCESS | 8841 | Values: 290.6 292.2 300.1 302.1 304.2 4806.3 4807.8 4828.2 4838.0 4870.7 4792.3 4794.1 4812.6 4814.8 4816.6 3818.3 3833.0 3837.9 3843.8 3846.4 3462.9 3838.4 3841.5 3843.7 3849.6 3650.8 3713.0 3716.4 3726.8 3734.3 3701.5 3702.5 3711.0 3711.8 3714.4 3067.1 3141.6 3141.9 3239.8 3263.3 4628.2 4641.9 4642.7 4645.9 4678.5 4146.6 4149.4 4149.4 4153.3 4195.3 4669.4 4748.2 4971.0 4979.6 4980.7 3512.8 3527.3 3529.1 3536.2 3542.2 5149.7 5186.7 5193.7 5227.8 5232.0 3483.5 3589.5 3605.2 3605.2 3609.8 3620.3 3635.8 3637.4 3647.4 3657.6 4158.3 4162.4 4182.4 4187.9 4198.5 4949.4 4957.9 4982.2 4983.7 4992.7 1229.0 1255.4 1264.8 1271.0 1271.9 762.9 785.2 789.6 790.5 790.6 3969.7 3981.0 3984.0 3984.8 3990.8 4524.9 4536.8 4544.4 4556.0 4580.5 3944.3 3950.4 3956.9 3958.7 3969.9 2446.2 2455.1 2507.2 2696.2 2713.5 4589.7 4692.8 4750.1 4792.7 4803.8 5233.5 5258.3 5264.8 5265.8 5278.9 4742.5 4770.8 4784.3 4795.3 4803.0 4962.6 5003.1 5079.0 5102.6 5116.5 5017.2 5019.0 5037.2 5040.1 5053.2 4781.2 4789.2 4790.5 4798.7 4803.3 3449.8 3556.9 3568.7 3594.1 3599.5 5155.3 5155.3 5164.8 5168.9 5174.3 5006.5 5007.9 5010.9 5014.7 5046.7 4798.6 4954.2 4978.6 4991.7 5023.4 4905.3 4909.3 4913.2 4914.2 4920.9 5003.7 5009.2 5011.4 5019.4 5035.0 4672.6 4909.7 4910.7 4950.7 4959.0 22:36:44 INFO - PROCESS | 8841 | 22:36:44 INFO - PROCESS | 8841 | [#5] yui.html Cycles:180 Average:14151.96 Median:474.81 stddev:17812.17 (3751.4%) stddev-sans-first:17833.26 22:36:44 INFO - PROCESS | 8841 | Values: 645.1 661.9 735.2 738.0 748.8 11762.6 12311.1 12409.4 12455.5 12513.2 11647.5 12255.2 12348.8 12357.1 12445.1 787.6 802.9 804.2 804.4 804.6 616.7 639.2 773.8 793.9 795.1 842.9 844.8 845.1 845.1 845.3 838.1 838.1 838.1 838.3 838.7 475.9 487.7 590.6 605.2 617.1 12260.0 12262.1 12269.9 12286.1 12289.7 11677.7 11812.4 12134.3 12410.9 12681.4 10785.7 10872.8 11126.5 11204.4 11590.7 3892.9 3902.0 3902.8 3996.9 4004.2 45543.0 46175.3 46399.0 46444.5 46587.3 9112.5 9233.3 9233.4 9283.8 9730.2 16368.3 17014.0 17286.3 17318.6 17483.1 6403.3 6405.2 6459.1 6459.3 6476.5 3524.5 3531.3 3554.4 3572.0 3634.3 2619.5 2709.3 2719.6 2726.7 2733.7 463.8 476.0 479.4 486.4 486.4 543.7 569.8 571.3 572.6 573.4 7042.9 7673.9 7732.1 7743.2 7952.0 473.8 488.0 509.8 537.2 569.7 3352.3 3581.8 3908.4 3969.2 4077.6 60217.0 67306.3 68401.0 69256.0 69939.0 57942.7 58702.7 59295.4 59549.0 59722.0 53305.0 54234.5 55165.7 56566.9 57951.0 7673.1 7723.2 7829.7 7894.8 7942.7 28524.4 33021.5 33056.3 33515.5 38244.2 39178.0 46438.8 47156.8 47984.5 50022.5 10143.9 10355.7 10358.7 10436.9 10566.0 11342.7 11493.8 11652.9 12473.8 12563.8 10248.8 10519.1 10551.2 10557.9 10822.3 10833.6 10954.9 10973.2 11090.6 11518.7 10617.1 10755.5 10827.6 11137.1 11264.9 9016.0 9033.9 9165.4 9740.8 10194.8 9486.2 9565.0 9804.8 9847.1 9889.9 22:36:44 INFO - PROCESS | 8841 | -------- Summary: end -------- 22:36:44 INFO - PROCESS | 8841 | 22:36:45 INFO - TEST-INFO | 8841: exit 0 22:36:45 INFO - TEST-OK | dromaeo_css | took 1121523ms 22:36:45 INFO - TEST-START | kraken 22:36:45 INFO - operating with platform_type : linux_ 22:36:45 INFO - Initialising browser for kraken test... 22:36:45 INFO - TEST-INFO | started process 9144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v4cep/profile http://localhost:58651/getInfo.html) 22:36:49 INFO - PROCESS | 9144 | __metrics Screen width/height:1600/1200 22:36:49 INFO - PROCESS | 9144 | colorDepth:24 22:36:49 INFO - PROCESS | 9144 | Browser inner width/height: 1024/697 22:36:49 INFO - PROCESS | 9144 | __metrics 22:36:49 INFO - PROCESS | 9144 | 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" 22:36:49 INFO - PROCESS | 9144 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:50 INFO - PROCESS | 9144 | console.error: PushService: 22:36:50 INFO - PROCESS | 9144 | stateChangeProcessEnqueue: Error transitioning state 22:36:50 INFO - PROCESS | 9144 | UnknownError 22:36:51 INFO - TEST-INFO | 9144: exit 0 22:36:51 INFO - Browser initialized. 22:36:51 INFO - Running cycle 1/1 for kraken test... 22:36:51 INFO - TEST-INFO | started process 9227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v4cep/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:37:03 INFO - PROCESS | 9227 | RSS: Main: 173551616 22:37:03 INFO - PROCESS | 9227 | 22:37:06 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-beat-detection) 22:37:07 INFO - PROCESS | 9227 | RSS: Main: 229978112 22:37:07 INFO - PROCESS | 9227 | 22:37:09 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-dft) 22:37:10 INFO - PROCESS | 9227 | RSS: Main: 217198592 22:37:10 INFO - PROCESS | 9227 | 22:37:13 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-fft) 22:37:14 INFO - PROCESS | 9227 | RSS: Main: 299757568 22:37:14 INFO - PROCESS | 9227 | 22:37:16 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-oscillator) 22:37:17 INFO - PROCESS | 9227 | RSS: Main: 207974400 22:37:17 INFO - PROCESS | 9227 | 22:37:19 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:37:19 INFO - PROCESS | 9227 | RSS: Main: 213254144 22:37:19 INFO - PROCESS | 9227 | 22:37:23 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-darkroom) 22:37:23 INFO - PROCESS | 9227 | RSS: Main: 248811520 22:37:23 INFO - PROCESS | 9227 | 22:37:27 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-desaturate) 22:37:27 INFO - PROCESS | 9227 | RSS: Main: 248758272 22:37:27 INFO - PROCESS | 9227 | 22:37:30 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58651/tests/kraken/driver.html?testName=json-parse-financial) 22:37:31 INFO - PROCESS | 9227 | RSS: Main: 247787520 22:37:31 INFO - PROCESS | 9227 | 22:37:32 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:37:33 INFO - PROCESS | 9227 | RSS: Main: 210378752 22:37:33 INFO - PROCESS | 9227 | 22:37:35 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:37:35 INFO - PROCESS | 9227 | RSS: Main: 217939968 22:37:35 INFO - PROCESS | 9227 | 22:37:37 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:37:38 INFO - PROCESS | 9227 | RSS: Main: 227037184 22:37:38 INFO - PROCESS | 9227 | 22:37:41 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:37:42 INFO - PROCESS | 9227 | RSS: Main: 235458560 22:37:42 INFO - PROCESS | 9227 | 22:37:45 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:37:45 INFO - PROCESS | 9227 | RSS: Main: 231432192 22:37:45 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58651/tests/kraken/driver.html?testName=ai-astar) 22:37:47 INFO - PROCESS | 9227 | RSS: Main: 282304512 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | __start_tp_report 22:37:47 INFO - PROCESS | 9227 | _x_x_mozilla_page_load 22:37:47 INFO - PROCESS | 9227 | _x_x_mozilla_page_load_details 22:37:47 INFO - PROCESS | 9227 | |i|pagename|runs| 22:37:47 INFO - PROCESS | 9227 | |0;ai-astar;107;115;115;116;117;115;114;118;116;115 22:37:47 INFO - PROCESS | 9227 | |1;audio-beat-detection;156;127;133;165;127;129;127;125;168;126 22:37:47 INFO - PROCESS | 9227 | |2;audio-dft;162;160;161;161;161;160;163;162;159;160 22:37:47 INFO - PROCESS | 9227 | |3;audio-fft;78;76;76;107;76;77;78;77;103;75 22:37:47 INFO - PROCESS | 9227 | |4;audio-oscillator;85;86;111;85;84;84;117;84;90;114 22:37:47 INFO - PROCESS | 9227 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;117 22:37:47 INFO - PROCESS | 9227 | |6;imaging-darkroom;147;148;148;148;148;148;148;147;148;147 22:37:47 INFO - PROCESS | 9227 | |7;imaging-desaturate;85;85;85;84;84;85;85;84;85;85 22:37:47 INFO - PROCESS | 9227 | |8;json-parse-financial;62;61;62;62;62;64;65;64;64;62 22:37:47 INFO - PROCESS | 9227 | |9;json-stringify-tinderbox;66;66;66;66;66;66;66;66;66;67 22:37:47 INFO - PROCESS | 9227 | |10;stanford-crypto-aes;85;84;83;84;82;83;83;83;82;82 22:37:47 INFO - PROCESS | 9227 | |11;stanford-crypto-ccm;152;142;140;140;140;150;142;138;179;140 22:37:47 INFO - PROCESS | 9227 | |12;stanford-crypto-pbkdf2;181;183;177;177;177;185;174;174;177;173 22:37:47 INFO - PROCESS | 9227 | |13;stanford-crypto-sha256-iterative;71;75;70;69;70;70;73;69;72;69 22:37:47 INFO - PROCESS | 9227 | __end_tp_report 22:37:47 INFO - PROCESS | 9227 | __start_cc_report 22:37:47 INFO - PROCESS | 9227 | _x_x_mozilla_cycle_collect,1947 22:37:47 INFO - PROCESS | 9227 | __end_cc_report 22:37:47 INFO - PROCESS | 9227 | __startTimestamp1477633067855__endTimestamp 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | ------- Summary: start ------- 22:37:47 INFO - PROCESS | 9227 | Number of tests: 14 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.97 (2.6%) stddev-sans-first:1.22 22:37:47 INFO - PROCESS | 9227 | Values: 107.0 115.0 115.0 116.0 117.0 115.0 114.0 118.0 116.0 115.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:131.00 stddev:17.43 (13.3%) stddev-sans-first:17.27 22:37:47 INFO - PROCESS | 9227 | Values: 156.0 127.0 133.0 165.0 127.0 129.0 127.0 125.0 168.0 126.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 22:37:47 INFO - PROCESS | 9227 | Values: 162.0 160.0 161.0 161.0 161.0 160.0 163.0 162.0 159.0 160.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:12.04 (15.7%) stddev-sans-first:12.67 22:37:47 INFO - PROCESS | 9227 | Values: 78.0 76.0 76.0 107.0 76.0 77.0 78.0 77.0 103.0 75.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.50 stddev:13.98 (16.5%) stddev-sans-first:14.45 22:37:47 INFO - PROCESS | 9227 | Values: 85.0 86.0 111.0 85.0 84.0 84.0 117.0 84.0 90.0 114.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:37:47 INFO - PROCESS | 9227 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:37:47 INFO - PROCESS | 9227 | Values: 147.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 22:37:47 INFO - PROCESS | 9227 | Values: 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.36 22:37:47 INFO - PROCESS | 9227 | Values: 62.0 61.0 62.0 62.0 62.0 64.0 65.0 64.0 64.0 62.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 22:37:47 INFO - PROCESS | 9227 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:0.78 22:37:47 INFO - PROCESS | 9227 | Values: 85.0 84.0 83.0 84.0 82.0 83.0 83.0 83.0 82.0 82.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.00 stddev:12.38 (8.7%) stddev-sans-first:12.96 22:37:47 INFO - PROCESS | 9227 | Values: 152.0 142.0 140.0 140.0 140.0 150.0 142.0 138.0 179.0 140.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:177.00 stddev:3.99 (2.3%) stddev-sans-first:4.07 22:37:47 INFO - PROCESS | 9227 | Values: 181.0 183.0 177.0 177.0 177.0 185.0 174.0 174.0 177.0 173.0 22:37:47 INFO - PROCESS | 9227 | 22:37:47 INFO - PROCESS | 9227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.50 stddev:1.99 (2.8%) stddev-sans-first:2.11 22:37:47 INFO - PROCESS | 9227 | Values: 71.0 75.0 70.0 69.0 70.0 70.0 73.0 69.0 72.0 69.0 22:37:47 INFO - PROCESS | 9227 | -------- Summary: end -------- 22:37:47 INFO - PROCESS | 9227 | 22:37:49 INFO - TEST-INFO | 9227: exit 0 22:37:49 INFO - TEST-OK | kraken | took 63974ms 22:37:49 INFO - SUITE-END | took 1185s 22:37:49 INFO - Completed test suite (00:19:45) 22:37:49 INFO - javascript benchmark 22:37:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2536.1630661881577, 2553.9616905746407, 2591.9481610367798, 2598.883050262738, 2610.569256072748, 4513.368128462018, 4595.5634214749625, 4610.6542009349305, 4614.100250451163, 4625.2137136686715, 4471.0, 4486.461624605044, 4539.863804085874, 4571.588557029875, 4611.907761844761, 4182.079942412664, 4203.957960420387, 4263.0, 4279.486461624594, 4375.9562404375865, 3607.801570913599, 4313.245182093121, 4345.130973805236, 4350.434443522354, 4389.429374181352, 4175.373693945902, 4215.873523794291, 4224.957750422487, 4232.76719780412, 4293.720908140961, 4149.564295748964, 4172.895677608054, 4197.517285512175, 4198.85304014358, 4201.915961680749, 4192.538820729717, 4193.35003074524, 4194.748315101104, 4240.363945408182, 4243.045314804175, 4448.466184057901, 4514.413126293593, 4544.681872268942, 4546.8863278417975, 4604.861854144381, 4924.60603151747, 4938.851834444972, 4947.604191664658, 4959.107360675077, 4972.254161875748, 4924.532169443933, 4928.802847886081, 4936.284238785356, 4941.407031156285, 5000.799968001312, 4414.448193975689, 4603.240465323218, 4612.74629895359, 4613.261878099555, 4671.883202919887, 4828.975855120772, 4888.9755551222015, 4981.178105612534, 5022.146235140035, 5036.84889453317, 4806.255030470283, 4814.133455977958, 4815.686980346266, 4863.781129849165, 4867.634927380461, 4898.21628539432, 4905.411350637875, 4909.582685471775, 4910.803567857317, 4971.701697898137, 4683.086798074411, 4720.409948756405, 4774.140654682121, 4858.416989961157, 4861.6353773467135, 4792.376990991149, 4834.154023045953, 4843.24929635907, 4869.14789911764, 4872.4153101628035, 3877.127646279621, 3880.5149356330458, 3891.5135608048995, 3905.6875449963936, 3922.490076290064, 3452.913677158091, 3454.7408944329277, 3470.2076541954502, 3488.651134886491, 3500.0, 4104.384342348611, 4154.252234597741, 4170.103427763045, 4235.174141042467, 4260.147970405931, 4922.483139270325, 4953.23224900141, 4954.380702412199, 5008.824691135793, 5019.84940451787, 4264.637505811978, 4266.381374700651, 4274.829006839754, 4312.460942382202, 4328.696991210585, 4292.377605247221, 4313.374560688745, 4336.891577710582, 4482.932756008662, 4493.393391892053, 4587.747673877969, 4624.953750462452, 4625.306204069417, 4628.583427491542, 4684.578387945101, 4943.036107958914, 4943.950560494349, 4950.529699678525, 4960.8759781005765, 5017.222330538772, 4436.26801577736, 4608.608268297098, 4621.722696638212, 4623.190941585276, 4682.836100736458, 4772.856814295576, 4813.9037219256115, 4849.199882019428, 4856.660033797601, 4876.536729010738, 4906.092372911023, 4915.18899381598, 4915.785253634144, 4917.262410638433, 4972.8508144755715, 4776.402949631296, 4778.689385189951, 4782.641301902441, 4784.904301913873, 4837.0, 4535.31970204472, 4553.134904368159, 4568.565986231302, 4574.0, 4718.598919091915, 4678.181318269358, 4736.100140973204, 4736.621070314298, 4738.028704115717, 4738.4787673356595, 4711.8350857719815, 4725.385699858996, 4726.338312636302, 4759.50025247344, 4808.110499557593, 4545.2954792007295, 4658.464276608233, 4660.4174478190225, 4668.253079507263, 4715.952840471551], "value": 4476.636294415658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3082738680795, 542.8615702995736, 557.0835974821422, 558.0624550754733, 559.5859064292425, 28473.857630711842, 38535.61464385355, 39743.60256397435, 40093.0, 43844.78077609615, 41092.17815643693, 41676.0, 41745.58254417455, 41757.58242417575, 41803.372949405704, 7300.671469783846, 7625.809354766134, 7831.6475758591005, 7854.7250846220395, 7883.0934442539265, 7331.376832969204, 9941.602335906555, 10237.539310731036, 10237.795244095114, 10486.528106235237, 10266.076053155215, 10329.225308101884, 10333.741656458611, 10336.948315258413, 10356.637517686882, 10013.799724005552, 10055.446950417723, 10087.94956025219, 10092.39445633257, 10163.44101074437, 10042.497875106215, 10104.848427273524, 10112.140468060225, 10118.08937195656, 10125.443100629462, 38180.80909595434, 38479.691218526976, 38533.0, 38543.0, 38544.61455385466, 2962.9259268518244, 3059.3728285701377, 3131.812091274508, 3207.3905957868164, 3627.782333060025, 29338.11985640434, 29408.558871616944, 29444.55833162504, 29467.85266073656, 29502.409951800844, 3451.8274086295582, 3506.3162683276773, 3622.040159357772, 3629.383004889175, 3676.5955744868043, 243766.0, 244720.77639611866, 245079.0, 246290.0, 246632.0, 30655.0, 51571.742141289804, 51850.22224666633, 51865.0, 51881.0, 31817.681823181472, 33873.32253354919, 33970.66029339675, 33999.4900076499, 34044.48933266003, 11494.42527873603, 11552.133589980785, 11598.942005290088, 11599.594014209462, 11608.76782464346, 8747.606357713918, 8905.866412003825, 9429.104235097655, 9826.852597211047, 9983.0, 7668.194839541768, 7756.922430775733, 7832.569208693462, 7852.725154619675, 7858.724944626911, 3027.5155975043886, 3046.8019578727753, 3094.3501864608234, 3099.302656902224, 3135.0751528299206, 800.8078061265254, 862.2369203255164, 886.2068448738343, 909.3679892474798, 968.3221744778542, 26765.464690706467, 26799.330016749736, 27717.0, 27842.16473505798, 28000.579991300147, 823.6458322921202, 844.5608283692445, 867.2454964181203, 876.640577363278, 963.2679163835536, 14045.227512486912, 14392.280385980659, 14570.927145364205, 14617.0, 14663.48677796272, 362111.0, 364153.0, 364727.0, 366122.0, 366795.0, 49395.50604493981, 49817.0, 49919.25121123186, 49920.251196232086, 50073.24890126651, 873.4322690251388, 956.9521523923776, 994.5971881388194, 1028.3624153025173, 1063.2663462211049, 24388.366210419965, 28179.295517611405, 28297.0, 29019.564706528996, 29334.55998160072, 38401.0, 39060.41409378805, 39090.60909390869, 39091.41362879616, 39169.0, 291115.0, 293004.0, 293235.0, 293402.0, 561130.0, 37705.245895081396, 37993.43009854799, 38073.42889856599, 38362.6163738359, 38859.0, 40715.0, 40756.79621601992, 40957.0, 41919.580804191566, 41948.0, 35924.820375899, 35985.280294393444, 36038.4594231092, 36045.45931810972, 36475.27049459049, 34808.0, 36096.639033609325, 36569.63430365769, 36844.447333289485, 36907.6309236915, 35403.291934160654, 35737.821310893276, 36566.0, 36731.0, 36961.81519092495, 30882.845585772826, 32053.13889027637, 33089.66910330866, 33192.502112468814, 33258.83370583132, 25063.624045639695, 25274.873625631753, 25275.494490109726, 25338.017991079363, 25738.35654108662], "value": 16746.748957382097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3465346534653, 365.33144345847086, 372.12921763074405, 375.6844250829304, 394.21944549791414, 12418.503259869594, 12474.937625311872, 13304.667383315435, 14377.712445751078, 17316.567085822862, 16615.584610384747, 17141.74287385687, 17270.0, 17432.0, 17461.476155715318, 4811.3264143019915, 5112.693238405689, 5142.717150556718, 5149.588032957355, 5149.639525233235, 5045.697258164503, 5138.640295179339, 5141.0489059523925, 5150.459201783796, 5424.945750542503, 5513.558915286788, 5516.420775818541, 5519.199716041172, 5523.696196709199, 5525.972370138164, 5499.560035197194, 5510.008198524264, 5535.446455354432, 5957.285125784891, 6004.3395226525045, 5349.277847490578, 5356.9732151339385, 5363.785448582052, 5375.892482150374, 5380.273663055476, 12472.81290780639, 21740.673889891663, 22450.0, 22471.438214044618, 22534.211302604494, 1850.4911149434013, 1918.5779128591687, 1937.1282922684848, 1943.436403443014, 1981.6532106881382, 13285.335733213396, 13966.650833729136, 14300.070495417765, 15125.621859453491, 15360.155191464464, 1823.7537932379225, 1837.9448616541524, 1850.5003649014825, 1876.2401227502883, 1877.2303355624265, 78988.0, 80202.59898700527, 82599.0, 83655.5817220916, 85441.57279213626, 15887.364505419884, 15888.0, 16058.75911861323, 16415.671686566202, 16433.753493697604, 28782.0, 28874.422511549652, 28883.277918051797, 28912.71087289142, 29112.0, 7385.8153546161775, 7462.4776265660885, 7506.635409845881, 7670.501417407851, 7833.451658383972, 5999.370066143079, 6078.574499785061, 6242.937570624326, 6262.373762623793, 6284.5600807943, 7896.289333959856, 8264.504129752115, 8386.87419688705, 8508.829823403497, 8542.871856922151, 3031.9393612127633, 3323.401787678241, 3328.417526932777, 3350.6015626168346, 3391.253924136686, 677.7119724117231, 772.2817779465039, 850.4174640371366, 869.7216890595075, 896.9058248883773, 16131.193440327937, 16288.185590720654, 16616.0, 16709.081000545088, 17121.400750973655, 746.1344839985591, 758.8027112950673, 760.6653072648018, 761.7752762934947, 771.1478815908453, 8969.372143949991, 9291.907080929239, 9435.245180385553, 9491.19324857381, 9668.903310966942, 338627.0, 339307.0, 340302.0, 341749.0, 345451.0, 74942.0, 77652.0, 77896.22103779003, 78408.60795695985, 79809.60095199604, 857.9699710510102, 883.6597909804643, 883.6951251818112, 888.5424006636588, 890.4212262029732, 14658.560243192722, 14691.485797997018, 14903.701925961637, 14933.328000240233, 15342.23288835576, 35302.47046294359, 35821.82089089538, 36143.19284035735, 36405.0, 36839.263214735016, 48734.0, 49287.75356123196, 49327.50672493373, 49598.0, 49629.0, 6491.772787952399, 6697.2633010367845, 6739.326067393222, 7233.204347521873, 7932.722354717557, 11024.779504409706, 11307.0, 11740.882591173979, 12255.387230638611, 12283.877161228273, 9911.157551608194, 9961.601535938482, 10204.387736735524, 10275.537600807833, 10803.783924321628, 10134.138598219233, 10221.43782091992, 10433.843492347469, 10478.738031549272, 10571.524281407508, 10123.088921997056, 10231.28381013322, 10262.076413122855, 10527.420991845522, 10726.51730672106, 6968.675951569186, 6998.2651821558, 7031.226565077735, 7065.682044307916, 7267.600281984542, 8947.19475247231, 10091.0, 10257.128144107834, 10489.52797124116, 10798.56805727762], "value": 8739.306452157343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1189.3696340939305, 1344.9865501344987, 1355.4374934402222, 1414.9221792801397, 1637.5333030086429, 6147.385261473851, 6874.346937040979, 7088.929110708891, 7091.361777440029, 7291.453141014418, 7072.115985501812, 7131.0729605151255, 7136.714531418737, 7138.036365090711, 7142.500024998252, 2094.8952552372357, 2123.437289118385, 2124.362691192644, 2124.3839286606867, 2124.861883977544, 2087.499000239947, 2127.6595744680853, 2129.2547608337113, 2130.872147671145, 2136.423165745248, 2053.0966374795044, 2065.101680768863, 2065.1532871522677, 2070.710100585919, 2073.3365323096614, 1993.3322337017116, 2040.9285675001452, 2041.5100375909824, 2041.806028427297, 2045.764737055228, 1976.5453945592594, 1994.371772891549, 1995.281698588507, 1998.5103649605794, 1999.1103958738368, 6975.511714180009, 7009.12385951756, 7049.189343225544, 7163.820904477378, 7230.313120253568, 4261.786910654455, 4437.711548749321, 4438.977805110986, 4439.445069366329, 4442.155990361854, 2648.1393547097077, 2835.503786837295, 2886.321714397115, 2892.4938135826146, 2893.2332931772885, 863.7797361672733, 871.7471933139382, 876.0626130040858, 885.0706757904239, 889.3330002498126, 9365.34442589019, 9485.525723713787, 9488.240940724725, 9509.381890177116, 9531.714048578553, 3525.823708814549, 3698.2973235085788, 3773.660370566662, 3774.301754175486, 3796.65830075289, 7583.62081895903, 7664.425168112414, 7677.692892284246, 7680.654370553339, 7688.0, 4260.25445547028, 4261.573842615714, 4264.0832221072615, 4266.701330906807, 4266.743995360288, 3496.4580490024086, 3596.0, 3691.6123806999876, 3961.643452089326, 3964.0684439156776, 2906.3579077820964, 3235.2397186661115, 3275.3449310138067, 3283.228441316289, 3310.470324748029, 949.1315446366498, 974.8537719342014, 976.1166144638971, 979.2361957673027, 990.0, 579.4871538688207, 611.7247238742494, 778.9727359542388, 785.7485604606471, 815.0708192660372, 4584.816607335736, 4647.1635105680625, 4723.7874295656775, 4735.384400028043, 4760.214564596872, 398.7886420197242, 400.95990400960255, 402.26586479674125, 405.52958568061496, 855.1747563601031, 3187.1713354527988, 3288.2601414681503, 3307.2393349529743, 3314.6685331467143, 3430.468277417004, 8428.367872409593, 8538.70114545988, 8713.433626814236, 8730.432521886058, 8732.694355697648, 8556.957215214008, 8568.614412351459, 8570.95714521436, 8571.400001999926, 8620.655173792979, 6523.608583485006, 6658.234303055114, 6663.833404164838, 6672.566283191674, 6674.432673222734, 4782.450018247946, 4885.267209918541, 5012.724300163526, 5101.336826212569, 5108.642395032312, 7788.571628560484, 7832.0601527817025, 7915.920840791749, 8031.83936321282, 8039.316658084128, 7606.847863042819, 7817.5309481431295, 7849.3328067114935, 8053.879191812245, 8054.8791768122355, 5645.520130788929, 5813.360530341574, 5978.0, 6113.388661134029, 6140.692965351804, 6839.042534045338, 7055.18865330473, 7058.435325173871, 7060.188078371053, 7068.081149450744, 6236.906446403398, 6310.05349197624, 6312.305646378986, 6332.936670633235, 6493.512986525935, 6182.319944805978, 6208.068789681403, 6236.875262494816, 6245.96877015612, 6366.490680745622, 5754.079347304411, 5770.480656740913, 5819.447152520504, 5832.737526811388, 5866.970665146647, 4064.7357921734992, 4098.0, 4107.9794601028, 4214.915701685888, 4243.215005224043, 4156.771377574262, 4302.870913872589, 4334.501532323823, 4353.934690979574, 4387.561243875587], "value": 3729.981126874223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.62073993438565, 292.2037447954325, 300.14159503819076, 302.0756485155423, 304.1802342686461, 4806.255030470278, 4807.807687692492, 4828.155072862244, 4837.975810120949, 4870.7092620455605, 4792.257200133976, 4794.137055330039, 4812.566868981791, 4814.759262036901, 4816.590589799863, 3818.331791936407, 3832.9650994231542, 3837.884863454087, 3843.8270277837564, 3846.384578467446, 3462.9480557791653, 3838.3858582626785, 3841.500604921356, 3843.6540711335974, 3849.615038496156, 3650.7627004244773, 3713.0, 3716.4239542870896, 3726.77639341639, 3734.253149370123, 3701.5002974598356, 3702.5186725725753, 3710.9814450927843, 3711.8329675164546, 3714.4428335749585, 3067.1412004638737, 3141.6387115481784, 3141.937161256762, 3239.838008099609, 3263.3473305339026, 4628.213203755336, 4641.930371044403, 4642.675012749109, 4645.907081858378, 4678.508756580578, 4146.606072423115, 4149.356849688304, 4149.37759336102, 4153.314703073989, 4195.328747400401, 4669.392978912753, 4748.240281554935, 4971.0, 4979.6265280104135, 4980.651354405193, 3512.8243587820507, 3527.3474407234744, 3529.135361836341, 3536.169000284931, 3542.2384187399834, 5149.742512874342, 5186.740662966837, 5193.68837869729, 5227.843164705065, 5231.973840130813, 3483.4600636901323, 3589.4795254687924, 3605.152789094561, 3605.1708107135505, 3609.783412995229, 3620.31214069326, 3635.763675361093, 3637.418013117888, 3647.4164133739005, 3657.6159503252306, 4158.272302347077, 4162.396452514368, 4182.393552934807, 4187.937180942288, 4198.475190601175, 4949.356583644103, 4957.851264462072, 4982.227754698028, 4983.725895075806, 4992.72540010303, 1228.9631311060682, 1255.3534929511309, 1264.8166015927638, 1270.9618711438673, 1271.853736820259, 762.9122650895107, 785.2422412372089, 789.5815217934504, 790.5335851847437, 790.5612385126195, 3969.749528898388, 3981.0, 3983.960160398417, 3984.7808370539897, 3990.84036638537, 4524.88687782808, 4536.750478723702, 4544.409226800561, 4555.954440455619, 4580.496145424001, 3944.3097457944746, 3950.4074388841905, 3956.9010774730864, 3958.7228893977144, 3969.861054863066, 2446.2172104926253, 2455.1407007547214, 2507.247825652297, 2696.177665811907, 2713.511567917794, 4589.747563883951, 4692.81228750853, 4750.14497390473, 4792.688475249098, 4803.78382972767, 5233.476652334813, 5258.3463634683585, 5264.815731449381, 5265.8156964506825, 5278.9208161877605, 4742.549457801503, 4770.809167633325, 4784.282357646381, 4795.328653988445, 4803.0, 4962.578180854668, 5003.086481212267, 5079.0, 5102.566281866083, 5116.541785591088, 5017.222330538626, 5019.0, 5037.168867136881, 5040.092783299041, 5053.2420136979745, 4781.187198176388, 4789.161896668, 4790.520947905321, 4798.688085274446, 4803.279508073677, 3449.8102604357, 3556.893293201208, 3568.660977207161, 3594.1194407370363, 3599.460080987768, 5155.2782610433815, 5155.32980712505, 5164.7934082636275, 5168.9483105168465, 5174.327337446259, 5006.549410553068, 5007.874803129951, 5010.874728131826, 5014.6991180529285, 5046.747662616928, 4798.592119669867, 4954.182559877724, 4978.576820970258, 4991.700497970133, 5023.422306434661, 4905.264210368473, 4909.3126962224605, 4913.213885778401, 4914.238293064581, 4920.8769780755765, 5003.724795136302, 5009.173486374853, 5011.4487406386, 5019.447860735243, 5034.974825125851, 4672.556107169813, 4909.729964851825, 4910.705357678551, 4950.6782059166035, 4958.950410495849], "value": 3702.997875816914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.0968643898541, 661.9338066193379, 735.165587058688, 737.959412232327, 748.8202831320484, 11762.588309409173, 12311.138220324581, 12409.441575129107, 12455.501779928814, 12513.249205047703, 11647.475863586138, 12255.203411778228, 12348.753024939495, 12357.135000549964, 12445.06662000349, 787.5904529644567, 802.863513202757, 804.2399932064202, 804.3766081286991, 804.6419343392192, 616.7009000634689, 639.1722719078804, 773.7949443397504, 793.9087004994412, 795.0697683710073, 842.873568964654, 844.7634662294568, 845.0746432656232, 845.121074082953, 845.3026253341018, 838.0864857305505, 838.1032295443878, 838.1199740272689, 838.2916435611928, 838.7357982235576, 475.85724282715046, 487.73174753885223, 590.6072461812932, 605.1709158452948, 617.1144407774813, 12260.0, 12262.141650084408, 12269.877301226963, 12286.13997020209, 12289.69275768104, 11677.70805729855, 11812.40937953099, 12134.271943683407, 12410.875891241063, 12681.365931703378, 10785.730356741065, 10872.836907446395, 11126.499307531181, 11204.383758893258, 11590.71023224426, 3892.902677433087, 3901.9804900975596, 3902.751119641716, 3996.8800935971967, 4004.179143275651, 45543.0, 46175.30737038947, 46399.0, 46444.53555464436, 46587.30119048217, 9112.453252804853, 9233.261339092856, 9233.445993240428, 9283.814323713488, 9730.172935300438, 16368.345266189457, 17013.979161250118, 17286.308547658205, 17318.567035823955, 17483.125843707763, 6403.327650596713, 6405.19935008124, 6459.063435801782, 6459.321771214049, 6476.481881449473, 3524.506569080331, 3531.346700860349, 3554.413521768931, 3571.982140089283, 3634.254977729559, 2619.5415802234534, 2709.3091261728528, 2719.5920611908373, 2726.6591676040493, 2733.658292713411, 463.76348062488375, 475.9952400475951, 479.4007490636704, 486.406583967559, 486.4405933176875, 543.736287900368, 569.8034178208511, 571.3058633760002, 572.6134858970179, 573.3635664412499, 7042.914640114195, 7673.923260767321, 7732.149463559004, 7743.225677432324, 7952.045754509496, 473.76311844077964, 487.99756001219765, 509.7986295413291, 537.2129829799362, 569.6553585080966, 3352.2792599591203, 3581.7850928944345, 3908.355121404993, 3969.186316805048, 4077.55146933843, 60217.0, 67306.28855980132, 68401.0, 69256.0, 69939.0, 57942.710286448295, 58702.706486467294, 59295.40704592985, 59549.0, 59722.0, 53305.0, 54234.45765542294, 55165.72417137888, 56566.86866262652, 57951.0, 7673.079230492377, 7723.150453450004, 7829.686812527435, 7894.802629934068, 7942.722004729807, 28524.429511409242, 33021.50467742938, 33056.338873222885, 33515.497267540515, 38244.17558244153, 39178.0, 46438.76780616075, 47156.7642161787, 47984.520154798, 50022.49977500179, 10143.949280253551, 10355.741106472398, 10358.689239322832, 10436.895631043895, 10566.0, 11342.659720208407, 11493.82759258595, 11652.94173529127, 12473.750524989267, 12563.811542827048, 10248.846267305848, 10519.10587600032, 10551.208659350734, 10557.9472102639, 10822.29640709644, 10833.620823271147, 10954.945225273823, 10973.177011723992, 11090.611828586283, 11518.712032199262, 10617.097546708615, 10755.516001779783, 10827.566897324019, 11137.109031277316, 11264.887351126385, 9016.0, 9033.928464322162, 9165.404248723811, 9740.75648108803, 10194.796104078025, 9486.166007905227, 9564.95217523908, 9804.754881127743, 9847.113759761656, 9889.901100988898], "value": 6012.501070599907, "unit": "score"}], "name": "dromaeo_css", "value": 6155.853904836732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 116.0, 117.0, 115.0, 114.0, 118.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 133.0, 165.0, 127.0, 129.0, 127.0, 125.0, 168.0, 126.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 163.0, 162.0, 159.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 107.0, 76.0, 77.0, 78.0, 77.0, 103.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 111.0, 85.0, 84.0, 84.0, 117.0, 84.0, 90.0, 114.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 64.0, 65.0, 64.0, 64.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 82.0, 83.0, 83.0, 83.0, 82.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 142.0, 140.0, 140.0, 140.0, 150.0, 142.0, 138.0, 179.0, 140.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 177.0, 177.0, 177.0, 185.0, 174.0, 174.0, 177.0, 173.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 70.0, 69.0, 70.0, 70.0, 73.0, 69.0, 72.0, 69.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1546.2999999999997, "alertThreshold": 2.0}]} 22:37:49 INFO - Return code: 0 22:37:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:37:49 INFO - # TBPL SUCCESS # 22:37:49 INFO - Running post-action listener: _resource_record_post_action 22:37:49 INFO - [mozharness: 2016-10-28 05:37:49.662497Z] Finished run-tests step (success) 22:37:49 INFO - Running post-run listener: _resource_record_post_run 22:37:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391331840; Read time: 16; Write time: 306592 22:37:49 INFO - TinderboxPrint: CPU usage
13.1% 22:37:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:37:49 INFO - TinderboxPrint: I/O write bytes / time
391,331,840 / 306,592 22:37:49 INFO - TinderboxPrint: CPU idle
8,336.7 (86.9%) 22:37:49 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 22:37:49 INFO - TinderboxPrint: Swap in / out
0 / 0 22:37:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98807808; Read time: 0; Write time: 62276 22:37:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292524032; Read time: 0; Write time: 244316 22:37:50 INFO - Running post-run listener: _upload_blobber_files 22:37:50 INFO - Blob upload gear active. 22:37:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:37:50 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 22:37:50 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'] 22:37:50 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 22:37:50 INFO - (blobuploader) - INFO - Open directory for files ... 22:37:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:37:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:52 INFO - (blobuploader) - INFO - Done attempting. 22:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:53 INFO - (blobuploader) - INFO - Done attempting. 22:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:56 INFO - (blobuploader) - INFO - Done attempting. 22:37:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:37:56 INFO - Return code: 0 22:37:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:37:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:37:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c1eed9b50b271c567231dc71d292a9afef12d445f41671e9d7d0d8681e7cd073c232b2b5c22fc65ce9bdef9ddbeb4f7e74fcca86623912da8a1ae9b9c9f249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e39fe355d32b2b1aeb8e82274e57153a9ad53208298fdbf161fc971b06a299a0576993d08fee49cfd58fca4d59583486775c4a299f7c121ae51b013be34848c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56455e746df223a4405ee1a427e3e1cbb13310840640d29dacff484bafc9d3d1ca0d2d3651debea3351195c42d02d62a4edb51e7f6e6a215477926c229f115a1"} 22:37:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:37:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:37:56 INFO - Contents: 22:37:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c1eed9b50b271c567231dc71d292a9afef12d445f41671e9d7d0d8681e7cd073c232b2b5c22fc65ce9bdef9ddbeb4f7e74fcca86623912da8a1ae9b9c9f249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e39fe355d32b2b1aeb8e82274e57153a9ad53208298fdbf161fc971b06a299a0576993d08fee49cfd58fca4d59583486775c4a299f7c121ae51b013be34848c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56455e746df223a4405ee1a427e3e1cbb13310840640d29dacff484bafc9d3d1ca0d2d3651debea3351195c42d02d62a4edb51e7f6e6a215477926c229f115a1"} 22:37:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:37:56 INFO - Copying logs to upload dir... 22:37:56 INFO - mkdir: /builds/slave/test/build/upload/logs 22:37:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.106382 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-27 22:37:56.597689) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:37:56.600944) ========= 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-1477631828.699976-852342624 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/d7c1eed9b50b271c567231dc71d292a9afef12d445f41671e9d7d0d8681e7cd073c232b2b5c22fc65ce9bdef9ddbeb4f7e74fcca86623912da8a1ae9b9c9f249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e39fe355d32b2b1aeb8e82274e57153a9ad53208298fdbf161fc971b06a299a0576993d08fee49cfd58fca4d59583486775c4a299f7c121ae51b013be34848c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56455e746df223a4405ee1a427e3e1cbb13310840640d29dacff484bafc9d3d1ca0d2d3651debea3351195c42d02d62a4edb51e7f6e6a215477926c229f115a1"} build_url:https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/POSfLdVTT8CBgw0GlrSZlA/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/d7c1eed9b50b271c567231dc71d292a9afef12d445f41671e9d7d0d8681e7cd073c232b2b5c22fc65ce9bdef9ddbeb4f7e74fcca86623912da8a1ae9b9c9f249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e39fe355d32b2b1aeb8e82274e57153a9ad53208298fdbf161fc971b06a299a0576993d08fee49cfd58fca4d59583486775c4a299f7c121ae51b013be34848c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56455e746df223a4405ee1a427e3e1cbb13310840640d29dacff484bafc9d3d1ca0d2d3651debea3351195c42d02d62a4edb51e7f6e6a215477926c229f115a1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:37:56.626467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:37:56.626789) ========= 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-1477631828.699976-852342624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:37:56.709312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:37:56.709644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:37:56.709944) ========= ========= Total master_lag: 0.17 =========