builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1477007358.48 results: success (0) buildid: 20161020162138 builduid: 9240a5999b8c42739c84628b3cc32c80 revision: 4be40c5468626cd5065cbc79674c933b908a2450 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.484890) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.485410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.485731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.504702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.505081) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 16:49:18-- 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% 50.8M=0s 2016-10-20 16:49:18 (50.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.633998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.634382) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014723 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:18.688065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 16:49:18.688953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4be40c5468626cd5065cbc79674c933b908a2450 --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 4be40c5468626cd5065cbc79674c933b908a2450 --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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 16:49:18,936 truncating revision to first 12 chars 2016-10-20 16:49:18,936 Setting DEBUG logging. 2016-10-20 16:49:18,936 attempt 1/10 2016-10-20 16:49:18,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4be40c546862?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 16:49:20,037 unpacking tar archive at: fx-team-4be40c546862/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 16:49:20.127118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:20.127548) ========= script_repo_revision: 4be40c5468626cd5065cbc79674c933b908a2450 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:20.127999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:20.128323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 16:49:20.138229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-20 16:49:20.138560) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:20 INFO - MultiFileLogger online at 20161020 16:49:20 in /builds/slave/test 16:49:20 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 16:49:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:49:20 INFO - {'append_to_log': False, 16:49:20 INFO - 'base_work_dir': '/builds/slave/test', 16:49:20 INFO - 'blob_upload_branch': 'Fx-Team', 16:49:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:49:20 INFO - 'branch': 'Fx-Team', 16:49:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:20 INFO - 'config_files': ('talos/linux_config.py',), 16:49:20 INFO - 'default_actions': ('clobber', 16:49:20 INFO - 'read-buildbot-config', 16:49:20 INFO - 'download-and-extract', 16:49:20 INFO - 'populate-webroot', 16:49:20 INFO - 'create-virtualenv', 16:49:20 INFO - 'install', 16:49:20 INFO - 'run-tests'), 16:49:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:20 INFO - 'download_minidump_stackwalk': True, 16:49:20 INFO - 'download_symbols': 'ondemand', 16:49:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:20 INFO - 'installer_path': 'installer.exe', 16:49:20 INFO - 'log_level': 'info', 16:49:20 INFO - 'log_name': 'talos', 16:49:20 INFO - 'log_to_console': True, 16:49:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:20 INFO - 'opt_config_files': (), 16:49:20 INFO - 'pip_index': False, 16:49:20 INFO - 'sps_profile': False, 16:49:20 INFO - 'sps_profile_interval': 0, 16:49:20 INFO - 'suite': 'dromaeojs', 16:49:20 INFO - 'system_bits': '32', 16:49:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:20 INFO - 'title': 'talos-linux64-ix-051', 16:49:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:20 INFO - 'use_talos_json': True, 16:49:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:49:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:20 INFO - 'work_dir': 'build'} 16:49:20 INFO - [mozharness: 2016-10-20 23:49:20.487063Z] Running clobber step. 16:49:20 INFO - Running pre-action listener: _resource_record_pre_action 16:49:20 INFO - Running main action method: clobber 16:49:20 INFO - rmtree: /builds/slave/test/build 16:49:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:49:20 INFO - Running post-action listener: _resource_record_post_action 16:49:20 INFO - [mozharness: 2016-10-20 23:49:20.947755Z] Finished clobber step (success) 16:49:20 INFO - [mozharness: 2016-10-20 23:49:20.947854Z] Running read-buildbot-config step. 16:49:20 INFO - Running pre-action listener: _resource_record_pre_action 16:49:20 INFO - Running main action method: read_buildbot_config 16:49:20 INFO - Using buildbot properties: 16:49:20 INFO - { 16:49:20 INFO - "project": "", 16:49:20 INFO - "product": "firefox", 16:49:20 INFO - "script_repo_revision": "production", 16:49:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:49:20 INFO - "repository": "", 16:49:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:49:20 INFO - "buildid": "20161020162138", 16:49:20 INFO - "stage_platform": "linux64-pgo", 16:49:20 INFO - "basedir": "/builds/slave/test", 16:49:20 INFO - "buildnumber": 550, 16:49:20 INFO - "platform": "ubuntu64_hw", 16:49:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:49:20 INFO - "slavebuilddir": "test", 16:49:20 INFO - "branch": "fx-team", 16:49:20 INFO - "revision": "4be40c5468626cd5065cbc79674c933b908a2450", 16:49:20 INFO - "slavename": "talos-linux64-ix-051", 16:49:20 INFO - "builduid": "9240a5999b8c42739c84628b3cc32c80", 16:49:20 INFO - "repo_path": "integration/fx-team" 16:49:20 INFO - } 16:49:20 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:49:20 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 16:49:20 INFO - Running post-action listener: _resource_record_post_action 16:49:20 INFO - [mozharness: 2016-10-20 23:49:20.950209Z] Finished read-buildbot-config step (success) 16:49:20 INFO - [mozharness: 2016-10-20 23:49:20.950297Z] Running download-and-extract step. 16:49:20 INFO - Running pre-action listener: _resource_record_pre_action 16:49:20 INFO - Running main action method: download_and_extract 16:49:20 INFO - mkdir: /builds/slave/test/build/tests 16:49:20 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')]} 16:49:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:49:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/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 16:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/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 16:49:20 INFO - Downloaded 1361 bytes. 16:49:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:49:20 INFO - Using the following test package requirements: 16:49:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:49:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'jsshell-linux-x86_64.zip'], 16:49:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:49:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:49:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:20 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:49:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:49:21 INFO - Http code: 200 16:49:21 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:49:21 INFO - x-amz-cf-id: kRgx-X3o6Zm2DXiAsW5YdXvgnsEh0XKiTiHS3-FtCUY2WoIIbrkYYA== 16:49:21 INFO - x-amz-replication-status: COMPLETED 16:49:21 INFO - x-amz-version-id: 8WO5OdKUmh6FA96tn8Xz_vD_jh8OSfMA 16:49:21 INFO - Expected file size: 22118595 16:49:21 INFO - Obtained file size: 22118595 16:49:25 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 16:49:25 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:49:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:25 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:49:25 INFO - Http code: 200 16:49:25 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:49:25 INFO - x-amz-cf-id: uJKWg9l5ZnWFtaVXaHCFE33veb8e3EwDS2lO6VrmY5Guc22R7FHJBg== 16:49:25 INFO - x-amz-replication-status: COMPLETED 16:49:25 INFO - x-amz-version-id: 8WO5OdKUmh6FA96tn8Xz_vD_jh8OSfMA 16:49:25 INFO - Expected file size: 22118595 16:49:25 INFO - Obtained file size: 22118595 16:49:30 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:49:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:49:30 INFO - Http code: 200 16:49:30 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 16:49:30 INFO - x-amz-cf-id: bEM3_UrN3VrDRTvPxaVXU3B1e5Kg06N_qU_38-Hz7QtClltWombG6w== 16:49:30 INFO - x-amz-replication-status: COMPLETED 16:49:30 INFO - x-amz-version-id: K_3cyRDL4QKhcDnyCov1LUdK5Ynd.gs9 16:49:30 INFO - Expected file size: 14409028 16:49:30 INFO - Obtained file size: 14409028 16:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:49:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/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 16:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/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 16:49:31 INFO - Downloaded 59484413 bytes. 16:49:31 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:49:31 INFO - mkdir: /builds/slave/test/properties 16:49:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:49:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:49:31 INFO - Contents: 16:49:31 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:49:31 INFO - Running post-action listener: _resource_record_post_action 16:49:31 INFO - Running post-action listener: set_extra_try_arguments 16:49:31 INFO - [mozharness: 2016-10-20 23:49:31.639708Z] Finished download-and-extract step (success) 16:49:31 INFO - [mozharness: 2016-10-20 23:49:31.639935Z] Running populate-webroot step. 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: populate_webroot 16:49:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:31 INFO - '--tppagecycles', 16:49:31 INFO - '7'], 16:49:31 INFO - 'tests': ['tsvgm']}}, 16:49:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:49:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:49:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:49:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['damp', 'tps']}, 16:49:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'tests': ['damp', 'tps']}, 16:49:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['dromaeo_dom']}, 16:49:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['basic_compositor_video']}, 16:49:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:49:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['a11yr', 16:49:31 INFO - 'ts_paint', 16:49:31 INFO - 'tpaint', 16:49:31 INFO - 'sessionrestore', 16:49:31 INFO - 'sessionrestore_no_auto_restore', 16:49:31 INFO - 'tabpaint']}, 16:49:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['tsvgx', 16:49:31 INFO - 'tsvgr_opacity', 16:49:31 INFO - 'tart', 16:49:31 INFO - 'tscrollx', 16:49:31 INFO - 'cart']}, 16:49:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:49:31 INFO - 'tsvgr_opacity', 16:49:31 INFO - 'tart', 16:49:31 INFO - 'tscrollx', 16:49:31 INFO - 'cart']}, 16:49:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'talos_options': ['--disable-e10s'], 16:49:31 INFO - 'tests': ['tp5o']}, 16:49:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'tests': ['tp5o']}, 16:49:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'talos_options': ['--disable-e10s', 16:49:31 INFO - '--xperf_path', 16:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:31 INFO - 'tests': ['tp5n']}, 16:49:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:31 INFO - 'talos_options': ['--xperf_path', 16:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:31 INFO - 'tests': ['tp5n']}}, 16:49:31 INFO - 'talos.zip': {'path': '', 16:49:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:31 INFO - Running post-action listener: _resource_record_post_action 16:49:31 INFO - [mozharness: 2016-10-20 23:49:31.655989Z] Finished populate-webroot step (success) 16:49:31 INFO - [mozharness: 2016-10-20 23:49:31.656076Z] Running create-virtualenv step. 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: create_virtualenv 16:49:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:49:31 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 16:49:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:49:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:31 INFO - Using real prefix '/usr' 16:49:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:49:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:34 INFO - Installing pip.................done. 16:49:34 INFO - Return code: 0 16:49:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:49:34 INFO - Reading from file tmpfile_stdout 16:49:34 INFO - Output received: 16:49:34 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) 16:49:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:49:34 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')]} 16:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:34 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')]} 16:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:34 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:34 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 16:49:34 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 16:49:34 INFO - Using env: {'DISPLAY': ':0', 16:49:34 INFO - 'HOME': '/home/cltbld', 16:49:34 INFO - 'LANG': 'en_US.UTF-8', 16:49:34 INFO - 'LANGUAGE': 'en_US:en', 16:49:34 INFO - 'LOGNAME': 'cltbld', 16:49:34 INFO - 'MAIL': '/var/mail/cltbld', 16:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:34 INFO - 'MOZ_NO_REMOTE': '1', 16:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:34 INFO - 'NO_EM_RESTART': '1', 16:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:34 INFO - 'PWD': '/builds/slave/test', 16:49:34 INFO - 'SHELL': '/bin/bash', 16:49:34 INFO - 'SHLVL': '1', 16:49:34 INFO - 'TERM': 'linux', 16:49:34 INFO - 'TMOUT': '86400', 16:49:34 INFO - 'USER': 'cltbld', 16:49:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:34 INFO - '_': '/tools/buildbot/bin/python'} 16:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:34 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 16:49:34 INFO - Cleaning up... 16:49:34 INFO - Return code: 0 16:49:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:49:34 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')]} 16:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:34 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')]} 16:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:34 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:34 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 16:49:34 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 16:49:34 INFO - Using env: {'DISPLAY': ':0', 16:49:34 INFO - 'HOME': '/home/cltbld', 16:49:34 INFO - 'LANG': 'en_US.UTF-8', 16:49:34 INFO - 'LANGUAGE': 'en_US:en', 16:49:34 INFO - 'LOGNAME': 'cltbld', 16:49:34 INFO - 'MAIL': '/var/mail/cltbld', 16:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:34 INFO - 'MOZ_NO_REMOTE': '1', 16:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:34 INFO - 'NO_EM_RESTART': '1', 16:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:34 INFO - 'PWD': '/builds/slave/test', 16:49:34 INFO - 'SHELL': '/bin/bash', 16:49:34 INFO - 'SHLVL': '1', 16:49:34 INFO - 'TERM': 'linux', 16:49:34 INFO - 'TMOUT': '86400', 16:49:34 INFO - 'USER': 'cltbld', 16:49:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:34 INFO - '_': '/tools/buildbot/bin/python'} 16:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:34 INFO - Downloading/unpacking psutil>=3.1.1 16:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:36 INFO - Installing collected packages: psutil 16:49:36 INFO - Running setup.py install for psutil 16:49:37 INFO - building 'psutil._psutil_linux' extension 16:49:37 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 16:49:37 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 16:49:37 INFO - building 'psutil._psutil_posix' extension 16:49:37 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 16:49:37 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 16:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:37 INFO - Successfully installed psutil 16:49:37 INFO - Cleaning up... 16:49:37 INFO - Return code: 0 16:49:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:49:37 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')]} 16:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 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')]} 16:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:37 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 16:49:37 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 16:49:37 INFO - Using env: {'DISPLAY': ':0', 16:49:37 INFO - 'HOME': '/home/cltbld', 16:49:37 INFO - 'LANG': 'en_US.UTF-8', 16:49:37 INFO - 'LANGUAGE': 'en_US:en', 16:49:37 INFO - 'LOGNAME': 'cltbld', 16:49:37 INFO - 'MAIL': '/var/mail/cltbld', 16:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:37 INFO - 'MOZ_NO_REMOTE': '1', 16:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:37 INFO - 'NO_EM_RESTART': '1', 16:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:37 INFO - 'PWD': '/builds/slave/test', 16:49:37 INFO - 'SHELL': '/bin/bash', 16:49:37 INFO - 'SHLVL': '1', 16:49:37 INFO - 'TERM': 'linux', 16:49:37 INFO - 'TMOUT': '86400', 16:49:37 INFO - 'USER': 'cltbld', 16:49:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:37 INFO - '_': '/tools/buildbot/bin/python'} 16:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:49:39 INFO - Installing collected packages: mozsystemmonitor 16:49:39 INFO - Running setup.py install for mozsystemmonitor 16:49:39 INFO - Successfully installed mozsystemmonitor 16:49:39 INFO - Cleaning up... 16:49:39 INFO - Return code: 0 16:49:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:39 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:39 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 16:49:39 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 16:49:39 INFO - Using env: {'DISPLAY': ':0', 16:49:39 INFO - 'HOME': '/home/cltbld', 16:49:39 INFO - 'LANG': 'en_US.UTF-8', 16:49:39 INFO - 'LANGUAGE': 'en_US:en', 16:49:39 INFO - 'LOGNAME': 'cltbld', 16:49:39 INFO - 'MAIL': '/var/mail/cltbld', 16:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:39 INFO - 'MOZ_NO_REMOTE': '1', 16:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:39 INFO - 'NO_EM_RESTART': '1', 16:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:39 INFO - 'PWD': '/builds/slave/test', 16:49:39 INFO - 'SHELL': '/bin/bash', 16:49:39 INFO - 'SHLVL': '1', 16:49:39 INFO - 'TERM': 'linux', 16:49:39 INFO - 'TMOUT': '86400', 16:49:39 INFO - 'USER': 'cltbld', 16:49:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:39 INFO - '_': '/tools/buildbot/bin/python'} 16:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:49:40 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 16:49:40 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 16:49:40 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 16:49:40 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 16:49:40 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 16:49:40 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 16:49:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:42 INFO - warning: no files found matching '*.txt' 16:49:42 INFO - no previously-included directories found matching 'build' 16:49:42 INFO - no previously-included directories found matching 'dist' 16:49:42 INFO - no previously-included directories found matching '.git*' 16:49:42 INFO - Installing collected packages: jsonschema, functools32 16:49:42 INFO - Running setup.py install for functools32 16:49:42 INFO - warning: no files found matching '*.txt' 16:49:42 INFO - no previously-included directories found matching 'build' 16:49:42 INFO - no previously-included directories found matching 'dist' 16:49:42 INFO - no previously-included directories found matching '.git*' 16:49:42 INFO - Successfully installed jsonschema functools32 16:49:42 INFO - Cleaning up... 16:49:42 INFO - Return code: 0 16:49:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:42 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 16:49:42 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 16:49:42 INFO - Using env: {'DISPLAY': ':0', 16:49:42 INFO - 'HOME': '/home/cltbld', 16:49:42 INFO - 'LANG': 'en_US.UTF-8', 16:49:42 INFO - 'LANGUAGE': 'en_US:en', 16:49:42 INFO - 'LOGNAME': 'cltbld', 16:49:42 INFO - 'MAIL': '/var/mail/cltbld', 16:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:42 INFO - 'MOZ_NO_REMOTE': '1', 16:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:42 INFO - 'NO_EM_RESTART': '1', 16:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:42 INFO - 'PWD': '/builds/slave/test', 16:49:42 INFO - 'SHELL': '/bin/bash', 16:49:42 INFO - 'SHLVL': '1', 16:49:42 INFO - 'TERM': 'linux', 16:49:42 INFO - 'TMOUT': '86400', 16:49:42 INFO - 'USER': 'cltbld', 16:49:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:42 INFO - '_': '/tools/buildbot/bin/python'} 16:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:49:42 INFO - Cleaning up... 16:49:42 INFO - Return code: 0 16:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:42 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 16:49:42 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 16:49:42 INFO - Using env: {'DISPLAY': ':0', 16:49:42 INFO - 'HOME': '/home/cltbld', 16:49:42 INFO - 'LANG': 'en_US.UTF-8', 16:49:42 INFO - 'LANGUAGE': 'en_US:en', 16:49:42 INFO - 'LOGNAME': 'cltbld', 16:49:42 INFO - 'MAIL': '/var/mail/cltbld', 16:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:42 INFO - 'MOZ_NO_REMOTE': '1', 16:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:42 INFO - 'NO_EM_RESTART': '1', 16:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:42 INFO - 'PWD': '/builds/slave/test', 16:49:42 INFO - 'SHELL': '/bin/bash', 16:49:42 INFO - 'SHLVL': '1', 16:49:42 INFO - 'TERM': 'linux', 16:49:42 INFO - 'TMOUT': '86400', 16:49:42 INFO - 'USER': 'cltbld', 16:49:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:42 INFO - '_': '/tools/buildbot/bin/python'} 16:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:42 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 16:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:49:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 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 16:49:45 INFO - Downloading docopt-0.6.1.tar.gz 16:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:45 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:45 INFO - Running setup.py install for blobuploader 16:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:45 INFO - Running setup.py install for requests 16:49:46 INFO - Running setup.py install for docopt 16:49:46 INFO - Successfully installed blobuploader requests docopt 16:49:46 INFO - Cleaning up... 16:49:46 INFO - Return code: 0 16:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:46 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 16:49:46 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 16:49:46 INFO - Using env: {'DISPLAY': ':0', 16:49:46 INFO - 'HOME': '/home/cltbld', 16:49:46 INFO - 'LANG': 'en_US.UTF-8', 16:49:46 INFO - 'LANGUAGE': 'en_US:en', 16:49:46 INFO - 'LOGNAME': 'cltbld', 16:49:46 INFO - 'MAIL': '/var/mail/cltbld', 16:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:46 INFO - 'MOZ_NO_REMOTE': '1', 16:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:46 INFO - 'NO_EM_RESTART': '1', 16:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:46 INFO - 'PWD': '/builds/slave/test', 16:49:46 INFO - 'SHELL': '/bin/bash', 16:49:46 INFO - 'SHLVL': '1', 16:49:46 INFO - 'TERM': 'linux', 16:49:46 INFO - 'TMOUT': '86400', 16:49:46 INFO - 'USER': 'cltbld', 16:49:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:46 INFO - '_': '/tools/buildbot/bin/python'} 16:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:46 INFO - Running setup.py (path:/tmp/pip-UaIPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:46 INFO - Running setup.py (path:/tmp/pip-PrkvsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:46 INFO - Running setup.py (path:/tmp/pip-Fv1nzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:46 INFO - Running setup.py (path:/tmp/pip-0dHBwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:46 INFO - Running setup.py (path:/tmp/pip-UtSugi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:46 INFO - Running setup.py (path:/tmp/pip-MSR73e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:47 INFO - Running setup.py (path:/tmp/pip-vZ84qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:47 INFO - Running setup.py (path:/tmp/pip-Q2zUNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:47 INFO - Running setup.py (path:/tmp/pip-Wf7taX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:47 INFO - Running setup.py (path:/tmp/pip-gvK1NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:47 INFO - Running setup.py (path:/tmp/pip-dfbhO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:47 INFO - Running setup.py (path:/tmp/pip-7JMWwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:47 INFO - Running setup.py (path:/tmp/pip-WPHcuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:47 INFO - Running setup.py (path:/tmp/pip-eElYsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:47 INFO - Running setup.py (path:/tmp/pip-SOpw4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:47 INFO - Running setup.py (path:/tmp/pip-TU3MfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:47 INFO - Running setup.py (path:/tmp/pip-O5_Yay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:47 INFO - Running setup.py install for manifestparser 16:49:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:47 INFO - Running setup.py install for mozcrash 16:49:48 INFO - Running setup.py install for mozdebug 16:49:48 INFO - Running setup.py install for mozdevice 16:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for mozfile 16:49:48 INFO - Running setup.py install for mozhttpd 16:49:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for mozinfo 16:49:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for mozInstall 16:49:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for mozleak 16:49:48 INFO - Running setup.py install for mozlog 16:49:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for moznetwork 16:49:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:48 INFO - Running setup.py install for mozprocess 16:49:49 INFO - Running setup.py install for mozprofile 16:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:49 INFO - Running setup.py install for mozrunner 16:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:49 INFO - Running setup.py install for mozscreenshot 16:49:49 INFO - Running setup.py install for moztest 16:49:49 INFO - Running setup.py install for mozversion 16:49:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:49 INFO - Cleaning up... 16:49:49 INFO - Return code: 0 16:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:49 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')]} 16:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 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')]} 16:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:49 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 16:49:49 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 16:49:49 INFO - Using env: {'DISPLAY': ':0', 16:49:49 INFO - 'HOME': '/home/cltbld', 16:49:49 INFO - 'LANG': 'en_US.UTF-8', 16:49:49 INFO - 'LANGUAGE': 'en_US:en', 16:49:49 INFO - 'LOGNAME': 'cltbld', 16:49:49 INFO - 'MAIL': '/var/mail/cltbld', 16:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:49 INFO - 'MOZ_NO_REMOTE': '1', 16:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:49 INFO - 'NO_EM_RESTART': '1', 16:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:49 INFO - 'PWD': '/builds/slave/test', 16:49:49 INFO - 'SHELL': '/bin/bash', 16:49:49 INFO - 'SHLVL': '1', 16:49:49 INFO - 'TERM': 'linux', 16:49:49 INFO - 'TMOUT': '86400', 16:49:49 INFO - 'USER': 'cltbld', 16:49:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:49 INFO - '_': '/tools/buildbot/bin/python'} 16:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:49 INFO - Running setup.py (path:/tmp/pip-V0YF1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:49 INFO - Running setup.py (path:/tmp/pip-BfpV9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:49 INFO - Running setup.py (path:/tmp/pip-Mfyqip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:50 INFO - Running setup.py (path:/tmp/pip-7nltH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:50 INFO - Running setup.py (path:/tmp/pip-FDc8Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:50 INFO - Running setup.py (path:/tmp/pip-18L6Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:50 INFO - Running setup.py (path:/tmp/pip-qxHyaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:50 INFO - Running setup.py (path:/tmp/pip-6C3RQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:50 INFO - Running setup.py (path:/tmp/pip-Lxxr8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:50 INFO - Running setup.py (path:/tmp/pip-zmKNb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:50 INFO - Running setup.py (path:/tmp/pip-wo0bd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:50 INFO - Running setup.py (path:/tmp/pip-xSmCdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:50 INFO - Running setup.py (path:/tmp/pip-rqbguF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:50 INFO - Running setup.py (path:/tmp/pip-ANivyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:50 INFO - Running setup.py (path:/tmp/pip-BXrZ1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:50 INFO - Running setup.py (path:/tmp/pip-JcZj2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:51 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)) 16:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:51 INFO - Running setup.py (path:/tmp/pip-EsTtf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:51 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)) 16:49:51 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)) 16:49:51 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)) 16:49:51 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)) 16:49:51 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)) 16:49:51 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)) 16:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:51 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 16:49:51 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 16:49:51 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 16:49:51 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 16:49:51 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 16:49:51 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 16:49:52 INFO - Downloading blessings-1.6.tar.gz 16:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:53 INFO - Installing collected packages: blessings 16:49:53 INFO - Running setup.py install for blessings 16:49:53 INFO - Successfully installed blessings 16:49:53 INFO - Cleaning up... 16:49:53 INFO - Return code: 0 16:49:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:53 INFO - Reading from file tmpfile_stdout 16:49:53 INFO - Current package versions: 16:49:53 INFO - argparse == 1.2.1 16:49:53 INFO - blessings == 1.6 16:49:53 INFO - blobuploader == 1.2.4 16:49:53 INFO - docopt == 0.6.1 16:49:53 INFO - functools32 == 3.2.3-2 16:49:53 INFO - jsonschema == 2.5.1 16:49:53 INFO - manifestparser == 1.1 16:49:53 INFO - mozInstall == 1.12 16:49:53 INFO - mozcrash == 0.17 16:49:53 INFO - mozdebug == 0.1 16:49:53 INFO - mozdevice == 0.48 16:49:53 INFO - mozfile == 1.2 16:49:53 INFO - mozhttpd == 0.7 16:49:53 INFO - mozinfo == 0.9 16:49:53 INFO - mozleak == 0.1 16:49:53 INFO - mozlog == 3.4 16:49:53 INFO - moznetwork == 0.27 16:49:53 INFO - mozprocess == 0.23 16:49:53 INFO - mozprofile == 0.28 16:49:53 INFO - mozrunner == 6.12 16:49:53 INFO - mozscreenshot == 0.1 16:49:53 INFO - mozsystemmonitor == 0.3 16:49:53 INFO - moztest == 0.7 16:49:53 INFO - mozversion == 1.4 16:49:53 INFO - psutil == 3.1.1 16:49:53 INFO - requests == 1.2.3 16:49:53 INFO - wsgiref == 0.1.2 16:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:53 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')]} 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 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')]} 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:53 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 16:49:53 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 16:49:53 INFO - Using env: {'DISPLAY': ':0', 16:49:53 INFO - 'HOME': '/home/cltbld', 16:49:53 INFO - 'LANG': 'en_US.UTF-8', 16:49:53 INFO - 'LANGUAGE': 'en_US:en', 16:49:53 INFO - 'LOGNAME': 'cltbld', 16:49:53 INFO - 'MAIL': '/var/mail/cltbld', 16:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:53 INFO - 'MOZ_NO_REMOTE': '1', 16:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:53 INFO - 'NO_EM_RESTART': '1', 16:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:53 INFO - 'PWD': '/builds/slave/test', 16:49:53 INFO - 'SHELL': '/bin/bash', 16:49:53 INFO - 'SHLVL': '1', 16:49:53 INFO - 'TERM': 'linux', 16:49:53 INFO - 'TMOUT': '86400', 16:49:53 INFO - 'USER': 'cltbld', 16:49:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:53 INFO - '_': '/tools/buildbot/bin/python'} 16:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 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)) 16:49:53 INFO - Cleaning up... 16:49:53 INFO - Return code: 0 16:49:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:53 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')]} 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 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')]} 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 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 0x7f5be6dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', '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 16:49:53 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 16:49:53 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 16:49:53 INFO - Using env: {'DISPLAY': ':0', 16:49:53 INFO - 'HOME': '/home/cltbld', 16:49:53 INFO - 'LANG': 'en_US.UTF-8', 16:49:53 INFO - 'LANGUAGE': 'en_US:en', 16:49:53 INFO - 'LOGNAME': 'cltbld', 16:49:53 INFO - 'MAIL': '/var/mail/cltbld', 16:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:53 INFO - 'MOZ_NO_REMOTE': '1', 16:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:53 INFO - 'NO_EM_RESTART': '1', 16:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:53 INFO - 'PWD': '/builds/slave/test', 16:49:53 INFO - 'SHELL': '/bin/bash', 16:49:53 INFO - 'SHLVL': '1', 16:49:53 INFO - 'TERM': 'linux', 16:49:53 INFO - 'TMOUT': '86400', 16:49:53 INFO - 'USER': 'cltbld', 16:49:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:53 INFO - '_': '/tools/buildbot/bin/python'} 16:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:49:53 INFO - Cleaning up... 16:49:53 INFO - Return code: 0 16:49:53 INFO - Running post-action listener: _resource_record_post_action 16:49:53 INFO - Running post-action listener: _start_resource_monitoring 16:49:53 INFO - Starting resource monitoring. 16:49:53 INFO - [mozharness: 2016-10-20 23:49:53.969357Z] Finished create-virtualenv step (success) 16:49:53 INFO - [mozharness: 2016-10-20 23:49:53.969817Z] Running install step. 16:49:53 INFO - Running pre-action listener: _resource_record_pre_action 16:49:53 INFO - Running main action method: install 16:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:54 INFO - Reading from file tmpfile_stdout 16:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:54 INFO - Reading from file tmpfile_stdout 16:49:54 INFO - Output received: 16:49:54 INFO - Usage: mozinstall [options] installer 16:49:54 INFO - Options: 16:49:54 INFO - -h, --help show this help message and exit 16:49:54 INFO - -d DEST, --destination=DEST 16:49:54 INFO - Directory to install application into. [default: 16:49:54 INFO - "/builds/slave/test"] 16:49:54 INFO - --app=APP Application being installed. [default: firefox] 16:49:54 INFO - mkdir: /builds/slave/test/build/application 16:49:54 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'] 16:49:54 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 16:50:11 INFO - Reading from file tmpfile_stdout 16:50:11 INFO - Output received: 16:50:11 INFO - /builds/slave/test/build/application/firefox/firefox 16:50:11 INFO - Running post-action listener: _resource_record_post_action 16:50:11 INFO - [mozharness: 2016-10-20 23:50:11.196290Z] Finished install step (success) 16:50:11 INFO - [mozharness: 2016-10-20 23:50:11.196612Z] Running run-tests step. 16:50:11 INFO - Running pre-action listener: _resource_record_pre_action 16:50:11 INFO - Running main action method: run_tests 16:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:50:11 INFO - Python 2.7.3 16:50:11 INFO - Return code: 0 16:50:11 INFO - grabbing minidump binary from tooltool 16:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:11 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 0x1c0f930>, '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 0x1c10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c10cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:11 INFO - Return code: 0 16:50:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:50:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:50:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:50:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:50:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:50:11 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 16:50:11 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 16:50:11 INFO - Using env: {'DISPLAY': ':0', 16:50:11 INFO - 'HOME': '/home/cltbld', 16:50:11 INFO - 'LANG': 'en_US.UTF-8', 16:50:11 INFO - 'LANGUAGE': 'en_US:en', 16:50:11 INFO - 'LOGNAME': 'cltbld', 16:50:11 INFO - 'MAIL': '/var/mail/cltbld', 16:50:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:50:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:11 INFO - 'MOZ_NO_REMOTE': '1', 16:50:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:11 INFO - 'NO_EM_RESTART': '1', 16:50:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:11 INFO - 'PWD': '/builds/slave/test', 16:50:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:50:11 INFO - 'SHELL': '/bin/bash', 16:50:11 INFO - 'SHLVL': '1', 16:50:11 INFO - 'TERM': 'linux', 16:50:11 INFO - 'TMOUT': '86400', 16:50:11 INFO - 'USER': 'cltbld', 16:50:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245', 16:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:11 INFO - '_': '/tools/buildbot/bin/python'} 16:50:11 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/1476992154/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 16:50:11 INFO - mozversion application_buildid: 20161020123554 16:50:11 INFO - mozversion application_changeset: 4be40c5468626cd5065cbc79674c933b908a2450 16:50:11 INFO - mozversion application_display_name: Nightly 16:50:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:11 INFO - mozversion application_name: Firefox 16:50:11 INFO - mozversion application_remotingname: firefox 16:50:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:50:11 INFO - mozversion application_vendor: Mozilla 16:50:11 INFO - mozversion application_version: 52.0a1 16:50:11 INFO - mozversion platform_buildid: 20161020123554 16:50:11 INFO - mozversion platform_changeset: 4be40c5468626cd5065cbc79674c933b908a2450 16:50:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:50:11 INFO - mozversion platform_version: 52.0a1 16:50:11 INFO - using testdate: 1477007411 16:50:11 INFO - actual date: 1477007411 16:50:11 INFO - starting webserver on 'localhost:49162' 16:50:11 INFO - SUITE-START | Running 2 tests 16:50:11 INFO - TEST-START | dromaeo_css 16:50:11 INFO - operating with platform_type : linux_ 16:50:11 INFO - Initialising browser for dromaeo_css test... 16:50:11 INFO - TEST-INFO | started process 27809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvlZ7f/profile http://localhost:49162/getInfo.html) 16:50:15 INFO - PROCESS | 27809 | __metrics Screen width/height:1600/1200 16:50:15 INFO - PROCESS | 27809 | colorDepth:24 16:50:15 INFO - PROCESS | 27809 | Browser inner width/height: 1024/697 16:50:15 INFO - PROCESS | 27809 | __metrics 16:50:16 INFO - PROCESS | 27809 | 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" 16:50:16 INFO - PROCESS | 27809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:16 INFO - PROCESS | 27809 | console.error: PushService: 16:50:16 INFO - PROCESS | 27809 | stateChangeProcessEnqueue: Error transitioning state 16:50:16 INFO - PROCESS | 27809 | UnknownError 16:50:17 INFO - TEST-INFO | 27809: exit 0 16:50:17 INFO - Browser initialized. 16:50:17 INFO - Running cycle 1/1 for dromaeo_css test... 16:50:17 INFO - TEST-INFO | started process 27892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvlZ7f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:29 INFO - PROCESS | 27892 | RSS: Main: 171335680 16:50:29 INFO - PROCESS | 27892 | 16:51:21 INFO - PROCESS | 27892 | 1477007481051 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] 16:53:31 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49162/tests/dromaeo/cssquery-ext.html) 16:53:33 INFO - PROCESS | 27892 | RSS: Main: 282697728 16:53:33 INFO - PROCESS | 27892 | 16:56:35 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-ext.html (next: http://localhost:49162/tests/dromaeo/cssquery-jquery.html) 16:56:36 INFO - PROCESS | 27892 | RSS: Main: 276299776 16:56:36 INFO - PROCESS | 27892 | 16:59:38 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49162/tests/dromaeo/cssquery-mootools.html) 16:59:38 INFO - PROCESS | 27892 | RSS: Main: 276656128 16:59:38 INFO - PROCESS | 27892 | 17:02:40 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49162/tests/dromaeo/cssquery-prototype.html) 17:02:41 INFO - PROCESS | 27892 | RSS: Main: 228704256 17:02:41 INFO - PROCESS | 27892 | 17:05:44 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49162/tests/dromaeo/cssquery-yui.html) 17:05:44 INFO - PROCESS | 27892 | RSS: Main: 217022464 17:05:44 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | Cycle 1(1): loaded http://localhost:49162/tests/dromaeo/cssquery-yui.html (next: http://localhost:49162/tests/dromaeo/cssquery-dojo.html) 17:08:48 INFO - PROCESS | 27892 | RSS: Main: 311586816 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | __start_tp_report 17:08:48 INFO - PROCESS | 27892 | _x_x_mozilla_page_load 17:08:48 INFO - PROCESS | 27892 | _x_x_mozilla_page_load_details 17:08:48 INFO - PROCESS | 27892 | |i|pagename|runs| 17:08:48 INFO - PROCESS | 27892 | |0;dojo.html;3044.391121775645;3063.3873225354932;3065.4022465619205;3120.7659425543075;3123.0786917859227;5108.667936584119;5161.4322424533275;5273.762680679369;5327.600429967753;5376.032314183451;5233.869153271161;5243.973780131094;5317.2821669074665;5371.274877891484;5439.184122381635;4811.06184294061;4851.611871050325;4866.270059491069;4874.049560335736;4908.705477671333;4826.46908840029;4902.509749025105;4932.630052746058;4945;4958.9752051239875;4892.168331383673;4939.160342741742;4942.283368911506;4961.702297862122;5015.197568389059;4728.456227533843;4762.333273341735;4798.328234047236;4801.1117943180625;4876.585490233334;4704.200285951397;4725.291206319045;4764.904701905977;4792.592629626486;4837.95162048382;5155.304033955405;5159.489118177424;5202.713850738208;5232.764525596319;5269.525742683139;5485.753141108659;5542.501174894239;5562.3881373048935;5566.693831839248;5568.693721845297;5580.939621471907;5687.943120568782;5729.82810515681;5733.799317023926;5798.9130163047585;5340;5345.812896548602;5345.812896548641;5348.893022139536;5354.598405119632;5543.833684989457;5795.710214489343;5800.4489573490455;5804.535637149018;5810.883782324415;5389.973050134724;5415.48552887475;5470.398256191816;5567.359753628303;5572.4706152915405;5666.178404131378;5666.744996475169;5679.091345384802;5719.142128680731;5721;5654.943450565524;5661.575381846378;5662.292213473316;5667.858303542444;5670.829875103754;5409.29679141709;5521.503064724194;5660.235868157746;5663.150527420919;5732.914006289909;4302.612764851178;4304.827806887752;4305.182015417061;4307.526172121127;4308.138372325548;3862.0537968197973;3902.375619900802;3905.1018265799025;3907.081835768592;3969.6030396960073;5441.83674489766;5447.754851031713;5455.1271796512365;5455.645383050169;5455.754491047913;5744.942550574441;5786.3056433228285;5788.334341550775;5798;5800.8259752207505;5211.348581427322;5237.764300606405;5353.652012619167;5397.9460205397445;5410;4978.054169707744;4978.178600530944;4981.4769449207315;4984.8753781155765;5031.195008798648;5932.228810254639;5950.613210141327;5951.107333900036;5953.2866896403675;6018.849528761729;5478;5595.972020139873;5628.831135065954;5711.685857277889;5756.819851930428;5849.034909240098;5886.6173698709445;5892.587518873809;5928.822135335947;5959.22530071088;5593.608447408642;5596.776128954796;5605.971970140286;5610.074337734228;5611.046122159161;5403.243545903498;5425.511703946664;5516.420775818642;5587.720613969366;5709.029464991045;5465.781368745205;5471;5473.425290344616;5535.031369510239;5537.861553461034;5401.432849550741;5438.755256013568;5441.127439027557;5451.64564303319;5460.754266058117;5330.733463326896;5374.892502150014;5385.865353366197;5440.755166017618;5443.074677304789;5523.613347065828;5636.098224284095;5658.292713410824;5675.120356344773;5692.260006199168;5516.503514683698;5521.089020311603;5523.8066667666435;5526.088195447706;5585.413531579125 17:08:48 INFO - PROCESS | 27892 | |1;ext.html;601.3415310235292;613;613.5183880653686;651.4885814635512;659.5449140093339;30248.243793905163;40183.39724904125;41038.58961410393;41159.99999999996;45553.54446455543;43369;43722.781386093026;43735.562644373545;43805;43810.990241561354;8759.824803503941;8955.686550970717;8956.641734330651;8960.059193784657;8962.551872406386;6215.906761398583;6352.333005034474;10377.792444151113;10627.41549214793;10635.042846143846;10860.34837909724;10921.617743378984;10938.343699378023;10943;10960.506777195005;10629.36223826569;10684.572617095308;10691.198160137981;10696.411697356642;10730.90747304276;10540.736481588021;10609.73475663107;10622.521986510626;10624.415657138854;10624.415657138854;40227.7988610058;40448.79775601133;40540.797296013334;40552.797236013925;40584.59415405837;3391.253924136686;3407.642197569244;3557.7509574329547;3833.11838277195;4041.4341992121126;30163.849180754176;31175.220619484466;31179.84410077935;31313;31329.373412531848;3935.724499285051;3994.3590354745234;4013.7591744495426;4090.365993271048;4267.615914567673;319349;322034;322615.3869230662;323018;325259;55114.448855511735;55388;55436.722816386464;55445.1683224752;55504.16743748847;58954.70522647359;59104.704476477345;59127.40872591219;59130.70434647799;59131.40868591345;15064.849351506344;15299;15303.770443443358;15332.080075195525;15341.539753807403;11595.536178552931;11653.88346116545;11708.765824683458;11709.941450292694;11887.16789824704;14774.335154917839;14903.254837258093;15187.392504299925;15587.688246235239;15620.218989050501;5981.671008094597;6023.427774361428;6145.9692701536205;6253.187085678833;6255.74977000924;875.9430637008702;887.8801361816202;1000.1848493477938;1001.8246806808925;1024.9538770755335;29086;30393.24016899551;30874.382512349628;30992.070237892898;31316.37367252688;1026.9844906415879;1040.9375437473775;1048.6120135549895;1066.5040756048475;1087.478010554938;16210.918945405198;16241.593960150854;16340.346386144422;16365.345386184657;16682.249298781582;455526;484687;494349;495014;738807;51144.23283650748;51558;51634;51663.74168129211;51765.2235216472;1294.223465920459;1305.6866352075433;1334.5929491505185;1338.6184937292826;1346.9797953030713;28558.714412855606;30515.711321651408;30694.539581905843;31129.37741245208;31233;48001.27998080102;48430.27354589613;48437.27344089912;48442.27336590025;48461;405305;405557;406730;407339.44954127964;407518;24761.876190618932;24844.627330590418;25549.87225063863;26207.60688589711;26550.468990619695;38730.6126938727;42521.36217956795;42685.5731442694;42752.57247427486;42838.143237134456;36622.816885916465;36673.63326366702;36906.261874762895;37064;37519.624803752704;36277.63722362848;36853.63146368502;37162.44256336103;37648.43527347147;38395.80802095972;36596.268074638894;37151.44272835964;37170;37417.43873841949;38084.80957595194;31312.686873130977;33187.170320742174;33567.83216083904;33674.83162584171;33873.830630846685;25456.363590910376;25656;25880.22359329223;26598.468030639666;27983.44033119367 17:08:48 INFO - PROCESS | 27892 | |2;jquery.html;368.8340246888897;373.68423681988725;396.75599506303615;396.99206015879685;416.41909536197005;13651.382383668324;14598.854011459882;16771.329146834127;19395.93322367269;19478.80521194791;19197.904010479964;19390.515237119078;19512;19742;19762.802371976275;5442.346918369801;5561.694106824133;5818.2145410369485;5825.417458254183;5826.854328641797;5277.7888884444765;5710.77156913723;5718.513926316247;5736.225609542721;5745.540356771469;5586.86032849178;5692.5161361284345;5701.315842098933;5706.457886500776;5713.628614140068;5776.624519406246;5922.2597175353085;5932.347441781422;5933;5938.317093534256;5599.60802743804;5740.225069615632;5740.339860915965;5743.712814359265;5788.27646544182;22116.447088822748;22198.445038873997;22531.21140760082;22583.096676132936;22937.54124917509;2053.2505635443104;2082.3232449453835;2109.6202683516963;2134.6157691615504;2293.185918998748;10041.598336066549;10095.949520252425;10246.692599222035;10684.626038088629;10691.411972341519;1855.9628807423776;1917.319351630165;1946.1145178943548;1949.3761996161234;1961.9705704414446;55068.724656376864;59565.40434595642;62913.68543157301;78968.21031789723;84357.57821210916;9922.454265015349;10489.685309440729;10751.19366047534;10806.189535784848;10981.505832237568;15460.458883939233;15494.07035577869;15496.457623983106;15499.767503487457;15511.301991410413;7789.844203116019;7842.343121033287;7984.880226796603;8022;8226.506409615442;7513.47405681608;7618.123915749649;7836.568988705562;7843.9215607844335;7906.604669766489;4502.279635258343;4608.470025947059;4666.183417901853;4735.029318989667;4740.3837501124635;1847.6951303034848;1922.4136638325165;1972.2151452935116;1990.4725247809054;2000.5698774763496;859.5873980489275;976.9755756106155;992.7666998255404;1014.5434554450527;1018.5162048027128;17833;19460.22159113648;19584.608307833765;20779.376618701463;20993.160273588885;909.9272058235325;909.9590518426687;917.1607978699549;924.7872989212519;927.3832901120815;8738.912610873937;11227.66317010491;11242.325460472397;11252.49363778632;11290.774184516264;333218;337409;338252;460560;462072;85832.57083714541;88732;90247.54876225708;91860;94132;1019.3374306700556;1022.5858527296457;1063.7925604507202;1065.2223876570147;1065.6589891234885;16424.589385265463;17306.307747689953;17973.73039404384;18195.32527621561;18209.271629134688;40062.79968600255;40147.59852401556;41556.58443415648;41596.58403415927;42065.57934420739;52582;54313.18530221971;55655.44344556665;56631.71684141553;57049.71475142764;7972.641231144728;7972.84054318922;8065.596720163851;8324.875126873223;8376.706815261681;11192.88807111951;12922;13132.27772472485;13153.342332883509;13466.528671496451;11264.965021366084;11530.654080377602;11867.406629668654;11914;11996.340201289013;10576.41829699374;11451.14116441287;11505.827412588986;11510.906463885918;11838.940805295919;11383.146264030396;11416.200865939305;11423.143264255048;11828.40857957116;12090.697732556757;7432.702691892264;7744.380449564134;8344.207300306462;8566.271866891384;8623.353248506262;11085;11237.269577477764;11412.372319522507;11415.143864210051;11658.825117623412 17:08:48 INFO - PROCESS | 27892 | |3;mootools.html;1307.2940612069483;1444.8916331275157;1477.0989696285267;1606.3414000259888;1735.6702226576958;7148.213696493388;7780.649870755816;8116.431849770518;8118.91881081189;8310.91689083109;8168.224018718227;8240.876386854203;8241;8243.711470098548;8245.670173193064;2279.282026161758;2304.700388949434;2305.3890718959487;2306.3888069661552;2314.2710046335433;2201.361605134509;2244.5286489837154;2249.4601295689;2257.898394572248;2260.1976298414074;2221.0671517962414;2243.607368710477;2249.9437514062115;2285.759995200505;2291.2897001929455;2212.9557408851733;2222.944426389345;2224.8887555622237;2226;2231.7768223177713;2190.769969153248;2196.626573482512;2198.1756841184556;2205.878676672782;2206.6689996500654;8109.4323397362205;8160.673573057071;8164.795880102985;8393.202645748644;8480.279176270025;5108.055009823194;5321.49445802652;5325.733713314357;5328.20076988451;5338.839834804962;3423.640517745626;3456.1532424556144;3465.5148279240925;3548.982255088734;3549.9172752310533;1116.4696769034724;1118.3681220110611;1118.6476259978162;1146.1346683254174;1161.030539499519;11670.241434306829;11696.590619328283;11772.352520611448;11785.764284714258;11814.881851181464;4354.934675979863;4363.629091527192;4572.45130584332;4581;4602.792874320664;9411;9436.339456238135;9440.763980900396;9442.38624489406;9446.29152813528;5222.294990176278;5222.738863056908;5228.607854410859;5232.816851410183;5234.057869583511;4180.540140584533;4295.699301048959;4715.104130215248;4789.233722604366;4906.092372910952;3634.5638523377365;3684.3552378333684;3759.473673685686;3777.54669439669;3817.732758706864;1168.2056201782868;1170.0044348549607;1180.651707746217;1190.434543591787;1195.9880401195876;862.3618522293458;896.7309807057857;907.5507623726297;909.1272378516699;933.5005771911995;5486.945130548724;5740.454656807597;5744.942550574441;5798;5829.708514574254;382.11921520894606;391.1355903453343;393.1311800919999;394.04051135485184;973.4937832327291;3732.328180927405;3940.4286378474962;3963.781991990468;3976.5029371328583;4099.61053699898;10380.117689996436;10691.35851848876;10740.30188037775;10753.56985720578;10780.568777248822;10517.053465188017;10602.681919542427;10664.41345725977;10681.786364272826;10682;7592.962035189788;8012.278894899487;8151.796205094802;8164.877526837102;8179.509229446252;5826.300843898759;5829.8251052468495;5935.228420305332;5982.790602328898;6000.129981152621;9354.71935841926;9517.333786634868;9549.856752148584;9557.23542116643;9662.758431039;9749.951250243703;9892.554835032584;9939.850902236327;9962.153216976638;10030.899691002996;6653.73385064592;6896.896546551906;7071.257517960746;7547.622618868925;7664.578448185403;7754.457187996786;8053.073896501977;8066.717664881701;8075.717349892726;8085.474444161111;6996.6151861648095;7087.326703963321;7111.111111111111;7262.9273707264365;7319.231480694663;7117.857642847218;7190.532615379983;7200.819979500555;7208.819779505554;7209.495335326476;6221.160143380585;6355.396237357444;6393.776217832354;6403.775867844603;6422.807315780534;4830.106430310404;4927.507249275187;4928.581070609039;4939.431965324034;5018.774155162953;4663.743494107856;4715.78778954941;4730.550597693214;4772.976135119302;4929.359183306147 17:08:48 INFO - PROCESS | 27892 | |4;prototype.html;306.6351042259711;320.3480916335258;327.07437950599797;335.6945179886304;337.81082593747504;5248.13405788045;5312;5323.190115360777;5326.8401947941575;5366.087765079936;4982.825601103962;5019.569422714527;5088.389393272803;5143.974280128604;5310.8141215057485;4093.5906409358977;4108.5686002969705;4110;4121.793910304487;4142.668586513072;4084.774567629714;4112.683941138836;4141.855035073773;4146.170765846828;4174.206900688874;3823.5029446171957;3905.2384784966944;4092.0997380576227;4106.527749308838;4117.155983023473;4059.4316795648633;4085.5301640311445;4106.864430496155;4123.690723195772;4131.834726610947;3666.6883314918264;3674.577423596294;3675.3935600625864;3678.0988657779017;3690.520232369775;5050.6212034097225;5079.174783955257;5137.152369858969;5168.483151684839;5184.496496016151;4724.763761811896;4741.478437371887;4778.092162489116;4788.832390866303;4796.208625576811;5458.052651568149;5479.287692599976;5499.450054994469;5523.861903452445;5534.4742249486235;3743.9251214975548;3971.225611005855;4047.150098479323;4054.635082842529;4057.1885622875543;5554.028045092093;5646.237757902672;5647.774089036434;5661.405552416978;5663.207150998822;3976.900577485586;4012.6990475714438;4019.477467929209;4032.4354590357375;4038.5153781545814;3888.630580094943;4087.2234275487563;4095.91808163841;4113.095119073799;4132.669386449077;4584.074688630783;4636;4651.697639653412;4675.158471475167;4710.3405523226775;5480.890382192413;5482.945170548323;5484.780608775604;5572.606848287928;5576.86057848557;1338.3575883575938;1403.109025768624;1408.6830463145916;1410.182094385254;1423.309694798022;881.7795551112222;914.9176574108362;918.2424499787702;919.4942781470164;921.5115988525957;4705.435347758223;4730.864592497775;4744.478107408182;4752.574227731736;4792.9281060784115;4620.884477888079;4935.284383764334;4954;4962.652614317035;4981.011393164145;4681.204195286809;4688.789004494806;4692.029347673985;4716.245400735935;4716.57550820421;2632.723564025788;2638.6569745932907;2645.854478003728;2647.8411295322344;2657.3223827924144;4883.267509873547;5016.297718319438;5040.747962601855;5056.84829455117;5123.38519377677;4946.554810067111;4965.677230979974;4985.825496107619;5006.299118123466;5013.849584512471;5019.02129084825;5060.3168572242275;5062.835547824021;5106.285120083191;5131.486851314913;4862.4651288357545;4941.555260026615;4985.376827896513;5317.388500322512;5746.913796292975;5589.217509548747;5642.60501764889;5659.3022093371;5663.8867222656145;5669.177969194526;5852.770918107245;5856.970715146397;5874.443272532868;5919.881602367843;5941.673207973603;3999.5200575931076;4052.4731784867777;4080.3471444568727;4096.3855421686985;4101.733387329814;5439.205062329501;5541.445855414427;5579.581531385081;5731.713414329351;5753.568482363923;5575.776968921197;5589.804356847653;5602.663840169603;5611.158326251095;5620.915686264628;5302.973485132549;5469.823987842633;5542.944570554243;5544.889102218014;5548.085910360919;5414.214938833926;5418.241446197457;5456.61803673739;5470.480304371237;5472.398036215934;5566.304211973504;5578.665280083208;5591.832245032656;5641.5204707600315;5670.829875103754;5194.156074593616;5428.212909128233;5439.5104440600535;5554.139108438037;5561.582881283839 17:08:48 INFO - PROCESS | 27892 | |5;yui.html;705.5872314695903;715.3954908102652;717.8205448637841;761.0524896503852;794.5629903553045;14953.775693364594;15898.682026359465;16652.000879947213;16652.417165399213;16655.833441665596;14586.927065364685;14737.852621473781;14836.48072317469;14855.034422762514;14869.330880110394;665.3080795972184;790.8497385496765;802.5987006496752;804.5494523067072;809.1423091522975;678.043958019193;781.5662307419379;790.8220650353682;794.9165337639552;810.2221867007651;841.7685136587456;843.5866425451516;844.0462277626274;844.4426678392263;844.8183640517287;683.0607914118087;829.4525613095389;840.4453060979755;841.8400503904269;841.970531031414;515.4793658405;598.724586690123;606.6420811721061;606.7785258380703;618.1006635345561;14071.788923166161;14078.577642670736;14082.507112251022;14118.788218176736;14140.505082322172;13278.336083195802;13996.8522820955;14022.509212177627;14168.220747858864;14183.858161418357;11560.53757849685;11905.583304584385;12276;13003.674908127277;13163.605091847165;4383.671224658164;4397.802098905557;4422.6682998774895;4635.072985402933;4641.698289611165;71393;72033.63983180051;72140.63929680371;72816;72869;11136.777264454828;11168.776624467466;11442;11505.482253298622;11622.024255876522;20862.895685521475;21014.579708405745;21070.47323816917;21161.576768464543;21233.68149477759;8101.473404228706;8140.3487720982175;8589.398742088119;8592.484450932963;8596.097409771884;4167.333226683716;4303.827846886152;4334.154839806208;4405.823767049346;4460.643148548108;3277.1643230975947;3361.1429085583018;3361.680640339164;3377.324535092991;3382.5940887093707;567.6877717255493;576.0076403085928;583.5185971573469;588.0532342927883;608.796053322142;604.4771272849042;694.4722011271369;718.9604571748499;730.3791776989516;754.4567911103996;9570.282228832726;9772.902270977342;9804.852927206097;9965.601375945025;10080.596776128872;634.3719717479754;674.8751480976035;710.9751158709524;721.1850608812009;725.9854802903913;4431.311694042215;4523.773811309421;4639.976800115978;4890.339804126468;4892.070506603805;119529.40235298942;120056;121513.88645851596;122556.38721806333;124432;62990;96589.51705241429;103216;106613;107797;58493;92132.53933730288;92695;93305;94672;8940;8942.451401350583;9311.813763724553;9314.580843861906;9369.344145909721;54213;54567.18149227685;55354.446455534926;55619.165712515154;57973.420265796805;74163;75057.6247118761;82138.58930705309;82681;83603;11792;11904.166708330335;11964.700882478008;12015.939920300343;12204.75590488203;11996.520139194683;12259.877401225873;12319.815202771786;12343.259404435763;13160.473581057033;12614.180078294881;13184;13367.866321336662;13590.388432520758;13601.115927464683;12373;12458.878700916961;12906.419211135333;13441.731165376834;13480.730385392433;11361.659150225507;11485.540578376771;11728.41357932117;12106.092043096627;12107.75784484323;9734.659286924923;9734.951325243612;10306.845397318897;10313.690589282334;10327.122194613543;10331.845022324822;10706.571737130738;10713.94643026811;10715.142788576739;10801.1644600417 17:08:48 INFO - PROCESS | 27892 | __end_tp_report 17:08:48 INFO - PROCESS | 27892 | __start_cc_report 17:08:48 INFO - PROCESS | 27892 | _x_x_mozilla_cycle_collect,1217 17:08:48 INFO - PROCESS | 27892 | __end_cc_report 17:08:48 INFO - PROCESS | 27892 | __startTimestamp1477008528269__endTimestamp 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | ------- Summary: start ------- 17:08:48 INFO - PROCESS | 27892 | Number of tests: 6 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#0] dojo.html Cycles:165 Average:5267.31 Median:5441.84 stddev:589.77 (10.8%) stddev-sans-first:565.21 17:08:48 INFO - PROCESS | 27892 | Values: 3044.4 3063.4 3065.4 3120.8 3123.1 5108.7 5161.4 5273.8 5327.6 5376.0 5233.9 5244.0 5317.3 5371.3 5439.2 4811.1 4851.6 4866.3 4874.0 4908.7 4826.5 4902.5 4932.6 4945.0 4959.0 4892.2 4939.2 4942.3 4961.7 5015.2 4728.5 4762.3 4798.3 4801.1 4876.6 4704.2 4725.3 4764.9 4792.6 4838.0 5155.3 5159.5 5202.7 5232.8 5269.5 5485.8 5542.5 5562.4 5566.7 5568.7 5580.9 5687.9 5729.8 5733.8 5798.9 5340.0 5345.8 5345.8 5348.9 5354.6 5543.8 5795.7 5800.4 5804.5 5810.9 5390.0 5415.5 5470.4 5567.4 5572.5 5666.2 5666.7 5679.1 5719.1 5721.0 5654.9 5661.6 5662.3 5667.9 5670.8 5409.3 5521.5 5660.2 5663.2 5732.9 4302.6 4304.8 4305.2 4307.5 4308.1 3862.1 3902.4 3905.1 3907.1 3969.6 5441.8 5447.8 5455.1 5455.6 5455.8 5744.9 5786.3 5788.3 5798.0 5800.8 5211.3 5237.8 5353.7 5397.9 5410.0 4978.1 4978.2 4981.5 4984.9 5031.2 5932.2 5950.6 5951.1 5953.3 6018.8 5478.0 5596.0 5628.8 5711.7 5756.8 5849.0 5886.6 5892.6 5928.8 5959.2 5593.6 5596.8 5606.0 5610.1 5611.0 5403.2 5425.5 5516.4 5587.7 5709.0 5465.8 5471.0 5473.4 5535.0 5537.9 5401.4 5438.8 5441.1 5451.6 5460.8 5330.7 5374.9 5385.9 5440.8 5443.1 5523.6 5636.1 5658.3 5675.1 5692.3 5516.5 5521.1 5523.8 5526.1 5585.4 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#1] ext.html Cycles:180 Average:57154.45 Median:36436.95 stddev:115366.03 (316.6%) stddev-sans-first:115611.52 17:08:48 INFO - PROCESS | 27892 | Values: 601.3 613.0 613.5 651.5 659.5 30248.2 40183.4 41038.6 41160.0 45553.5 43369.0 43722.8 43735.6 43805.0 43811.0 8759.8 8955.7 8956.6 8960.1 8962.6 6215.9 6352.3 10377.8 10627.4 10635.0 10860.3 10921.6 10938.3 10943.0 10960.5 10629.4 10684.6 10691.2 10696.4 10730.9 10540.7 10609.7 10622.5 10624.4 10624.4 40227.8 40448.8 40540.8 40552.8 40584.6 3391.3 3407.6 3557.8 3833.1 4041.4 30163.8 31175.2 31179.8 31313.0 31329.4 3935.7 3994.4 4013.8 4090.4 4267.6 319349.0 322034.0 322615.4 323018.0 325259.0 55114.4 55388.0 55436.7 55445.2 55504.2 58954.7 59104.7 59127.4 59130.7 59131.4 15064.8 15299.0 15303.8 15332.1 15341.5 11595.5 11653.9 11708.8 11709.9 11887.2 14774.3 14903.3 15187.4 15587.7 15620.2 5981.7 6023.4 6146.0 6253.2 6255.7 875.9 887.9 1000.2 1001.8 1025.0 29086.0 30393.2 30874.4 30992.1 31316.4 1027.0 1040.9 1048.6 1066.5 1087.5 16210.9 16241.6 16340.3 16365.3 16682.2 455526.0 484687.0 494349.0 495014.0 738807.0 51144.2 51558.0 51634.0 51663.7 51765.2 1294.2 1305.7 1334.6 1338.6 1347.0 28558.7 30515.7 30694.5 31129.4 31233.0 48001.3 48430.3 48437.3 48442.3 48461.0 405305.0 405557.0 406730.0 407339.4 407518.0 24761.9 24844.6 25549.9 26207.6 26550.5 38730.6 42521.4 42685.6 42752.6 42838.1 36622.8 36673.6 36906.3 37064.0 37519.6 36277.6 36853.6 37162.4 37648.4 38395.8 36596.3 37151.4 37170.0 37417.4 38084.8 31312.7 33187.2 33567.8 33674.8 33873.8 25456.4 25656.0 25880.2 26598.5 27983.4 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#2] jquery.html Cycles:180 Average:25493.30 Median:335313.50 stddev:64912.80 (19.4%) stddev-sans-first:65067.49 17:08:48 INFO - PROCESS | 27892 | Values: 368.8 373.7 396.8 397.0 416.4 13651.4 14598.9 16771.3 19395.9 19478.8 19197.9 19390.5 19512.0 19742.0 19762.8 5442.3 5561.7 5818.2 5825.4 5826.9 5277.8 5710.8 5718.5 5736.2 5745.5 5586.9 5692.5 5701.3 5706.5 5713.6 5776.6 5922.3 5932.3 5933.0 5938.3 5599.6 5740.2 5740.3 5743.7 5788.3 22116.4 22198.4 22531.2 22583.1 22937.5 2053.3 2082.3 2109.6 2134.6 2293.2 10041.6 10095.9 10246.7 10684.6 10691.4 1856.0 1917.3 1946.1 1949.4 1962.0 55068.7 59565.4 62913.7 78968.2 84357.6 9922.5 10489.7 10751.2 10806.2 10981.5 15460.5 15494.1 15496.5 15499.8 15511.3 7789.8 7842.3 7984.9 8022.0 8226.5 7513.5 7618.1 7836.6 7843.9 7906.6 4502.3 4608.5 4666.2 4735.0 4740.4 1847.7 1922.4 1972.2 1990.5 2000.6 859.6 977.0 992.8 1014.5 1018.5 17833.0 19460.2 19584.6 20779.4 20993.2 909.9 910.0 917.2 924.8 927.4 8738.9 11227.7 11242.3 11252.5 11290.8 333218.0 337409.0 338252.0 460560.0 462072.0 85832.6 88732.0 90247.5 91860.0 94132.0 1019.3 1022.6 1063.8 1065.2 1065.7 16424.6 17306.3 17973.7 18195.3 18209.3 40062.8 40147.6 41556.6 41596.6 42065.6 52582.0 54313.2 55655.4 56631.7 57049.7 7972.6 7972.8 8065.6 8324.9 8376.7 11192.9 12922.0 13132.3 13153.3 13466.5 11265.0 11530.7 11867.4 11914.0 11996.3 10576.4 11451.1 11505.8 11510.9 11838.9 11383.1 11416.2 11423.1 11828.4 12090.7 7432.7 7744.4 8344.2 8566.3 8623.4 11085.0 11237.3 11412.4 11415.1 11658.8 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#3] mootools.html Cycles:180 Average:5520.68 Median:4928.04 stddev:3134.92 (63.6%) stddev-sans-first:3127.72 17:08:48 INFO - PROCESS | 27892 | Values: 1307.3 1444.9 1477.1 1606.3 1735.7 7148.2 7780.6 8116.4 8118.9 8310.9 8168.2 8240.9 8241.0 8243.7 8245.7 2279.3 2304.7 2305.4 2306.4 2314.3 2201.4 2244.5 2249.5 2257.9 2260.2 2221.1 2243.6 2249.9 2285.8 2291.3 2213.0 2222.9 2224.9 2226.0 2231.8 2190.8 2196.6 2198.2 2205.9 2206.7 8109.4 8160.7 8164.8 8393.2 8480.3 5108.1 5321.5 5325.7 5328.2 5338.8 3423.6 3456.2 3465.5 3549.0 3549.9 1116.5 1118.4 1118.6 1146.1 1161.0 11670.2 11696.6 11772.4 11785.8 11814.9 4354.9 4363.6 4572.5 4581.0 4602.8 9411.0 9436.3 9440.8 9442.4 9446.3 5222.3 5222.7 5228.6 5232.8 5234.1 4180.5 4295.7 4715.1 4789.2 4906.1 3634.6 3684.4 3759.5 3777.5 3817.7 1168.2 1170.0 1180.7 1190.4 1196.0 862.4 896.7 907.6 909.1 933.5 5486.9 5740.5 5744.9 5798.0 5829.7 382.1 391.1 393.1 394.0 973.5 3732.3 3940.4 3963.8 3976.5 4099.6 10380.1 10691.4 10740.3 10753.6 10780.6 10517.1 10602.7 10664.4 10681.8 10682.0 7593.0 8012.3 8151.8 8164.9 8179.5 5826.3 5829.8 5935.2 5982.8 6000.1 9354.7 9517.3 9549.9 9557.2 9662.8 9750.0 9892.6 9939.9 9962.2 10030.9 6653.7 6896.9 7071.3 7547.6 7664.6 7754.5 8053.1 8066.7 8075.7 8085.5 6996.6 7087.3 7111.1 7262.9 7319.2 7117.9 7190.5 7200.8 7208.8 7209.5 6221.2 6355.4 6393.8 6403.8 6422.8 4830.1 4927.5 4928.6 4939.4 5018.8 4663.7 4715.8 4730.6 4773.0 4929.4 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#4] prototype.html Cycles:180 Average:4509.94 Median:4984.10 stddev:1314.98 (26.4%) stddev-sans-first:1280.27 17:08:48 INFO - PROCESS | 27892 | Values: 306.6 320.3 327.1 335.7 337.8 5248.1 5312.0 5323.2 5326.8 5366.1 4982.8 5019.6 5088.4 5144.0 5310.8 4093.6 4108.6 4110.0 4121.8 4142.7 4084.8 4112.7 4141.9 4146.2 4174.2 3823.5 3905.2 4092.1 4106.5 4117.2 4059.4 4085.5 4106.9 4123.7 4131.8 3666.7 3674.6 3675.4 3678.1 3690.5 5050.6 5079.2 5137.2 5168.5 5184.5 4724.8 4741.5 4778.1 4788.8 4796.2 5458.1 5479.3 5499.5 5523.9 5534.5 3743.9 3971.2 4047.2 4054.6 4057.2 5554.0 5646.2 5647.8 5661.4 5663.2 3976.9 4012.7 4019.5 4032.4 4038.5 3888.6 4087.2 4095.9 4113.1 4132.7 4584.1 4636.0 4651.7 4675.2 4710.3 5480.9 5482.9 5484.8 5572.6 5576.9 1338.4 1403.1 1408.7 1410.2 1423.3 881.8 914.9 918.2 919.5 921.5 4705.4 4730.9 4744.5 4752.6 4792.9 4620.9 4935.3 4954.0 4962.7 4981.0 4681.2 4688.8 4692.0 4716.2 4716.6 2632.7 2638.7 2645.9 2647.8 2657.3 4883.3 5016.3 5040.7 5056.8 5123.4 4946.6 4965.7 4985.8 5006.3 5013.8 5019.0 5060.3 5062.8 5106.3 5131.5 4862.5 4941.6 4985.4 5317.4 5746.9 5589.2 5642.6 5659.3 5663.9 5669.2 5852.8 5857.0 5874.4 5919.9 5941.7 3999.5 4052.5 4080.3 4096.4 4101.7 5439.2 5541.4 5579.6 5731.7 5753.6 5575.8 5589.8 5602.7 5611.2 5620.9 5303.0 5469.8 5542.9 5544.9 5548.1 5414.2 5418.2 5456.6 5470.5 5472.4 5566.3 5578.7 5591.8 5641.5 5670.8 5194.2 5428.2 5439.5 5554.1 5561.6 17:08:48 INFO - PROCESS | 27892 | 17:08:48 INFO - PROCESS | 27892 | [#5] yui.html Cycles:180 Average:20786.32 Median:4492.21 stddev:30741.99 (684.3%) stddev-sans-first:30791.26 17:08:48 INFO - PROCESS | 27892 | Values: 705.6 715.4 717.8 761.1 794.6 14953.8 15898.7 16652.0 16652.4 16655.8 14586.9 14737.9 14836.5 14855.0 14869.3 665.3 790.8 802.6 804.5 809.1 678.0 781.6 790.8 794.9 810.2 841.8 843.6 844.0 844.4 844.8 683.1 829.5 840.4 841.8 842.0 515.5 598.7 606.6 606.8 618.1 14071.8 14078.6 14082.5 14118.8 14140.5 13278.3 13996.9 14022.5 14168.2 14183.9 11560.5 11905.6 12276.0 13003.7 13163.6 4383.7 4397.8 4422.7 4635.1 4641.7 71393.0 72033.6 72140.6 72816.0 72869.0 11136.8 11168.8 11442.0 11505.5 11622.0 20862.9 21014.6 21070.5 21161.6 21233.7 8101.5 8140.3 8589.4 8592.5 8596.1 4167.3 4303.8 4334.2 4405.8 4460.6 3277.2 3361.1 3361.7 3377.3 3382.6 567.7 576.0 583.5 588.1 608.8 604.5 694.5 719.0 730.4 754.5 9570.3 9772.9 9804.9 9965.6 10080.6 634.4 674.9 711.0 721.2 726.0 4431.3 4523.8 4640.0 4890.3 4892.1 119529.4 120056.0 121513.9 122556.4 124432.0 62990.0 96589.5 103216.0 106613.0 107797.0 58493.0 92132.5 92695.0 93305.0 94672.0 8940.0 8942.5 9311.8 9314.6 9369.3 54213.0 54567.2 55354.4 55619.2 57973.4 74163.0 75057.6 82138.6 82681.0 83603.0 11792.0 11904.2 11964.7 12015.9 12204.8 11996.5 12259.9 12319.8 12343.3 13160.5 12614.2 13184.0 13367.9 13590.4 13601.1 12373.0 12458.9 12906.4 13441.7 13480.7 11361.7 11485.5 11728.4 12106.1 12107.8 9734.7 9735.0 10306.8 10313.7 10327.1 10331.8 10706.6 10713.9 10715.1 10801.2 17:08:48 INFO - PROCESS | 27892 | -------- Summary: end -------- 17:08:48 INFO - PROCESS | 27892 | 17:08:49 INFO - TEST-INFO | 27892: exit 0 17:08:49 INFO - TEST-OK | dromaeo_css | took 1117789ms 17:08:49 INFO - TEST-START | kraken 17:08:49 INFO - operating with platform_type : linux_ 17:08:49 INFO - Initialising browser for kraken test... 17:08:49 INFO - TEST-INFO | started process 28205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgoaWrm/profile http://localhost:49162/getInfo.html) 17:08:53 INFO - PROCESS | 28205 | __metrics Screen width/height:1600/1200 17:08:53 INFO - PROCESS | 28205 | colorDepth:24 17:08:53 INFO - PROCESS | 28205 | Browser inner width/height: 1024/697 17:08:53 INFO - PROCESS | 28205 | __metrics 17:08:53 INFO - PROCESS | 28205 | 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" 17:08:53 INFO - PROCESS | 28205 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:54 INFO - PROCESS | 28205 | console.error: PushService: 17:08:54 INFO - PROCESS | 28205 | stateChangeProcessEnqueue: Error transitioning state 17:08:54 INFO - PROCESS | 28205 | UnknownError 17:08:54 INFO - TEST-INFO | 28205: exit 0 17:08:54 INFO - Browser initialized. 17:08:54 INFO - Running cycle 1/1 for kraken test... 17:08:54 INFO - TEST-INFO | started process 28285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgoaWrm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:07 INFO - PROCESS | 28285 | RSS: Main: 172068864 17:09:07 INFO - PROCESS | 28285 | 17:09:09 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49162/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:10 INFO - PROCESS | 28285 | RSS: Main: 229232640 17:09:10 INFO - PROCESS | 28285 | 17:09:13 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49162/tests/kraken/driver.html?testName=audio-dft) 17:09:13 INFO - PROCESS | 28285 | RSS: Main: 215359488 17:09:13 INFO - PROCESS | 28285 | 17:09:16 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49162/tests/kraken/driver.html?testName=audio-fft) 17:09:17 INFO - PROCESS | 28285 | RSS: Main: 297496576 17:09:17 INFO - PROCESS | 28285 | 17:09:19 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49162/tests/kraken/driver.html?testName=audio-oscillator) 17:09:20 INFO - PROCESS | 28285 | RSS: Main: 205979648 17:09:20 INFO - PROCESS | 28285 | 17:09:22 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:22 INFO - PROCESS | 28285 | RSS: Main: 211070976 17:09:22 INFO - PROCESS | 28285 | 17:09:25 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49162/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:26 INFO - PROCESS | 28285 | RSS: Main: 247525376 17:09:26 INFO - PROCESS | 28285 | 17:09:29 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49162/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:30 INFO - PROCESS | 28285 | RSS: Main: 246702080 17:09:30 INFO - PROCESS | 28285 | 17:09:33 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49162/tests/kraken/driver.html?testName=json-parse-financial) 17:09:33 INFO - PROCESS | 28285 | RSS: Main: 245985280 17:09:33 INFO - PROCESS | 28285 | 17:09:35 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:35 INFO - PROCESS | 28285 | RSS: Main: 208347136 17:09:35 INFO - PROCESS | 28285 | 17:09:37 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:38 INFO - PROCESS | 28285 | RSS: Main: 215203840 17:09:38 INFO - PROCESS | 28285 | 17:09:40 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:40 INFO - PROCESS | 28285 | RSS: Main: 225193984 17:09:40 INFO - PROCESS | 28285 | 17:09:43 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:44 INFO - PROCESS | 28285 | RSS: Main: 233066496 17:09:44 INFO - PROCESS | 28285 | 17:09:46 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:47 INFO - PROCESS | 28285 | RSS: Main: 230948864 17:09:47 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:49162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49162/tests/kraken/driver.html?testName=ai-astar) 17:09:49 INFO - PROCESS | 28285 | RSS: Main: 282525696 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | __start_tp_report 17:09:49 INFO - PROCESS | 28285 | _x_x_mozilla_page_load 17:09:49 INFO - PROCESS | 28285 | _x_x_mozilla_page_load_details 17:09:49 INFO - PROCESS | 28285 | |i|pagename|runs| 17:09:49 INFO - PROCESS | 28285 | |0;ai-astar;109;111;112;113;114;113;113;112;113;113 17:09:49 INFO - PROCESS | 28285 | |1;audio-beat-detection;154;126;121;177;125;124;122;122;154;120 17:09:49 INFO - PROCESS | 28285 | |2;audio-dft;162;161;162;160;160;164;161;163;161;160 17:09:49 INFO - PROCESS | 28285 | |3;audio-fft;77;75;75;115;77;75;76;75;100;76 17:09:49 INFO - PROCESS | 28285 | |4;audio-oscillator;83;82;121;82;83;82;114;83;84;111 17:09:49 INFO - PROCESS | 28285 | |5;imaging-gaussian-blur;118;118;117;117;118;119;117;117;116;117 17:09:49 INFO - PROCESS | 28285 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;145;146 17:09:49 INFO - PROCESS | 28285 | |7;imaging-desaturate;84;85;84;85;86;84;85;86;85;84 17:09:49 INFO - PROCESS | 28285 | |8;json-parse-financial;55;52;51;55;50;53;53;52;54;53 17:09:49 INFO - PROCESS | 28285 | |9;json-stringify-tinderbox;60;61;61;62;61;61;61;60;62;62 17:09:49 INFO - PROCESS | 28285 | |10;stanford-crypto-aes;86;81;89;79;80;87;83;80;86;80 17:09:49 INFO - PROCESS | 28285 | |11;stanford-crypto-ccm;134;143;131;131;141;134;131;154;171;144 17:09:49 INFO - PROCESS | 28285 | |12;stanford-crypto-pbkdf2;168;166;167;170;171;171;171;168;168;176 17:09:49 INFO - PROCESS | 28285 | |13;stanford-crypto-sha256-iterative;65;67;66;73;69;67;67;70;64;65 17:09:49 INFO - PROCESS | 28285 | __end_tp_report 17:09:49 INFO - PROCESS | 28285 | __start_cc_report 17:09:49 INFO - PROCESS | 28285 | _x_x_mozilla_cycle_collect,1670 17:09:49 INFO - PROCESS | 28285 | __end_cc_report 17:09:49 INFO - PROCESS | 28285 | __startTimestamp1477008589558__endTimestamp 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | ------- Summary: start ------- 17:09:49 INFO - PROCESS | 28285 | Number of tests: 14 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.42 (1.3%) stddev-sans-first:0.87 17:09:49 INFO - PROCESS | 28285 | Values: 109.0 111.0 112.0 113.0 114.0 113.0 113.0 112.0 113.0 113.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:125.50 stddev:19.85 (15.8%) stddev-sans-first:19.75 17:09:49 INFO - PROCESS | 28285 | Values: 154.0 126.0 121.0 177.0 125.0 124.0 122.0 122.0 154.0 120.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 17:09:49 INFO - PROCESS | 28285 | Values: 162.0 161.0 162.0 160.0 160.0 164.0 161.0 163.0 161.0 160.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.87 (18.4%) stddev-sans-first:14.59 17:09:49 INFO - PROCESS | 28285 | Values: 77.0 75.0 75.0 115.0 77.0 75.0 76.0 75.0 100.0 76.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:82.50 stddev:15.95 (19.3%) stddev-sans-first:16.55 17:09:49 INFO - PROCESS | 28285 | Values: 83.0 82.0 121.0 82.0 83.0 82.0 114.0 83.0 84.0 111.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 17:09:49 INFO - PROCESS | 28285 | Values: 118.0 118.0 117.0 117.0 118.0 119.0 117.0 117.0 116.0 117.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 17:09:49 INFO - PROCESS | 28285 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 17:09:49 INFO - PROCESS | 28285 | Values: 84.0 85.0 84.0 85.0 86.0 84.0 85.0 86.0 85.0 84.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.62 (3.1%) stddev-sans-first:1.51 17:09:49 INFO - PROCESS | 28285 | Values: 55.0 52.0 51.0 55.0 50.0 53.0 53.0 52.0 54.0 53.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 17:09:49 INFO - PROCESS | 28285 | Values: 60.0 61.0 61.0 62.0 61.0 61.0 61.0 60.0 62.0 62.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.50 stddev:3.60 (4.3%) stddev-sans-first:3.67 17:09:49 INFO - PROCESS | 28285 | Values: 86.0 81.0 89.0 79.0 80.0 87.0 83.0 80.0 86.0 80.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:142.00 stddev:12.82 (9.0%) stddev-sans-first:13.31 17:09:49 INFO - PROCESS | 28285 | Values: 134.0 143.0 131.0 131.0 141.0 134.0 131.0 154.0 171.0 144.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:2.88 (1.7%) stddev-sans-first:2.99 17:09:49 INFO - PROCESS | 28285 | Values: 168.0 166.0 167.0 170.0 171.0 171.0 171.0 168.0 168.0 176.0 17:09:49 INFO - PROCESS | 28285 | 17:09:49 INFO - PROCESS | 28285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.71 (4.0%) stddev-sans-first:2.74 17:09:49 INFO - PROCESS | 28285 | Values: 65.0 67.0 66.0 73.0 69.0 67.0 67.0 70.0 64.0 65.0 17:09:49 INFO - PROCESS | 28285 | -------- Summary: end -------- 17:09:49 INFO - PROCESS | 28285 | 17:09:50 INFO - TEST-INFO | 28285: exit 0 17:09:50 INFO - TEST-OK | kraken | took 61529ms 17:09:50 INFO - SUITE-END | took 1179s 17:09:51 INFO - Completed test suite (00:19:39) 17:09:51 INFO - javascript benchmark 17:09:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.391121775645, 3063.3873225354932, 3065.4022465619205, 3120.7659425543075, 3123.0786917859227, 5108.667936584119, 5161.4322424533275, 5273.762680679369, 5327.600429967753, 5376.032314183451, 5233.869153271161, 5243.973780131094, 5317.2821669074665, 5371.274877891484, 5439.184122381635, 4811.06184294061, 4851.611871050325, 4866.270059491069, 4874.049560335736, 4908.705477671333, 4826.46908840029, 4902.509749025105, 4932.630052746058, 4945.0, 4958.9752051239875, 4892.168331383673, 4939.160342741742, 4942.283368911506, 4961.702297862122, 5015.197568389059, 4728.456227533843, 4762.333273341735, 4798.328234047236, 4801.1117943180625, 4876.585490233334, 4704.200285951397, 4725.291206319045, 4764.904701905977, 4792.592629626486, 4837.95162048382, 5155.304033955405, 5159.489118177424, 5202.713850738208, 5232.764525596319, 5269.525742683139, 5485.753141108659, 5542.501174894239, 5562.3881373048935, 5566.693831839248, 5568.693721845297, 5580.939621471907, 5687.943120568782, 5729.82810515681, 5733.799317023926, 5798.9130163047585, 5340.0, 5345.812896548602, 5345.812896548641, 5348.893022139536, 5354.598405119632, 5543.833684989457, 5795.710214489343, 5800.4489573490455, 5804.535637149018, 5810.883782324415, 5389.973050134724, 5415.48552887475, 5470.398256191816, 5567.359753628303, 5572.4706152915405, 5666.178404131378, 5666.744996475169, 5679.091345384802, 5719.142128680731, 5721.0, 5654.943450565524, 5661.575381846378, 5662.292213473316, 5667.858303542444, 5670.829875103754, 5409.29679141709, 5521.503064724194, 5660.235868157746, 5663.150527420919, 5732.914006289909, 4302.612764851178, 4304.827806887752, 4305.182015417061, 4307.526172121127, 4308.138372325548, 3862.0537968197973, 3902.375619900802, 3905.1018265799025, 3907.081835768592, 3969.6030396960073, 5441.83674489766, 5447.754851031713, 5455.1271796512365, 5455.645383050169, 5455.754491047913, 5744.942550574441, 5786.3056433228285, 5788.334341550775, 5798.0, 5800.8259752207505, 5211.348581427322, 5237.764300606405, 5353.652012619167, 5397.9460205397445, 5410.0, 4978.054169707744, 4978.178600530944, 4981.4769449207315, 4984.8753781155765, 5031.195008798648, 5932.228810254639, 5950.613210141327, 5951.107333900036, 5953.2866896403675, 6018.849528761729, 5478.0, 5595.972020139873, 5628.831135065954, 5711.685857277889, 5756.819851930428, 5849.034909240098, 5886.6173698709445, 5892.587518873809, 5928.822135335947, 5959.22530071088, 5593.608447408642, 5596.776128954796, 5605.971970140286, 5610.074337734228, 5611.046122159161, 5403.243545903498, 5425.511703946664, 5516.420775818642, 5587.720613969366, 5709.029464991045, 5465.781368745205, 5471.0, 5473.425290344616, 5535.031369510239, 5537.861553461034, 5401.432849550741, 5438.755256013568, 5441.127439027557, 5451.64564303319, 5460.754266058117, 5330.733463326896, 5374.892502150014, 5385.865353366197, 5440.755166017618, 5443.074677304789, 5523.613347065828, 5636.098224284095, 5658.292713410824, 5675.120356344773, 5692.260006199168, 5516.503514683698, 5521.089020311603, 5523.8066667666435, 5526.088195447706, 5585.413531579125], "value": 5228.171042808667, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.3415310235292, 613.0, 613.5183880653686, 651.4885814635512, 659.5449140093339, 30248.243793905163, 40183.39724904125, 41038.58961410393, 41159.99999999996, 45553.54446455543, 43369.0, 43722.781386093026, 43735.562644373545, 43805.0, 43810.990241561354, 8759.824803503941, 8955.686550970717, 8956.641734330651, 8960.059193784657, 8962.551872406386, 6215.906761398583, 6352.333005034474, 10377.792444151113, 10627.41549214793, 10635.042846143846, 10860.34837909724, 10921.617743378984, 10938.343699378023, 10943.0, 10960.506777195005, 10629.36223826569, 10684.572617095308, 10691.198160137981, 10696.411697356642, 10730.90747304276, 10540.736481588021, 10609.73475663107, 10622.521986510626, 10624.415657138854, 10624.415657138854, 40227.7988610058, 40448.79775601133, 40540.797296013334, 40552.797236013925, 40584.59415405837, 3391.253924136686, 3407.642197569244, 3557.7509574329547, 3833.11838277195, 4041.4341992121126, 30163.849180754176, 31175.220619484466, 31179.84410077935, 31313.0, 31329.373412531848, 3935.724499285051, 3994.3590354745234, 4013.7591744495426, 4090.365993271048, 4267.615914567673, 319349.0, 322034.0, 322615.3869230662, 323018.0, 325259.0, 55114.448855511735, 55388.0, 55436.722816386464, 55445.1683224752, 55504.16743748847, 58954.70522647359, 59104.704476477345, 59127.40872591219, 59130.70434647799, 59131.40868591345, 15064.849351506344, 15299.0, 15303.770443443358, 15332.080075195525, 15341.539753807403, 11595.536178552931, 11653.88346116545, 11708.765824683458, 11709.941450292694, 11887.16789824704, 14774.335154917839, 14903.254837258093, 15187.392504299925, 15587.688246235239, 15620.218989050501, 5981.671008094597, 6023.427774361428, 6145.9692701536205, 6253.187085678833, 6255.74977000924, 875.9430637008702, 887.8801361816202, 1000.1848493477938, 1001.8246806808925, 1024.9538770755335, 29086.0, 30393.24016899551, 30874.382512349628, 30992.070237892898, 31316.37367252688, 1026.9844906415879, 1040.9375437473775, 1048.6120135549895, 1066.5040756048475, 1087.478010554938, 16210.918945405198, 16241.593960150854, 16340.346386144422, 16365.345386184657, 16682.249298781582, 455526.0, 484687.0, 494349.0, 495014.0, 738807.0, 51144.23283650748, 51558.0, 51634.0, 51663.74168129211, 51765.2235216472, 1294.223465920459, 1305.6866352075433, 1334.5929491505185, 1338.6184937292826, 1346.9797953030713, 28558.714412855606, 30515.711321651408, 30694.539581905843, 31129.37741245208, 31233.0, 48001.27998080102, 48430.27354589613, 48437.27344089912, 48442.27336590025, 48461.0, 405305.0, 405557.0, 406730.0, 407339.44954127964, 407518.0, 24761.876190618932, 24844.627330590418, 25549.87225063863, 26207.60688589711, 26550.468990619695, 38730.6126938727, 42521.36217956795, 42685.5731442694, 42752.57247427486, 42838.143237134456, 36622.816885916465, 36673.63326366702, 36906.261874762895, 37064.0, 37519.624803752704, 36277.63722362848, 36853.63146368502, 37162.44256336103, 37648.43527347147, 38395.80802095972, 36596.268074638894, 37151.44272835964, 37170.0, 37417.43873841949, 38084.80957595194, 31312.686873130977, 33187.170320742174, 33567.83216083904, 33674.83162584171, 33873.830630846685, 25456.363590910376, 25656.0, 25880.22359329223, 26598.468030639666, 27983.44033119367], "value": 19281.475122490105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.8340246888897, 373.68423681988725, 396.75599506303615, 396.99206015879685, 416.41909536197005, 13651.382383668324, 14598.854011459882, 16771.329146834127, 19395.93322367269, 19478.80521194791, 19197.904010479964, 19390.515237119078, 19512.0, 19742.0, 19762.802371976275, 5442.346918369801, 5561.694106824133, 5818.2145410369485, 5825.417458254183, 5826.854328641797, 5277.7888884444765, 5710.77156913723, 5718.513926316247, 5736.225609542721, 5745.540356771469, 5586.86032849178, 5692.5161361284345, 5701.315842098933, 5706.457886500776, 5713.628614140068, 5776.624519406246, 5922.2597175353085, 5932.347441781422, 5933.0, 5938.317093534256, 5599.60802743804, 5740.225069615632, 5740.339860915965, 5743.712814359265, 5788.27646544182, 22116.447088822748, 22198.445038873997, 22531.21140760082, 22583.096676132936, 22937.54124917509, 2053.2505635443104, 2082.3232449453835, 2109.6202683516963, 2134.6157691615504, 2293.185918998748, 10041.598336066549, 10095.949520252425, 10246.692599222035, 10684.626038088629, 10691.411972341519, 1855.9628807423776, 1917.319351630165, 1946.1145178943548, 1949.3761996161234, 1961.9705704414446, 55068.724656376864, 59565.40434595642, 62913.68543157301, 78968.21031789723, 84357.57821210916, 9922.454265015349, 10489.685309440729, 10751.19366047534, 10806.189535784848, 10981.505832237568, 15460.458883939233, 15494.07035577869, 15496.457623983106, 15499.767503487457, 15511.301991410413, 7789.844203116019, 7842.343121033287, 7984.880226796603, 8022.0, 8226.506409615442, 7513.47405681608, 7618.123915749649, 7836.568988705562, 7843.9215607844335, 7906.604669766489, 4502.279635258343, 4608.470025947059, 4666.183417901853, 4735.029318989667, 4740.3837501124635, 1847.6951303034848, 1922.4136638325165, 1972.2151452935116, 1990.4725247809054, 2000.5698774763496, 859.5873980489275, 976.9755756106155, 992.7666998255404, 1014.5434554450527, 1018.5162048027128, 17833.0, 19460.22159113648, 19584.608307833765, 20779.376618701463, 20993.160273588885, 909.9272058235325, 909.9590518426687, 917.1607978699549, 924.7872989212519, 927.3832901120815, 8738.912610873937, 11227.66317010491, 11242.325460472397, 11252.49363778632, 11290.774184516264, 333218.0, 337409.0, 338252.0, 460560.0, 462072.0, 85832.57083714541, 88732.0, 90247.54876225708, 91860.0, 94132.0, 1019.3374306700556, 1022.5858527296457, 1063.7925604507202, 1065.2223876570147, 1065.6589891234885, 16424.589385265463, 17306.307747689953, 17973.73039404384, 18195.32527621561, 18209.271629134688, 40062.79968600255, 40147.59852401556, 41556.58443415648, 41596.58403415927, 42065.57934420739, 52582.0, 54313.18530221971, 55655.44344556665, 56631.71684141553, 57049.71475142764, 7972.641231144728, 7972.84054318922, 8065.596720163851, 8324.875126873223, 8376.706815261681, 11192.88807111951, 12922.0, 13132.27772472485, 13153.342332883509, 13466.528671496451, 11264.965021366084, 11530.654080377602, 11867.406629668654, 11914.0, 11996.340201289013, 10576.41829699374, 11451.14116441287, 11505.827412588986, 11510.906463885918, 11838.940805295919, 11383.146264030396, 11416.200865939305, 11423.143264255048, 11828.40857957116, 12090.697732556757, 7432.702691892264, 7744.380449564134, 8344.207300306462, 8566.271866891384, 8623.353248506262, 11085.0, 11237.269577477764, 11412.372319522507, 11415.143864210051, 11658.825117623412], "value": 8964.184724197781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.2940612069483, 1444.8916331275157, 1477.0989696285267, 1606.3414000259888, 1735.6702226576958, 7148.213696493388, 7780.649870755816, 8116.431849770518, 8118.91881081189, 8310.91689083109, 8168.224018718227, 8240.876386854203, 8241.0, 8243.711470098548, 8245.670173193064, 2279.282026161758, 2304.700388949434, 2305.3890718959487, 2306.3888069661552, 2314.2710046335433, 2201.361605134509, 2244.5286489837154, 2249.4601295689, 2257.898394572248, 2260.1976298414074, 2221.0671517962414, 2243.607368710477, 2249.9437514062115, 2285.759995200505, 2291.2897001929455, 2212.9557408851733, 2222.944426389345, 2224.8887555622237, 2226.0, 2231.7768223177713, 2190.769969153248, 2196.626573482512, 2198.1756841184556, 2205.878676672782, 2206.6689996500654, 8109.4323397362205, 8160.673573057071, 8164.795880102985, 8393.202645748644, 8480.279176270025, 5108.055009823194, 5321.49445802652, 5325.733713314357, 5328.20076988451, 5338.839834804962, 3423.640517745626, 3456.1532424556144, 3465.5148279240925, 3548.982255088734, 3549.9172752310533, 1116.4696769034724, 1118.3681220110611, 1118.6476259978162, 1146.1346683254174, 1161.030539499519, 11670.241434306829, 11696.590619328283, 11772.352520611448, 11785.764284714258, 11814.881851181464, 4354.934675979863, 4363.629091527192, 4572.45130584332, 4581.0, 4602.792874320664, 9411.0, 9436.339456238135, 9440.763980900396, 9442.38624489406, 9446.29152813528, 5222.294990176278, 5222.738863056908, 5228.607854410859, 5232.816851410183, 5234.057869583511, 4180.540140584533, 4295.699301048959, 4715.104130215248, 4789.233722604366, 4906.092372910952, 3634.5638523377365, 3684.3552378333684, 3759.473673685686, 3777.54669439669, 3817.732758706864, 1168.2056201782868, 1170.0044348549607, 1180.651707746217, 1190.434543591787, 1195.9880401195876, 862.3618522293458, 896.7309807057857, 907.5507623726297, 909.1272378516699, 933.5005771911995, 5486.945130548724, 5740.454656807597, 5744.942550574441, 5798.0, 5829.708514574254, 382.11921520894606, 391.1355903453343, 393.1311800919999, 394.04051135485184, 973.4937832327291, 3732.328180927405, 3940.4286378474962, 3963.781991990468, 3976.5029371328583, 4099.61053699898, 10380.117689996436, 10691.35851848876, 10740.30188037775, 10753.56985720578, 10780.568777248822, 10517.053465188017, 10602.681919542427, 10664.41345725977, 10681.786364272826, 10682.0, 7592.962035189788, 8012.278894899487, 8151.796205094802, 8164.877526837102, 8179.509229446252, 5826.300843898759, 5829.8251052468495, 5935.228420305332, 5982.790602328898, 6000.129981152621, 9354.71935841926, 9517.333786634868, 9549.856752148584, 9557.23542116643, 9662.758431039, 9749.951250243703, 9892.554835032584, 9939.850902236327, 9962.153216976638, 10030.899691002996, 6653.73385064592, 6896.896546551906, 7071.257517960746, 7547.622618868925, 7664.578448185403, 7754.457187996786, 8053.073896501977, 8066.717664881701, 8075.717349892726, 8085.474444161111, 6996.6151861648095, 7087.326703963321, 7111.111111111111, 7262.9273707264365, 7319.231480694663, 7117.857642847218, 7190.532615379983, 7200.819979500555, 7208.819779505554, 7209.495335326476, 6221.160143380585, 6355.396237357444, 6393.776217832354, 6403.775867844603, 6422.807315780534, 4830.106430310404, 4927.507249275187, 4928.581070609039, 4939.431965324034, 5018.774155162953, 4663.743494107856, 4715.78778954941, 4730.550597693214, 4772.976135119302, 4929.359183306147], "value": 4373.881135645623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6351042259711, 320.3480916335258, 327.07437950599797, 335.6945179886304, 337.81082593747504, 5248.13405788045, 5312.0, 5323.190115360777, 5326.8401947941575, 5366.087765079936, 4982.825601103962, 5019.569422714527, 5088.389393272803, 5143.974280128604, 5310.8141215057485, 4093.5906409358977, 4108.5686002969705, 4110.0, 4121.793910304487, 4142.668586513072, 4084.774567629714, 4112.683941138836, 4141.855035073773, 4146.170765846828, 4174.206900688874, 3823.5029446171957, 3905.2384784966944, 4092.0997380576227, 4106.527749308838, 4117.155983023473, 4059.4316795648633, 4085.5301640311445, 4106.864430496155, 4123.690723195772, 4131.834726610947, 3666.6883314918264, 3674.577423596294, 3675.3935600625864, 3678.0988657779017, 3690.520232369775, 5050.6212034097225, 5079.174783955257, 5137.152369858969, 5168.483151684839, 5184.496496016151, 4724.763761811896, 4741.478437371887, 4778.092162489116, 4788.832390866303, 4796.208625576811, 5458.052651568149, 5479.287692599976, 5499.450054994469, 5523.861903452445, 5534.4742249486235, 3743.9251214975548, 3971.225611005855, 4047.150098479323, 4054.635082842529, 4057.1885622875543, 5554.028045092093, 5646.237757902672, 5647.774089036434, 5661.405552416978, 5663.207150998822, 3976.900577485586, 4012.6990475714438, 4019.477467929209, 4032.4354590357375, 4038.5153781545814, 3888.630580094943, 4087.2234275487563, 4095.91808163841, 4113.095119073799, 4132.669386449077, 4584.074688630783, 4636.0, 4651.697639653412, 4675.158471475167, 4710.3405523226775, 5480.890382192413, 5482.945170548323, 5484.780608775604, 5572.606848287928, 5576.86057848557, 1338.3575883575938, 1403.109025768624, 1408.6830463145916, 1410.182094385254, 1423.309694798022, 881.7795551112222, 914.9176574108362, 918.2424499787702, 919.4942781470164, 921.5115988525957, 4705.435347758223, 4730.864592497775, 4744.478107408182, 4752.574227731736, 4792.9281060784115, 4620.884477888079, 4935.284383764334, 4954.0, 4962.652614317035, 4981.011393164145, 4681.204195286809, 4688.789004494806, 4692.029347673985, 4716.245400735935, 4716.57550820421, 2632.723564025788, 2638.6569745932907, 2645.854478003728, 2647.8411295322344, 2657.3223827924144, 4883.267509873547, 5016.297718319438, 5040.747962601855, 5056.84829455117, 5123.38519377677, 4946.554810067111, 4965.677230979974, 4985.825496107619, 5006.299118123466, 5013.849584512471, 5019.02129084825, 5060.3168572242275, 5062.835547824021, 5106.285120083191, 5131.486851314913, 4862.4651288357545, 4941.555260026615, 4985.376827896513, 5317.388500322512, 5746.913796292975, 5589.217509548747, 5642.60501764889, 5659.3022093371, 5663.8867222656145, 5669.177969194526, 5852.770918107245, 5856.970715146397, 5874.443272532868, 5919.881602367843, 5941.673207973603, 3999.5200575931076, 4052.4731784867777, 4080.3471444568727, 4096.3855421686985, 4101.733387329814, 5439.205062329501, 5541.445855414427, 5579.581531385081, 5731.713414329351, 5753.568482363923, 5575.776968921197, 5589.804356847653, 5602.663840169603, 5611.158326251095, 5620.915686264628, 5302.973485132549, 5469.823987842633, 5542.944570554243, 5544.889102218014, 5548.085910360919, 5414.214938833926, 5418.241446197457, 5456.61803673739, 5470.480304371237, 5472.398036215934, 5566.304211973504, 5578.665280083208, 5591.832245032656, 5641.5204707600315, 5670.829875103754, 5194.156074593616, 5428.212909128233, 5439.5104440600535, 5554.139108438037, 5561.582881283839], "value": 4092.02448332512, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5872314695903, 715.3954908102652, 717.8205448637841, 761.0524896503852, 794.5629903553045, 14953.775693364594, 15898.682026359465, 16652.000879947213, 16652.417165399213, 16655.833441665596, 14586.927065364685, 14737.852621473781, 14836.48072317469, 14855.034422762514, 14869.330880110394, 665.3080795972184, 790.8497385496765, 802.5987006496752, 804.5494523067072, 809.1423091522975, 678.043958019193, 781.5662307419379, 790.8220650353682, 794.9165337639552, 810.2221867007651, 841.7685136587456, 843.5866425451516, 844.0462277626274, 844.4426678392263, 844.8183640517287, 683.0607914118087, 829.4525613095389, 840.4453060979755, 841.8400503904269, 841.970531031414, 515.4793658405, 598.724586690123, 606.6420811721061, 606.7785258380703, 618.1006635345561, 14071.788923166161, 14078.577642670736, 14082.507112251022, 14118.788218176736, 14140.505082322172, 13278.336083195802, 13996.8522820955, 14022.509212177627, 14168.220747858864, 14183.858161418357, 11560.53757849685, 11905.583304584385, 12276.0, 13003.674908127277, 13163.605091847165, 4383.671224658164, 4397.802098905557, 4422.6682998774895, 4635.072985402933, 4641.698289611165, 71393.0, 72033.63983180051, 72140.63929680371, 72816.0, 72869.0, 11136.777264454828, 11168.776624467466, 11442.0, 11505.482253298622, 11622.024255876522, 20862.895685521475, 21014.579708405745, 21070.47323816917, 21161.576768464543, 21233.68149477759, 8101.473404228706, 8140.3487720982175, 8589.398742088119, 8592.484450932963, 8596.097409771884, 4167.333226683716, 4303.827846886152, 4334.154839806208, 4405.823767049346, 4460.643148548108, 3277.1643230975947, 3361.1429085583018, 3361.680640339164, 3377.324535092991, 3382.5940887093707, 567.6877717255493, 576.0076403085928, 583.5185971573469, 588.0532342927883, 608.796053322142, 604.4771272849042, 694.4722011271369, 718.9604571748499, 730.3791776989516, 754.4567911103996, 9570.282228832726, 9772.902270977342, 9804.852927206097, 9965.601375945025, 10080.596776128872, 634.3719717479754, 674.8751480976035, 710.9751158709524, 721.1850608812009, 725.9854802903913, 4431.311694042215, 4523.773811309421, 4639.976800115978, 4890.339804126468, 4892.070506603805, 119529.40235298942, 120056.0, 121513.88645851596, 122556.38721806333, 124432.0, 62990.0, 96589.51705241429, 103216.0, 106613.0, 107797.0, 58493.0, 92132.53933730288, 92695.0, 93305.0, 94672.0, 8940.0, 8942.451401350583, 9311.813763724553, 9314.580843861906, 9369.344145909721, 54213.0, 54567.18149227685, 55354.446455534926, 55619.165712515154, 57973.420265796805, 74163.0, 75057.6247118761, 82138.58930705309, 82681.0, 83603.0, 11792.0, 11904.166708330335, 11964.700882478008, 12015.939920300343, 12204.75590488203, 11996.520139194683, 12259.877401225873, 12319.815202771786, 12343.259404435763, 13160.473581057033, 12614.180078294881, 13184.0, 13367.866321336662, 13590.388432520758, 13601.115927464683, 12373.0, 12458.878700916961, 12906.419211135333, 13441.731165376834, 13480.730385392433, 11361.659150225507, 11485.540578376771, 11728.41357932117, 12106.092043096627, 12107.75784484323, 9734.659286924923, 9734.951325243612, 10306.845397318897, 10313.690589282334, 10327.122194613543, 10331.845022324822, 10706.571737130738, 10713.94643026811, 10715.142788576739, 10801.1644600417], "value": 7369.4038424455675, "unit": "score"}], "name": "dromaeo_css", "value": 7015.321147289163, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 113.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 121.0, 177.0, 125.0, 124.0, 122.0, 122.0, 154.0, 120.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 160.0, 164.0, 161.0, 163.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 115.0, 77.0, 75.0, 76.0, 75.0, 100.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 121.0, 82.0, 83.0, 82.0, 114.0, 83.0, 84.0, 111.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 116.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 86.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 55.0, 50.0, 53.0, 53.0, 52.0, 54.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 89.0, 79.0, 80.0, 87.0, 83.0, 80.0, 86.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 131.0, 131.0, 141.0, 134.0, 131.0, 154.0, 171.0, 144.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 167.0, 170.0, 171.0, 171.0, 171.0, 168.0, 168.0, 176.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 73.0, 69.0, 67.0, 67.0, 70.0, 64.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1506.0999999999997, "alertThreshold": 2.0}]} 17:09:51 INFO - Return code: 0 17:09:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:09:51 INFO - # TBPL SUCCESS # 17:09:51 INFO - Running post-action listener: _resource_record_post_action 17:09:51 INFO - [mozharness: 2016-10-21 00:09:51.352218Z] Finished run-tests step (success) 17:09:51 INFO - Running post-run listener: _resource_record_post_run 17:09:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 394485760; Read time: 0; Write time: 300280 17:09:51 INFO - TinderboxPrint: CPU usage
13.1% 17:09:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:09:51 INFO - TinderboxPrint: I/O write bytes / time
394,485,760 / 300,280 17:09:51 INFO - TinderboxPrint: CPU idle
8,299.4 (86.9%) 17:09:51 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 17:09:51 INFO - TinderboxPrint: Swap in / out
0 / 0 17:09:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106835968; Read time: 0; Write time: 107024 17:09:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287330304; Read time: 0; Write time: 193256 17:09:51 INFO - Running post-run listener: _upload_blobber_files 17:09:51 INFO - Blob upload gear active. 17:09:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:09:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:53 INFO - (blobuploader) - INFO - Done attempting. 17:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:53 INFO - (blobuploader) - INFO - Done attempting. 17:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:57 INFO - (blobuploader) - INFO - Done attempting. 17:09:57 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:57 INFO - Return code: 0 17:09:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86f06c4bd3a654a0d07c693ba76b7a6ab84e73801515f37b42d10f76f9e183bc57d2a488ec0431d5f0478a9187388045c97dec7081b5731ed2242824ff86fc83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901be50bc11c7b2dd162e5d878c8914c044e01c42d7f7f1967d30f8e4bbd2584e61742c8786f452cdb740a77d21882fd3fdea2b8d7860dd688314276d04a2e50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d635c3c532d0517bd62323958e1247933dbe5af18730c474b30d1539fb33983170edd5d1c830e5109fcd27083c08b813fe388b875d86b5b2c9d9d3e3eba4f74"} 17:09:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:57 INFO - Contents: 17:09:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86f06c4bd3a654a0d07c693ba76b7a6ab84e73801515f37b42d10f76f9e183bc57d2a488ec0431d5f0478a9187388045c97dec7081b5731ed2242824ff86fc83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901be50bc11c7b2dd162e5d878c8914c044e01c42d7f7f1967d30f8e4bbd2584e61742c8786f452cdb740a77d21882fd3fdea2b8d7860dd688314276d04a2e50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d635c3c532d0517bd62323958e1247933dbe5af18730c474b30d1539fb33983170edd5d1c830e5109fcd27083c08b813fe388b875d86b5b2c9d9d3e3eba4f74"} 17:09:57 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:57 INFO - Copying logs to upload dir... 17:09:57 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.727233 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-20 17:09:56.872122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 17:09:56.875560) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 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/86f06c4bd3a654a0d07c693ba76b7a6ab84e73801515f37b42d10f76f9e183bc57d2a488ec0431d5f0478a9187388045c97dec7081b5731ed2242824ff86fc83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901be50bc11c7b2dd162e5d878c8914c044e01c42d7f7f1967d30f8e4bbd2584e61742c8786f452cdb740a77d21882fd3fdea2b8d7860dd688314276d04a2e50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d635c3c532d0517bd62323958e1247933dbe5af18730c474b30d1539fb33983170edd5d1c830e5109fcd27083c08b813fe388b875d86b5b2c9d9d3e3eba4f74"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476992154/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/86f06c4bd3a654a0d07c693ba76b7a6ab84e73801515f37b42d10f76f9e183bc57d2a488ec0431d5f0478a9187388045c97dec7081b5731ed2242824ff86fc83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901be50bc11c7b2dd162e5d878c8914c044e01c42d7f7f1967d30f8e4bbd2584e61742c8786f452cdb740a77d21882fd3fdea2b8d7860dd688314276d04a2e50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d635c3c532d0517bd62323958e1247933dbe5af18730c474b30d1539fb33983170edd5d1c830e5109fcd27083c08b813fe388b875d86b5b2c9d9d3e3eba4f74"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 17:09:56.900988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 17:09:56.901302) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477007356.104702-1401473245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 17:09:56.982881) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 17:09:56.983206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 17:09:56.983496) ========= ========= Total master_lag: 0.17 =========