builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1476506317.2 results: success (0) buildid: 20161014213134 builduid: c288ff98bbc6446384fb60ecaf184eee revision: 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.199219) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.199658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.199922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.214409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.214697) ========= 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=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 21:38:37-- 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% 214M=0s 2016-10-14 21:38:37 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.387334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.387662) ========= 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=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:37.437533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-14 21:38:37.437889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 --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 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 --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=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 21:38:37,886 truncating revision to first 12 chars 2016-10-14 21:38:37,886 Setting DEBUG logging. 2016-10-14 21:38:37,886 attempt 1/10 2016-10-14 21:38:37,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45f9fc18cf3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 21:38:41,102 unpacking tar archive at: fx-team-45f9fc18cf3d/testing/mozharness/ program finished with exit code 0 elapsedTime=3.542507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-14 21:38:40.993750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:40.994083) ========= script_repo_revision: 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:40.994466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:40.994743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 21:38:41.003270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-14 21:38:41.003560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:38:41 INFO - MultiFileLogger online at 20161014 21:38:41 in /builds/slave/test 21:38:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:38:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:38:41 INFO - {'append_to_log': False, 21:38:41 INFO - 'base_work_dir': '/builds/slave/test', 21:38:41 INFO - 'blob_upload_branch': 'Fx-Team', 21:38:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:38:41 INFO - 'branch': 'Fx-Team', 21:38:41 INFO - 'buildbot_json_path': 'buildprops.json', 21:38:41 INFO - 'config_files': ('talos/linux_config.py',), 21:38:41 INFO - 'default_actions': ('clobber', 21:38:41 INFO - 'read-buildbot-config', 21:38:41 INFO - 'download-and-extract', 21:38:41 INFO - 'populate-webroot', 21:38:41 INFO - 'create-virtualenv', 21:38:41 INFO - 'install', 21:38:41 INFO - 'run-tests'), 21:38:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:38:41 INFO - 'download_minidump_stackwalk': True, 21:38:41 INFO - 'download_symbols': 'ondemand', 21:38:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:38:41 INFO - 'tooltool.py': '/tools/tooltool.py', 21:38:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:38:41 INFO - '/tools/misc-python/virtualenv.py')}, 21:38:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:38:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:38:41 INFO - 'installer_path': 'installer.exe', 21:38:41 INFO - 'log_level': 'info', 21:38:41 INFO - 'log_name': 'talos', 21:38:41 INFO - 'log_to_console': True, 21:38:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:38:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:38:41 INFO - 'opt_config_files': (), 21:38:41 INFO - 'pip_index': False, 21:38:41 INFO - 'sps_profile': False, 21:38:41 INFO - 'sps_profile_interval': 0, 21:38:41 INFO - 'suite': 'dromaeojs-e10s', 21:38:41 INFO - 'system_bits': '32', 21:38:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:38:41 INFO - 'title': 'talos-linux64-ix-050', 21:38:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:38:41 INFO - 'use_talos_json': True, 21:38:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:38:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:38:41 INFO - 'work_dir': 'build'} 21:38:41 INFO - [mozharness: 2016-10-15 04:38:41.549740Z] Running clobber step. 21:38:41 INFO - Running pre-action listener: _resource_record_pre_action 21:38:41 INFO - Running main action method: clobber 21:38:41 INFO - rmtree: /builds/slave/test/build 21:38:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:38:42 INFO - Running post-action listener: _resource_record_post_action 21:38:42 INFO - [mozharness: 2016-10-15 04:38:42.016313Z] Finished clobber step (success) 21:38:42 INFO - [mozharness: 2016-10-15 04:38:42.016412Z] Running read-buildbot-config step. 21:38:42 INFO - Running pre-action listener: _resource_record_pre_action 21:38:42 INFO - Running main action method: read_buildbot_config 21:38:42 INFO - Using buildbot properties: 21:38:42 INFO - { 21:38:42 INFO - "project": "", 21:38:42 INFO - "product": "firefox", 21:38:42 INFO - "script_repo_revision": "production", 21:38:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:38:42 INFO - "repository": "", 21:38:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:38:42 INFO - "buildid": "20161014213134", 21:38:42 INFO - "stage_platform": "linux64-pgo", 21:38:42 INFO - "basedir": "/builds/slave/test", 21:38:42 INFO - "buildnumber": 1249, 21:38:42 INFO - "platform": "ubuntu64_hw", 21:38:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:38:42 INFO - "slavebuilddir": "test", 21:38:42 INFO - "branch": "fx-team", 21:38:42 INFO - "revision": "45f9fc18cf3dab70ba8d1982f40fea9246ae60b9", 21:38:42 INFO - "slavename": "talos-linux64-ix-050", 21:38:42 INFO - "builduid": "c288ff98bbc6446384fb60ecaf184eee", 21:38:42 INFO - "repo_path": "integration/fx-team" 21:38:42 INFO - } 21:38:42 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:38:42 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:38:42 INFO - Running post-action listener: _resource_record_post_action 21:38:42 INFO - [mozharness: 2016-10-15 04:38:42.018846Z] Finished read-buildbot-config step (success) 21:38:42 INFO - [mozharness: 2016-10-15 04:38:42.018935Z] Running download-and-extract step. 21:38:42 INFO - Running pre-action listener: _resource_record_pre_action 21:38:42 INFO - Running main action method: download_and_extract 21:38:42 INFO - mkdir: /builds/slave/test/build/tests 21:38: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')]} 21:38:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/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 21:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/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 21:38:42 INFO - Downloaded 1361 bytes. 21:38:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:42 INFO - Using the following test package requirements: 21:38:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:38:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:38:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'jsshell-linux-x86_64.zip'], 21:38:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:38:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:38:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:38:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:38:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:38:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:38:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:42 INFO - Http code: 200 21:38:42 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 21:38:42 INFO - x-amz-cf-id: vWHmkKX424xFlXBDoJ92e4ec4mvbPPeSeBgwqCCB9hQfVcU5x9Zr8A== 21:38:42 INFO - x-amz-replication-status: COMPLETED 21:38:42 INFO - x-amz-version-id: DMS3xsNvcBvftOdrafxtBYKSz.RPxtiP 21:38:42 INFO - Expected file size: 22123399 21:38:42 INFO - Obtained file size: 22123399 21:38:46 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 21:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:46 INFO - Http code: 200 21:38:46 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 21:38:46 INFO - x-amz-cf-id: kfyVG4h8dPUuRXITr0xJ6cSDaOhi6MZklNats9OJwB1qiP7VJxPNKQ== 21:38:46 INFO - x-amz-replication-status: COMPLETED 21:38:46 INFO - x-amz-version-id: DMS3xsNvcBvftOdrafxtBYKSz.RPxtiP 21:38:46 INFO - Expected file size: 22123399 21:38:46 INFO - Obtained file size: 22123399 21:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:38:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:38:51 INFO - Http code: 200 21:38:51 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 21:38:51 INFO - x-amz-cf-id: 73BGiQRdROpw0ptxymsCkUNc0kyssdKLQWxkvFf0Dc0eUdhynbBT8g== 21:38:51 INFO - x-amz-replication-status: COMPLETED 21:38:51 INFO - x-amz-version-id: lewCsRN3UlCmccprILKzvVG4gaz7GRMz 21:38:51 INFO - Expected file size: 14409028 21:38:51 INFO - Obtained file size: 14409028 21:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:51 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:51 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/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 21:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/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 21:38:52 INFO - Downloaded 59607670 bytes. 21:38:52 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:52 INFO - mkdir: /builds/slave/test/properties 21:38:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:52 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:52 INFO - Contents: 21:38:52 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:52 INFO - Running post-action listener: _resource_record_post_action 21:38:52 INFO - Running post-action listener: set_extra_try_arguments 21:38:52 INFO - [mozharness: 2016-10-15 04:38:52.694727Z] Finished download-and-extract step (success) 21:38:52 INFO - [mozharness: 2016-10-15 04:38:52.694955Z] Running populate-webroot step. 21:38:52 INFO - Running pre-action listener: _resource_record_pre_action 21:38:52 INFO - Running main action method: populate_webroot 21:38:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:52 INFO - '--tppagecycles', 21:38:52 INFO - '7'], 21:38:52 INFO - 'tests': ['tsvgm']}}, 21:38:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['damp', 'tps']}, 21:38:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'tests': ['damp', 'tps']}, 21:38:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['dromaeo_dom']}, 21:38:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['basic_compositor_video']}, 21:38:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:38:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['a11yr', 21:38:52 INFO - 'ts_paint', 21:38:52 INFO - 'tpaint', 21:38:52 INFO - 'sessionrestore', 21:38:52 INFO - 'sessionrestore_no_auto_restore', 21:38:52 INFO - 'tabpaint']}, 21:38:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['tsvgx', 21:38:52 INFO - 'tsvgr_opacity', 21:38:52 INFO - 'tart', 21:38:52 INFO - 'tscrollx', 21:38:52 INFO - 'cart']}, 21:38:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:52 INFO - 'tsvgr_opacity', 21:38:52 INFO - 'tart', 21:38:52 INFO - 'tscrollx', 21:38:52 INFO - 'cart']}, 21:38:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'talos_options': ['--disable-e10s'], 21:38:52 INFO - 'tests': ['tp5o']}, 21:38:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'tests': ['tp5o']}, 21:38:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'talos_options': ['--disable-e10s', 21:38:52 INFO - '--xperf_path', 21:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:52 INFO - 'tests': ['tp5n']}, 21:38:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:52 INFO - 'talos_options': ['--xperf_path', 21:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:52 INFO - 'tests': ['tp5n']}}, 21:38:52 INFO - 'talos.zip': {'path': '', 21:38:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:52 INFO - Running post-action listener: _resource_record_post_action 21:38:52 INFO - [mozharness: 2016-10-15 04:38:52.714860Z] Finished populate-webroot step (success) 21:38:52 INFO - [mozharness: 2016-10-15 04:38:52.714948Z] Running create-virtualenv step. 21:38:52 INFO - Running pre-action listener: _resource_record_pre_action 21:38:52 INFO - Running main action method: create_virtualenv 21:38:52 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:52 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 21:38:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:52 INFO - Using real prefix '/usr' 21:38:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:55 INFO - Installing pip.................done. 21:38:55 INFO - Return code: 0 21:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:38:55 INFO - Reading from file tmpfile_stdout 21:38:55 INFO - Output received: 21:38:55 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) 21:38:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:38:55 INFO - Using env: {'DISPLAY': ':0', 21:38:55 INFO - 'HOME': '/home/cltbld', 21:38:55 INFO - 'LANG': 'en_US.UTF-8', 21:38:55 INFO - 'LANGUAGE': 'en_US:en', 21:38:55 INFO - 'LOGNAME': 'cltbld', 21:38:55 INFO - 'MAIL': '/var/mail/cltbld', 21:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:55 INFO - 'MOZ_NO_REMOTE': '1', 21:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:55 INFO - 'NO_EM_RESTART': '1', 21:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:55 INFO - 'PWD': '/builds/slave/test', 21:38:55 INFO - 'SHELL': '/bin/bash', 21:38:55 INFO - 'SHLVL': '1', 21:38:55 INFO - 'TERM': 'linux', 21:38:55 INFO - 'TMOUT': '86400', 21:38:55 INFO - 'USER': 'cltbld', 21:38:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:55 INFO - '_': '/tools/buildbot/bin/python'} 21:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:55 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 21:38:55 INFO - Cleaning up... 21:38:55 INFO - Return code: 0 21:38:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:38:55 INFO - Using env: {'DISPLAY': ':0', 21:38:55 INFO - 'HOME': '/home/cltbld', 21:38:55 INFO - 'LANG': 'en_US.UTF-8', 21:38:55 INFO - 'LANGUAGE': 'en_US:en', 21:38:55 INFO - 'LOGNAME': 'cltbld', 21:38:55 INFO - 'MAIL': '/var/mail/cltbld', 21:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:55 INFO - 'MOZ_NO_REMOTE': '1', 21:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:55 INFO - 'NO_EM_RESTART': '1', 21:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:55 INFO - 'PWD': '/builds/slave/test', 21:38:55 INFO - 'SHELL': '/bin/bash', 21:38:55 INFO - 'SHLVL': '1', 21:38:55 INFO - 'TERM': 'linux', 21:38:55 INFO - 'TMOUT': '86400', 21:38:55 INFO - 'USER': 'cltbld', 21:38:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:55 INFO - '_': '/tools/buildbot/bin/python'} 21:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:55 INFO - Downloading/unpacking psutil>=3.1.1 21:38:55 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 21:38:55 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 21:38:55 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 21:38:55 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 21:38:55 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 21:38:55 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 21:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:57 INFO - Installing collected packages: psutil 21:38:57 INFO - Running setup.py install for psutil 21:38:58 INFO - building 'psutil._psutil_linux' extension 21:38:58 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 21:38:58 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 21:38:58 INFO - building 'psutil._psutil_posix' extension 21:38:58 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 21:38:58 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 21:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:58 INFO - Successfully installed psutil 21:38:58 INFO - Cleaning up... 21:38:58 INFO - Return code: 0 21:38:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:58 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:38:58 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 21:38:58 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 21:38:58 INFO - Using env: {'DISPLAY': ':0', 21:38:58 INFO - 'HOME': '/home/cltbld', 21:38:58 INFO - 'LANG': 'en_US.UTF-8', 21:38:58 INFO - 'LANGUAGE': 'en_US:en', 21:38:58 INFO - 'LOGNAME': 'cltbld', 21:38:58 INFO - 'MAIL': '/var/mail/cltbld', 21:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:58 INFO - 'MOZ_NO_REMOTE': '1', 21:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:58 INFO - 'NO_EM_RESTART': '1', 21:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:58 INFO - 'PWD': '/builds/slave/test', 21:38:58 INFO - 'SHELL': '/bin/bash', 21:38:58 INFO - 'SHLVL': '1', 21:38:58 INFO - 'TERM': 'linux', 21:38:58 INFO - 'TMOUT': '86400', 21:38:58 INFO - 'USER': 'cltbld', 21:38:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:58 INFO - '_': '/tools/buildbot/bin/python'} 21:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:39:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:39:00 INFO - Installing collected packages: mozsystemmonitor 21:39:00 INFO - Running setup.py install for mozsystemmonitor 21:39:00 INFO - Successfully installed mozsystemmonitor 21:39:00 INFO - Cleaning up... 21:39:00 INFO - Return code: 0 21:39:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:39:00 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')]} 21:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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')]} 21:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:00 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 21:39:00 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 21:39:00 INFO - Using env: {'DISPLAY': ':0', 21:39:00 INFO - 'HOME': '/home/cltbld', 21:39:00 INFO - 'LANG': 'en_US.UTF-8', 21:39:00 INFO - 'LANGUAGE': 'en_US:en', 21:39:00 INFO - 'LOGNAME': 'cltbld', 21:39:00 INFO - 'MAIL': '/var/mail/cltbld', 21:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:00 INFO - 'MOZ_NO_REMOTE': '1', 21:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:00 INFO - 'NO_EM_RESTART': '1', 21:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:00 INFO - 'PWD': '/builds/slave/test', 21:39:00 INFO - 'SHELL': '/bin/bash', 21:39:00 INFO - 'SHLVL': '1', 21:39:00 INFO - 'TERM': 'linux', 21:39:00 INFO - 'TMOUT': '86400', 21:39:00 INFO - 'USER': 'cltbld', 21:39:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:00 INFO - '_': '/tools/buildbot/bin/python'} 21:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:01 INFO - Downloading/unpacking jsonschema==2.5.1 21:39:01 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 21:39:01 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 21:39:01 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 21:39:01 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 21:39:01 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 21:39:01 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 21:39:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:39:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 INFO - Downloading functools32-3.2.3-2.tar.gz 21:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:39:03 INFO - warning: no files found matching '*.txt' 21:39:03 INFO - no previously-included directories found matching 'build' 21:39:03 INFO - no previously-included directories found matching 'dist' 21:39:03 INFO - no previously-included directories found matching '.git*' 21:39:03 INFO - Installing collected packages: jsonschema, functools32 21:39:03 INFO - Running setup.py install for functools32 21:39:03 INFO - warning: no files found matching '*.txt' 21:39:03 INFO - no previously-included directories found matching 'build' 21:39:03 INFO - no previously-included directories found matching 'dist' 21:39:03 INFO - no previously-included directories found matching '.git*' 21:39:03 INFO - Successfully installed jsonschema functools32 21:39:03 INFO - Cleaning up... 21:39:03 INFO - Return code: 0 21:39:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:03 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:03 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 21:39:03 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 21:39:03 INFO - Using env: {'DISPLAY': ':0', 21:39:03 INFO - 'HOME': '/home/cltbld', 21:39:03 INFO - 'LANG': 'en_US.UTF-8', 21:39:03 INFO - 'LANGUAGE': 'en_US:en', 21:39:03 INFO - 'LOGNAME': 'cltbld', 21:39:03 INFO - 'MAIL': '/var/mail/cltbld', 21:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:03 INFO - 'MOZ_NO_REMOTE': '1', 21:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:03 INFO - 'NO_EM_RESTART': '1', 21:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:03 INFO - 'PWD': '/builds/slave/test', 21:39:03 INFO - 'SHELL': '/bin/bash', 21:39:03 INFO - 'SHLVL': '1', 21:39:03 INFO - 'TERM': 'linux', 21:39:03 INFO - 'TMOUT': '86400', 21:39:03 INFO - 'USER': 'cltbld', 21:39:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:03 INFO - '_': '/tools/buildbot/bin/python'} 21:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:39:03 INFO - Cleaning up... 21:39:03 INFO - Return code: 0 21:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:03 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:03 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 21:39:03 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 21:39:03 INFO - Using env: {'DISPLAY': ':0', 21:39:03 INFO - 'HOME': '/home/cltbld', 21:39:03 INFO - 'LANG': 'en_US.UTF-8', 21:39:03 INFO - 'LANGUAGE': 'en_US:en', 21:39:03 INFO - 'LOGNAME': 'cltbld', 21:39:03 INFO - 'MAIL': '/var/mail/cltbld', 21:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:03 INFO - 'MOZ_NO_REMOTE': '1', 21:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:03 INFO - 'NO_EM_RESTART': '1', 21:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:03 INFO - 'PWD': '/builds/slave/test', 21:39:03 INFO - 'SHELL': '/bin/bash', 21:39:03 INFO - 'SHLVL': '1', 21:39:03 INFO - 'TERM': 'linux', 21:39:03 INFO - 'TMOUT': '86400', 21:39:03 INFO - 'USER': 'cltbld', 21:39:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:03 INFO - '_': '/tools/buildbot/bin/python'} 21:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:03 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 21:39:06 INFO - Downloading blobuploader-1.2.4.tar.gz 21:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:39:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 INFO - Downloading docopt-0.6.1.tar.gz 21:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 21:39:06 INFO - Running setup.py install for blobuploader 21:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:39:06 INFO - Running setup.py install for requests 21:39:07 INFO - Running setup.py install for docopt 21:39:07 INFO - Successfully installed blobuploader requests docopt 21:39:07 INFO - Cleaning up... 21:39:07 INFO - Return code: 0 21:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:07 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:07 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 21:39:07 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 21:39:07 INFO - Using env: {'DISPLAY': ':0', 21:39:07 INFO - 'HOME': '/home/cltbld', 21:39:07 INFO - 'LANG': 'en_US.UTF-8', 21:39:07 INFO - 'LANGUAGE': 'en_US:en', 21:39:07 INFO - 'LOGNAME': 'cltbld', 21:39:07 INFO - 'MAIL': '/var/mail/cltbld', 21:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:07 INFO - 'MOZ_NO_REMOTE': '1', 21:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:07 INFO - 'NO_EM_RESTART': '1', 21:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:07 INFO - 'PWD': '/builds/slave/test', 21:39:07 INFO - 'SHELL': '/bin/bash', 21:39:07 INFO - 'SHLVL': '1', 21:39:07 INFO - 'TERM': 'linux', 21:39:07 INFO - 'TMOUT': '86400', 21:39:07 INFO - 'USER': 'cltbld', 21:39:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:07 INFO - '_': '/tools/buildbot/bin/python'} 21:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:07 INFO - Running setup.py (path:/tmp/pip-IigbKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:07 INFO - Running setup.py (path:/tmp/pip-_6QKyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:07 INFO - Running setup.py (path:/tmp/pip-TvDQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:07 INFO - Running setup.py (path:/tmp/pip-vHrWVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:08 INFO - Running setup.py (path:/tmp/pip-pKfZxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:08 INFO - Running setup.py (path:/tmp/pip-TH5iEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:08 INFO - Running setup.py (path:/tmp/pip-lsLVlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:08 INFO - Running setup.py (path:/tmp/pip-fIccfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:08 INFO - Running setup.py (path:/tmp/pip-H0i_Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:08 INFO - Running setup.py (path:/tmp/pip-EtI0yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:08 INFO - Running setup.py (path:/tmp/pip-rOeFLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:08 INFO - Running setup.py (path:/tmp/pip-rPltZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:08 INFO - Running setup.py (path:/tmp/pip-230331-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:08 INFO - Running setup.py (path:/tmp/pip-lVuY7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:08 INFO - Running setup.py (path:/tmp/pip-Edx5Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:08 INFO - Running setup.py (path:/tmp/pip-5Cp13c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:08 INFO - Running setup.py (path:/tmp/pip-T4Islz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:39:08 INFO - Running setup.py install for manifestparser 21:39:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for mozcrash 21:39:09 INFO - Running setup.py install for mozdebug 21:39:09 INFO - Running setup.py install for mozdevice 21:39:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for mozfile 21:39:09 INFO - Running setup.py install for mozhttpd 21:39:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for mozinfo 21:39:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for mozInstall 21:39:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for mozleak 21:39:09 INFO - Running setup.py install for mozlog 21:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:39:09 INFO - Running setup.py install for moznetwork 21:39:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Running setup.py install for mozprocess 21:39:10 INFO - Running setup.py install for mozprofile 21:39:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Running setup.py install for mozrunner 21:39:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Running setup.py install for mozscreenshot 21:39:10 INFO - Running setup.py install for moztest 21:39:10 INFO - Running setup.py install for mozversion 21:39:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:39:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:39:10 INFO - Cleaning up... 21:39:10 INFO - Return code: 0 21:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:10 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')]} 21:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:10 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')]} 21:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:10 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:10 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 21:39:10 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 21:39:10 INFO - Using env: {'DISPLAY': ':0', 21:39:10 INFO - 'HOME': '/home/cltbld', 21:39:10 INFO - 'LANG': 'en_US.UTF-8', 21:39:10 INFO - 'LANGUAGE': 'en_US:en', 21:39:10 INFO - 'LOGNAME': 'cltbld', 21:39:10 INFO - 'MAIL': '/var/mail/cltbld', 21:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:10 INFO - 'MOZ_NO_REMOTE': '1', 21:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:10 INFO - 'NO_EM_RESTART': '1', 21:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:10 INFO - 'PWD': '/builds/slave/test', 21:39:10 INFO - 'SHELL': '/bin/bash', 21:39:10 INFO - 'SHLVL': '1', 21:39:10 INFO - 'TERM': 'linux', 21:39:10 INFO - 'TMOUT': '86400', 21:39:10 INFO - 'USER': 'cltbld', 21:39:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:10 INFO - '_': '/tools/buildbot/bin/python'} 21:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:11 INFO - Running setup.py (path:/tmp/pip-meA2i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:11 INFO - Running setup.py (path:/tmp/pip-q4OUzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:11 INFO - Running setup.py (path:/tmp/pip-XHSUEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:11 INFO - Running setup.py (path:/tmp/pip-iSMKns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:11 INFO - Running setup.py (path:/tmp/pip-CiHRp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:11 INFO - Running setup.py (path:/tmp/pip-LCBPIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:11 INFO - Running setup.py (path:/tmp/pip-L1vwZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:11 INFO - Running setup.py (path:/tmp/pip-DYrQBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:11 INFO - Running setup.py (path:/tmp/pip-Y98vGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:11 INFO - Running setup.py (path:/tmp/pip-Qgyh5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:11 INFO - Running setup.py (path:/tmp/pip-_zau2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:11 INFO - Running setup.py (path:/tmp/pip-cuqk_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:11 INFO - Running setup.py (path:/tmp/pip-OjlmQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:11 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)) 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:11 INFO - Running setup.py (path:/tmp/pip-EDPJ9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:12 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)) 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:12 INFO - Running setup.py (path:/tmp/pip-s228Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:12 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)) 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:12 INFO - Running setup.py (path:/tmp/pip-95fniH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:12 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)) 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:12 INFO - Running setup.py (path:/tmp/pip-qBSV7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:12 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)) 21:39:12 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)) 21:39:12 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)) 21:39:12 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)) 21:39:12 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)) 21:39:12 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)) 21:39:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:14 INFO - Downloading blessings-1.6.tar.gz 21:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:14 INFO - Installing collected packages: blessings 21:39:14 INFO - Running setup.py install for blessings 21:39:14 INFO - Successfully installed blessings 21:39:14 INFO - Cleaning up... 21:39:14 INFO - Return code: 0 21:39:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:39:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:14 INFO - Reading from file tmpfile_stdout 21:39:14 INFO - Current package versions: 21:39:14 INFO - argparse == 1.2.1 21:39:14 INFO - blessings == 1.6 21:39:14 INFO - blobuploader == 1.2.4 21:39:14 INFO - docopt == 0.6.1 21:39:14 INFO - functools32 == 3.2.3-2 21:39:14 INFO - jsonschema == 2.5.1 21:39:14 INFO - manifestparser == 1.1 21:39:14 INFO - mozInstall == 1.12 21:39:14 INFO - mozcrash == 0.17 21:39:14 INFO - mozdebug == 0.1 21:39:14 INFO - mozdevice == 0.48 21:39:14 INFO - mozfile == 1.2 21:39:14 INFO - mozhttpd == 0.7 21:39:14 INFO - mozinfo == 0.9 21:39:14 INFO - mozleak == 0.1 21:39:14 INFO - mozlog == 3.4 21:39:14 INFO - moznetwork == 0.27 21:39:14 INFO - mozprocess == 0.23 21:39:14 INFO - mozprofile == 0.28 21:39:14 INFO - mozrunner == 6.12 21:39:14 INFO - mozscreenshot == 0.1 21:39:14 INFO - mozsystemmonitor == 0.3 21:39:14 INFO - moztest == 0.7 21:39:14 INFO - mozversion == 1.4 21:39:14 INFO - psutil == 3.1.1 21:39:14 INFO - requests == 1.2.3 21:39:14 INFO - wsgiref == 0.1.2 21:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:14 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')]} 21:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 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')]} 21:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:14 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 21:39:14 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 21:39:14 INFO - Using env: {'DISPLAY': ':0', 21:39:14 INFO - 'HOME': '/home/cltbld', 21:39:14 INFO - 'LANG': 'en_US.UTF-8', 21:39:14 INFO - 'LANGUAGE': 'en_US:en', 21:39:14 INFO - 'LOGNAME': 'cltbld', 21:39:14 INFO - 'MAIL': '/var/mail/cltbld', 21:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:14 INFO - 'MOZ_NO_REMOTE': '1', 21:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:14 INFO - 'NO_EM_RESTART': '1', 21:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:14 INFO - 'PWD': '/builds/slave/test', 21:39:14 INFO - 'SHELL': '/bin/bash', 21:39:14 INFO - 'SHLVL': '1', 21:39:14 INFO - 'TERM': 'linux', 21:39:14 INFO - 'TMOUT': '86400', 21:39:14 INFO - 'USER': 'cltbld', 21:39:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:14 INFO - '_': '/tools/buildbot/bin/python'} 21:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 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)) 21:39:14 INFO - Cleaning up... 21:39:14 INFO - Return code: 0 21:39:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:39:14 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')]} 21:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 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')]} 21:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 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 0x7fa8732baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, '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': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', '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 21:39:14 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 21:39:14 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 21:39:14 INFO - Using env: {'DISPLAY': ':0', 21:39:14 INFO - 'HOME': '/home/cltbld', 21:39:14 INFO - 'LANG': 'en_US.UTF-8', 21:39:14 INFO - 'LANGUAGE': 'en_US:en', 21:39:14 INFO - 'LOGNAME': 'cltbld', 21:39:14 INFO - 'MAIL': '/var/mail/cltbld', 21:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:14 INFO - 'MOZ_NO_REMOTE': '1', 21:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:14 INFO - 'NO_EM_RESTART': '1', 21:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:14 INFO - 'PWD': '/builds/slave/test', 21:39:14 INFO - 'SHELL': '/bin/bash', 21:39:14 INFO - 'SHLVL': '1', 21:39:14 INFO - 'TERM': 'linux', 21:39:14 INFO - 'TMOUT': '86400', 21:39:14 INFO - 'USER': 'cltbld', 21:39:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:14 INFO - '_': '/tools/buildbot/bin/python'} 21:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:39:15 INFO - Cleaning up... 21:39:15 INFO - Return code: 0 21:39:15 INFO - Running post-action listener: _resource_record_post_action 21:39:15 INFO - Running post-action listener: _start_resource_monitoring 21:39:15 INFO - Starting resource monitoring. 21:39:15 INFO - [mozharness: 2016-10-15 04:39:15.103025Z] Finished create-virtualenv step (success) 21:39:15 INFO - [mozharness: 2016-10-15 04:39:15.103489Z] Running install step. 21:39:15 INFO - Running pre-action listener: _resource_record_pre_action 21:39:15 INFO - Running main action method: install 21:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:15 INFO - Reading from file tmpfile_stdout 21:39:15 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:39:15 INFO - Reading from file tmpfile_stdout 21:39:15 INFO - Output received: 21:39:15 INFO - Usage: mozinstall [options] installer 21:39:15 INFO - Options: 21:39:15 INFO - -h, --help show this help message and exit 21:39:15 INFO - -d DEST, --destination=DEST 21:39:15 INFO - Directory to install application into. [default: 21:39:15 INFO - "/builds/slave/test"] 21:39:15 INFO - --app=APP Application being installed. [default: firefox] 21:39:15 INFO - mkdir: /builds/slave/test/build/application 21:39:15 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'] 21:39:15 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 21:39:32 INFO - Reading from file tmpfile_stdout 21:39:32 INFO - Output received: 21:39:32 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:32 INFO - Running post-action listener: _resource_record_post_action 21:39:32 INFO - [mozharness: 2016-10-15 04:39:32.370760Z] Finished install step (success) 21:39:32 INFO - [mozharness: 2016-10-15 04:39:32.371035Z] Running run-tests step. 21:39:32 INFO - Running pre-action listener: _resource_record_pre_action 21:39:32 INFO - Running main action method: run_tests 21:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:32 INFO - Python 2.7.3 21:39:32 INFO - Return code: 0 21:39:32 INFO - grabbing minidump binary from tooltool 21:39: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')]} 21:39:32 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 0x2ba5790>, '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 0x2ba6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:32 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 21:39:32 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 21:39:32 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 21:39:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:32 INFO - Return code: 0 21:39:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:39:32 INFO - Using env: {'DISPLAY': ':0', 21:39:32 INFO - 'HOME': '/home/cltbld', 21:39:32 INFO - 'LANG': 'en_US.UTF-8', 21:39:32 INFO - 'LANGUAGE': 'en_US:en', 21:39:32 INFO - 'LOGNAME': 'cltbld', 21:39:32 INFO - 'MAIL': '/var/mail/cltbld', 21:39:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:32 INFO - 'MOZ_NO_REMOTE': '1', 21:39:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:32 INFO - 'NO_EM_RESTART': '1', 21:39:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:32 INFO - 'PWD': '/builds/slave/test', 21:39:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:32 INFO - 'SHELL': '/bin/bash', 21:39:32 INFO - 'SHLVL': '1', 21:39:32 INFO - 'TERM': 'linux', 21:39:32 INFO - 'TMOUT': '86400', 21:39:32 INFO - 'USER': 'cltbld', 21:39:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922', 21:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:32 INFO - '_': '/tools/buildbot/bin/python'} 21:39:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:39:32 INFO - mozversion application_buildid: 20161014183004 21:39:32 INFO - mozversion application_changeset: 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 21:39:32 INFO - mozversion application_display_name: Nightly 21:39:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:32 INFO - mozversion application_name: Firefox 21:39:32 INFO - mozversion application_remotingname: firefox 21:39:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:39:32 INFO - mozversion application_vendor: Mozilla 21:39:32 INFO - mozversion application_version: 52.0a1 21:39:32 INFO - mozversion platform_buildid: 20161014183004 21:39:32 INFO - mozversion platform_changeset: 45f9fc18cf3dab70ba8d1982f40fea9246ae60b9 21:39:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:39:32 INFO - mozversion platform_version: 52.0a1 21:39:32 INFO - using testdate: 1476506372 21:39:32 INFO - actual date: 1476506372 21:39:32 INFO - starting webserver on 'localhost:55939' 21:39:32 INFO - SUITE-START | Running 2 tests 21:39:32 INFO - TEST-START | dromaeo_css 21:39:32 INFO - operating with platform_type : linux_ 21:39:32 INFO - Initialising browser for dromaeo_css test... 21:39:32 INFO - TEST-INFO | started process 22080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppU4HAx/profile http://localhost:55939/getInfo.html) 21:39:36 INFO - PROCESS | 22080 | __metrics Screen width/height:1600/1200 21:39:36 INFO - PROCESS | 22080 | colorDepth:24 21:39:36 INFO - PROCESS | 22080 | Browser inner width/height: 1024/697 21:39:36 INFO - PROCESS | 22080 | __metrics 21:39:37 ERROR - PROCESS | 22080 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:39:38 INFO - TEST-INFO | 22080: exit 0 21:39:38 INFO - Browser initialized. 21:39:38 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:38 INFO - TEST-INFO | started process 22208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppU4HAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:50 INFO - PROCESS | 22208 | RSS: Main: 182685696 21:39:50 INFO - PROCESS | 22208 | 21:40:40 INFO - PROCESS | 22208 | 1476506440316 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] 21:42:51 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55939/tests/dromaeo/cssquery-ext.html) 21:42:52 INFO - PROCESS | 22208 | RSS: Main: 196235264 21:42:52 INFO - PROCESS | 22208 | 21:45:55 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-ext.html (next: http://localhost:55939/tests/dromaeo/cssquery-jquery.html) 21:45:55 INFO - PROCESS | 22208 | RSS: Main: 194736128 21:45:55 INFO - PROCESS | 22208 | 21:48:57 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55939/tests/dromaeo/cssquery-mootools.html) 21:48:58 INFO - PROCESS | 22208 | RSS: Main: 196743168 21:48:58 INFO - PROCESS | 22208 | 21:52:00 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55939/tests/dromaeo/cssquery-prototype.html) 21:52:00 INFO - PROCESS | 22208 | RSS: Main: 193187840 21:52:00 INFO - PROCESS | 22208 | 21:55:03 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55939/tests/dromaeo/cssquery-yui.html) 21:55:04 INFO - PROCESS | 22208 | RSS: Main: 196825088 21:55:04 INFO - PROCESS | 22208 | 21:58:06 INFO - PROCESS | 22208 | Cycle 1(1): loaded http://localhost:55939/tests/dromaeo/cssquery-yui.html (next: http://localhost:55939/tests/dromaeo/cssquery-dojo.html) 21:58:07 INFO - PROCESS | 22208 | RSS: Main: 196816896 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | __start_tp_report 21:58:07 INFO - PROCESS | 22208 | _x_x_mozilla_page_load 21:58:07 INFO - PROCESS | 22208 | _x_x_mozilla_page_load_details 21:58:07 INFO - PROCESS | 22208 | |i|pagename|runs| 21:58:07 INFO - PROCESS | 22208 | |0;dojo.html;3038.088573427971;3055.5722198892145;3077.1384012476506;3089.4902341113716;3096.81419114853;5257.13257312543;5343.118385466399;5381.946180538193;5421.430749771272;5491.313585801775;5272.841814745554;5384.300040994665;5386.326709161355;5416.241726158341;5467.972660136694;4913.557779799818;4944.283078953549;4953.108440480721;4994.275830004647;4998.650094493387;4953.876153096184;4956.801727930879;4966.205407134859;4980.900381992358;5048.520390562909;4955.975220123913;5010.924836127461;5040.773165207556;5049.570786483153;5083.618728595352;4695.600873925686;4713.1280713067845;4788.545088216614;4804.471508134137;4911.287863259843;4752.691075080109;4780.952190478086;4798.5441383068555;4842.806287748486;4855.077535268323;5336.828568602228;5386.326709161355;5392.05639013175;5398.4871437213405;5400.810971615974;5674.517665998395;5692.715364231772;5742.971285143548;5749.166370876242;5753.510951569122;5761.654300741969;5774.653520788724;5776.306843178803;5781.075027995543;5814.5057670098095;5429.212764149176;5435.945640543583;5446.673199607957;5447.591430642718;5450.5367043800925;5602.4957753802355;5649.519790817744;5841.561882858718;5870.207521984563;5874.030784920526;5658.264425624642;5661.34894487131;5663.575231857627;5676.375598684142;5724.084146536534;5704.8859022819315;5735.4551317624755;5735.483806457439;5735.971320143372;5736.053551164095;5550;5607.971960140173;5646.520045796154;5679.148127780783;5702.771889124471;5693.146028095819;5722.942770572241;5751.1085781703905;5784.074548072373;5787;4406.2949928012;4444.6666500012625;4445.644348452116;4451.488078870907;4499.910001799945;3878.437626544135;3900.278448487039;3942.211557688474;3971.4241434991764;4009.258287216874;5397.082495975694;5481.862953426196;5514.503694667419;5533.335999680065;5572.3034620672415;5799.043157878987;5804.9419505805245;5806.825795226066;5808.157817116495;5815.476607105381;5324.387695414999;5391.218273350342;5519.089350257163;5522.889542209134;5529.917051244234;4879.56083952446;4918.926216106761;4929.9893521827935;4932.383452068491;4994.925076123861;6002.729877155539;6008.038713805858;6014.8195554133445;6023.939760602426;6024.548158888101;5603.80386686464;5826.621269617462;5837.474627283395;5839.795607153729;5841.065429531254;5871.031279838779;5884.852878678067;5888.087346461305;5889.970550147222;6007.429294217042;5631.774729010794;5632.295963004624;5632.521235694848;5636.689982051026;5643.661380317194;5755.165501002415;5771.365149833431;5771.4805667488445;5772.134179873053;5780.537556995346;5530.861728456821;5546.722663866871;5621.213030175697;5623.2408624835125;5679.829605111853;5671.0359238930305;5686.374498805211;5692.459216374438;5713.200151978644;5742.741576629145;5358.6248962572245;5552.472515111058;5583.441655834384;5593.133064375028;5629.155626656035;5522.944770552243;5586.804461843816;5643.661380317194;5663.03728366187;5720.256366672306;5536.667799932017;5544.112941929272;5545.639533430314;5560.277163968658;5560.304961879765 21:58:07 INFO - PROCESS | 22208 | |1;ext.html;574.2649408756791;578.4995978478618;585.5198737035627;586.410657289424;588.1031427073713;41466;43037.13925721484;43063.56936430635;47379.76310118453;47485;44842;45020.77489612556;45051.09897802042;45133.097338053216;45430.54569454304;8816.294696424287;8931.55342232889;8984.640614375417;8988.730338089868;8989.820203595957;8859.468431894074;8930.330225233134;8937.821243575125;8954.910450895506;8964;8940.642374305053;8957.37298389113;8997.235235005033;9004.054574269705;9016.8647470288;8911.108889111101;8915.55422228886;8965.686200983;8971.461712297283;8986.820263594724;8786.07746186654;8821.823563528758;8828.24959878411;8900.287976961892;8914.821703565956;42041.159176816596;42299.78850105761;42343.7882810587;42351;42506.149877002594;3495.6329585393423;3578.1694712138665;3653.94519082214;3799;3986.4219688145345;32362.352752945044;32615.51076733851;32673.183170420692;32676;34469.82765086184;4025.731894453238;4205.684573656958;4290.056187638715;4317.4819021717285;4322.0491491871735;312981.67188198434;317966;319938;320522;321954.3902280497;58445.41554584485;58571;58720.41279587235;58771.41228587745;59011.704941475014;62259.481995830916;62441.37558624447;62512.687436562526;62554.37445625485;62624.373756262765;14421.269447666347;14561.053531520629;14610.853891461162;14616.123032618078;14819.25903704832;9987.450690211963;10051.798964020678;10064.043915827984;10075.193984481224;10083.394996300245;17130.40043598493;17488;17542.21060052301;17589.824101759074;17935.192916318796;6196.752129914753;6197.690115494297;6246.15676883624;6299.6535190564955;6300.810975670737;877.4866702978701;996.7807082441851;1029.9031531419014;1068.4283908109123;1120.3222050659233;31574.368512630077;31625.8418707905;31904.68095319017;32099.35801284008;32101.35797284088;1062.7768168684509;1115.654147214366;1151.6142092398973;1175.2126075529416;1191.4340688173222;15624.609384765472;16238.431654892021;16594.419195328348;16647.41734039327;16791.832081679273;778032;799947;800357;800399;803844;57126;57509.424905750406;57574;57734.133987990215;57843.71078144582;1274.5539061328645;1298.558490113366;1320.7292505036444;1326.2241588670543;1327.5220920468623;30880.53679194769;32956.67043329536;33308.500372493945;33575.83212083924;33662.326753465284;51689;51837.22244166265;52222.21666674927;52325;52406;407841;407941;409013;409716;412641.494340235;27186.592201117393;27382.315442114108;27568.862155689094;27626.44747105087;27743.86128069347;46674.53325466702;46868;47100;48305;48348;39929.2014159721;40445.393319100825;40735;42354.36468452914;42487.57512424836;40631.7968410156;40827.7958610205;41135;41446.79276603598;41737;39987.20025599413;40668;41020.1795964085;41255.7937210312;43656.56343436652;30728.846355768077;35328;36456.27087458183;36933;37063.81468092642;28021.159365219075;28052.29869253285;28072;28279.858600706866;28443.28891777722 21:58:07 INFO - PROCESS | 22208 | |2;jquery.html;383.11118205762625;384.27947598253274;384.91916697493525;398.39444045051505;414.2564097445086;15619.140947247897;16384.83615163848;18932.148053337616;19113.713294300564;19161.329353472633;11148.609798657028;15266.313015914282;15506.922465387657;18544.350947716834;18673.533161670966;5012.9749351253195;5298.258243845865;5299.231611416342;5299.5760339172775;5318.228856815779;5141.537261646451;5241.056609810252;5294.920576191341;5811.970940145294;5821;5785.190073389729;5787.855303617401;5795.304563452391;5801.970990145043;5821.330546987108;5517.5585953123855;5692.203091567184;5708;5708.743106560215;5789.623674461168;5073.492650734934;5078.873028174288;5119.25770763241;5119.846404607868;5127.66670166438;13175.538856139989;18658.90670546652;21446.463838404008;22740.20409285667;22943.31170064884;2207.9668804967937;2289.7252329720372;2312.1213938703354;2399.7360290368047;2818.873150708223;9878.357906736039;9989.051040151175;10010.099091081765;12495.812562811565;14277.643058923506;1867.738516607676;1871.2608519634805;1913.3112079651314;1964.567795085079;1980.7524059492564;82923.5853820727;83076;83344.16655833485;84227.5788621059;86725.56637216774;10100;10339.379637221791;10400.375977441226;10500.317479363817;10576.52405641748;15292.311845966959;15301.770473442908;15350.539483815503;15364.462243821412;15382.461613843461;7385.6307184640555;7429.7399591014055;7638.809029774189;7652.7704168875025;7733.458657893893;6948.652567371712;7077.787666370017;7103.396211321992;7381.520201186906;7398.556086634711;4479.731216127043;4547.363369128325;4607.677462577654;4682.578567928903;4766.523347665275;1858.3681548273653;1915.2243341446735;1966.4690533556145;1969.9704504432445;2032.4613977296028;891.7993451473496;957.8994205608311;971.8493633486821;988.7245453365078;1116.4361997191365;19261.903690481457;19375.612487750448;19380.8061919379;19423.223071076998;19912.402627921187;958.4345236310471;960.3421656165409;963.2919803944095;976.7216343342113;999.3504222255592;10470.267081304235;10773.192010599236;10785.514651840685;10868.619598314179;10941.28881622692;435349;446482;446834;447701;448520;52431;69391.65304173548;83340.58329708433;83526.582367089;84706;952.1050212800085;964.4599024546136;987.3730181334904;992.4938281476499;999.1557134221571;16445.91777041107;16670.74993875117;17282.913585431994;17389.304427823252;17438.91280543589;37122;37924.43113353247;37979.81010094932;39142;39725.20549588934;48272.517274828206;50966.74516627393;51944.22083668673;53452.732736337624;54816.45183548273;8128.309093727099;8131.9593402032615;8247.969003874516;8283.875741863756;8459.450135741157;12191.390430478263;12603.87396126027;12690;12779.61661150167;13059.151155174883;10896.78206435851;11171.72070698239;11214.55141794319;11361.091112711129;11408.315501069963;10490.583771190792;10516.57933682644;10768.676939691823;11047.226694131334;11566.132540059361;10623.256372053882;10849.186311026862;11035.11719062457;11219.831702524632;11372.31766094037;7395.593242371506;7743.225677432211;7986.440949133505;8059.420985284887;8467.95766021166;10869.402182880018;11421.486033128363;11607.593734219261;11656.88343116592;11657.53369865196 21:58:07 INFO - PROCESS | 22208 | |3;mootools.html;1483.6365090552815;1520.825105112912;1684.7641330213764;1704.9829501704978;1807.2228941555134;8332.583370831457;8616.741497755062;8898.733038008853;8906.287497000232;8935.508547029918;9081.818363632723;9219.35464517484;9246.768830779234;9253.167214950654;9327.393719408234;2264.8980795864186;2270.9545809083806;2286.1998300594823;2286.942826429336;2308.549832782608;2228.2089858100385;2232.8771917544527;2308.90764369425;2315.085541211229;2315.710536182977;2254.0983606557343;2257.3679369776487;2273.795358417742;2275.7041584594062;2275.7269127704617;2173.4131784418196;2182.2689399051337;2189.8029177373955;2193.7915897989747;2203.768604296542;2182.694422780812;2198.560287942402;2201.5486825200796;2211.159759291459;2214.1918199857096;9068.274538037007;9180.357374983754;9210.078992100804;9235.492047937361;9245.491497967609;5198.090334191539;5309.920351194735;5324.227986941911;5328.360596728378;5331.413544510101;3222.693844084808;3267.673232676737;3416.180116771982;3455.3434847378917;3455.706264967481;1052.3265110329396;1095.775366049958;1103.0954617213888;1108.0526150141675;1125.1111621818754;12604.306763128025;12623.116381853273;12705;12719.55481558141;12721.93639031799;4236.131593023423;4406.669499787528;4503.81984720614;4527.162474942146;4605.263157894788;9914.305998580174;9919.454430006419;9935.950320248352;9983.750406239902;10000;5253.947460525345;5259.710715910662;5263.7104959226845;5264.6051546134195;5266.1574148136115;4676.789544470507;4846.224604063333;4894.828680996148;4895.951040489621;4902.191138462185;3860.864869729546;3919.6668283195677;3927.7839718815167;4010.819513121858;4068.349064149722;1229.3668760588125;1260.4832018872219;1260.6659235302652;1266.6769973656842;1295.4170623219588;824.472337703858;940.7412961435523;943.8678584998106;966.429806414219;970.010589199013;5846.181534585162;5906.940930590725;6001.279846418458;6043.969780151071;6047.516198704093;411.07303031663406;419.8740377886622;420.49960546949035;422.6576473056834;424.4249042547366;3818.3317919364;4075.4294398784195;4106.7946602669745;4152.397902304149;4265.189613973335;10771.246012779187;10885.727856803485;11130.944345278222;11168.553257869595;11218.551257949754;10762.139028877671;10919.781604367869;10940.726481838017;10941.945290273497;10972;8360.372972027122;8386.119457457002;8441.746747597583;8461.19618636241;8467.53428561435;5660.971695141498;5686.715664216856;5709.3719690834805;5718.571107166896;5888.499477544286;10136.847947280648;10161.745956351151;10377.688669339932;10419.06228439444;10423.21825863048;10064.69805905824;10180.694579162637;10283.742906427398;10288;10366.740831479274;7477.214892436215;7605.087389513294;7635.121960974559;7897.960510197412;8086.636101375335;8867.423617464845;8944.821103578022;8949.686760963335;8950.194482496607;8952.373333866566;7402.407807375289;7422.406207503494;7559.886601700869;7798.805029874298;8012.078610959814;7415.480916335805;7549.50928189666;7611.238876112345;7634.885476717743;7849;6975.546589471668;7024.3141646005615;7031.753888613874;7038;7096.148462184365;5025.095482813129;5027.27104569828;5103.617228707788;5107.310513080686;5206.609504287269;5040.798368065236;5111.693298402108;5114.723947843174;5115.565176959852;5203.479652034766 21:58:07 INFO - PROCESS | 22208 | |4;prototype.html;311.24212542459105;318.7036056467486;325.0751611664813;332.0867614061333;334.1945910356042;5421.7289135543215;5529.640573362729;5550.58370622204;5555.583331250163;5596.748146333414;5377.731113444332;5389.110796718537;5442.727863606824;5505.284313039299;5549.94551035303;4010.4385386045906;4108.4864391951005;4170.4369910062205;4229.873103806891;4253.191893540233;4226.175895700339;4239.788010599473;4254.127903779733;4277.935830962538;4281.850135245251;4177.436046133778;4182.602652747984;4200.810963506634;4226.788660566975;4236.343366778139;3948.8420463181583;4144.316187829005;4166.791630427172;4190.329547272422;4226.070264541796;3634.436662317345;3643.1802844360072;3647.8176091195332;3655.8720444784303;3657.8353974070965;5322.946770532284;5336.813211537617;5343.706096164709;5376.435474275223;5395.730213489349;4474.255040534194;4704.036457032048;4724.984128412408;4814.181589129857;4817.56641902227;5642.153676948491;5644.745986430579;5661.688607126606;5706.258186435778;5752.7851777066135;3925.8822235332987;3960.1089754805225;3971.920561588752;3975.662068724133;3983.8406463741417;5487.725613719338;5852.6488410695065;5960.97019514904;5961.195238642815;5970.850728731773;3991.560928297885;4026.516817981861;4049.4330793688905;4049.8987525312104;4065.2276067547073;4053.250148722496;4079.816408261576;4092.120194158211;4098.200850834119;4123.670106391482;4608.700434471749;4723.385959825201;4771;4781.641376896747;4784.473707892129;5684.8294551163535;5721.512406774269;5722.399148089474;5730.885382292331;5771.422857714195;1392.7005693775684;1403.98211296809;1405.908615939981;1406.21252098825;1406.2687402550616;901.607800606725;917.660465627722;926.7080869526078;940.5609417591097;947.6020071569957;5324.227986941872;5401.648892822032;5410.810621628224;5421;5438.619296649275;5767.279090113736;5806.332271788799;5820.632151444407;5836.591438599257;5917.5857689961285;5321.255024296602;5534.640248383842;5568.220449137124;5569.830335629563;5588.6646801192055;3109.8134111953354;3135.294558724269;3149.4488464518618;3157.936841263162;3178.8887388941275;5832.93770770349;6127.969360153171;6160.168377269011;6168.753249870045;6180.783672571439;6018.608790428608;6026.487748541423;6055.697215139314;6094.634321940698;6127.234095738033;6171.938280617316;6201.596896201732;6212.72042758077;6215.141035123804;6267.780627678009;5619.80330688424;5897.967855625334;5912.438318359749;5917.497012753965;5971.820845374646;5884.941150588439;5899.38056504078;5942.465178133989;5945.286565612154;5979.910301345396;5781.508571771446;6102.481289090477;6226.750929962751;6229.844253893689;6230.906536401867;4182.1844740275355;4197.181549597799;4208.989842437854;4210.5157906841105;4241.724287921275;5882.764619429968;5893.499052580579;5915.733791979285;5916.230889984275;5917.230760001173;5626.549876009827;5671.914921276267;5680.630759000652;5724.227229323988;5846.707664616837;5617.213590097472;5618.578606604439;5643.746031428677;5683.60214784961;5699.772009119589;5409.702466364388;5654.236678048411;5668.093105103164;5697.578529125188;5709.54323654115;5617.045102332531;5690.601657884074;5766.452187042224;5790.507806836466;5867.882642347044;5722.799702010409;5723.942760572508;5733.655980641175;5740.282464691913;5741 21:58:07 INFO - PROCESS | 22208 | |5;yui.html;750.1448348882275;754.6264599023483;764.6788348893464;806.0528878567682;836.3351135847003;15460.536183914472;16798.748018779726;16867.57831054224;16897.324107035736;16954.152292385377;15240.161791101513;15354.616134596641;15365.615859603515;15407.07557546548;15539.766903496457;793.948393354433;814.70263353876;819.9221073997961;822.0710597025383;822.6627082896014;800.7757827808223;805.7743831727125;806.1696452653777;806.4959400374765;810.4084018666377;848.0628905059913;848.3340577646549;849.0745087854237;850.0139837788167;850.3622283287534;842.9199226073513;843.2200214801285;844.5312851367519;847.9491230526188;849.3375167369462;622.4615707413101;625.4996003197424;630.3192552043781;631.4380201620561;631.8988961766096;14121.505747298897;14212.928935355361;14322.928385358007;14329.140251584835;14347.497837575635;12418.689532761662;12429.564965226175;12468.964692040012;13319.667008324772;13384.460787009424;10471.84292235617;10775.191860610486;10836.349819010806;11472.139589530818;11683.299002059819;3794.6964242860504;3847.2305538892333;3922.4116382542848;3980.44273801668;3993.980030099831;75664.62167689126;75790.10524736925;77418.61290693567;77999.22000779977;78656.60671696662;9986.550605222783;10187.949060254652;10213.33613315132;10256.12822910046;10325.173986081096;20402.28591999273;20437.89781051085;20515.589688206153;20534.281300154424;20914.895425522776;8062.742144845917;8199.631016604268;8365.07984121746;8405.201505856934;8474.915250847536;4214.325707886724;4311.762853043113;4354.8258069677495;4363.956360436418;4488.349189367524;3394.321135772855;3507.7895326280504;3522.577290725078;3525.4006818840858;3528.7177025837873;558.3941423555488;565.1522715926111;568.7554351628756;597.1580072098408;603.6016229288737;570.5084880531093;625.8685676007998;682.1643486728717;723.8190452386904;750.7222327738772;9428.669996550088;9840.557174927002;10098.192144628412;10242.385456872611;10316.948415258026;626.971786269619;672.495628278791;693.8863124684909;724.0731863215093;741.3920585120258;4462.3752674625575;4470.485894122153;4932.383452068491;4985.152524070917;5033.295338652591;62635.6868215656;104909;119429;120250;122621.38689306496;104937;105386;107492.46253768838;107677;107986;51370.74314628403;51776.22335664968;71856;73907.63046184843;90742;9258.861117083114;9417.764555886157;9448.763780905532;10070;10224.53989570486;47153;47392.763036184595;47700.04599907913;48414.03171936612;49886.25170622371;62178.68910655599;68961;70685.29314706787;71223.64388178026;72251.27748722656;13020;13090.869091308965;13347.132436391603;13391.397387117799;13452.260125693181;13974.60253974635;14499.855001450273;14737.557873263819;14957.925210373878;15172.468963586221;11835.881641183478;12186.268823870596;12267.754644906874;13971.510997115052;14227.857721422653;13781.173129612256;13932.512362067278;14182.503612373517;14413.351399186851;14552.49066282675;12783.93608031954;12820.166689165175;12873.678158046123;13315.733685326433;13333.333333333489;9933.939303630912;10038.799224015333;10314.587416503256;10394.844077338998;10493.160547156362;9602.567884445078;10890.346579205274;11386.886131138583;11391.715207119889;11623.418829058683 21:58:07 INFO - PROCESS | 22208 | __end_tp_report 21:58:07 INFO - PROCESS | 22208 | __start_cc_report 21:58:07 INFO - PROCESS | 22208 | _x_x_mozilla_cycle_collect,320 21:58:07 INFO - PROCESS | 22208 | __end_cc_report 21:58:07 INFO - PROCESS | 22208 | __startTimestamp1476507487112__endTimestamp 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | ------- Summary: start ------- 21:58:07 INFO - PROCESS | 22208 | Number of tests: 6 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#0] dojo.html Cycles:165 Average:5348.73 Median:5552.47 stddev:606.15 (10.9%) stddev-sans-first:580.27 21:58:07 INFO - PROCESS | 22208 | Values: 3038.1 3055.6 3077.1 3089.5 3096.8 5257.1 5343.1 5381.9 5421.4 5491.3 5272.8 5384.3 5386.3 5416.2 5468.0 4913.6 4944.3 4953.1 4994.3 4998.7 4953.9 4956.8 4966.2 4980.9 5048.5 4956.0 5010.9 5040.8 5049.6 5083.6 4695.6 4713.1 4788.5 4804.5 4911.3 4752.7 4781.0 4798.5 4842.8 4855.1 5336.8 5386.3 5392.1 5398.5 5400.8 5674.5 5692.7 5743.0 5749.2 5753.5 5761.7 5774.7 5776.3 5781.1 5814.5 5429.2 5435.9 5446.7 5447.6 5450.5 5602.5 5649.5 5841.6 5870.2 5874.0 5658.3 5661.3 5663.6 5676.4 5724.1 5704.9 5735.5 5735.5 5736.0 5736.1 5550.0 5608.0 5646.5 5679.1 5702.8 5693.1 5722.9 5751.1 5784.1 5787.0 4406.3 4444.7 4445.6 4451.5 4499.9 3878.4 3900.3 3942.2 3971.4 4009.3 5397.1 5481.9 5514.5 5533.3 5572.3 5799.0 5804.9 5806.8 5808.2 5815.5 5324.4 5391.2 5519.1 5522.9 5529.9 4879.6 4918.9 4930.0 4932.4 4994.9 6002.7 6008.0 6014.8 6023.9 6024.5 5603.8 5826.6 5837.5 5839.8 5841.1 5871.0 5884.9 5888.1 5890.0 6007.4 5631.8 5632.3 5632.5 5636.7 5643.7 5755.2 5771.4 5771.5 5772.1 5780.5 5530.9 5546.7 5621.2 5623.2 5679.8 5671.0 5686.4 5692.5 5713.2 5742.7 5358.6 5552.5 5583.4 5593.1 5629.2 5522.9 5586.8 5643.7 5663.0 5720.3 5536.7 5544.1 5545.6 5560.3 5560.3 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#1] ext.html Cycles:180 Average:65794.57 Median:41889.08 stddev:147774.08 (352.8%) stddev-sans-first:148107.49 21:58:07 INFO - PROCESS | 22208 | Values: 574.3 578.5 585.5 586.4 588.1 41466.0 43037.1 43063.6 47379.8 47485.0 44842.0 45020.8 45051.1 45133.1 45430.5 8816.3 8931.6 8984.6 8988.7 8989.8 8859.5 8930.3 8937.8 8954.9 8964.0 8940.6 8957.4 8997.2 9004.1 9016.9 8911.1 8915.6 8965.7 8971.5 8986.8 8786.1 8821.8 8828.2 8900.3 8914.8 42041.2 42299.8 42343.8 42351.0 42506.1 3495.6 3578.2 3653.9 3799.0 3986.4 32362.4 32615.5 32673.2 32676.0 34469.8 4025.7 4205.7 4290.1 4317.5 4322.0 312981.7 317966.0 319938.0 320522.0 321954.4 58445.4 58571.0 58720.4 58771.4 59011.7 62259.5 62441.4 62512.7 62554.4 62624.4 14421.3 14561.1 14610.9 14616.1 14819.3 9987.5 10051.8 10064.0 10075.2 10083.4 17130.4 17488.0 17542.2 17589.8 17935.2 6196.8 6197.7 6246.2 6299.7 6300.8 877.5 996.8 1029.9 1068.4 1120.3 31574.4 31625.8 31904.7 32099.4 32101.4 1062.8 1115.7 1151.6 1175.2 1191.4 15624.6 16238.4 16594.4 16647.4 16791.8 778032.0 799947.0 800357.0 800399.0 803844.0 57126.0 57509.4 57574.0 57734.1 57843.7 1274.6 1298.6 1320.7 1326.2 1327.5 30880.5 32956.7 33308.5 33575.8 33662.3 51689.0 51837.2 52222.2 52325.0 52406.0 407841.0 407941.0 409013.0 409716.0 412641.5 27186.6 27382.3 27568.9 27626.4 27743.9 46674.5 46868.0 47100.0 48305.0 48348.0 39929.2 40445.4 40735.0 42354.4 42487.6 40631.8 40827.8 41135.0 41446.8 41737.0 39987.2 40668.0 41020.2 41255.8 43656.6 30728.8 35328.0 36456.3 36933.0 37063.8 28021.2 28052.3 28072.0 28279.9 28443.3 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#2] jquery.html Cycles:180 Average:26706.76 Median:39433.60 stddev:73357.55 (186.0%) stddev-sans-first:73536.71 21:58:07 INFO - PROCESS | 22208 | Values: 383.1 384.3 384.9 398.4 414.3 15619.1 16384.8 18932.1 19113.7 19161.3 11148.6 15266.3 15506.9 18544.4 18673.5 5013.0 5298.3 5299.2 5299.6 5318.2 5141.5 5241.1 5294.9 5812.0 5821.0 5785.2 5787.9 5795.3 5802.0 5821.3 5517.6 5692.2 5708.0 5708.7 5789.6 5073.5 5078.9 5119.3 5119.8 5127.7 13175.5 18658.9 21446.5 22740.2 22943.3 2208.0 2289.7 2312.1 2399.7 2818.9 9878.4 9989.1 10010.1 12495.8 14277.6 1867.7 1871.3 1913.3 1964.6 1980.8 82923.6 83076.0 83344.2 84227.6 86725.6 10100.0 10339.4 10400.4 10500.3 10576.5 15292.3 15301.8 15350.5 15364.5 15382.5 7385.6 7429.7 7638.8 7652.8 7733.5 6948.7 7077.8 7103.4 7381.5 7398.6 4479.7 4547.4 4607.7 4682.6 4766.5 1858.4 1915.2 1966.5 1970.0 2032.5 891.8 957.9 971.8 988.7 1116.4 19261.9 19375.6 19380.8 19423.2 19912.4 958.4 960.3 963.3 976.7 999.4 10470.3 10773.2 10785.5 10868.6 10941.3 435349.0 446482.0 446834.0 447701.0 448520.0 52431.0 69391.7 83340.6 83526.6 84706.0 952.1 964.5 987.4 992.5 999.2 16445.9 16670.7 17282.9 17389.3 17438.9 37122.0 37924.4 37979.8 39142.0 39725.2 48272.5 50966.7 51944.2 53452.7 54816.5 8128.3 8132.0 8248.0 8283.9 8459.5 12191.4 12603.9 12690.0 12779.6 13059.2 10896.8 11171.7 11214.6 11361.1 11408.3 10490.6 10516.6 10768.7 11047.2 11566.1 10623.3 10849.2 11035.1 11219.8 11372.3 7395.6 7743.2 7986.4 8059.4 8468.0 10869.4 11421.5 11607.6 11656.9 11657.5 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#3] mootools.html Cycles:180 Average:5816.32 Median:4641.03 stddev:3389.29 (73.0%) stddev-sans-first:3383.16 21:58:07 INFO - PROCESS | 22208 | Values: 1483.6 1520.8 1684.8 1705.0 1807.2 8332.6 8616.7 8898.7 8906.3 8935.5 9081.8 9219.4 9246.8 9253.2 9327.4 2264.9 2271.0 2286.2 2286.9 2308.5 2228.2 2232.9 2308.9 2315.1 2315.7 2254.1 2257.4 2273.8 2275.7 2275.7 2173.4 2182.3 2189.8 2193.8 2203.8 2182.7 2198.6 2201.5 2211.2 2214.2 9068.3 9180.4 9210.1 9235.5 9245.5 5198.1 5309.9 5324.2 5328.4 5331.4 3222.7 3267.7 3416.2 3455.3 3455.7 1052.3 1095.8 1103.1 1108.1 1125.1 12604.3 12623.1 12705.0 12719.6 12721.9 4236.1 4406.7 4503.8 4527.2 4605.3 9914.3 9919.5 9936.0 9983.8 10000.0 5253.9 5259.7 5263.7 5264.6 5266.2 4676.8 4846.2 4894.8 4896.0 4902.2 3860.9 3919.7 3927.8 4010.8 4068.3 1229.4 1260.5 1260.7 1266.7 1295.4 824.5 940.7 943.9 966.4 970.0 5846.2 5906.9 6001.3 6044.0 6047.5 411.1 419.9 420.5 422.7 424.4 3818.3 4075.4 4106.8 4152.4 4265.2 10771.2 10885.7 11130.9 11168.6 11218.6 10762.1 10919.8 10940.7 10941.9 10972.0 8360.4 8386.1 8441.7 8461.2 8467.5 5661.0 5686.7 5709.4 5718.6 5888.5 10136.8 10161.7 10377.7 10419.1 10423.2 10064.7 10180.7 10283.7 10288.0 10366.7 7477.2 7605.1 7635.1 7898.0 8086.6 8867.4 8944.8 8949.7 8950.2 8952.4 7402.4 7422.4 7559.9 7798.8 8012.1 7415.5 7549.5 7611.2 7634.9 7849.0 6975.5 7024.3 7031.8 7038.0 7096.1 5025.1 5027.3 5103.6 5107.3 5206.6 5040.8 5111.7 5114.7 5115.6 5203.5 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#4] prototype.html Cycles:180 Average:4803.65 Median:5550.26 stddev:1447.95 (26.1%) stddev-sans-first:1412.21 21:58:07 INFO - PROCESS | 22208 | Values: 311.2 318.7 325.1 332.1 334.2 5421.7 5529.6 5550.6 5555.6 5596.7 5377.7 5389.1 5442.7 5505.3 5549.9 4010.4 4108.5 4170.4 4229.9 4253.2 4226.2 4239.8 4254.1 4277.9 4281.9 4177.4 4182.6 4200.8 4226.8 4236.3 3948.8 4144.3 4166.8 4190.3 4226.1 3634.4 3643.2 3647.8 3655.9 3657.8 5322.9 5336.8 5343.7 5376.4 5395.7 4474.3 4704.0 4725.0 4814.2 4817.6 5642.2 5644.7 5661.7 5706.3 5752.8 3925.9 3960.1 3971.9 3975.7 3983.8 5487.7 5852.6 5961.0 5961.2 5970.9 3991.6 4026.5 4049.4 4049.9 4065.2 4053.3 4079.8 4092.1 4098.2 4123.7 4608.7 4723.4 4771.0 4781.6 4784.5 5684.8 5721.5 5722.4 5730.9 5771.4 1392.7 1404.0 1405.9 1406.2 1406.3 901.6 917.7 926.7 940.6 947.6 5324.2 5401.6 5410.8 5421.0 5438.6 5767.3 5806.3 5820.6 5836.6 5917.6 5321.3 5534.6 5568.2 5569.8 5588.7 3109.8 3135.3 3149.4 3157.9 3178.9 5832.9 6128.0 6160.2 6168.8 6180.8 6018.6 6026.5 6055.7 6094.6 6127.2 6171.9 6201.6 6212.7 6215.1 6267.8 5619.8 5898.0 5912.4 5917.5 5971.8 5884.9 5899.4 5942.5 5945.3 5979.9 5781.5 6102.5 6226.8 6229.8 6230.9 4182.2 4197.2 4209.0 4210.5 4241.7 5882.8 5893.5 5915.7 5916.2 5917.2 5626.5 5671.9 5680.6 5724.2 5846.7 5617.2 5618.6 5643.7 5683.6 5699.8 5409.7 5654.2 5668.1 5697.6 5709.5 5617.0 5690.6 5766.5 5790.5 5867.9 5722.8 5723.9 5733.7 5740.3 5741.0 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [#5] yui.html Cycles:180 Average:19892.34 Median:4104.15 stddev:28841.37 (702.7%) stddev-sans-first:28886.46 21:58:07 INFO - PROCESS | 22208 | Values: 750.1 754.6 764.7 806.1 836.3 15460.5 16798.7 16867.6 16897.3 16954.2 15240.2 15354.6 15365.6 15407.1 15539.8 793.9 814.7 819.9 822.1 822.7 800.8 805.8 806.2 806.5 810.4 848.1 848.3 849.1 850.0 850.4 842.9 843.2 844.5 847.9 849.3 622.5 625.5 630.3 631.4 631.9 14121.5 14212.9 14322.9 14329.1 14347.5 12418.7 12429.6 12469.0 13319.7 13384.5 10471.8 10775.2 10836.3 11472.1 11683.3 3794.7 3847.2 3922.4 3980.4 3994.0 75664.6 75790.1 77418.6 77999.2 78656.6 9986.6 10187.9 10213.3 10256.1 10325.2 20402.3 20437.9 20515.6 20534.3 20914.9 8062.7 8199.6 8365.1 8405.2 8474.9 4214.3 4311.8 4354.8 4364.0 4488.3 3394.3 3507.8 3522.6 3525.4 3528.7 558.4 565.2 568.8 597.2 603.6 570.5 625.9 682.2 723.8 750.7 9428.7 9840.6 10098.2 10242.4 10316.9 627.0 672.5 693.9 724.1 741.4 4462.4 4470.5 4932.4 4985.2 5033.3 62635.7 104909.0 119429.0 120250.0 122621.4 104937.0 105386.0 107492.5 107677.0 107986.0 51370.7 51776.2 71856.0 73907.6 90742.0 9258.9 9417.8 9448.8 10070.0 10224.5 47153.0 47392.8 47700.0 48414.0 49886.3 62178.7 68961.0 70685.3 71223.6 72251.3 13020.0 13090.9 13347.1 13391.4 13452.3 13974.6 14499.9 14737.6 14957.9 15172.5 11835.9 12186.3 12267.8 13971.5 14227.9 13781.2 13932.5 14182.5 14413.4 14552.5 12783.9 12820.2 12873.7 13315.7 13333.3 9933.9 10038.8 10314.6 10394.8 10493.2 9602.6 10890.3 11386.9 11391.7 11623.4 21:58:07 INFO - PROCESS | 22208 | -------- Summary: end -------- 21:58:07 INFO - PROCESS | 22208 | 21:58:07 INFO - PROCESS | 22208 | [Parent 22208] WARNING: pipe error (77): Connection reset by peer: file /builds/slave/fx-team-l64-pgo-00000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 322 21:58:08 INFO - TEST-INFO | 22208: exit 0 21:58:08 INFO - TEST-OK | dromaeo_css | took 1115548ms 21:58:08 INFO - TEST-START | kraken 21:58:08 INFO - operating with platform_type : linux_ 21:58:08 INFO - Initialising browser for kraken test... 21:58:08 INFO - TEST-INFO | started process 22570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTArK72/profile http://localhost:55939/getInfo.html) 21:58:12 INFO - PROCESS | 22570 | __metrics Screen width/height:1600/1200 21:58:12 INFO - PROCESS | 22570 | colorDepth:24 21:58:12 INFO - PROCESS | 22570 | Browser inner width/height: 1024/697 21:58:12 INFO - PROCESS | 22570 | __metrics 21:58:13 ERROR - PROCESS | 22570 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:58:14 INFO - TEST-INFO | 22570: exit 0 21:58:14 INFO - Browser initialized. 21:58:14 INFO - Running cycle 1/1 for kraken test... 21:58:14 INFO - TEST-INFO | started process 22693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTArK72/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:26 INFO - PROCESS | 22693 | RSS: Main: 182775808 21:58:26 INFO - PROCESS | 22693 | 21:58:29 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55939/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:30 INFO - PROCESS | 22693 | RSS: Main: 196657152 21:58:30 INFO - PROCESS | 22693 | 21:58:32 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55939/tests/kraken/driver.html?testName=audio-dft) 21:58:33 INFO - PROCESS | 22693 | RSS: Main: 194441216 21:58:33 INFO - PROCESS | 22693 | 21:58:36 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55939/tests/kraken/driver.html?testName=audio-fft) 21:58:36 INFO - PROCESS | 22693 | RSS: Main: 190799872 21:58:36 INFO - PROCESS | 22693 | 21:58:38 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55939/tests/kraken/driver.html?testName=audio-oscillator) 21:58:39 INFO - PROCESS | 22693 | RSS: Main: 191315968 21:58:39 INFO - PROCESS | 22693 | 21:58:41 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:42 INFO - PROCESS | 22693 | RSS: Main: 191594496 21:58:42 INFO - PROCESS | 22693 | 21:58:45 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55939/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:46 INFO - PROCESS | 22693 | RSS: Main: 192229376 21:58:46 INFO - PROCESS | 22693 | 21:58:49 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55939/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:50 INFO - PROCESS | 22693 | RSS: Main: 190545920 21:58:50 INFO - PROCESS | 22693 | 21:58:52 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55939/tests/kraken/driver.html?testName=json-parse-financial) 21:58:53 INFO - PROCESS | 22693 | RSS: Main: 191619072 21:58:53 INFO - PROCESS | 22693 | 21:58:54 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:55 INFO - PROCESS | 22693 | RSS: Main: 191963136 21:58:55 INFO - PROCESS | 22693 | 21:58:57 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:58 INFO - PROCESS | 22693 | RSS: Main: 191705088 21:58:58 INFO - PROCESS | 22693 | 21:59:00 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:59:00 INFO - PROCESS | 22693 | RSS: Main: 192081920 21:59:00 INFO - PROCESS | 22693 | 21:59:03 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:59:04 INFO - PROCESS | 22693 | RSS: Main: 191881216 21:59:04 INFO - PROCESS | 22693 | 21:59:07 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:59:07 INFO - PROCESS | 22693 | RSS: Main: 192360448 21:59:07 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | Cycle 1(1): loaded http://localhost:55939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55939/tests/kraken/driver.html?testName=ai-astar) 21:59:09 INFO - PROCESS | 22693 | RSS: Main: 193798144 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | __start_tp_report 21:59:09 INFO - PROCESS | 22693 | _x_x_mozilla_page_load 21:59:09 INFO - PROCESS | 22693 | _x_x_mozilla_page_load_details 21:59:09 INFO - PROCESS | 22693 | |i|pagename|runs| 21:59:09 INFO - PROCESS | 22693 | |0;ai-astar;108;113;113;112;112;113;112;114;113;113 21:59:09 INFO - PROCESS | 22693 | |1;audio-beat-detection;157;124;127;164;127;122;125;125;171;123 21:59:09 INFO - PROCESS | 22693 | |2;audio-dft;164;163;167;167;164;164;162;163;163;161 21:59:09 INFO - PROCESS | 22693 | |3;audio-fft;77;77;76;110;77;76;75;76;99;77 21:59:09 INFO - PROCESS | 22693 | |4;audio-oscillator;84;82;113;83;83;85;107;83;82;112 21:59:09 INFO - PROCESS | 22693 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;119;117 21:59:09 INFO - PROCESS | 22693 | |6;imaging-darkroom;147;149;148;148;147;148;148;146;148;147 21:59:09 INFO - PROCESS | 22693 | |7;imaging-desaturate;85;87;85;85;85;85;86;86;85;84 21:59:09 INFO - PROCESS | 22693 | |8;json-parse-financial;54;54;53;56;55;57;55;54;54;56 21:59:09 INFO - PROCESS | 22693 | |9;json-stringify-tinderbox;63;61;61;62;61;61;60;61;60;60 21:59:09 INFO - PROCESS | 22693 | |10;stanford-crypto-aes;80;81;80;80;82;86;86;87;82;80 21:59:09 INFO - PROCESS | 22693 | |11;stanford-crypto-ccm;135;133;146;144;135;133;132;135;175;132 21:59:09 INFO - PROCESS | 22693 | |12;stanford-crypto-pbkdf2;170;167;167;174;166;171;171;169;163;171 21:59:09 INFO - PROCESS | 22693 | |13;stanford-crypto-sha256-iterative;72;68;68;66;69;75;67;65;64;69 21:59:09 INFO - PROCESS | 22693 | __end_tp_report 21:59:09 INFO - PROCESS | 22693 | __start_cc_report 21:59:09 INFO - PROCESS | 22693 | _x_x_mozilla_cycle_collect,802 21:59:09 INFO - PROCESS | 22693 | __end_cc_report 21:59:09 INFO - PROCESS | 22693 | __startTimestamp1476507549637__endTimestamp 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | ------- Summary: start ------- 21:59:09 INFO - PROCESS | 22693 | Number of tests: 14 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.64 (1.4%) stddev-sans-first:0.67 21:59:09 INFO - PROCESS | 22693 | Values: 108.0 113.0 113.0 112.0 112.0 113.0 112.0 114.0 113.0 113.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:127.00 stddev:19.32 (15.2%) stddev-sans-first:19.02 21:59:09 INFO - PROCESS | 22693 | Values: 157.0 124.0 127.0 164.0 127.0 122.0 125.0 125.0 171.0 123.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.93 (1.2%) stddev-sans-first:2.05 21:59:09 INFO - PROCESS | 22693 | Values: 164.0 163.0 167.0 167.0 164.0 164.0 162.0 163.0 163.0 161.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.16 (15.8%) stddev-sans-first:12.76 21:59:09 INFO - PROCESS | 22693 | Values: 77.0 77.0 76.0 110.0 77.0 76.0 75.0 76.0 99.0 77.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.00 stddev:13.41 (16.2%) stddev-sans-first:13.95 21:59:09 INFO - PROCESS | 22693 | Values: 84.0 82.0 113.0 83.0 83.0 85.0 107.0 83.0 82.0 112.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 21:59:09 INFO - PROCESS | 22693 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 117.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 21:59:09 INFO - PROCESS | 22693 | Values: 147.0 149.0 148.0 148.0 147.0 148.0 148.0 146.0 148.0 147.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 21:59:09 INFO - PROCESS | 22693 | Values: 85.0 87.0 85.0 85.0 85.0 85.0 86.0 86.0 85.0 84.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.27 21:59:09 INFO - PROCESS | 22693 | Values: 54.0 54.0 53.0 56.0 55.0 57.0 55.0 54.0 54.0 56.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 21:59:09 INFO - PROCESS | 22693 | Values: 63.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 60.0 60.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.84 (3.5%) stddev-sans-first:2.87 21:59:09 INFO - PROCESS | 22693 | Values: 80.0 81.0 80.0 80.0 82.0 86.0 86.0 87.0 82.0 80.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:135.00 stddev:13.24 (9.8%) stddev-sans-first:13.92 21:59:09 INFO - PROCESS | 22693 | Values: 135.0 133.0 146.0 144.0 135.0 133.0 132.0 135.0 175.0 132.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:170.50 stddev:3.18 (1.9%) stddev-sans-first:3.35 21:59:09 INFO - PROCESS | 22693 | Values: 170.0 167.0 167.0 174.0 166.0 171.0 171.0 169.0 163.0 171.0 21:59:09 INFO - PROCESS | 22693 | 21:59:09 INFO - PROCESS | 22693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:3.27 (4.8%) stddev-sans-first:3.18 21:59:09 INFO - PROCESS | 22693 | Values: 72.0 68.0 68.0 66.0 69.0 75.0 67.0 65.0 64.0 69.0 21:59:09 INFO - PROCESS | 22693 | -------- Summary: end -------- 21:59:09 INFO - PROCESS | 22693 | 21:59:10 INFO - TEST-INFO | 22693: exit 0 21:59:10 INFO - TEST-OK | kraken | took 62540ms 21:59:10 INFO - SUITE-END | took 1178s 21:59:10 INFO - Completed test suite (00:19:38) 21:59:10 INFO - javascript benchmark 21:59:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7159.770081093674, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.088573427971, 3055.5722198892145, 3077.1384012476506, 3089.4902341113716, 3096.81419114853, 5257.13257312543, 5343.118385466399, 5381.946180538193, 5421.430749771272, 5491.313585801775, 5272.841814745554, 5384.300040994665, 5386.326709161355, 5416.241726158341, 5467.972660136694, 4913.557779799818, 4944.283078953549, 4953.108440480721, 4994.275830004647, 4998.650094493387, 4953.876153096184, 4956.801727930879, 4966.205407134859, 4980.900381992358, 5048.520390562909, 4955.975220123913, 5010.924836127461, 5040.773165207556, 5049.570786483153, 5083.618728595352, 4695.600873925686, 4713.1280713067845, 4788.545088216614, 4804.471508134137, 4911.287863259843, 4752.691075080109, 4780.952190478086, 4798.5441383068555, 4842.806287748486, 4855.077535268323, 5336.828568602228, 5386.326709161355, 5392.05639013175, 5398.4871437213405, 5400.810971615974, 5674.517665998395, 5692.715364231772, 5742.971285143548, 5749.166370876242, 5753.510951569122, 5761.654300741969, 5774.653520788724, 5776.306843178803, 5781.075027995543, 5814.5057670098095, 5429.212764149176, 5435.945640543583, 5446.673199607957, 5447.591430642718, 5450.5367043800925, 5602.4957753802355, 5649.519790817744, 5841.561882858718, 5870.207521984563, 5874.030784920526, 5658.264425624642, 5661.34894487131, 5663.575231857627, 5676.375598684142, 5724.084146536534, 5704.8859022819315, 5735.4551317624755, 5735.483806457439, 5735.971320143372, 5736.053551164095, 5550.0, 5607.971960140173, 5646.520045796154, 5679.148127780783, 5702.771889124471, 5693.146028095819, 5722.942770572241, 5751.1085781703905, 5784.074548072373, 5787.0, 4406.2949928012, 4444.6666500012625, 4445.644348452116, 4451.488078870907, 4499.910001799945, 3878.437626544135, 3900.278448487039, 3942.211557688474, 3971.4241434991764, 4009.258287216874, 5397.082495975694, 5481.862953426196, 5514.503694667419, 5533.335999680065, 5572.3034620672415, 5799.043157878987, 5804.9419505805245, 5806.825795226066, 5808.157817116495, 5815.476607105381, 5324.387695414999, 5391.218273350342, 5519.089350257163, 5522.889542209134, 5529.917051244234, 4879.56083952446, 4918.926216106761, 4929.9893521827935, 4932.383452068491, 4994.925076123861, 6002.729877155539, 6008.038713805858, 6014.8195554133445, 6023.939760602426, 6024.548158888101, 5603.80386686464, 5826.621269617462, 5837.474627283395, 5839.795607153729, 5841.065429531254, 5871.031279838779, 5884.852878678067, 5888.087346461305, 5889.970550147222, 6007.429294217042, 5631.774729010794, 5632.295963004624, 5632.521235694848, 5636.689982051026, 5643.661380317194, 5755.165501002415, 5771.365149833431, 5771.4805667488445, 5772.134179873053, 5780.537556995346, 5530.861728456821, 5546.722663866871, 5621.213030175697, 5623.2408624835125, 5679.829605111853, 5671.0359238930305, 5686.374498805211, 5692.459216374438, 5713.200151978644, 5742.741576629145, 5358.6248962572245, 5552.472515111058, 5583.441655834384, 5593.133064375028, 5629.155626656035, 5522.944770552243, 5586.804461843816, 5643.661380317194, 5663.03728366187, 5720.256366672306, 5536.667799932017, 5544.112941929272, 5545.639533430314, 5560.277163968658, 5560.304961879765], "value": 5307.465552408072, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2649408756791, 578.4995978478618, 585.5198737035627, 586.410657289424, 588.1031427073713, 41466.0, 43037.13925721484, 43063.56936430635, 47379.76310118453, 47485.0, 44842.0, 45020.77489612556, 45051.09897802042, 45133.097338053216, 45430.54569454304, 8816.294696424287, 8931.55342232889, 8984.640614375417, 8988.730338089868, 8989.820203595957, 8859.468431894074, 8930.330225233134, 8937.821243575125, 8954.910450895506, 8964.0, 8940.642374305053, 8957.37298389113, 8997.235235005033, 9004.054574269705, 9016.8647470288, 8911.108889111101, 8915.55422228886, 8965.686200983, 8971.461712297283, 8986.820263594724, 8786.07746186654, 8821.823563528758, 8828.24959878411, 8900.287976961892, 8914.821703565956, 42041.159176816596, 42299.78850105761, 42343.7882810587, 42351.0, 42506.149877002594, 3495.6329585393423, 3578.1694712138665, 3653.94519082214, 3799.0, 3986.4219688145345, 32362.352752945044, 32615.51076733851, 32673.183170420692, 32676.0, 34469.82765086184, 4025.731894453238, 4205.684573656958, 4290.056187638715, 4317.4819021717285, 4322.0491491871735, 312981.67188198434, 317966.0, 319938.0, 320522.0, 321954.3902280497, 58445.41554584485, 58571.0, 58720.41279587235, 58771.41228587745, 59011.704941475014, 62259.481995830916, 62441.37558624447, 62512.687436562526, 62554.37445625485, 62624.373756262765, 14421.269447666347, 14561.053531520629, 14610.853891461162, 14616.123032618078, 14819.25903704832, 9987.450690211963, 10051.798964020678, 10064.043915827984, 10075.193984481224, 10083.394996300245, 17130.40043598493, 17488.0, 17542.21060052301, 17589.824101759074, 17935.192916318796, 6196.752129914753, 6197.690115494297, 6246.15676883624, 6299.6535190564955, 6300.810975670737, 877.4866702978701, 996.7807082441851, 1029.9031531419014, 1068.4283908109123, 1120.3222050659233, 31574.368512630077, 31625.8418707905, 31904.68095319017, 32099.35801284008, 32101.35797284088, 1062.7768168684509, 1115.654147214366, 1151.6142092398973, 1175.2126075529416, 1191.4340688173222, 15624.609384765472, 16238.431654892021, 16594.419195328348, 16647.41734039327, 16791.832081679273, 778032.0, 799947.0, 800357.0, 800399.0, 803844.0, 57126.0, 57509.424905750406, 57574.0, 57734.133987990215, 57843.71078144582, 1274.5539061328645, 1298.558490113366, 1320.7292505036444, 1326.2241588670543, 1327.5220920468623, 30880.53679194769, 32956.67043329536, 33308.500372493945, 33575.83212083924, 33662.326753465284, 51689.0, 51837.22244166265, 52222.21666674927, 52325.0, 52406.0, 407841.0, 407941.0, 409013.0, 409716.0, 412641.494340235, 27186.592201117393, 27382.315442114108, 27568.862155689094, 27626.44747105087, 27743.86128069347, 46674.53325466702, 46868.0, 47100.0, 48305.0, 48348.0, 39929.2014159721, 40445.393319100825, 40735.0, 42354.36468452914, 42487.57512424836, 40631.7968410156, 40827.7958610205, 41135.0, 41446.79276603598, 41737.0, 39987.20025599413, 40668.0, 41020.1795964085, 41255.7937210312, 43656.56343436652, 30728.846355768077, 35328.0, 36456.27087458183, 36933.0, 37063.81468092642, 28021.159365219075, 28052.29869253285, 28072.0, 28279.858600706866, 28443.28891777722], "value": 19956.480189587743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.11118205762625, 384.27947598253274, 384.91916697493525, 398.39444045051505, 414.2564097445086, 15619.140947247897, 16384.83615163848, 18932.148053337616, 19113.713294300564, 19161.329353472633, 11148.609798657028, 15266.313015914282, 15506.922465387657, 18544.350947716834, 18673.533161670966, 5012.9749351253195, 5298.258243845865, 5299.231611416342, 5299.5760339172775, 5318.228856815779, 5141.537261646451, 5241.056609810252, 5294.920576191341, 5811.970940145294, 5821.0, 5785.190073389729, 5787.855303617401, 5795.304563452391, 5801.970990145043, 5821.330546987108, 5517.5585953123855, 5692.203091567184, 5708.0, 5708.743106560215, 5789.623674461168, 5073.492650734934, 5078.873028174288, 5119.25770763241, 5119.846404607868, 5127.66670166438, 13175.538856139989, 18658.90670546652, 21446.463838404008, 22740.20409285667, 22943.31170064884, 2207.9668804967937, 2289.7252329720372, 2312.1213938703354, 2399.7360290368047, 2818.873150708223, 9878.357906736039, 9989.051040151175, 10010.099091081765, 12495.812562811565, 14277.643058923506, 1867.738516607676, 1871.2608519634805, 1913.3112079651314, 1964.567795085079, 1980.7524059492564, 82923.5853820727, 83076.0, 83344.16655833485, 84227.5788621059, 86725.56637216774, 10100.0, 10339.379637221791, 10400.375977441226, 10500.317479363817, 10576.52405641748, 15292.311845966959, 15301.770473442908, 15350.539483815503, 15364.462243821412, 15382.461613843461, 7385.6307184640555, 7429.7399591014055, 7638.809029774189, 7652.7704168875025, 7733.458657893893, 6948.652567371712, 7077.787666370017, 7103.396211321992, 7381.520201186906, 7398.556086634711, 4479.731216127043, 4547.363369128325, 4607.677462577654, 4682.578567928903, 4766.523347665275, 1858.3681548273653, 1915.2243341446735, 1966.4690533556145, 1969.9704504432445, 2032.4613977296028, 891.7993451473496, 957.8994205608311, 971.8493633486821, 988.7245453365078, 1116.4361997191365, 19261.903690481457, 19375.612487750448, 19380.8061919379, 19423.223071076998, 19912.402627921187, 958.4345236310471, 960.3421656165409, 963.2919803944095, 976.7216343342113, 999.3504222255592, 10470.267081304235, 10773.192010599236, 10785.514651840685, 10868.619598314179, 10941.28881622692, 435349.0, 446482.0, 446834.0, 447701.0, 448520.0, 52431.0, 69391.65304173548, 83340.58329708433, 83526.582367089, 84706.0, 952.1050212800085, 964.4599024546136, 987.3730181334904, 992.4938281476499, 999.1557134221571, 16445.91777041107, 16670.74993875117, 17282.913585431994, 17389.304427823252, 17438.91280543589, 37122.0, 37924.43113353247, 37979.81010094932, 39142.0, 39725.20549588934, 48272.517274828206, 50966.74516627393, 51944.22083668673, 53452.732736337624, 54816.45183548273, 8128.309093727099, 8131.9593402032615, 8247.969003874516, 8283.875741863756, 8459.450135741157, 12191.390430478263, 12603.87396126027, 12690.0, 12779.61661150167, 13059.151155174883, 10896.78206435851, 11171.72070698239, 11214.55141794319, 11361.091112711129, 11408.315501069963, 10490.583771190792, 10516.57933682644, 10768.676939691823, 11047.226694131334, 11566.132540059361, 10623.256372053882, 10849.186311026862, 11035.11719062457, 11219.831702524632, 11372.31766094037, 7395.593242371506, 7743.225677432211, 7986.440949133505, 8059.420985284887, 8467.95766021166, 10869.402182880018, 11421.486033128363, 11607.593734219261, 11656.88343116592, 11657.53369865196], "value": 8806.46441025885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.6365090552815, 1520.825105112912, 1684.7641330213764, 1704.9829501704978, 1807.2228941555134, 8332.583370831457, 8616.741497755062, 8898.733038008853, 8906.287497000232, 8935.508547029918, 9081.818363632723, 9219.35464517484, 9246.768830779234, 9253.167214950654, 9327.393719408234, 2264.8980795864186, 2270.9545809083806, 2286.1998300594823, 2286.942826429336, 2308.549832782608, 2228.2089858100385, 2232.8771917544527, 2308.90764369425, 2315.085541211229, 2315.710536182977, 2254.0983606557343, 2257.3679369776487, 2273.795358417742, 2275.7041584594062, 2275.7269127704617, 2173.4131784418196, 2182.2689399051337, 2189.8029177373955, 2193.7915897989747, 2203.768604296542, 2182.694422780812, 2198.560287942402, 2201.5486825200796, 2211.159759291459, 2214.1918199857096, 9068.274538037007, 9180.357374983754, 9210.078992100804, 9235.492047937361, 9245.491497967609, 5198.090334191539, 5309.920351194735, 5324.227986941911, 5328.360596728378, 5331.413544510101, 3222.693844084808, 3267.673232676737, 3416.180116771982, 3455.3434847378917, 3455.706264967481, 1052.3265110329396, 1095.775366049958, 1103.0954617213888, 1108.0526150141675, 1125.1111621818754, 12604.306763128025, 12623.116381853273, 12705.0, 12719.55481558141, 12721.93639031799, 4236.131593023423, 4406.669499787528, 4503.81984720614, 4527.162474942146, 4605.263157894788, 9914.305998580174, 9919.454430006419, 9935.950320248352, 9983.750406239902, 10000.0, 5253.947460525345, 5259.710715910662, 5263.7104959226845, 5264.6051546134195, 5266.1574148136115, 4676.789544470507, 4846.224604063333, 4894.828680996148, 4895.951040489621, 4902.191138462185, 3860.864869729546, 3919.6668283195677, 3927.7839718815167, 4010.819513121858, 4068.349064149722, 1229.3668760588125, 1260.4832018872219, 1260.6659235302652, 1266.6769973656842, 1295.4170623219588, 824.472337703858, 940.7412961435523, 943.8678584998106, 966.429806414219, 970.010589199013, 5846.181534585162, 5906.940930590725, 6001.279846418458, 6043.969780151071, 6047.516198704093, 411.07303031663406, 419.8740377886622, 420.49960546949035, 422.6576473056834, 424.4249042547366, 3818.3317919364, 4075.4294398784195, 4106.7946602669745, 4152.397902304149, 4265.189613973335, 10771.246012779187, 10885.727856803485, 11130.944345278222, 11168.553257869595, 11218.551257949754, 10762.139028877671, 10919.781604367869, 10940.726481838017, 10941.945290273497, 10972.0, 8360.372972027122, 8386.119457457002, 8441.746747597583, 8461.19618636241, 8467.53428561435, 5660.971695141498, 5686.715664216856, 5709.3719690834805, 5718.571107166896, 5888.499477544286, 10136.847947280648, 10161.745956351151, 10377.688669339932, 10419.06228439444, 10423.21825863048, 10064.69805905824, 10180.694579162637, 10283.742906427398, 10288.0, 10366.740831479274, 7477.214892436215, 7605.087389513294, 7635.121960974559, 7897.960510197412, 8086.636101375335, 8867.423617464845, 8944.821103578022, 8949.686760963335, 8950.194482496607, 8952.373333866566, 7402.407807375289, 7422.406207503494, 7559.886601700869, 7798.805029874298, 8012.078610959814, 7415.480916335805, 7549.50928189666, 7611.238876112345, 7634.885476717743, 7849.0, 6975.546589471668, 7024.3141646005615, 7031.753888613874, 7038.0, 7096.148462184365, 5025.095482813129, 5027.27104569828, 5103.617228707788, 5107.310513080686, 5206.609504287269, 5040.798368065236, 5111.693298402108, 5114.723947843174, 5115.565176959852, 5203.479652034766], "value": 4530.1472131366545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.24212542459105, 318.7036056467486, 325.0751611664813, 332.0867614061333, 334.1945910356042, 5421.7289135543215, 5529.640573362729, 5550.58370622204, 5555.583331250163, 5596.748146333414, 5377.731113444332, 5389.110796718537, 5442.727863606824, 5505.284313039299, 5549.94551035303, 4010.4385386045906, 4108.4864391951005, 4170.4369910062205, 4229.873103806891, 4253.191893540233, 4226.175895700339, 4239.788010599473, 4254.127903779733, 4277.935830962538, 4281.850135245251, 4177.436046133778, 4182.602652747984, 4200.810963506634, 4226.788660566975, 4236.343366778139, 3948.8420463181583, 4144.316187829005, 4166.791630427172, 4190.329547272422, 4226.070264541796, 3634.436662317345, 3643.1802844360072, 3647.8176091195332, 3655.8720444784303, 3657.8353974070965, 5322.946770532284, 5336.813211537617, 5343.706096164709, 5376.435474275223, 5395.730213489349, 4474.255040534194, 4704.036457032048, 4724.984128412408, 4814.181589129857, 4817.56641902227, 5642.153676948491, 5644.745986430579, 5661.688607126606, 5706.258186435778, 5752.7851777066135, 3925.8822235332987, 3960.1089754805225, 3971.920561588752, 3975.662068724133, 3983.8406463741417, 5487.725613719338, 5852.6488410695065, 5960.97019514904, 5961.195238642815, 5970.850728731773, 3991.560928297885, 4026.516817981861, 4049.4330793688905, 4049.8987525312104, 4065.2276067547073, 4053.250148722496, 4079.816408261576, 4092.120194158211, 4098.200850834119, 4123.670106391482, 4608.700434471749, 4723.385959825201, 4771.0, 4781.641376896747, 4784.473707892129, 5684.8294551163535, 5721.512406774269, 5722.399148089474, 5730.885382292331, 5771.422857714195, 1392.7005693775684, 1403.98211296809, 1405.908615939981, 1406.21252098825, 1406.2687402550616, 901.607800606725, 917.660465627722, 926.7080869526078, 940.5609417591097, 947.6020071569957, 5324.227986941872, 5401.648892822032, 5410.810621628224, 5421.0, 5438.619296649275, 5767.279090113736, 5806.332271788799, 5820.632151444407, 5836.591438599257, 5917.5857689961285, 5321.255024296602, 5534.640248383842, 5568.220449137124, 5569.830335629563, 5588.6646801192055, 3109.8134111953354, 3135.294558724269, 3149.4488464518618, 3157.936841263162, 3178.8887388941275, 5832.93770770349, 6127.969360153171, 6160.168377269011, 6168.753249870045, 6180.783672571439, 6018.608790428608, 6026.487748541423, 6055.697215139314, 6094.634321940698, 6127.234095738033, 6171.938280617316, 6201.596896201732, 6212.72042758077, 6215.141035123804, 6267.780627678009, 5619.80330688424, 5897.967855625334, 5912.438318359749, 5917.497012753965, 5971.820845374646, 5884.941150588439, 5899.38056504078, 5942.465178133989, 5945.286565612154, 5979.910301345396, 5781.508571771446, 6102.481289090477, 6226.750929962751, 6229.844253893689, 6230.906536401867, 4182.1844740275355, 4197.181549597799, 4208.989842437854, 4210.5157906841105, 4241.724287921275, 5882.764619429968, 5893.499052580579, 5915.733791979285, 5916.230889984275, 5917.230760001173, 5626.549876009827, 5671.914921276267, 5680.630759000652, 5724.227229323988, 5846.707664616837, 5617.213590097472, 5618.578606604439, 5643.746031428677, 5683.60214784961, 5699.772009119589, 5409.702466364388, 5654.236678048411, 5668.093105103164, 5697.578529125188, 5709.54323654115, 5617.045102332531, 5690.601657884074, 5766.452187042224, 5790.507806836466, 5867.882642347044, 5722.799702010409, 5723.942760572508, 5733.655980641175, 5740.282464691913, 5741.0], "value": 4333.354328851187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1448348882275, 754.6264599023483, 764.6788348893464, 806.0528878567682, 836.3351135847003, 15460.536183914472, 16798.748018779726, 16867.57831054224, 16897.324107035736, 16954.152292385377, 15240.161791101513, 15354.616134596641, 15365.615859603515, 15407.07557546548, 15539.766903496457, 793.948393354433, 814.70263353876, 819.9221073997961, 822.0710597025383, 822.6627082896014, 800.7757827808223, 805.7743831727125, 806.1696452653777, 806.4959400374765, 810.4084018666377, 848.0628905059913, 848.3340577646549, 849.0745087854237, 850.0139837788167, 850.3622283287534, 842.9199226073513, 843.2200214801285, 844.5312851367519, 847.9491230526188, 849.3375167369462, 622.4615707413101, 625.4996003197424, 630.3192552043781, 631.4380201620561, 631.8988961766096, 14121.505747298897, 14212.928935355361, 14322.928385358007, 14329.140251584835, 14347.497837575635, 12418.689532761662, 12429.564965226175, 12468.964692040012, 13319.667008324772, 13384.460787009424, 10471.84292235617, 10775.191860610486, 10836.349819010806, 11472.139589530818, 11683.299002059819, 3794.6964242860504, 3847.2305538892333, 3922.4116382542848, 3980.44273801668, 3993.980030099831, 75664.62167689126, 75790.10524736925, 77418.61290693567, 77999.22000779977, 78656.60671696662, 9986.550605222783, 10187.949060254652, 10213.33613315132, 10256.12822910046, 10325.173986081096, 20402.28591999273, 20437.89781051085, 20515.589688206153, 20534.281300154424, 20914.895425522776, 8062.742144845917, 8199.631016604268, 8365.07984121746, 8405.201505856934, 8474.915250847536, 4214.325707886724, 4311.762853043113, 4354.8258069677495, 4363.956360436418, 4488.349189367524, 3394.321135772855, 3507.7895326280504, 3522.577290725078, 3525.4006818840858, 3528.7177025837873, 558.3941423555488, 565.1522715926111, 568.7554351628756, 597.1580072098408, 603.6016229288737, 570.5084880531093, 625.8685676007998, 682.1643486728717, 723.8190452386904, 750.7222327738772, 9428.669996550088, 9840.557174927002, 10098.192144628412, 10242.385456872611, 10316.948415258026, 626.971786269619, 672.495628278791, 693.8863124684909, 724.0731863215093, 741.3920585120258, 4462.3752674625575, 4470.485894122153, 4932.383452068491, 4985.152524070917, 5033.295338652591, 62635.6868215656, 104909.0, 119429.0, 120250.0, 122621.38689306496, 104937.0, 105386.0, 107492.46253768838, 107677.0, 107986.0, 51370.74314628403, 51776.22335664968, 71856.0, 73907.63046184843, 90742.0, 9258.861117083114, 9417.764555886157, 9448.763780905532, 10070.0, 10224.53989570486, 47153.0, 47392.763036184595, 47700.04599907913, 48414.03171936612, 49886.25170622371, 62178.68910655599, 68961.0, 70685.29314706787, 71223.64388178026, 72251.27748722656, 13020.0, 13090.869091308965, 13347.132436391603, 13391.397387117799, 13452.260125693181, 13974.60253974635, 14499.855001450273, 14737.557873263819, 14957.925210373878, 15172.468963586221, 11835.881641183478, 12186.268823870596, 12267.754644906874, 13971.510997115052, 14227.857721422653, 13781.173129612256, 13932.512362067278, 14182.503612373517, 14413.351399186851, 14552.49066282675, 12783.93608031954, 12820.166689165175, 12873.678158046123, 13315.733685326433, 13333.333333333489, 9933.939303630912, 10038.799224015333, 10314.587416503256, 10394.844077338998, 10493.160547156362, 9602.567884445078, 10890.346579205274, 11386.886131138583, 11391.715207119889, 11623.418829058683], "value": 7355.990348948128, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 127.0, 164.0, 127.0, 122.0, 125.0, 125.0, 171.0, 123.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 167.0, 167.0, 164.0, 164.0, 162.0, 163.0, 163.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 110.0, 77.0, 76.0, 75.0, 76.0, 99.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 83.0, 83.0, 85.0, 107.0, 83.0, 82.0, 112.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 146.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 56.0, 55.0, 57.0, 55.0, 54.0, 54.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 80.0, 82.0, 86.0, 86.0, 87.0, 82.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 146.0, 144.0, 135.0, 133.0, 132.0, 135.0, 175.0, 132.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 167.0, 174.0, 166.0, 171.0, 171.0, 169.0, 163.0, 171.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 66.0, 69.0, 75.0, 67.0, 65.0, 64.0, 69.0], "value": 68.3, "unit": "score"}]}]} 21:59:10 INFO - Return code: 0 21:59:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:59:10 ERROR - # TBPL SUCCESS # 21:59:10 INFO - Running post-action listener: _resource_record_post_action 21:59:10 INFO - [mozharness: 2016-10-15 04:59:10.964966Z] Finished run-tests step (success) 21:59:10 INFO - Running post-run listener: _resource_record_post_run 21:59:11 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404275200; Read time: 156; Write time: 244448 21:59:11 INFO - TinderboxPrint: CPU usage
13.4% 21:59:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 156 21:59:11 INFO - TinderboxPrint: I/O write bytes / time
404,275,200 / 244,448 21:59:11 INFO - TinderboxPrint: CPU idle
8,254.7 (86.6%) 21:59:11 INFO - TinderboxPrint: CPU user
1,214.4 (12.7%) 21:59:11 INFO - TinderboxPrint: Swap in / out
0 / 0 21:59:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115003392; Read time: 0; Write time: 73544 21:59:11 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289271808; Read time: 156; Write time: 170904 21:59:11 INFO - Running post-run listener: _upload_blobber_files 21:59:11 INFO - Blob upload gear active. 21:59:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:59:11 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 21:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 21:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:12 INFO - (blobuploader) - INFO - Done attempting. 21:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:16 INFO - (blobuploader) - INFO - Done attempting. 21:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:17 INFO - (blobuploader) - INFO - Done attempting. 21:59:17 INFO - (blobuploader) - INFO - Iteration through files over. 21:59:17 INFO - Return code: 0 21:59:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:59:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:59:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8818eb923764cce0b2cf96e458f54403941a9308b9e09f463c26bbe6763eb1163b7aeb60108ad755c18a5e2cda272682c22022a33cf9f1fbc791abad73a8fcba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6362f002f690dac1a3e170bafb9d62a71601b10f3b7595b639e0a250ae5373c0de01188576eb5a4a29d81d6828918bcecff934528f338a96010918e185674b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bef493ec08f3ab1c8c8b408e558a4aaa80974457fc9e2fc7801b3e146435d9a193a83aa53a43349b3ca7bb0c99c583608a985ca1c33e9ad860f5c45e9b4c29"} 21:59:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:59:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:59:17 INFO - Contents: 21:59:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8818eb923764cce0b2cf96e458f54403941a9308b9e09f463c26bbe6763eb1163b7aeb60108ad755c18a5e2cda272682c22022a33cf9f1fbc791abad73a8fcba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6362f002f690dac1a3e170bafb9d62a71601b10f3b7595b639e0a250ae5373c0de01188576eb5a4a29d81d6828918bcecff934528f338a96010918e185674b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bef493ec08f3ab1c8c8b408e558a4aaa80974457fc9e2fc7801b3e146435d9a193a83aa53a43349b3ca7bb0c99c583608a985ca1c33e9ad860f5c45e9b4c29"} 21:59:17 INFO - Running post-run listener: copy_logs_to_upload_dir 21:59:17 INFO - Copying logs to upload dir... 21:59:17 INFO - mkdir: /builds/slave/test/build/upload/logs 21:59:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.868780 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-14 21:59:16.877406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 21:59:16.881090) ========= 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=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8818eb923764cce0b2cf96e458f54403941a9308b9e09f463c26bbe6763eb1163b7aeb60108ad755c18a5e2cda272682c22022a33cf9f1fbc791abad73a8fcba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6362f002f690dac1a3e170bafb9d62a71601b10f3b7595b639e0a250ae5373c0de01188576eb5a4a29d81d6828918bcecff934528f338a96010918e185674b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bef493ec08f3ab1c8c8b408e558a4aaa80974457fc9e2fc7801b3e146435d9a193a83aa53a43349b3ca7bb0c99c583608a985ca1c33e9ad860f5c45e9b4c29"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476495004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8818eb923764cce0b2cf96e458f54403941a9308b9e09f463c26bbe6763eb1163b7aeb60108ad755c18a5e2cda272682c22022a33cf9f1fbc791abad73a8fcba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6362f002f690dac1a3e170bafb9d62a71601b10f3b7595b639e0a250ae5373c0de01188576eb5a4a29d81d6828918bcecff934528f338a96010918e185674b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bef493ec08f3ab1c8c8b408e558a4aaa80974457fc9e2fc7801b3e146435d9a193a83aa53a43349b3ca7bb0c99c583608a985ca1c33e9ad860f5c45e9b4c29"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 21:59:16.906445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:59:16.906772) ========= 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=6dbc10da6d83fee962c624be000001a8-1476506316.950342-239299922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 21:59:16.991534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 21:59:16.991852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 21:59:16.992135) ========= ========= Total master_lag: 0.16 =========