builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1477630241.35 results: success (0) buildid: 20161027213403 builduid: 3d82d784d11b48cf9db4f726c84c8040 revision: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.347150) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.347621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.347894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.362739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.363120) ========= 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-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 21:50:41-- 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% 18.7M=0.001s 2016-10-27 21:50:41 (18.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.485247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.485893) ========= 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-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016366 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.537320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:41.537666) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 --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 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 --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-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 21:50:41,968 truncating revision to first 12 chars 2016-10-27 21:50:41,969 Setting DEBUG logging. 2016-10-27 21:50:41,969 attempt 1/10 2016-10-27 21:50:41,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9272c247ecf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 21:50:42,273 unpacking tar archive at: fx-team-9272c247ecf1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:42.183215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:42.183626) ========= script_repo_revision: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:42.184018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:42.184280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 21:50:42.195166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-27 21:50:42.195507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:50:42 INFO - MultiFileLogger online at 20161027 21:50:42 in /builds/slave/test 21:50:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:50:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:50:42 INFO - {'append_to_log': False, 21:50:42 INFO - 'base_work_dir': '/builds/slave/test', 21:50:42 INFO - 'blob_upload_branch': 'Fx-Team', 21:50:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:50:42 INFO - 'branch': 'Fx-Team', 21:50:42 INFO - 'buildbot_json_path': 'buildprops.json', 21:50:42 INFO - 'config_files': ('talos/linux_config.py',), 21:50:42 INFO - 'default_actions': ('clobber', 21:50:42 INFO - 'read-buildbot-config', 21:50:42 INFO - 'download-and-extract', 21:50:42 INFO - 'populate-webroot', 21:50:42 INFO - 'create-virtualenv', 21:50:42 INFO - 'install', 21:50:42 INFO - 'run-tests'), 21:50:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:50:42 INFO - 'download_minidump_stackwalk': True, 21:50:42 INFO - 'download_symbols': 'ondemand', 21:50:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:50:42 INFO - 'tooltool.py': '/tools/tooltool.py', 21:50:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:50:42 INFO - '/tools/misc-python/virtualenv.py')}, 21:50:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:50:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:50:42 INFO - 'installer_path': 'installer.exe', 21:50:42 INFO - 'log_level': 'info', 21:50:42 INFO - 'log_name': 'talos', 21:50:42 INFO - 'log_to_console': True, 21:50:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:50:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:50:42 INFO - 'opt_config_files': (), 21:50:42 INFO - 'pip_index': False, 21:50:42 INFO - 'sps_profile': False, 21:50:42 INFO - 'sps_profile_interval': 0, 21:50:42 INFO - 'suite': 'dromaeojs', 21:50:42 INFO - 'system_bits': '32', 21:50:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:50:42 INFO - 'title': 'talos-linux64-ix-050', 21:50:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:50:42 INFO - 'use_talos_json': True, 21:50:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:50:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:50:42 INFO - 'work_dir': 'build'} 21:50:42 INFO - [mozharness: 2016-10-28 04:50:42.727704Z] Running clobber step. 21:50:42 INFO - Running pre-action listener: _resource_record_pre_action 21:50:42 INFO - Running main action method: clobber 21:50:42 INFO - rmtree: /builds/slave/test/build 21:50:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:50:43 INFO - Running post-action listener: _resource_record_post_action 21:50:43 INFO - [mozharness: 2016-10-28 04:50:43.191074Z] Finished clobber step (success) 21:50:43 INFO - [mozharness: 2016-10-28 04:50:43.191175Z] Running read-buildbot-config step. 21:50:43 INFO - Running pre-action listener: _resource_record_pre_action 21:50:43 INFO - Running main action method: read_buildbot_config 21:50:43 INFO - Using buildbot properties: 21:50:43 INFO - { 21:50:43 INFO - "project": "", 21:50:43 INFO - "product": "firefox", 21:50:43 INFO - "script_repo_revision": "production", 21:50:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:50:43 INFO - "repository": "", 21:50:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:50:43 INFO - "buildid": "20161027213403", 21:50:43 INFO - "stage_platform": "linux64-pgo", 21:50:43 INFO - "basedir": "/builds/slave/test", 21:50:43 INFO - "buildnumber": 1664, 21:50:43 INFO - "platform": "ubuntu64_hw", 21:50:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:50:43 INFO - "slavebuilddir": "test", 21:50:43 INFO - "branch": "fx-team", 21:50:43 INFO - "revision": "9272c247ecf1fc24a72b4ef3181d95c12b2063d2", 21:50:43 INFO - "slavename": "talos-linux64-ix-050", 21:50:43 INFO - "builduid": "3d82d784d11b48cf9db4f726c84c8040", 21:50:43 INFO - "repo_path": "integration/fx-team" 21:50:43 INFO - } 21:50:43 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:50:43 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:50:43 INFO - Running post-action listener: _resource_record_post_action 21:50:43 INFO - [mozharness: 2016-10-28 04:50:43.193550Z] Finished read-buildbot-config step (success) 21:50:43 INFO - [mozharness: 2016-10-28 04:50:43.193638Z] Running download-and-extract step. 21:50:43 INFO - Running pre-action listener: _resource_record_pre_action 21:50:43 INFO - Running main action method: download_and_extract 21:50:43 INFO - mkdir: /builds/slave/test/build/tests 21:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:50:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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:50:43 INFO - Downloaded 1361 bytes. 21:50:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:50:43 INFO - Using the following test package requirements: 21:50:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:50:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:50:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'jsshell-linux-x86_64.zip'], 21:50:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:50:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:50:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:50:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:50:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:50:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:50:43 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/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:50:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:50:43 INFO - Http code: 200 21:50:43 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 21:50:43 INFO - x-amz-cf-id: qcc6ps-1hyOMiNp7U-Cg42eJAkm8F2IMEvW32Kpr2cnN3zX8VnNFiQ== 21:50:43 INFO - x-amz-replication-status: PENDING 21:50:43 INFO - x-amz-version-id: wVmtMgT6k6O_5Pd1t_0GXFsEMO2pyY58 21:50:43 INFO - Expected file size: 21992577 21:50:43 INFO - Obtained file size: 21992577 21:50:47 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:50:47 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/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:50:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:50:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:50:47 INFO - Http code: 200 21:50:47 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 21:50:47 INFO - x-amz-cf-id: LFo_9bUKNQ7Va0xwW4Px42Wyio49O1iJGC6ZGVOwxrhH00VCx6QVTQ== 21:50:47 INFO - x-amz-replication-status: PENDING 21:50:47 INFO - x-amz-version-id: wVmtMgT6k6O_5Pd1t_0GXFsEMO2pyY58 21:50:47 INFO - Expected file size: 21992577 21:50:47 INFO - Obtained file size: 21992577 21:50:52 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/1477618222/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:50:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:50:52 INFO - Http code: 200 21:50:52 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 21:50:52 INFO - x-amz-cf-id: EdNHQ7dTmefjZUE7rGXBxSMkZvuMpBVIPqVvL4jpcmJVLu7ZdWnQEQ== 21:50:52 INFO - x-amz-replication-status: PENDING 21:50:52 INFO - x-amz-version-id: yfWe.PcEsdcSXUPQd53GfoiyR21nAr1w 21:50:52 INFO - Expected file size: 14409028 21:50:52 INFO - Obtained file size: 14409028 21:50:52 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:50:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:50:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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:50:53 INFO - Downloaded 59366889 bytes. 21:50:53 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:50:53 INFO - mkdir: /builds/slave/test/properties 21:50:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:50:53 INFO - Writing to file /builds/slave/test/properties/build_url 21:50:53 INFO - Contents: 21:50:53 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:50:53 INFO - Running post-action listener: _resource_record_post_action 21:50:53 INFO - Running post-action listener: set_extra_try_arguments 21:50:53 INFO - [mozharness: 2016-10-28 04:50:53.939221Z] Finished download-and-extract step (success) 21:50:53 INFO - [mozharness: 2016-10-28 04:50:53.939490Z] Running populate-webroot step. 21:50:53 INFO - Running pre-action listener: _resource_record_pre_action 21:50:53 INFO - Running main action method: populate_webroot 21:50:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:50:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:50:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:50:53 INFO - '--tppagecycles', 21:50:53 INFO - '7'], 21:50:53 INFO - 'tests': ['tsvgm']}}, 21:50:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:50:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:50:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:50:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:50:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['damp', 'tps']}, 21:50:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'tests': ['damp', 'tps']}, 21:50:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['dromaeo_dom']}, 21:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:50:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['basic_compositor_video']}, 21:50:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:50:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'other-e10s': {'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['a11yr', 21:50:53 INFO - 'ts_paint', 21:50:53 INFO - 'tpaint', 21:50:53 INFO - 'sessionrestore', 21:50:53 INFO - 'sessionrestore_no_auto_restore', 21:50:53 INFO - 'tabpaint']}, 21:50:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['tsvgx', 21:50:53 INFO - 'tsvgr_opacity', 21:50:53 INFO - 'tart', 21:50:53 INFO - 'tscrollx', 21:50:53 INFO - 'cart']}, 21:50:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:50:53 INFO - 'tsvgr_opacity', 21:50:53 INFO - 'tart', 21:50:53 INFO - 'tscrollx', 21:50:53 INFO - 'cart']}, 21:50:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'talos_options': ['--disable-e10s'], 21:50:53 INFO - 'tests': ['tp5o']}, 21:50:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'tests': ['tp5o']}, 21:50:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'talos_options': ['--disable-e10s', 21:50:53 INFO - '--xperf_path', 21:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:53 INFO - 'tests': ['tp5n']}, 21:50:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:53 INFO - 'talos_options': ['--xperf_path', 21:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:53 INFO - 'tests': ['tp5n']}}, 21:50:53 INFO - 'talos.zip': {'path': '', 21:50:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:50:53 INFO - Running post-action listener: _resource_record_post_action 21:50:53 INFO - [mozharness: 2016-10-28 04:50:53.955433Z] Finished populate-webroot step (success) 21:50:53 INFO - [mozharness: 2016-10-28 04:50:53.955523Z] Running create-virtualenv step. 21:50:53 INFO - Running pre-action listener: _resource_record_pre_action 21:50:53 INFO - Running main action method: create_virtualenv 21:50:53 INFO - Creating virtualenv /builds/slave/test/build/venv 21:50:53 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:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:50:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:50:54 INFO - Using real prefix '/usr' 21:50:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 21:50:56 INFO - Installing pip.................done. 21:50:56 INFO - Return code: 0 21:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:50:56 INFO - Reading from file tmpfile_stdout 21:50:56 INFO - Output received: 21:50:56 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:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:50:56 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:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:56 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:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:56 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:50:56 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:50:56 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:50:56 INFO - Using env: {'DISPLAY': ':0', 21:50:56 INFO - 'HOME': '/home/cltbld', 21:50:56 INFO - 'LANG': 'en_US.UTF-8', 21:50:56 INFO - 'LANGUAGE': 'en_US:en', 21:50:56 INFO - 'LOGNAME': 'cltbld', 21:50:56 INFO - 'MAIL': '/var/mail/cltbld', 21:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:56 INFO - 'MOZ_NO_REMOTE': '1', 21:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:56 INFO - 'NO_EM_RESTART': '1', 21:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:56 INFO - 'PWD': '/builds/slave/test', 21:50:56 INFO - 'SHELL': '/bin/bash', 21:50:56 INFO - 'SHLVL': '1', 21:50:56 INFO - 'TERM': 'linux', 21:50:56 INFO - 'TMOUT': '86400', 21:50:56 INFO - 'USER': 'cltbld', 21:50:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:56 INFO - '_': '/tools/buildbot/bin/python'} 21:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:56 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:50:56 INFO - Cleaning up... 21:50:56 INFO - Return code: 0 21:50:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:50:56 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:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:56 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:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:56 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:50:56 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:50:56 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:50:56 INFO - Using env: {'DISPLAY': ':0', 21:50:56 INFO - 'HOME': '/home/cltbld', 21:50:56 INFO - 'LANG': 'en_US.UTF-8', 21:50:56 INFO - 'LANGUAGE': 'en_US:en', 21:50:56 INFO - 'LOGNAME': 'cltbld', 21:50:56 INFO - 'MAIL': '/var/mail/cltbld', 21:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:56 INFO - 'MOZ_NO_REMOTE': '1', 21:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:56 INFO - 'NO_EM_RESTART': '1', 21:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:56 INFO - 'PWD': '/builds/slave/test', 21:50:56 INFO - 'SHELL': '/bin/bash', 21:50:56 INFO - 'SHLVL': '1', 21:50:56 INFO - 'TERM': 'linux', 21:50:56 INFO - 'TMOUT': '86400', 21:50:56 INFO - 'USER': 'cltbld', 21:50:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:56 INFO - '_': '/tools/buildbot/bin/python'} 21:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:57 INFO - Downloading/unpacking psutil>=3.1.1 21:50:57 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:50:57 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:50:57 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:50:57 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:50:57 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:50:57 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:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:59 INFO - Installing collected packages: psutil 21:50:59 INFO - Running setup.py install for psutil 21:50:59 INFO - building 'psutil._psutil_linux' extension 21:50:59 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:50:59 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:50:59 INFO - building 'psutil._psutil_posix' extension 21:50:59 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:50:59 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:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:59 INFO - Successfully installed psutil 21:50:59 INFO - Cleaning up... 21:50:59 INFO - Return code: 0 21:50:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:50:59 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:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:59 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:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:59 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:50:59 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:50:59 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:50:59 INFO - Using env: {'DISPLAY': ':0', 21:50:59 INFO - 'HOME': '/home/cltbld', 21:50:59 INFO - 'LANG': 'en_US.UTF-8', 21:50:59 INFO - 'LANGUAGE': 'en_US:en', 21:50:59 INFO - 'LOGNAME': 'cltbld', 21:50:59 INFO - 'MAIL': '/var/mail/cltbld', 21:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:59 INFO - 'MOZ_NO_REMOTE': '1', 21:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:59 INFO - 'NO_EM_RESTART': '1', 21:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:59 INFO - 'PWD': '/builds/slave/test', 21:50:59 INFO - 'SHELL': '/bin/bash', 21:50:59 INFO - 'SHLVL': '1', 21:50:59 INFO - 'TERM': 'linux', 21:50:59 INFO - 'TMOUT': '86400', 21:50:59 INFO - 'USER': 'cltbld', 21:50:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:59 INFO - '_': '/tools/buildbot/bin/python'} 21:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:51:02 INFO - Installing collected packages: mozsystemmonitor 21:51:02 INFO - Running setup.py install for mozsystemmonitor 21:51:02 INFO - Successfully installed mozsystemmonitor 21:51:02 INFO - Cleaning up... 21:51:02 INFO - Return code: 0 21:51:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:51:02 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:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:02 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:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:02 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:02 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:51:02 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:51:02 INFO - Using env: {'DISPLAY': ':0', 21:51:02 INFO - 'HOME': '/home/cltbld', 21:51:02 INFO - 'LANG': 'en_US.UTF-8', 21:51:02 INFO - 'LANGUAGE': 'en_US:en', 21:51:02 INFO - 'LOGNAME': 'cltbld', 21:51:02 INFO - 'MAIL': '/var/mail/cltbld', 21:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:02 INFO - 'MOZ_NO_REMOTE': '1', 21:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:02 INFO - 'NO_EM_RESTART': '1', 21:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:02 INFO - 'PWD': '/builds/slave/test', 21:51:02 INFO - 'SHELL': '/bin/bash', 21:51:02 INFO - 'SHLVL': '1', 21:51:02 INFO - 'TERM': 'linux', 21:51:02 INFO - 'TMOUT': '86400', 21:51:02 INFO - 'USER': 'cltbld', 21:51:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:02 INFO - '_': '/tools/buildbot/bin/python'} 21:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:51:02 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:51:02 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:51:02 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:51:02 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:51:02 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:51:02 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:51:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:51:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:51:04 INFO - warning: no files found matching '*.txt' 21:51:04 INFO - no previously-included directories found matching 'build' 21:51:04 INFO - no previously-included directories found matching 'dist' 21:51:04 INFO - no previously-included directories found matching '.git*' 21:51:04 INFO - Installing collected packages: jsonschema, functools32 21:51:04 INFO - Running setup.py install for functools32 21:51:04 INFO - warning: no files found matching '*.txt' 21:51:04 INFO - no previously-included directories found matching 'build' 21:51:04 INFO - no previously-included directories found matching 'dist' 21:51:04 INFO - no previously-included directories found matching '.git*' 21:51:04 INFO - Successfully installed jsonschema functools32 21:51:04 INFO - Cleaning up... 21:51:04 INFO - Return code: 0 21:51:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:51:04 INFO - Using env: {'DISPLAY': ':0', 21:51:04 INFO - 'HOME': '/home/cltbld', 21:51:04 INFO - 'LANG': 'en_US.UTF-8', 21:51:04 INFO - 'LANGUAGE': 'en_US:en', 21:51:04 INFO - 'LOGNAME': 'cltbld', 21:51:04 INFO - 'MAIL': '/var/mail/cltbld', 21:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:04 INFO - 'MOZ_NO_REMOTE': '1', 21:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:04 INFO - 'NO_EM_RESTART': '1', 21:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:04 INFO - 'PWD': '/builds/slave/test', 21:51:04 INFO - 'SHELL': '/bin/bash', 21:51:04 INFO - 'SHLVL': '1', 21:51:04 INFO - 'TERM': 'linux', 21:51:04 INFO - 'TMOUT': '86400', 21:51:04 INFO - 'USER': 'cltbld', 21:51:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:04 INFO - '_': '/tools/buildbot/bin/python'} 21:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:51:05 INFO - Cleaning up... 21:51:05 INFO - Return code: 0 21:51:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:51:05 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:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:05 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:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:05 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:05 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:51:05 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:51:05 INFO - Using env: {'DISPLAY': ':0', 21:51:05 INFO - 'HOME': '/home/cltbld', 21:51:05 INFO - 'LANG': 'en_US.UTF-8', 21:51:05 INFO - 'LANGUAGE': 'en_US:en', 21:51:05 INFO - 'LOGNAME': 'cltbld', 21:51:05 INFO - 'MAIL': '/var/mail/cltbld', 21:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:05 INFO - 'MOZ_NO_REMOTE': '1', 21:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:05 INFO - 'NO_EM_RESTART': '1', 21:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:05 INFO - 'PWD': '/builds/slave/test', 21:51:05 INFO - 'SHELL': '/bin/bash', 21:51:05 INFO - 'SHLVL': '1', 21:51:05 INFO - 'TERM': 'linux', 21:51:05 INFO - 'TMOUT': '86400', 21:51:05 INFO - 'USER': 'cltbld', 21:51:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:05 INFO - '_': '/tools/buildbot/bin/python'} 21:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:51:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:51:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:08 INFO - Downloading docopt-0.6.1.tar.gz 21:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:51:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:51:08 INFO - Running setup.py install for blobuploader 21:51:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:51:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:51:08 INFO - Running setup.py install for requests 21:51:08 INFO - Running setup.py install for docopt 21:51:08 INFO - Successfully installed blobuploader requests docopt 21:51:08 INFO - Cleaning up... 21:51:08 INFO - Return code: 0 21:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:08 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:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:08 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:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:08 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:08 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:51:08 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:51:08 INFO - Using env: {'DISPLAY': ':0', 21:51:08 INFO - 'HOME': '/home/cltbld', 21:51:08 INFO - 'LANG': 'en_US.UTF-8', 21:51:08 INFO - 'LANGUAGE': 'en_US:en', 21:51:08 INFO - 'LOGNAME': 'cltbld', 21:51:08 INFO - 'MAIL': '/var/mail/cltbld', 21:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:08 INFO - 'MOZ_NO_REMOTE': '1', 21:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:08 INFO - 'NO_EM_RESTART': '1', 21:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:08 INFO - 'PWD': '/builds/slave/test', 21:51:08 INFO - 'SHELL': '/bin/bash', 21:51:08 INFO - 'SHLVL': '1', 21:51:08 INFO - 'TERM': 'linux', 21:51:08 INFO - 'TMOUT': '86400', 21:51:08 INFO - 'USER': 'cltbld', 21:51:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:08 INFO - '_': '/tools/buildbot/bin/python'} 21:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:09 INFO - Running setup.py (path:/tmp/pip-izHLjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:09 INFO - Running setup.py (path:/tmp/pip-9LblOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:09 INFO - Running setup.py (path:/tmp/pip-rPH_gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:09 INFO - Running setup.py (path:/tmp/pip-SmSeb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:09 INFO - Running setup.py (path:/tmp/pip-P5vGnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:09 INFO - Running setup.py (path:/tmp/pip-noFEv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:09 INFO - Running setup.py (path:/tmp/pip-rNvBVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:09 INFO - Running setup.py (path:/tmp/pip-g0doxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:09 INFO - Running setup.py (path:/tmp/pip-nqtBEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:09 INFO - Running setup.py (path:/tmp/pip-dchaIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:09 INFO - Running setup.py (path:/tmp/pip-pxsLXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:09 INFO - Running setup.py (path:/tmp/pip-k8ZUDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:09 INFO - Running setup.py (path:/tmp/pip-EClbOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:09 INFO - Running setup.py (path:/tmp/pip-G8YZYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:10 INFO - Running setup.py (path:/tmp/pip-AhyYub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:10 INFO - Running setup.py (path:/tmp/pip-vrty9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:10 INFO - Running setup.py (path:/tmp/pip-p3myMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:51:10 INFO - Running setup.py install for manifestparser 21:51:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:51:10 INFO - Running setup.py install for mozcrash 21:51:10 INFO - Running setup.py install for mozdebug 21:51:10 INFO - Running setup.py install for mozdevice 21:51:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:51:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:51:10 INFO - Running setup.py install for mozfile 21:51:10 INFO - Running setup.py install for mozhttpd 21:51:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:51:10 INFO - Running setup.py install for mozinfo 21:51:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:51:10 INFO - Running setup.py install for mozInstall 21:51:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Running setup.py install for mozleak 21:51:11 INFO - Running setup.py install for mozlog 21:51:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Running setup.py install for moznetwork 21:51:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Running setup.py install for mozprocess 21:51:11 INFO - Running setup.py install for mozprofile 21:51:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Running setup.py install for mozrunner 21:51:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:51:11 INFO - Running setup.py install for mozscreenshot 21:51:11 INFO - Running setup.py install for moztest 21:51:11 INFO - Running setup.py install for mozversion 21:51:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:51:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:51:12 INFO - Cleaning up... 21:51:12 INFO - Return code: 0 21:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:12 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:12 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:51:12 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:51:12 INFO - Using env: {'DISPLAY': ':0', 21:51:12 INFO - 'HOME': '/home/cltbld', 21:51:12 INFO - 'LANG': 'en_US.UTF-8', 21:51:12 INFO - 'LANGUAGE': 'en_US:en', 21:51:12 INFO - 'LOGNAME': 'cltbld', 21:51:12 INFO - 'MAIL': '/var/mail/cltbld', 21:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:12 INFO - 'MOZ_NO_REMOTE': '1', 21:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:12 INFO - 'NO_EM_RESTART': '1', 21:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:12 INFO - 'PWD': '/builds/slave/test', 21:51:12 INFO - 'SHELL': '/bin/bash', 21:51:12 INFO - 'SHLVL': '1', 21:51:12 INFO - 'TERM': 'linux', 21:51:12 INFO - 'TMOUT': '86400', 21:51:12 INFO - 'USER': 'cltbld', 21:51:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:12 INFO - '_': '/tools/buildbot/bin/python'} 21:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:12 INFO - Running setup.py (path:/tmp/pip-jB8Dkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:12 INFO - Running setup.py (path:/tmp/pip-PnUJaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:12 INFO - Running setup.py (path:/tmp/pip-Yy1DS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:12 INFO - Running setup.py (path:/tmp/pip-_wcJyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:12 INFO - Running setup.py (path:/tmp/pip-IOE7ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:12 INFO - Running setup.py (path:/tmp/pip-4WuHeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:12 INFO - Running setup.py (path:/tmp/pip-jp6_v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:12 INFO - Running setup.py (path:/tmp/pip-w9iTFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:12 INFO - Running setup.py (path:/tmp/pip-RnWk0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:12 INFO - Running setup.py (path:/tmp/pip-aKGCjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:12 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:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:12 INFO - Running setup.py (path:/tmp/pip-6Fddsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:13 INFO - Running setup.py (path:/tmp/pip-hcgp79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:13 INFO - Running setup.py (path:/tmp/pip-PJH1jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:13 INFO - Running setup.py (path:/tmp/pip-YJb685-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:13 INFO - Running setup.py (path:/tmp/pip-z1d1Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:13 INFO - Running setup.py (path:/tmp/pip-Ktc08C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:13 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:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:13 INFO - Running setup.py (path:/tmp/pip-uppeb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:13 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:51:13 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:51:13 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:51:13 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:51:13 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:51:13 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:51:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:51:13 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:51:13 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:51:13 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:51:13 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:51:13 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:51:13 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:51:15 INFO - Downloading blessings-1.6.tar.gz 21:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:51:15 INFO - Installing collected packages: blessings 21:51:15 INFO - Running setup.py install for blessings 21:51:15 INFO - Successfully installed blessings 21:51:15 INFO - Cleaning up... 21:51:15 INFO - Return code: 0 21:51:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:15 INFO - Reading from file tmpfile_stdout 21:51:15 INFO - Current package versions: 21:51:15 INFO - argparse == 1.2.1 21:51:15 INFO - blessings == 1.6 21:51:15 INFO - blobuploader == 1.2.4 21:51:15 INFO - docopt == 0.6.1 21:51:15 INFO - functools32 == 3.2.3-2 21:51:15 INFO - jsonschema == 2.5.1 21:51:15 INFO - manifestparser == 1.1 21:51:15 INFO - mozInstall == 1.12 21:51:15 INFO - mozcrash == 0.17 21:51:15 INFO - mozdebug == 0.1 21:51:15 INFO - mozdevice == 0.48 21:51:15 INFO - mozfile == 1.2 21:51:15 INFO - mozhttpd == 0.7 21:51:15 INFO - mozinfo == 0.9 21:51:15 INFO - mozleak == 0.1 21:51:15 INFO - mozlog == 3.4 21:51:15 INFO - moznetwork == 0.27 21:51:15 INFO - mozprocess == 0.23 21:51:15 INFO - mozprofile == 0.28 21:51:15 INFO - mozrunner == 6.12 21:51:15 INFO - mozscreenshot == 0.1 21:51:15 INFO - mozsystemmonitor == 0.3 21:51:15 INFO - moztest == 0.7 21:51:15 INFO - mozversion == 1.4 21:51:15 INFO - psutil == 3.1.1 21:51:15 INFO - requests == 1.2.3 21:51:15 INFO - wsgiref == 0.1.2 21:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:15 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:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:15 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:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:15 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:15 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:51:15 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:51:15 INFO - Using env: {'DISPLAY': ':0', 21:51:15 INFO - 'HOME': '/home/cltbld', 21:51:15 INFO - 'LANG': 'en_US.UTF-8', 21:51:15 INFO - 'LANGUAGE': 'en_US:en', 21:51:15 INFO - 'LOGNAME': 'cltbld', 21:51:15 INFO - 'MAIL': '/var/mail/cltbld', 21:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:15 INFO - 'MOZ_NO_REMOTE': '1', 21:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:15 INFO - 'NO_EM_RESTART': '1', 21:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:15 INFO - 'PWD': '/builds/slave/test', 21:51:15 INFO - 'SHELL': '/bin/bash', 21:51:15 INFO - 'SHLVL': '1', 21:51:15 INFO - 'TERM': 'linux', 21:51:15 INFO - 'TMOUT': '86400', 21:51:15 INFO - 'USER': 'cltbld', 21:51:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:15 INFO - '_': '/tools/buildbot/bin/python'} 21:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 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:51:16 INFO - Cleaning up... 21:51:16 INFO - Return code: 0 21:51:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:16 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 0x7fe2a204df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, '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-1477630241.50862-1402613319', '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:51:16 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:51:16 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:51:16 INFO - Using env: {'DISPLAY': ':0', 21:51:16 INFO - 'HOME': '/home/cltbld', 21:51:16 INFO - 'LANG': 'en_US.UTF-8', 21:51:16 INFO - 'LANGUAGE': 'en_US:en', 21:51:16 INFO - 'LOGNAME': 'cltbld', 21:51:16 INFO - 'MAIL': '/var/mail/cltbld', 21:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:16 INFO - 'MOZ_NO_REMOTE': '1', 21:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:16 INFO - 'NO_EM_RESTART': '1', 21:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:16 INFO - 'PWD': '/builds/slave/test', 21:51:16 INFO - 'SHELL': '/bin/bash', 21:51:16 INFO - 'SHLVL': '1', 21:51:16 INFO - 'TERM': 'linux', 21:51:16 INFO - 'TMOUT': '86400', 21:51:16 INFO - 'USER': 'cltbld', 21:51:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:16 INFO - '_': '/tools/buildbot/bin/python'} 21:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:51:16 INFO - Cleaning up... 21:51:16 INFO - Return code: 0 21:51:16 INFO - Running post-action listener: _resource_record_post_action 21:51:16 INFO - Running post-action listener: _start_resource_monitoring 21:51:16 INFO - Starting resource monitoring. 21:51:16 INFO - [mozharness: 2016-10-28 04:51:16.416980Z] Finished create-virtualenv step (success) 21:51:16 INFO - [mozharness: 2016-10-28 04:51:16.417496Z] Running install step. 21:51:16 INFO - Running pre-action listener: _resource_record_pre_action 21:51:16 INFO - Running main action method: install 21:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:16 INFO - Reading from file tmpfile_stdout 21:51:16 INFO - Detecting whether we're running mozinstall >=1.0... 21:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:51:16 INFO - Reading from file tmpfile_stdout 21:51:16 INFO - Output received: 21:51:16 INFO - Usage: mozinstall [options] installer 21:51:16 INFO - Options: 21:51:16 INFO - -h, --help show this help message and exit 21:51:16 INFO - -d DEST, --destination=DEST 21:51:16 INFO - Directory to install application into. [default: 21:51:16 INFO - "/builds/slave/test"] 21:51:16 INFO - --app=APP Application being installed. [default: firefox] 21:51:16 INFO - mkdir: /builds/slave/test/build/application 21:51:16 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:51:16 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:51:33 INFO - Reading from file tmpfile_stdout 21:51:33 INFO - Output received: 21:51:33 INFO - /builds/slave/test/build/application/firefox/firefox 21:51:33 INFO - Running post-action listener: _resource_record_post_action 21:51:33 INFO - [mozharness: 2016-10-28 04:51:33.606660Z] Finished install step (success) 21:51:33 INFO - [mozharness: 2016-10-28 04:51:33.606912Z] Running run-tests step. 21:51:33 INFO - Running pre-action listener: _resource_record_pre_action 21:51:33 INFO - Running main action method: run_tests 21:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:51:33 INFO - Python 2.7.3 21:51:33 INFO - Return code: 0 21:51:33 INFO - grabbing minidump binary from tooltool 21:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:33 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 0x2019790>, '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 0x201a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:51:33 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:51:33 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:51:33 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:51:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:51:33 INFO - Return code: 0 21:51:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:51:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:51:33 INFO - Using env: {'DISPLAY': ':0', 21:51:33 INFO - 'HOME': '/home/cltbld', 21:51:33 INFO - 'LANG': 'en_US.UTF-8', 21:51:33 INFO - 'LANGUAGE': 'en_US:en', 21:51:33 INFO - 'LOGNAME': 'cltbld', 21:51:33 INFO - 'MAIL': '/var/mail/cltbld', 21:51:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:51:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:33 INFO - 'MOZ_NO_REMOTE': '1', 21:51:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:33 INFO - 'NO_EM_RESTART': '1', 21:51:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:33 INFO - 'PWD': '/builds/slave/test', 21:51:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:51:33 INFO - 'SHELL': '/bin/bash', 21:51:33 INFO - 'SHLVL': '1', 21:51:33 INFO - 'TERM': 'linux', 21:51:33 INFO - 'TMOUT': '86400', 21:51:33 INFO - 'USER': 'cltbld', 21:51:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477630241.50862-1402613319', 21:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:33 INFO - '_': '/tools/buildbot/bin/python'} 21:51:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:51:33 INFO - mozversion application_buildid: 20161027183022 21:51:33 INFO - mozversion application_changeset: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 21:51:33 INFO - mozversion application_display_name: Nightly 21:51:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:51:33 INFO - mozversion application_name: Firefox 21:51:33 INFO - mozversion application_remotingname: firefox 21:51:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:51:33 INFO - mozversion application_vendor: Mozilla 21:51:33 INFO - mozversion application_version: 52.0a1 21:51:33 INFO - mozversion platform_buildid: 20161027183022 21:51:33 INFO - mozversion platform_changeset: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 21:51:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:51:33 INFO - mozversion platform_version: 52.0a1 21:51:33 INFO - using testdate: 1477630293 21:51:33 INFO - actual date: 1477630293 21:51:33 INFO - starting webserver on 'localhost:35634' 21:51:33 INFO - SUITE-START | Running 2 tests 21:51:33 INFO - TEST-START | dromaeo_css 21:51:33 INFO - operating with platform_type : linux_ 21:51:33 INFO - Initialising browser for dromaeo_css test... 21:51:33 INFO - TEST-INFO | started process 22584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9wCGMg/profile http://localhost:35634/getInfo.html) 21:51:37 INFO - PROCESS | 22584 | __metrics Screen width/height:1600/1200 21:51:37 INFO - PROCESS | 22584 | colorDepth:24 21:51:37 INFO - PROCESS | 22584 | Browser inner width/height: 1024/697 21:51:37 INFO - PROCESS | 22584 | __metrics 21:51:38 INFO - PROCESS | 22584 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:51:38 INFO - PROCESS | 22584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:51:38 INFO - PROCESS | 22584 | console.error: PushService: 21:51:38 INFO - PROCESS | 22584 | stateChangeProcessEnqueue: Error transitioning state 21:51:38 INFO - PROCESS | 22584 | UnknownError 21:51:39 INFO - TEST-INFO | 22584: exit 0 21:51:39 INFO - Browser initialized. 21:51:39 INFO - Running cycle 1/1 for dromaeo_css test... 21:51:39 INFO - TEST-INFO | started process 22667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9wCGMg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:51 INFO - PROCESS | 22667 | RSS: Main: 172146688 21:51:51 INFO - PROCESS | 22667 | 21:52:42 INFO - PROCESS | 22667 | 1477630362891 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:54:53 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35634/tests/dromaeo/cssquery-ext.html) 21:54:56 INFO - PROCESS | 22667 | RSS: Main: 424759296 21:54:56 INFO - PROCESS | 22667 | 21:57:58 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-ext.html (next: http://localhost:35634/tests/dromaeo/cssquery-jquery.html) 21:57:59 INFO - PROCESS | 22667 | RSS: Main: 289325056 21:57:59 INFO - PROCESS | 22667 | 22:01:01 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35634/tests/dromaeo/cssquery-mootools.html) 22:01:02 INFO - PROCESS | 22667 | RSS: Main: 219734016 22:01:02 INFO - PROCESS | 22667 | 22:04:04 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35634/tests/dromaeo/cssquery-prototype.html) 22:04:04 INFO - PROCESS | 22667 | RSS: Main: 243806208 22:04:04 INFO - PROCESS | 22667 | 22:07:07 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35634/tests/dromaeo/cssquery-yui.html) 22:07:08 INFO - PROCESS | 22667 | RSS: Main: 219545600 22:07:08 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | Cycle 1(1): loaded http://localhost:35634/tests/dromaeo/cssquery-yui.html (next: http://localhost:35634/tests/dromaeo/cssquery-dojo.html) 22:10:10 INFO - PROCESS | 22667 | RSS: Main: 312942592 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | __start_tp_report 22:10:10 INFO - PROCESS | 22667 | _x_x_mozilla_page_load 22:10:10 INFO - PROCESS | 22667 | _x_x_mozilla_page_load_details 22:10:10 INFO - PROCESS | 22667 | |i|pagename|runs| 22:10:10 INFO - PROCESS | 22667 | |0;dojo.html;3030.045535656268;3056.602641656585;3057.7859549831505;3096.5045592705173;3111.5643809866624;5297.788088476466;5305.867353316169;5359.973200133999;5362.865928351793;5418.972905135473;5378.91931621025;5392.083345831208;5407.918881216785;5414.40441551429;5418.647787893784;4879.951200487994;4900.362952816129;4921.212605983043;4968.056069346812;5022.799088036474;4982.900341993158;5045.949540504585;5048.6970781753025;5049.899002019957;5052.26742122392;4935.012997400534;4968.950310496903;5001.549860512553;5017.64876458648;5035.697858128524;5040.873978150521;5063.088644044071;5064.392272927273;5076.82231121909;5128.71792051437;4851;4890.8043678252825;4897.04507621014;4949.851504454872;4965.428975667808;5371.597130215249;5385.649932754398;5409.945900541023;5424.376196737387;5445.128779395317;5814.825555233349;5816.563757718188;5819.505342045931;5821.243238379026;5822.534197264209;5725.627834190765;5781.13283007548;5855.473007429352;5867.090600956859;5881.2354393928945;5441.59188060897;5485.232067510552;5487.807926722546;5488.1767734839295;5548.4451554845;5928.644281343133;5959.672218027963;5963.165156878041;5978.222831031938;5988.970055149784;5614.9157762633595;5724.542036637059;5730.856728581819;5731.484166425042;5734.942650573525;5731.742071606787;5752.108423194411;5760.0783874579865;5804.506616937523;5864.560157988168;5728.255326807572;5773.797917072882;5775.826725198251;5777.942220577825;5778.451047150514;5768.480836724715;5785.537157027427;5786.103154011135;5790;5848.415158484203;4350.630196433339;4375.146846364928;4396.956030439718;4432.933505997413;4463.888402789957;3985.6412922837085;4004.0790618157985;4017.397390391465;4022.1955608877756;4027.637512623878;5415.512603865671;5419.539339156137;5422.566194704415;5423.728813559306;5424.810131645373;5711.885762284731;5760.884782304331;5793.478586927196;5851.38560451155;5851.473367396955;5390.380106287827;5416.593755468356;5442.863928401822;5444.128939369761;5482.671039737628;5011.1481048221885;5015.548600625962;5017.874553136201;5021.196608542616;5100.1074811907765;5861.9706901465215;5937.970310148422;5995.340512543617;6002.939970600325;6007.789727359522;5764.884702306014;5826.679532625746;5827.271591051119;5828.125781132864;5837.124431335334;5907.9704601476715;5928.733207005609;5987.161797348462;5990.041593345044;6049.727762250797;5748.712564371681;5749;5800.59395842287;5813.883722325614;5823.068309070698;5784;5833.562482813721;5840.591158618856;5846.473817356458;5847;5556.972215138899;5619.016672082287;5702.714864256687;5704.942950570441;5710.200571919851;5661.575381846295;5663.122216056518;5669.54643628517;5670.858228544319;5674.716264186856;5618.830675778258;5649.4633009864;5654.830355089354;5660.6037577370835;5664.943350566442;5671.574631902541;5684.545236381162;5690.061139911868;5693.117566777156;5697.23087383198;5534.916976245279;5577.3028371453565;5578.553715702653;5580.776768929198;5584.776608935759 22:10:10 INFO - PROCESS | 22667 | |1;ext.html;610.7129649064939;611.3458599298749;632.6077831744319;650.0314531348292;654.9945833146122;31699.841500792492;40517.79741101294;42150.789246053806;42418.57581424185;46781;44946;45368.236335184825;45455.54544454563;45476.3178552322;45511.317330240076;7849.960750196241;8784.868226976585;8896.8665470018;8939.687110951118;8940.19538241558;7922.168172341908;10397.48012599367;10694.78610427791;10703.1437485001;11027.889721102807;10803.513841877135;10827;10844.186685998542;10855.945720271427;10856.240063195579;10637.095846853026;10679.466026698672;10694.893051069468;10702.41136737479;10705.678829635124;10513.264071514997;10542.314749541332;10557.630482933137;10560.94719526405;10570.52432640533;41428.79285603583;41813.58186418127;41922.161556769;42177;42205.788971055255;3363.949540756866;3491.109767009422;3498.2828520153307;3637.436197389409;3856.402257650069;31584.684153158632;31680.683193168003;31751.52372714411;31892;32380.190495237573;4194.182134483777;4312.654987600984;4324.136562127835;4327.3725309830215;4365.105153443536;310346;311318;312069;313891;315007;58839.70580147157;59188.704056479444;59206;59216.11175832366;59245;35204.119897002776;35728;36136.09659758474;38085.80957095197;62361.68819155875;14949.551513454613;15118;15127.47053853132;15128.621784455256;15129.352363336373;10910.127189824794;10970.232083754061;11053.668389948154;11200.103991680646;11288.492017859217;18704.971226582667;19127.2349106037;19161.52096197606;19187.616247674967;19290.517737056685;6845.486588505882;6890.8621827564175;6913.274106218774;6980.581165130108;7093.822654433578;889.208604342136;1016.4612755239734;1021.8927012663712;1132.8697199822127;1161.4483120517687;31380;31936.680633193835;32053.839730801195;32167.028795484348;32337.191570210933;1103.8951299626522;1114.7681811598068;1148.3224897310627;1156.1675593572613;1184.6150001249457;16726.6654666906;16911.49265522036;17077.487675369757;17199.1400429978;17341;515187;518976;518978;520287;520481;58409.123863142086;58949;58955.70522147362;58961.70519147377;58992;1184.163310872766;1276.329926788425;1305.8824705776526;1344.1934839096464;1365;29143;32914;32924.835375822964;33468.163295917795;33846.83076584601;49742.25386619276;50171;50568.747156263984;50592.49407506025;50657.746711266205;388790;389269;389587;389630;390129;24161;26406.207813765617;27267.59098613562;27915.720842791314;28374.148775536767;46160.30759538677;46885.29672054854;47027;47370.289445657654;48655.51344486651;39423.80288098656;39478.40782388324;39548.209035819695;40092.59907400889;41740.791296043324;39544.60455395524;39900;40218.798906005286;42975.57024429716;44447.55552444434;40426;42033;43269.78365108154;43709;43715.56284437115;31377.529337059506;36654.63345366512;36834.68802413577;37076.258474830895;37414.81292593628;28268.85865570659;28310.292242693275;28466.715332847234;28816.855915720287;28833.42333153367 22:10:10 INFO - PROCESS | 22667 | |2;jquery.html;373.2404556727061;381.4830904124911;393.4118492853184;398.21750260737645;416.7999360307052;14084.50704225351;18010.72983905241;18103.909480452596;18522.907385463088;19887.502812429695;17845.55386115348;18498.0750962452;18649.347272845454;18700.06499675014;18724.906375468137;5593.496585307322;5887.499562537189;5895.734691938873;5898.1447690084915;5898.321693005317;4219.5358510563965;4334.742924551876;4518.2319005769095;4521.253993091136;5808.738606762706;6634.270230274666;6653.4344580710695;6657.633830139341;6660.200775906898;6660.700268487905;6368.713407896656;6508.446782023558;6544.181977252843;6556.114924485229;6657.533972621918;5557.166425036236;5778.335491418498;5786;5787.363390027093;5789.884202315972;23282.185123520594;23510;23524.411889702722;23720.64419033716;23881.880590596935;2412.7225369082603;2440.19473573722;2465.938351541208;2598.285471495335;2630.579107342816;14198.219097949608;14560.490382836655;14582.854171458255;14780.260986950609;14957.850421495863;1861.795202527721;1886.41680354387;1936.6320399124263;2000.5398758285676;2013.144413624204;60301.69849150726;75579.24420755832;77644;83860.87182589488;88119.55940220258;9663.806723865624;9815.509224538744;10137.341072830242;10157.898421015696;10253.84619230712;14365.13809171453;14465.13209207451;14650.413983440756;14752.409903603735;14814;7379.88930166048;7508.849823003509;7585.089789225218;7662.693492260359;7714.614269286625;7173.10336207974;7238.746643867545;7269.89095163573;7389.298016688406;7446.367058799954;6228.719707613168;6418;6430.871382572323;6459.547831651739;6530.8040758777315;1695.745638154262;1781.0738416023596;1824.3523549139863;1857.730629058779;1912.5218695326168;962.3600305796567;962.9807403851884;996.7557948302713;1050.910672592823;1067.3809190669392;18803.717944230848;20311;20408.59182816365;20614.896925515277;20806.687899681518;970.1220395542045;983.8819341679044;1007.959681612742;1018.7962407518526;1033.8087453821067;10694.73263168427;11620;11676.47455864488;11716.355600441888;11733.647990560126;419958;431158;431918;434255;450716;84824.57587712022;85546;85592;85788.99215582274;86150;977.59429836617;998.4059484606647;1000.5197505197691;1017.4658304390107;1027.671145233533;16069.35722571084;16804.159792010596;17807.643847123243;18208.544786380447;18225.270989160286;35837.64162358447;40005.79997099996;40563.59436405598;40839.18321633491;41364.586354136074;52834.037447192386;53685.46314536805;56054.43945560492;56481;58155.709221453624;8203.42576019673;8636.481811091355;8695.347848911231;8736.082711315474;8866.33502487329;9745.951270243604;12683.619491415273;13346.933265333611;13800.654983625489;13972.650683732989;11405.828912566152;11760.470778815145;12033.157678962389;12080.16116212707;12100.455479503267;6459.773907913201;7632.752169413228;10663.306885052447;10897.509612067317;11016;10873.184511161853;11157.609483668033;11326.716832079264;11705.941470292593;11715;7309.707611695472;7334.669939852826;7626.9618651906385;8573.271271941954;8725;8559.272461840814;10006.44964526958;11005.504752286006;11592;11973.640790776291 22:10:10 INFO - PROCESS | 22667 | |3;mootools.html;1419.9219042952634;1462.7074585082985;1549.1479686172609;1693.0857337038;1698.4055580546817;7291.453141014432;7489.363404110657;8083.636236369362;8595.828083438335;8623.844038990252;8051.597420128985;8339.83320333593;8341.666333346659;8470.110638382957;8516.31869450444;2337.8947947342367;2361.409647588103;2366.3374255208482;2369.4668699542635;2370.1941339944415;2060.6908963655424;2348.9060437582475;2386.4153282445827;2397.436602398435;2404.5791986402396;2014.929477468289;2288.78256565626;2365.077619728307;2366.4438856868624;2380.4286971126976;2275.7496675365696;2281.9315420537328;2284.9657255141187;2291.9541609167804;2320.0951628864755;2336.707911511061;2353.7881590656752;2356.422676444265;2374.786269235777;2374.905003799846;8465.49207047573;8525.275351595123;8531.146885311482;8537.445066070686;8585.570721463964;5167.457416971201;5264.710440925747;5303.337082864642;5306.628536002481;5322.787088516455;3413.6586341365914;3425.9657403425895;3486.267883744417;3491.2319289756465;3507.368673638744;1111.3220935229504;1117.2961034548182;1137.9146564007733;1168.3865970365541;2075.6263872502946;11364.545418183263;11696.766064678744;11742.178047536676;11764.58823941158;11860.466279017464;4492.752898590609;4588.95411045892;4594.448666160015;4759.666823322404;4831.323614693945;9389.201917836925;9408.576614052385;9448.858267126;9465.195458386115;9493.952530237304;5250.107481728115;5254.0805359062015;5258.342707161605;5289.788408463695;5298.867528311746;4808.687435316693;4904.950950490521;4907.312976183337;4930.382558946437;4949.257611358253;3506.4564992426212;3550.822458877046;3598.1364472526407;3622.8188590570367;3651.9817400912825;1027.2552399510296;1091.792559413709;1133.7165708572857;1163.3078318400537;1170.2978213072088;816.2245866426919;915.9725208243764;917.6788124156625;925.3799954030816;956.364017928084;5629.943700562942;5710.3433105193435;5723.914141287884;5784.566157538202;5883.852903677357;899.0964081098585;923.9907600923905;947.1097168661436;955.2119501411363;959.2469911119738;3783.2244389900006;3851.807409629507;3931.4692516510477;3944.053427177514;3994.6804255659476;10332.896671033344;10698.78602427947;10731.034206921415;10738.140948724084;10741;10615.89384106149;10621.203409744145;10636;10706.839397409045;10724.946375268073;7646.541207527566;7913.643886025143;7920.445568810128;8036.839263214703;8100.149484304181;5495.752691128989;5522.831720930657;5527.226188333717;5596.524295434933;5614.354349249726;9198.448093114435;9257.907420925705;9318;9613.51932403391;9653.517324133905;9660.855087173557;9776.560054797408;9807.852882206915;9847.162991145833;9947.751306217402;7585;7677.616119193906;7692.538447693157;7704.768856934301;7706.229377062249;7971.083325417651;8063.193680632125;8128.75613731589;8144.226298501633;8153.7553873383895;7303.342699157101;7369.8157546061775;7374.741884034033;7607.087149542091;7617.733379331697;7280.635968201675;7321.890171647536;7334.559926404433;7360.374368178765;7387.482876198615;6587.143671322698;6745.86508269822;6783.084283621845;6793.626350550767;6820.488463365366;4946.258061290835;4973.776180071978;5019.598432125495;5068.518490743373;5073.289739436408;4747.382840230748;4803.279508073817;4805.783739731651;4828.420589529139;4960.70235785854 22:10:10 INFO - PROCESS | 22667 | |4;prototype.html;329.35957327290276;334.23627012276944;343.3990516595957;343.4196208407792;347.99478007829873;5181.1710126379785;5284.577233821295;5394.514493695567;5440.374356948947;5443.972780136099;5214.739263036842;5283.867903302419;5300.734963251842;5303.946960530394;5350.438203988574;4162.646175075122;4212.178625168093;4214.431051808013;4236.661067114639;4241.36379543068;4172.77049762263;4206.3690446432975;4221.34569141782;4226.492820861486;4241.384999175118;4184.91630167398;4194.66442684586;4207.747535147885;4236.385724070024;4243.893902652443;4165.895852603694;4174.561671024544;4191.350340697197;4195.832166713328;4214.7471151731;3739.0183202902504;3768.4724138620613;3768.5854555998817;3769.8115094245454;3815.2178803345246;4961.675677296184;5135.537801597874;5154.484551544853;5166.870828229286;5178.689278643255;4715.1512727709;4716.198246298103;4741;4744.976275118637;4758.904821903542;5253.737313134328;5536.307961504812;5538.778448862041;5543.279373681436;5615.354234263071;3965.4844870166694;3984.641382275609;4004.2592120457807;4006.238814625212;4026.8255142223165;5719.942800571983;5725.914111288334;5728.513076388512;5732.283464566929;5735.799247026334;4093.7339072960162;4097.918041639151;4129.793510324472;4132.483439570054;4149.419081328617;4011.839526418969;4109.506859176858;4138.296489596776;4149.356849688304;4163.770992595376;4681.695689780154;4706.247000479907;4713.713848783337;4731.526847315241;4736.171170045228;5542.58664040667;5544.889102218014;5547.528460080857;5558.194061861008;5577.693226872561;1283;1340.4035204334173;1369.582277405381;1430.427828868461;1435.1102316563797;898.1602201941206;902.702108304258;922.0180507759216;927.758782716485;930.1489137439303;4581.861424923871;4628.490866004737;4637.234856248749;4637.724625727952;4646.4191976003;4899.828506002273;4939.431965323962;4956.826511072095;4968.354113965162;4995.375578052744;4439.445069366329;4585.770711464414;4651.348811166439;4676.883077923011;4677.508861569554;2656.9601455978177;2657.38880057584;2672.3452754075374;2672.492226476963;2685.3420911876715;5051.393832740095;5077.416097148801;5078.451072422947;5111.488851114858;5126.256692779526;4720.811167553259;4964.354633897642;5052.812589041572;5068.873278168002;5098.796048158107;5046.243063540498;5083.602009447432;5085.46602606721;5099.5410413063;5108.59131269505;4940.530649588283;4953.925691114564;4969;4971.502849715;5056.924146137737;4887.413510378778;4894.681845680019;4939.43196532389;5316.601254905975;5723.656580605177;5878.3239927408895;5881.9705901470215;5884.499817515559;5895.764169433174;5904.202932604216;4113.568075352045;4142.150859073822;4154.875353739392;4182.64447521964;4186.246475634415;5430.484104010113;5714.942850571441;5747.706765977621;5777.306723193075;5848.912266315923;5443.666301756095;5459.972700136474;5583.55331573465;5601.6358936668985;5612.466815652507;5566.9680566593715;5571.220029195835;5597.80407685729;5610.298712660918;5631.887362252814;5353.457107873729;5555.916661250004;5587.167100458156;5587.552995760248;5612.747426365741;5620.943790562042;5622;5625.959197548466;5628.971855140862;5634.661615429551;5478.877040087272;5502.624343914022;5503.459031471194;5517.896420715953;5535.25274087993 22:10:10 INFO - PROCESS | 22667 | |5;yui.html;739.8853177757446;754.9282818132278;768.9846203075939;802.6949759091544;844.1010324004936;13643.181409115448;13714.65713357164;13840.10039347443;13879.444822207099;13962.162270263778;13711.58865234042;14031.929840350784;14113.78829317561;14253.78619320711;14305.78541321881;806.1615919443772;819.8114433680257;821.2936874288138;822.8230930349973;823.8764185372182;672.2940912042336;688.7795905310303;801.9558924259163;829.4069740135802;835.4903508859591;870.1559487297343;871.6774793326479;873.4104479476359;873.8601823708208;873.8732883731855;864.7103220421103;865.5153114256005;865.9047504774501;866.1295398124907;866.1814585216972;509.12430619334685;520.6043407010699;521.5045706578727;523.2125650895379;611.0803241122127;13747.450101995908;14300.642483937881;14330.211838348887;14357.210353430557;14357.78463323051;13389.732205355838;13715.931420342935;13861.090959682833;14021;14098.859011409857;11399.829002564968;11471.483783229774;11577.53689852405;12061.758764824743;12100.334481603508;4175.206710724983;4260.467441569804;4344.326629372453;4466.464024317071;4467.508574056851;65031;69274;69304.6534767328;70016.64991675009;70443.64778176128;10363.792724145625;10610.57557697699;10697.304675196086;10929.453527323602;10950.616728414467;18565.81434185668;19221.90389048046;20582.38252852417;20601.381958541268;20670.10618513379;6927.272636373108;7465.514741541782;7981.002374703162;8114.513129212266;8216.630251638691;4489.461264648263;4513;4530.365748795171;4543.864033991502;4556.931646025312;3402.302527981758;3497.178163131662;3500.1249687578106;3506.7545271830727;3512.947305790415;617.3425302053299;627.1783963008473;637.9202599675041;640.8494003909078;648.3419329380682;675.8749631318124;692.5809885019592;701.680735265453;702.8383471801515;760.5284723471373;9154.148301400268;9393.765155871159;9642.42145471274;9786;9855.310128291094;715.8317795318096;716.1406312425111;724.5978481942467;728.1735230513406;742.0798210219289;4330.2638551446325;4499.68502204849;4522;4582.473015603182;4600.42494688164;55614;59185.0507656085;88572.5571372139;91262;91309.54345228232;51788.74105629448;58530.707346462994;76820.61589692016;78425;78647;68983;69693;71151.99999999897;72480;74172;8631.002736999253;8844.115588441104;9060.411073280216;9148.451092934445;9244.861327080234;43075.56924430715;44152.7792361049;44595.33107003463;44743.32885006793;46090.539094609965;35142.472862906565;54880.72559637176;55912.44087559072;61300.38699612947;64434.67782661057;11746.76506469883;11803.822942655695;12087.917581016785;12199.085068619712;12610;13396.665083372995;13577.93211033978;13762.518311859038;13901.235432051335;15135.243237838284;13066.01593368111;13142;13296.135751176143;13412.731745365234;13520.93239533796;10614.840777388192;11195.60815371458;11199.60801371948;12963.675908102374;13103.737925241632;12743.745125097632;12814.359282036048;12854.357282135668;12858.357082146042;13005.21968681882;10702.197335199735;11264.66206013821;11325.207235493437;11690.123240756808;11803.173777835469;11222.466796185932;11235.606753763579;11296.209265351676;11420.200585958903;11592.768144637228 22:10:10 INFO - PROCESS | 22667 | __end_tp_report 22:10:10 INFO - PROCESS | 22667 | __start_cc_report 22:10:10 INFO - PROCESS | 22667 | _x_x_mozilla_cycle_collect,2673 22:10:10 INFO - PROCESS | 22667 | __end_cc_report 22:10:10 INFO - PROCESS | 22667 | __startTimestamp1477631410943__endTimestamp 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | ------- Summary: start ------- 22:10:10 INFO - PROCESS | 22667 | Number of tests: 6 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#0] dojo.html Cycles:165 Average:5394.87 Median:5618.83 stddev:610.24 (10.9%) stddev-sans-first:583.23 22:10:10 INFO - PROCESS | 22667 | Values: 3030.0 3056.6 3057.8 3096.5 3111.6 5297.8 5305.9 5360.0 5362.9 5419.0 5378.9 5392.1 5407.9 5414.4 5418.6 4880.0 4900.4 4921.2 4968.1 5022.8 4982.9 5045.9 5048.7 5049.9 5052.3 4935.0 4969.0 5001.5 5017.6 5035.7 5040.9 5063.1 5064.4 5076.8 5128.7 4851.0 4890.8 4897.0 4949.9 4965.4 5371.6 5385.6 5409.9 5424.4 5445.1 5814.8 5816.6 5819.5 5821.2 5822.5 5725.6 5781.1 5855.5 5867.1 5881.2 5441.6 5485.2 5487.8 5488.2 5548.4 5928.6 5959.7 5963.2 5978.2 5989.0 5614.9 5724.5 5730.9 5731.5 5734.9 5731.7 5752.1 5760.1 5804.5 5864.6 5728.3 5773.8 5775.8 5777.9 5778.5 5768.5 5785.5 5786.1 5790.0 5848.4 4350.6 4375.1 4397.0 4432.9 4463.9 3985.6 4004.1 4017.4 4022.2 4027.6 5415.5 5419.5 5422.6 5423.7 5424.8 5711.9 5760.9 5793.5 5851.4 5851.5 5390.4 5416.6 5442.9 5444.1 5482.7 5011.1 5015.5 5017.9 5021.2 5100.1 5862.0 5938.0 5995.3 6002.9 6007.8 5764.9 5826.7 5827.3 5828.1 5837.1 5908.0 5928.7 5987.2 5990.0 6049.7 5748.7 5749.0 5800.6 5813.9 5823.1 5784.0 5833.6 5840.6 5846.5 5847.0 5557.0 5619.0 5702.7 5704.9 5710.2 5661.6 5663.1 5669.5 5670.9 5674.7 5618.8 5649.5 5654.8 5660.6 5664.9 5671.6 5684.5 5690.1 5693.1 5697.2 5534.9 5577.3 5578.6 5580.8 5584.8 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#1] ext.html Cycles:180 Average:56933.67 Median:19886.77 stddev:110046.97 (553.4%) stddev-sans-first:110274.43 22:10:10 INFO - PROCESS | 22667 | Values: 610.7 611.3 632.6 650.0 655.0 31699.8 40517.8 42150.8 42418.6 46781.0 44946.0 45368.2 45455.5 45476.3 45511.3 7850.0 8784.9 8896.9 8939.7 8940.2 7922.2 10397.5 10694.8 10703.1 11027.9 10803.5 10827.0 10844.2 10855.9 10856.2 10637.1 10679.5 10694.9 10702.4 10705.7 10513.3 10542.3 10557.6 10560.9 10570.5 41428.8 41813.6 41922.2 42177.0 42205.8 3363.9 3491.1 3498.3 3637.4 3856.4 31584.7 31680.7 31751.5 31892.0 32380.2 4194.2 4312.7 4324.1 4327.4 4365.1 310346.0 311318.0 312069.0 313891.0 315007.0 58839.7 59188.7 59206.0 59216.1 59245.0 35204.1 35728.0 36136.1 38085.8 62361.7 14949.6 15118.0 15127.5 15128.6 15129.4 10910.1 10970.2 11053.7 11200.1 11288.5 18705.0 19127.2 19161.5 19187.6 19290.5 6845.5 6890.9 6913.3 6980.6 7093.8 889.2 1016.5 1021.9 1132.9 1161.4 31380.0 31936.7 32053.8 32167.0 32337.2 1103.9 1114.8 1148.3 1156.2 1184.6 16726.7 16911.5 17077.5 17199.1 17341.0 515187.0 518976.0 518978.0 520287.0 520481.0 58409.1 58949.0 58955.7 58961.7 58992.0 1184.2 1276.3 1305.9 1344.2 1365.0 29143.0 32914.0 32924.8 33468.2 33846.8 49742.3 50171.0 50568.7 50592.5 50657.7 388790.0 389269.0 389587.0 389630.0 390129.0 24161.0 26406.2 27267.6 27915.7 28374.1 46160.3 46885.3 47027.0 47370.3 48655.5 39423.8 39478.4 39548.2 40092.6 41740.8 39544.6 39900.0 40218.8 42975.6 44447.6 40426.0 42033.0 43269.8 43709.0 43715.6 31377.5 36654.6 36834.7 37076.3 37414.8 28268.9 28310.3 28466.7 28816.9 28833.4 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#2] jquery.html Cycles:180 Average:27011.27 Median:395.81 stddev:71607.46 (18091.2%) stddev-sans-first:71780.40 22:10:10 INFO - PROCESS | 22667 | Values: 373.2 381.5 393.4 398.2 416.8 14084.5 18010.7 18103.9 18522.9 19887.5 17845.6 18498.1 18649.3 18700.1 18724.9 5593.5 5887.5 5895.7 5898.1 5898.3 4219.5 4334.7 4518.2 4521.3 5808.7 6634.3 6653.4 6657.6 6660.2 6660.7 6368.7 6508.4 6544.2 6556.1 6657.5 5557.2 5778.3 5786.0 5787.4 5789.9 23282.2 23510.0 23524.4 23720.6 23881.9 2412.7 2440.2 2465.9 2598.3 2630.6 14198.2 14560.5 14582.9 14780.3 14957.9 1861.8 1886.4 1936.6 2000.5 2013.1 60301.7 75579.2 77644.0 83860.9 88119.6 9663.8 9815.5 10137.3 10157.9 10253.8 14365.1 14465.1 14650.4 14752.4 14814.0 7379.9 7508.8 7585.1 7662.7 7714.6 7173.1 7238.7 7269.9 7389.3 7446.4 6228.7 6418.0 6430.9 6459.5 6530.8 1695.7 1781.1 1824.4 1857.7 1912.5 962.4 963.0 996.8 1050.9 1067.4 18803.7 20311.0 20408.6 20614.9 20806.7 970.1 983.9 1008.0 1018.8 1033.8 10694.7 11620.0 11676.5 11716.4 11733.6 419958.0 431158.0 431918.0 434255.0 450716.0 84824.6 85546.0 85592.0 85789.0 86150.0 977.6 998.4 1000.5 1017.5 1027.7 16069.4 16804.2 17807.6 18208.5 18225.3 35837.6 40005.8 40563.6 40839.2 41364.6 52834.0 53685.5 56054.4 56481.0 58155.7 8203.4 8636.5 8695.3 8736.1 8866.3 9746.0 12683.6 13346.9 13800.7 13972.7 11405.8 11760.5 12033.2 12080.2 12100.5 6459.8 7632.8 10663.3 10897.5 11016.0 10873.2 11157.6 11326.7 11705.9 11715.0 7309.7 7334.7 7627.0 8573.3 8725.0 8559.3 10006.4 11005.5 11592.0 11973.6 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#3] mootools.html Cycles:180 Average:5595.06 Median:5208.78 stddev:3116.37 (59.8%) stddev-sans-first:3109.31 22:10:10 INFO - PROCESS | 22667 | Values: 1419.9 1462.7 1549.1 1693.1 1698.4 7291.5 7489.4 8083.6 8595.8 8623.8 8051.6 8339.8 8341.7 8470.1 8516.3 2337.9 2361.4 2366.3 2369.5 2370.2 2060.7 2348.9 2386.4 2397.4 2404.6 2014.9 2288.8 2365.1 2366.4 2380.4 2275.7 2281.9 2285.0 2292.0 2320.1 2336.7 2353.8 2356.4 2374.8 2374.9 8465.5 8525.3 8531.1 8537.4 8585.6 5167.5 5264.7 5303.3 5306.6 5322.8 3413.7 3426.0 3486.3 3491.2 3507.4 1111.3 1117.3 1137.9 1168.4 2075.6 11364.5 11696.8 11742.2 11764.6 11860.5 4492.8 4589.0 4594.4 4759.7 4831.3 9389.2 9408.6 9448.9 9465.2 9494.0 5250.1 5254.1 5258.3 5289.8 5298.9 4808.7 4905.0 4907.3 4930.4 4949.3 3506.5 3550.8 3598.1 3622.8 3652.0 1027.3 1091.8 1133.7 1163.3 1170.3 816.2 916.0 917.7 925.4 956.4 5629.9 5710.3 5723.9 5784.6 5883.9 899.1 924.0 947.1 955.2 959.2 3783.2 3851.8 3931.5 3944.1 3994.7 10332.9 10698.8 10731.0 10738.1 10741.0 10615.9 10621.2 10636.0 10706.8 10724.9 7646.5 7913.6 7920.4 8036.8 8100.1 5495.8 5522.8 5527.2 5596.5 5614.4 9198.4 9257.9 9318.0 9613.5 9653.5 9660.9 9776.6 9807.9 9847.2 9947.8 7585.0 7677.6 7692.5 7704.8 7706.2 7971.1 8063.2 8128.8 8144.2 8153.8 7303.3 7369.8 7374.7 7607.1 7617.7 7280.6 7321.9 7334.6 7360.4 7387.5 6587.1 6745.9 6783.1 6793.6 6820.5 4946.3 4973.8 5019.6 5068.5 5073.3 4747.4 4803.3 4805.8 4828.4 4960.7 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#4] prototype.html Cycles:180 Average:4531.86 Median:4966.35 stddev:1308.44 (26.3%) stddev-sans-first:1273.52 22:10:10 INFO - PROCESS | 22667 | Values: 329.4 334.2 343.4 343.4 348.0 5181.2 5284.6 5394.5 5440.4 5444.0 5214.7 5283.9 5300.7 5303.9 5350.4 4162.6 4212.2 4214.4 4236.7 4241.4 4172.8 4206.4 4221.3 4226.5 4241.4 4184.9 4194.7 4207.7 4236.4 4243.9 4165.9 4174.6 4191.4 4195.8 4214.7 3739.0 3768.5 3768.6 3769.8 3815.2 4961.7 5135.5 5154.5 5166.9 5178.7 4715.2 4716.2 4741.0 4745.0 4758.9 5253.7 5536.3 5538.8 5543.3 5615.4 3965.5 3984.6 4004.3 4006.2 4026.8 5719.9 5725.9 5728.5 5732.3 5735.8 4093.7 4097.9 4129.8 4132.5 4149.4 4011.8 4109.5 4138.3 4149.4 4163.8 4681.7 4706.2 4713.7 4731.5 4736.2 5542.6 5544.9 5547.5 5558.2 5577.7 1283.0 1340.4 1369.6 1430.4 1435.1 898.2 902.7 922.0 927.8 930.1 4581.9 4628.5 4637.2 4637.7 4646.4 4899.8 4939.4 4956.8 4968.4 4995.4 4439.4 4585.8 4651.3 4676.9 4677.5 2657.0 2657.4 2672.3 2672.5 2685.3 5051.4 5077.4 5078.5 5111.5 5126.3 4720.8 4964.4 5052.8 5068.9 5098.8 5046.2 5083.6 5085.5 5099.5 5108.6 4940.5 4953.9 4969.0 4971.5 5056.9 4887.4 4894.7 4939.4 5316.6 5723.7 5878.3 5882.0 5884.5 5895.8 5904.2 4113.6 4142.2 4154.9 4182.6 4186.2 5430.5 5714.9 5747.7 5777.3 5848.9 5443.7 5460.0 5583.6 5601.6 5612.5 5567.0 5571.2 5597.8 5610.3 5631.9 5353.5 5555.9 5587.2 5587.6 5612.7 5620.9 5622.0 5626.0 5629.0 5634.7 5478.9 5502.6 5503.5 5517.9 5535.3 22:10:10 INFO - PROCESS | 22667 | 22:10:10 INFO - PROCESS | 22667 | [#5] yui.html Cycles:180 Average:17218.60 Median:4537.11 stddev:22489.76 (495.7%) stddev-sans-first:22518.81 22:10:10 INFO - PROCESS | 22667 | Values: 739.9 754.9 769.0 802.7 844.1 13643.2 13714.7 13840.1 13879.4 13962.2 13711.6 14031.9 14113.8 14253.8 14305.8 806.2 819.8 821.3 822.8 823.9 672.3 688.8 802.0 829.4 835.5 870.2 871.7 873.4 873.9 873.9 864.7 865.5 865.9 866.1 866.2 509.1 520.6 521.5 523.2 611.1 13747.5 14300.6 14330.2 14357.2 14357.8 13389.7 13715.9 13861.1 14021.0 14098.9 11399.8 11471.5 11577.5 12061.8 12100.3 4175.2 4260.5 4344.3 4466.5 4467.5 65031.0 69274.0 69304.7 70016.6 70443.6 10363.8 10610.6 10697.3 10929.5 10950.6 18565.8 19221.9 20582.4 20601.4 20670.1 6927.3 7465.5 7981.0 8114.5 8216.6 4489.5 4513.0 4530.4 4543.9 4556.9 3402.3 3497.2 3500.1 3506.8 3512.9 617.3 627.2 637.9 640.8 648.3 675.9 692.6 701.7 702.8 760.5 9154.1 9393.8 9642.4 9786.0 9855.3 715.8 716.1 724.6 728.2 742.1 4330.3 4499.7 4522.0 4582.5 4600.4 55614.0 59185.1 88572.6 91262.0 91309.5 51788.7 58530.7 76820.6 78425.0 78647.0 68983.0 69693.0 71152.0 72480.0 74172.0 8631.0 8844.1 9060.4 9148.5 9244.9 43075.6 44152.8 44595.3 44743.3 46090.5 35142.5 54880.7 55912.4 61300.4 64434.7 11746.8 11803.8 12087.9 12199.1 12610.0 13396.7 13577.9 13762.5 13901.2 15135.2 13066.0 13142.0 13296.1 13412.7 13520.9 10614.8 11195.6 11199.6 12963.7 13103.7 12743.7 12814.4 12854.4 12858.4 13005.2 10702.2 11264.7 11325.2 11690.1 11803.2 11222.5 11235.6 11296.2 11420.2 11592.8 22:10:10 INFO - PROCESS | 22667 | -------- Summary: end -------- 22:10:10 INFO - PROCESS | 22667 | 22:10:11 INFO - TEST-INFO | 22667: exit 0 22:10:11 INFO - TEST-OK | dromaeo_css | took 1117949ms 22:10:11 INFO - TEST-START | kraken 22:10:11 INFO - operating with platform_type : linux_ 22:10:11 INFO - Initialising browser for kraken test... 22:10:11 INFO - TEST-INFO | started process 22972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3rFzfZ/profile http://localhost:35634/getInfo.html) 22:10:15 INFO - PROCESS | 22972 | __metrics Screen width/height:1600/1200 22:10:15 INFO - PROCESS | 22972 | colorDepth:24 22:10:15 INFO - PROCESS | 22972 | Browser inner width/height: 1024/697 22:10:15 INFO - PROCESS | 22972 | __metrics 22:10:16 INFO - PROCESS | 22972 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:10:16 INFO - PROCESS | 22972 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:10:17 INFO - PROCESS | 22972 | console.error: PushService: 22:10:17 INFO - PROCESS | 22972 | stateChangeProcessEnqueue: Error transitioning state 22:10:17 INFO - PROCESS | 22972 | UnknownError 22:10:17 INFO - TEST-INFO | 22972: exit 0 22:10:17 INFO - Browser initialized. 22:10:17 INFO - Running cycle 1/1 for kraken test... 22:10:17 INFO - TEST-INFO | started process 23056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3rFzfZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:29 INFO - PROCESS | 23056 | RSS: Main: 171708416 22:10:29 INFO - PROCESS | 23056 | 22:10:32 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35634/tests/kraken/driver.html?testName=audio-beat-detection) 22:10:33 INFO - PROCESS | 23056 | RSS: Main: 228859904 22:10:33 INFO - PROCESS | 23056 | 22:10:36 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35634/tests/kraken/driver.html?testName=audio-dft) 22:10:36 INFO - PROCESS | 23056 | RSS: Main: 215822336 22:10:36 INFO - PROCESS | 23056 | 22:10:39 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35634/tests/kraken/driver.html?testName=audio-fft) 22:10:40 INFO - PROCESS | 23056 | RSS: Main: 298147840 22:10:40 INFO - PROCESS | 23056 | 22:10:42 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35634/tests/kraken/driver.html?testName=audio-oscillator) 22:10:43 INFO - PROCESS | 23056 | RSS: Main: 206274560 22:10:43 INFO - PROCESS | 23056 | 22:10:45 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:10:45 INFO - PROCESS | 23056 | RSS: Main: 211349504 22:10:45 INFO - PROCESS | 23056 | 22:10:48 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35634/tests/kraken/driver.html?testName=imaging-darkroom) 22:10:49 INFO - PROCESS | 23056 | RSS: Main: 247771136 22:10:49 INFO - PROCESS | 23056 | 22:10:52 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35634/tests/kraken/driver.html?testName=imaging-desaturate) 22:10:53 INFO - PROCESS | 23056 | RSS: Main: 247451648 22:10:53 INFO - PROCESS | 23056 | 22:10:55 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35634/tests/kraken/driver.html?testName=json-parse-financial) 22:10:56 INFO - PROCESS | 23056 | RSS: Main: 246931456 22:10:56 INFO - PROCESS | 23056 | 22:10:58 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:10:58 INFO - PROCESS | 23056 | RSS: Main: 208826368 22:10:58 INFO - PROCESS | 23056 | 22:11:00 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:11:01 INFO - PROCESS | 23056 | RSS: Main: 216682496 22:11:01 INFO - PROCESS | 23056 | 22:11:03 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:11:03 INFO - PROCESS | 23056 | RSS: Main: 225660928 22:11:03 INFO - PROCESS | 23056 | 22:11:06 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:11:07 INFO - PROCESS | 23056 | RSS: Main: 233648128 22:11:07 INFO - PROCESS | 23056 | 22:11:09 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:11:10 INFO - PROCESS | 23056 | RSS: Main: 230551552 22:11:10 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:35634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35634/tests/kraken/driver.html?testName=ai-astar) 22:11:12 INFO - PROCESS | 23056 | RSS: Main: 282320896 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | __start_tp_report 22:11:12 INFO - PROCESS | 23056 | _x_x_mozilla_page_load 22:11:12 INFO - PROCESS | 23056 | _x_x_mozilla_page_load_details 22:11:12 INFO - PROCESS | 23056 | |i|pagename|runs| 22:11:12 INFO - PROCESS | 23056 | |0;ai-astar;104;113;111;112;111;112;112;111;111;111 22:11:12 INFO - PROCESS | 23056 | |1;audio-beat-detection;159;123;128;166;126;125;122;125;151;121 22:11:12 INFO - PROCESS | 23056 | |2;audio-dft;162;161;160;161;162;161;162;160;161;160 22:11:12 INFO - PROCESS | 23056 | |3;audio-fft;74;76;76;112;78;75;76;76;100;76 22:11:12 INFO - PROCESS | 23056 | |4;audio-oscillator;84;82;123;82;82;83;107;82;83;108 22:11:12 INFO - PROCESS | 23056 | |5;imaging-gaussian-blur;116;116;117;116;116;117;117;117;117;116 22:11:12 INFO - PROCESS | 23056 | |6;imaging-darkroom;146;146;146;145;145;147;145;145;145;147 22:11:12 INFO - PROCESS | 23056 | |7;imaging-desaturate;84;85;85;85;85;84;84;85;85;84 22:11:12 INFO - PROCESS | 23056 | |8;json-parse-financial;53;52;52;52;53;60;53;55;54;54 22:11:12 INFO - PROCESS | 23056 | |9;json-stringify-tinderbox;61;62;62;61;61;61;61;61;63;62 22:11:12 INFO - PROCESS | 23056 | |10;stanford-crypto-aes;81;80;83;86;92;79;80;81;83;79 22:11:12 INFO - PROCESS | 23056 | |11;stanford-crypto-ccm;142;131;130;135;129;131;138;134;169;142 22:11:12 INFO - PROCESS | 23056 | |12;stanford-crypto-pbkdf2;167;169;168;166;165;164;172;165;164;165 22:11:12 INFO - PROCESS | 23056 | |13;stanford-crypto-sha256-iterative;65;65;65;66;66;65;65;64;65;65 22:11:12 INFO - PROCESS | 23056 | __end_tp_report 22:11:12 INFO - PROCESS | 23056 | __start_cc_report 22:11:12 INFO - PROCESS | 23056 | _x_x_mozilla_cycle_collect,1709 22:11:12 INFO - PROCESS | 23056 | __end_cc_report 22:11:12 INFO - PROCESS | 23056 | __startTimestamp1477631472358__endTimestamp 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | ------- Summary: start ------- 22:11:12 INFO - PROCESS | 23056 | Number of tests: 14 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.49 (2.2%) stddev-sans-first:0.73 22:11:12 INFO - PROCESS | 23056 | Values: 104.0 113.0 111.0 112.0 111.0 112.0 112.0 111.0 111.0 111.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:127.00 stddev:17.10 (13.5%) stddev-sans-first:15.69 22:11:12 INFO - PROCESS | 23056 | Values: 159.0 123.0 128.0 166.0 126.0 125.0 122.0 125.0 151.0 121.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 22:11:12 INFO - PROCESS | 23056 | Values: 162.0 161.0 160.0 161.0 162.0 161.0 162.0 160.0 161.0 160.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.05 (17.2%) stddev-sans-first:13.53 22:11:12 INFO - PROCESS | 23056 | Values: 74.0 76.0 76.0 112.0 78.0 75.0 76.0 76.0 100.0 76.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.15 (18.5%) stddev-sans-first:15.82 22:11:12 INFO - PROCESS | 23056 | Values: 84.0 82.0 123.0 82.0 82.0 83.0 107.0 82.0 83.0 108.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:11:12 INFO - PROCESS | 23056 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:11:12 INFO - PROCESS | 23056 | Values: 146.0 146.0 146.0 145.0 145.0 147.0 145.0 145.0 145.0 147.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 22:11:12 INFO - PROCESS | 23056 | Values: 84.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:2.39 (4.5%) stddev-sans-first:2.52 22:11:12 INFO - PROCESS | 23056 | Values: 53.0 52.0 52.0 52.0 53.0 60.0 53.0 55.0 54.0 54.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 22:11:12 INFO - PROCESS | 23056 | Values: 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 63.0 62.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:4.01 (4.9%) stddev-sans-first:4.22 22:11:12 INFO - PROCESS | 23056 | Values: 81.0 80.0 83.0 86.0 92.0 79.0 80.0 81.0 83.0 79.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:136.50 stddev:11.84 (8.7%) stddev-sans-first:12.47 22:11:12 INFO - PROCESS | 23056 | Values: 142.0 131.0 130.0 135.0 129.0 131.0 138.0 134.0 169.0 142.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:2.55 (1.5%) stddev-sans-first:2.70 22:11:12 INFO - PROCESS | 23056 | Values: 167.0 169.0 168.0 166.0 165.0 164.0 172.0 165.0 164.0 165.0 22:11:12 INFO - PROCESS | 23056 | 22:11:12 INFO - PROCESS | 23056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:11:12 INFO - PROCESS | 23056 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 65.0 64.0 65.0 65.0 22:11:12 INFO - PROCESS | 23056 | -------- Summary: end -------- 22:11:12 INFO - PROCESS | 23056 | 22:11:13 INFO - TEST-INFO | 23056: exit 0 22:11:13 INFO - TEST-OK | kraken | took 61690ms 22:11:13 INFO - SUITE-END | took 1179s 22:11:14 INFO - Completed test suite (00:19:40) 22:11:14 INFO - javascript benchmark 22:11:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.045535656268, 3056.602641656585, 3057.7859549831505, 3096.5045592705173, 3111.5643809866624, 5297.788088476466, 5305.867353316169, 5359.973200133999, 5362.865928351793, 5418.972905135473, 5378.91931621025, 5392.083345831208, 5407.918881216785, 5414.40441551429, 5418.647787893784, 4879.951200487994, 4900.362952816129, 4921.212605983043, 4968.056069346812, 5022.799088036474, 4982.900341993158, 5045.949540504585, 5048.6970781753025, 5049.899002019957, 5052.26742122392, 4935.012997400534, 4968.950310496903, 5001.549860512553, 5017.64876458648, 5035.697858128524, 5040.873978150521, 5063.088644044071, 5064.392272927273, 5076.82231121909, 5128.71792051437, 4851.0, 4890.8043678252825, 4897.04507621014, 4949.851504454872, 4965.428975667808, 5371.597130215249, 5385.649932754398, 5409.945900541023, 5424.376196737387, 5445.128779395317, 5814.825555233349, 5816.563757718188, 5819.505342045931, 5821.243238379026, 5822.534197264209, 5725.627834190765, 5781.13283007548, 5855.473007429352, 5867.090600956859, 5881.2354393928945, 5441.59188060897, 5485.232067510552, 5487.807926722546, 5488.1767734839295, 5548.4451554845, 5928.644281343133, 5959.672218027963, 5963.165156878041, 5978.222831031938, 5988.970055149784, 5614.9157762633595, 5724.542036637059, 5730.856728581819, 5731.484166425042, 5734.942650573525, 5731.742071606787, 5752.108423194411, 5760.0783874579865, 5804.506616937523, 5864.560157988168, 5728.255326807572, 5773.797917072882, 5775.826725198251, 5777.942220577825, 5778.451047150514, 5768.480836724715, 5785.537157027427, 5786.103154011135, 5790.0, 5848.415158484203, 4350.630196433339, 4375.146846364928, 4396.956030439718, 4432.933505997413, 4463.888402789957, 3985.6412922837085, 4004.0790618157985, 4017.397390391465, 4022.1955608877756, 4027.637512623878, 5415.512603865671, 5419.539339156137, 5422.566194704415, 5423.728813559306, 5424.810131645373, 5711.885762284731, 5760.884782304331, 5793.478586927196, 5851.38560451155, 5851.473367396955, 5390.380106287827, 5416.593755468356, 5442.863928401822, 5444.128939369761, 5482.671039737628, 5011.1481048221885, 5015.548600625962, 5017.874553136201, 5021.196608542616, 5100.1074811907765, 5861.9706901465215, 5937.970310148422, 5995.340512543617, 6002.939970600325, 6007.789727359522, 5764.884702306014, 5826.679532625746, 5827.271591051119, 5828.125781132864, 5837.124431335334, 5907.9704601476715, 5928.733207005609, 5987.161797348462, 5990.041593345044, 6049.727762250797, 5748.712564371681, 5749.0, 5800.59395842287, 5813.883722325614, 5823.068309070698, 5784.0, 5833.562482813721, 5840.591158618856, 5846.473817356458, 5847.0, 5556.972215138899, 5619.016672082287, 5702.714864256687, 5704.942950570441, 5710.200571919851, 5661.575381846295, 5663.122216056518, 5669.54643628517, 5670.858228544319, 5674.716264186856, 5618.830675778258, 5649.4633009864, 5654.830355089354, 5660.6037577370835, 5664.943350566442, 5671.574631902541, 5684.545236381162, 5690.061139911868, 5693.117566777156, 5697.23087383198, 5534.916976245279, 5577.3028371453565, 5578.553715702653, 5580.776768929198, 5584.776608935759], "value": 5353.059041296185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7129649064939, 611.3458599298749, 632.6077831744319, 650.0314531348292, 654.9945833146122, 31699.841500792492, 40517.79741101294, 42150.789246053806, 42418.57581424185, 46781.0, 44946.0, 45368.236335184825, 45455.54544454563, 45476.3178552322, 45511.317330240076, 7849.960750196241, 8784.868226976585, 8896.8665470018, 8939.687110951118, 8940.19538241558, 7922.168172341908, 10397.48012599367, 10694.78610427791, 10703.1437485001, 11027.889721102807, 10803.513841877135, 10827.0, 10844.186685998542, 10855.945720271427, 10856.240063195579, 10637.095846853026, 10679.466026698672, 10694.893051069468, 10702.41136737479, 10705.678829635124, 10513.264071514997, 10542.314749541332, 10557.630482933137, 10560.94719526405, 10570.52432640533, 41428.79285603583, 41813.58186418127, 41922.161556769, 42177.0, 42205.788971055255, 3363.949540756866, 3491.109767009422, 3498.2828520153307, 3637.436197389409, 3856.402257650069, 31584.684153158632, 31680.683193168003, 31751.52372714411, 31892.0, 32380.190495237573, 4194.182134483777, 4312.654987600984, 4324.136562127835, 4327.3725309830215, 4365.105153443536, 310346.0, 311318.0, 312069.0, 313891.0, 315007.0, 58839.70580147157, 59188.704056479444, 59206.0, 59216.11175832366, 59245.0, 35204.119897002776, 35728.0, 36136.09659758474, 38085.80957095197, 62361.68819155875, 14949.551513454613, 15118.0, 15127.47053853132, 15128.621784455256, 15129.352363336373, 10910.127189824794, 10970.232083754061, 11053.668389948154, 11200.103991680646, 11288.492017859217, 18704.971226582667, 19127.2349106037, 19161.52096197606, 19187.616247674967, 19290.517737056685, 6845.486588505882, 6890.8621827564175, 6913.274106218774, 6980.581165130108, 7093.822654433578, 889.208604342136, 1016.4612755239734, 1021.8927012663712, 1132.8697199822127, 1161.4483120517687, 31380.0, 31936.680633193835, 32053.839730801195, 32167.028795484348, 32337.191570210933, 1103.8951299626522, 1114.7681811598068, 1148.3224897310627, 1156.1675593572613, 1184.6150001249457, 16726.6654666906, 16911.49265522036, 17077.487675369757, 17199.1400429978, 17341.0, 515187.0, 518976.0, 518978.0, 520287.0, 520481.0, 58409.123863142086, 58949.0, 58955.70522147362, 58961.70519147377, 58992.0, 1184.163310872766, 1276.329926788425, 1305.8824705776526, 1344.1934839096464, 1365.0, 29143.0, 32914.0, 32924.835375822964, 33468.163295917795, 33846.83076584601, 49742.25386619276, 50171.0, 50568.747156263984, 50592.49407506025, 50657.746711266205, 388790.0, 389269.0, 389587.0, 389630.0, 390129.0, 24161.0, 26406.207813765617, 27267.59098613562, 27915.720842791314, 28374.148775536767, 46160.30759538677, 46885.29672054854, 47027.0, 47370.289445657654, 48655.51344486651, 39423.80288098656, 39478.40782388324, 39548.209035819695, 40092.59907400889, 41740.791296043324, 39544.60455395524, 39900.0, 40218.798906005286, 42975.57024429716, 44447.55552444434, 40426.0, 42033.0, 43269.78365108154, 43709.0, 43715.56284437115, 31377.529337059506, 36654.63345366512, 36834.68802413577, 37076.258474830895, 37414.81292593628, 28268.85865570659, 28310.292242693275, 28466.715332847234, 28816.855915720287, 28833.42333153367], "value": 19978.019756004105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2404556727061, 381.4830904124911, 393.4118492853184, 398.21750260737645, 416.7999360307052, 14084.50704225351, 18010.72983905241, 18103.909480452596, 18522.907385463088, 19887.502812429695, 17845.55386115348, 18498.0750962452, 18649.347272845454, 18700.06499675014, 18724.906375468137, 5593.496585307322, 5887.499562537189, 5895.734691938873, 5898.1447690084915, 5898.321693005317, 4219.5358510563965, 4334.742924551876, 4518.2319005769095, 4521.253993091136, 5808.738606762706, 6634.270230274666, 6653.4344580710695, 6657.633830139341, 6660.200775906898, 6660.700268487905, 6368.713407896656, 6508.446782023558, 6544.181977252843, 6556.114924485229, 6657.533972621918, 5557.166425036236, 5778.335491418498, 5786.0, 5787.363390027093, 5789.884202315972, 23282.185123520594, 23510.0, 23524.411889702722, 23720.64419033716, 23881.880590596935, 2412.7225369082603, 2440.19473573722, 2465.938351541208, 2598.285471495335, 2630.579107342816, 14198.219097949608, 14560.490382836655, 14582.854171458255, 14780.260986950609, 14957.850421495863, 1861.795202527721, 1886.41680354387, 1936.6320399124263, 2000.5398758285676, 2013.144413624204, 60301.69849150726, 75579.24420755832, 77644.0, 83860.87182589488, 88119.55940220258, 9663.806723865624, 9815.509224538744, 10137.341072830242, 10157.898421015696, 10253.84619230712, 14365.13809171453, 14465.13209207451, 14650.413983440756, 14752.409903603735, 14814.0, 7379.88930166048, 7508.849823003509, 7585.089789225218, 7662.693492260359, 7714.614269286625, 7173.10336207974, 7238.746643867545, 7269.89095163573, 7389.298016688406, 7446.367058799954, 6228.719707613168, 6418.0, 6430.871382572323, 6459.547831651739, 6530.8040758777315, 1695.745638154262, 1781.0738416023596, 1824.3523549139863, 1857.730629058779, 1912.5218695326168, 962.3600305796567, 962.9807403851884, 996.7557948302713, 1050.910672592823, 1067.3809190669392, 18803.717944230848, 20311.0, 20408.59182816365, 20614.896925515277, 20806.687899681518, 970.1220395542045, 983.8819341679044, 1007.959681612742, 1018.7962407518526, 1033.8087453821067, 10694.73263168427, 11620.0, 11676.47455864488, 11716.355600441888, 11733.647990560126, 419958.0, 431158.0, 431918.0, 434255.0, 450716.0, 84824.57587712022, 85546.0, 85592.0, 85788.99215582274, 86150.0, 977.59429836617, 998.4059484606647, 1000.5197505197691, 1017.4658304390107, 1027.671145233533, 16069.35722571084, 16804.159792010596, 17807.643847123243, 18208.544786380447, 18225.270989160286, 35837.64162358447, 40005.79997099996, 40563.59436405598, 40839.18321633491, 41364.586354136074, 52834.037447192386, 53685.46314536805, 56054.43945560492, 56481.0, 58155.709221453624, 8203.42576019673, 8636.481811091355, 8695.347848911231, 8736.082711315474, 8866.33502487329, 9745.951270243604, 12683.619491415273, 13346.933265333611, 13800.654983625489, 13972.650683732989, 11405.828912566152, 11760.470778815145, 12033.157678962389, 12080.16116212707, 12100.455479503267, 6459.773907913201, 7632.752169413228, 10663.306885052447, 10897.509612067317, 11016.0, 10873.184511161853, 11157.609483668033, 11326.716832079264, 11705.941470292593, 11715.0, 7309.707611695472, 7334.669939852826, 7626.9618651906385, 8573.271271941954, 8725.0, 8559.272461840814, 10006.44964526958, 11005.504752286006, 11592.0, 11973.640790776291], "value": 9155.242640687455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.9219042952634, 1462.7074585082985, 1549.1479686172609, 1693.0857337038, 1698.4055580546817, 7291.453141014432, 7489.363404110657, 8083.636236369362, 8595.828083438335, 8623.844038990252, 8051.597420128985, 8339.83320333593, 8341.666333346659, 8470.110638382957, 8516.31869450444, 2337.8947947342367, 2361.409647588103, 2366.3374255208482, 2369.4668699542635, 2370.1941339944415, 2060.6908963655424, 2348.9060437582475, 2386.4153282445827, 2397.436602398435, 2404.5791986402396, 2014.929477468289, 2288.78256565626, 2365.077619728307, 2366.4438856868624, 2380.4286971126976, 2275.7496675365696, 2281.9315420537328, 2284.9657255141187, 2291.9541609167804, 2320.0951628864755, 2336.707911511061, 2353.7881590656752, 2356.422676444265, 2374.786269235777, 2374.905003799846, 8465.49207047573, 8525.275351595123, 8531.146885311482, 8537.445066070686, 8585.570721463964, 5167.457416971201, 5264.710440925747, 5303.337082864642, 5306.628536002481, 5322.787088516455, 3413.6586341365914, 3425.9657403425895, 3486.267883744417, 3491.2319289756465, 3507.368673638744, 1111.3220935229504, 1117.2961034548182, 1137.9146564007733, 1168.3865970365541, 2075.6263872502946, 11364.545418183263, 11696.766064678744, 11742.178047536676, 11764.58823941158, 11860.466279017464, 4492.752898590609, 4588.95411045892, 4594.448666160015, 4759.666823322404, 4831.323614693945, 9389.201917836925, 9408.576614052385, 9448.858267126, 9465.195458386115, 9493.952530237304, 5250.107481728115, 5254.0805359062015, 5258.342707161605, 5289.788408463695, 5298.867528311746, 4808.687435316693, 4904.950950490521, 4907.312976183337, 4930.382558946437, 4949.257611358253, 3506.4564992426212, 3550.822458877046, 3598.1364472526407, 3622.8188590570367, 3651.9817400912825, 1027.2552399510296, 1091.792559413709, 1133.7165708572857, 1163.3078318400537, 1170.2978213072088, 816.2245866426919, 915.9725208243764, 917.6788124156625, 925.3799954030816, 956.364017928084, 5629.943700562942, 5710.3433105193435, 5723.914141287884, 5784.566157538202, 5883.852903677357, 899.0964081098585, 923.9907600923905, 947.1097168661436, 955.2119501411363, 959.2469911119738, 3783.2244389900006, 3851.807409629507, 3931.4692516510477, 3944.053427177514, 3994.6804255659476, 10332.896671033344, 10698.78602427947, 10731.034206921415, 10738.140948724084, 10741.0, 10615.89384106149, 10621.203409744145, 10636.0, 10706.839397409045, 10724.946375268073, 7646.541207527566, 7913.643886025143, 7920.445568810128, 8036.839263214703, 8100.149484304181, 5495.752691128989, 5522.831720930657, 5527.226188333717, 5596.524295434933, 5614.354349249726, 9198.448093114435, 9257.907420925705, 9318.0, 9613.51932403391, 9653.517324133905, 9660.855087173557, 9776.560054797408, 9807.852882206915, 9847.162991145833, 9947.751306217402, 7585.0, 7677.616119193906, 7692.538447693157, 7704.768856934301, 7706.229377062249, 7971.083325417651, 8063.193680632125, 8128.75613731589, 8144.226298501633, 8153.7553873383895, 7303.342699157101, 7369.8157546061775, 7374.741884034033, 7607.087149542091, 7617.733379331697, 7280.635968201675, 7321.890171647536, 7334.559926404433, 7360.374368178765, 7387.482876198615, 6587.143671322698, 6745.86508269822, 6783.084283621845, 6793.626350550767, 6820.488463365366, 4946.258061290835, 4973.776180071978, 5019.598432125495, 5068.518490743373, 5073.289739436408, 4747.382840230748, 4803.279508073817, 4805.783739731651, 4828.420589529139, 4960.70235785854], "value": 4517.800593914804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.35957327290276, 334.23627012276944, 343.3990516595957, 343.4196208407792, 347.99478007829873, 5181.1710126379785, 5284.577233821295, 5394.514493695567, 5440.374356948947, 5443.972780136099, 5214.739263036842, 5283.867903302419, 5300.734963251842, 5303.946960530394, 5350.438203988574, 4162.646175075122, 4212.178625168093, 4214.431051808013, 4236.661067114639, 4241.36379543068, 4172.77049762263, 4206.3690446432975, 4221.34569141782, 4226.492820861486, 4241.384999175118, 4184.91630167398, 4194.66442684586, 4207.747535147885, 4236.385724070024, 4243.893902652443, 4165.895852603694, 4174.561671024544, 4191.350340697197, 4195.832166713328, 4214.7471151731, 3739.0183202902504, 3768.4724138620613, 3768.5854555998817, 3769.8115094245454, 3815.2178803345246, 4961.675677296184, 5135.537801597874, 5154.484551544853, 5166.870828229286, 5178.689278643255, 4715.1512727709, 4716.198246298103, 4741.0, 4744.976275118637, 4758.904821903542, 5253.737313134328, 5536.307961504812, 5538.778448862041, 5543.279373681436, 5615.354234263071, 3965.4844870166694, 3984.641382275609, 4004.2592120457807, 4006.238814625212, 4026.8255142223165, 5719.942800571983, 5725.914111288334, 5728.513076388512, 5732.283464566929, 5735.799247026334, 4093.7339072960162, 4097.918041639151, 4129.793510324472, 4132.483439570054, 4149.419081328617, 4011.839526418969, 4109.506859176858, 4138.296489596776, 4149.356849688304, 4163.770992595376, 4681.695689780154, 4706.247000479907, 4713.713848783337, 4731.526847315241, 4736.171170045228, 5542.58664040667, 5544.889102218014, 5547.528460080857, 5558.194061861008, 5577.693226872561, 1283.0, 1340.4035204334173, 1369.582277405381, 1430.427828868461, 1435.1102316563797, 898.1602201941206, 902.702108304258, 922.0180507759216, 927.758782716485, 930.1489137439303, 4581.861424923871, 4628.490866004737, 4637.234856248749, 4637.724625727952, 4646.4191976003, 4899.828506002273, 4939.431965323962, 4956.826511072095, 4968.354113965162, 4995.375578052744, 4439.445069366329, 4585.770711464414, 4651.348811166439, 4676.883077923011, 4677.508861569554, 2656.9601455978177, 2657.38880057584, 2672.3452754075374, 2672.492226476963, 2685.3420911876715, 5051.393832740095, 5077.416097148801, 5078.451072422947, 5111.488851114858, 5126.256692779526, 4720.811167553259, 4964.354633897642, 5052.812589041572, 5068.873278168002, 5098.796048158107, 5046.243063540498, 5083.602009447432, 5085.46602606721, 5099.5410413063, 5108.59131269505, 4940.530649588283, 4953.925691114564, 4969.0, 4971.502849715, 5056.924146137737, 4887.413510378778, 4894.681845680019, 4939.43196532389, 5316.601254905975, 5723.656580605177, 5878.3239927408895, 5881.9705901470215, 5884.499817515559, 5895.764169433174, 5904.202932604216, 4113.568075352045, 4142.150859073822, 4154.875353739392, 4182.64447521964, 4186.246475634415, 5430.484104010113, 5714.942850571441, 5747.706765977621, 5777.306723193075, 5848.912266315923, 5443.666301756095, 5459.972700136474, 5583.55331573465, 5601.6358936668985, 5612.466815652507, 5566.9680566593715, 5571.220029195835, 5597.80407685729, 5610.298712660918, 5631.887362252814, 5353.457107873729, 5555.916661250004, 5587.167100458156, 5587.552995760248, 5612.747426365741, 5620.943790562042, 5622.0, 5625.959197548466, 5628.971855140862, 5634.661615429551, 5478.877040087272, 5502.624343914022, 5503.459031471194, 5517.896420715953, 5535.25274087993], "value": 4117.747709325629, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.8853177757446, 754.9282818132278, 768.9846203075939, 802.6949759091544, 844.1010324004936, 13643.181409115448, 13714.65713357164, 13840.10039347443, 13879.444822207099, 13962.162270263778, 13711.58865234042, 14031.929840350784, 14113.78829317561, 14253.78619320711, 14305.78541321881, 806.1615919443772, 819.8114433680257, 821.2936874288138, 822.8230930349973, 823.8764185372182, 672.2940912042336, 688.7795905310303, 801.9558924259163, 829.4069740135802, 835.4903508859591, 870.1559487297343, 871.6774793326479, 873.4104479476359, 873.8601823708208, 873.8732883731855, 864.7103220421103, 865.5153114256005, 865.9047504774501, 866.1295398124907, 866.1814585216972, 509.12430619334685, 520.6043407010699, 521.5045706578727, 523.2125650895379, 611.0803241122127, 13747.450101995908, 14300.642483937881, 14330.211838348887, 14357.210353430557, 14357.78463323051, 13389.732205355838, 13715.931420342935, 13861.090959682833, 14021.0, 14098.859011409857, 11399.829002564968, 11471.483783229774, 11577.53689852405, 12061.758764824743, 12100.334481603508, 4175.206710724983, 4260.467441569804, 4344.326629372453, 4466.464024317071, 4467.508574056851, 65031.0, 69274.0, 69304.6534767328, 70016.64991675009, 70443.64778176128, 10363.792724145625, 10610.57557697699, 10697.304675196086, 10929.453527323602, 10950.616728414467, 18565.81434185668, 19221.90389048046, 20582.38252852417, 20601.381958541268, 20670.10618513379, 6927.272636373108, 7465.514741541782, 7981.002374703162, 8114.513129212266, 8216.630251638691, 4489.461264648263, 4513.0, 4530.365748795171, 4543.864033991502, 4556.931646025312, 3402.302527981758, 3497.178163131662, 3500.1249687578106, 3506.7545271830727, 3512.947305790415, 617.3425302053299, 627.1783963008473, 637.9202599675041, 640.8494003909078, 648.3419329380682, 675.8749631318124, 692.5809885019592, 701.680735265453, 702.8383471801515, 760.5284723471373, 9154.148301400268, 9393.765155871159, 9642.42145471274, 9786.0, 9855.310128291094, 715.8317795318096, 716.1406312425111, 724.5978481942467, 728.1735230513406, 742.0798210219289, 4330.2638551446325, 4499.68502204849, 4522.0, 4582.473015603182, 4600.42494688164, 55614.0, 59185.0507656085, 88572.5571372139, 91262.0, 91309.54345228232, 51788.74105629448, 58530.707346462994, 76820.61589692016, 78425.0, 78647.0, 68983.0, 69693.0, 71151.99999999897, 72480.0, 74172.0, 8631.002736999253, 8844.115588441104, 9060.411073280216, 9148.451092934445, 9244.861327080234, 43075.56924430715, 44152.7792361049, 44595.33107003463, 44743.32885006793, 46090.539094609965, 35142.472862906565, 54880.72559637176, 55912.44087559072, 61300.38699612947, 64434.67782661057, 11746.76506469883, 11803.822942655695, 12087.917581016785, 12199.085068619712, 12610.0, 13396.665083372995, 13577.93211033978, 13762.518311859038, 13901.235432051335, 15135.243237838284, 13066.01593368111, 13142.0, 13296.135751176143, 13412.731745365234, 13520.93239533796, 10614.840777388192, 11195.60815371458, 11199.60801371948, 12963.675908102374, 13103.737925241632, 12743.745125097632, 12814.359282036048, 12854.357282135668, 12858.357082146042, 13005.21968681882, 10702.197335199735, 11264.66206013821, 11325.207235493437, 11690.123240756808, 11803.173777835469, 11222.466796185932, 11235.606753763579, 11296.209265351676, 11420.200585958903, 11592.768144637228], "value": 7057.0280765283915, "unit": "score"}], "name": "dromaeo_css", "value": 7104.1687293062205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 128.0, 166.0, 126.0, 125.0, 122.0, 125.0, 151.0, 121.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 112.0, 78.0, 75.0, 76.0, 76.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 123.0, 82.0, 82.0, 83.0, 107.0, 82.0, 83.0, 108.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 53.0, 60.0, 53.0, 55.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 63.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 83.0, 86.0, 92.0, 79.0, 80.0, 81.0, 83.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 130.0, 135.0, 129.0, 131.0, 138.0, 134.0, 169.0, 142.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 168.0, 166.0, 165.0, 164.0, 172.0, 165.0, 164.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1494.1, "alertThreshold": 2.0}]} 22:11:14 INFO - Return code: 0 22:11:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:11:14 INFO - # TBPL SUCCESS # 22:11:14 INFO - Running post-action listener: _resource_record_post_action 22:11:14 INFO - [mozharness: 2016-10-28 05:11:14.153588Z] Finished run-tests step (success) 22:11:14 INFO - Running post-run listener: _resource_record_post_run 22:11:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 395866112; Read time: 0; Write time: 290424 22:11:14 INFO - TinderboxPrint: CPU usage
13.1% 22:11:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:11:14 INFO - TinderboxPrint: I/O write bytes / time
395,866,112 / 290,424 22:11:14 INFO - TinderboxPrint: CPU idle
8,300.6 (86.9%) 22:11:14 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 22:11:14 INFO - TinderboxPrint: Swap in / out
0 / 0 22:11:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105701376; Read time: 0; Write time: 94376 22:11:14 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286253056; Read time: 0; Write time: 195120 22:11:14 INFO - Running post-run listener: _upload_blobber_files 22:11:14 INFO - Blob upload gear active. 22:11:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:11:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:11:14 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'] 22:11:14 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 22:11:15 INFO - (blobuploader) - INFO - Open directory for files ... 22:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:16 INFO - (blobuploader) - INFO - Done attempting. 22:11:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:11:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:19 INFO - (blobuploader) - INFO - Done attempting. 22:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:21 INFO - (blobuploader) - INFO - Done attempting. 22:11:21 INFO - (blobuploader) - INFO - Iteration through files over. 22:11:21 INFO - Return code: 0 22:11:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:11:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:11:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3e162ccfcd6683db1c96db8c99eae90655200271fe7562d27faa7c224b1f8b8cc193b0c9e77d21c38b07e9df5a0e6ee53111ec984158100c5d1440ceda92b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/204ee436aad77851f5e267dc92f7207f65f95360c9d53d78b32bdad467e283274c5cf679b3baa64591bb7321af0f38caee420e8f917bd990b47f2502158ab842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/970d96778cee2ad4ee4f0e189a8ec8e98b8364fefa28ef606bd0422d02417c54adfc0e54a67172d5ee01857cc6c538e32ac52802ea1aa21b97fb9345e8f054bb"} 22:11:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:11:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:11:21 INFO - Contents: 22:11:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3e162ccfcd6683db1c96db8c99eae90655200271fe7562d27faa7c224b1f8b8cc193b0c9e77d21c38b07e9df5a0e6ee53111ec984158100c5d1440ceda92b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/204ee436aad77851f5e267dc92f7207f65f95360c9d53d78b32bdad467e283274c5cf679b3baa64591bb7321af0f38caee420e8f917bd990b47f2502158ab842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/970d96778cee2ad4ee4f0e189a8ec8e98b8364fefa28ef606bd0422d02417c54adfc0e54a67172d5ee01857cc6c538e32ac52802ea1aa21b97fb9345e8f054bb"} 22:11:21 INFO - Running post-run listener: copy_logs_to_upload_dir 22:11:21 INFO - Copying logs to upload dir... 22:11:21 INFO - mkdir: /builds/slave/test/build/upload/logs 22:11:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.536048 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-27 22:11:20.744036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:11:20.747699) ========= 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-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3e162ccfcd6683db1c96db8c99eae90655200271fe7562d27faa7c224b1f8b8cc193b0c9e77d21c38b07e9df5a0e6ee53111ec984158100c5d1440ceda92b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/204ee436aad77851f5e267dc92f7207f65f95360c9d53d78b32bdad467e283274c5cf679b3baa64591bb7321af0f38caee420e8f917bd990b47f2502158ab842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/970d96778cee2ad4ee4f0e189a8ec8e98b8364fefa28ef606bd0422d02417c54adfc0e54a67172d5ee01857cc6c538e32ac52802ea1aa21b97fb9345e8f054bb"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477618222/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3e162ccfcd6683db1c96db8c99eae90655200271fe7562d27faa7c224b1f8b8cc193b0c9e77d21c38b07e9df5a0e6ee53111ec984158100c5d1440ceda92b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/204ee436aad77851f5e267dc92f7207f65f95360c9d53d78b32bdad467e283274c5cf679b3baa64591bb7321af0f38caee420e8f917bd990b47f2502158ab842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/970d96778cee2ad4ee4f0e189a8ec8e98b8364fefa28ef606bd0422d02417c54adfc0e54a67172d5ee01857cc6c538e32ac52802ea1aa21b97fb9345e8f054bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:11:20.775812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:11:20.776325) ========= 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-1477630241.50862-1402613319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:11:20.827049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:11:20.827362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:11:20.827651) ========= ========= Total master_lag: 0.14 =========