builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1475145068.02 results: success (0) buildid: 20160929024420 builduid: 8aca712d030a493eabfb55c973f90fa9 revision: b67dc49095dcdb6f806cff7c303496e0d7e3efa4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.020006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.020842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.021124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.045606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.045894) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 03:31:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.1M=0s 2016-09-29 03:31:08 (33.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074387 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.133953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.134246) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:08.184130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 03:31:08.184442) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b67dc49095dcdb6f806cff7c303496e0d7e3efa4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b67dc49095dcdb6f806cff7c303496e0d7e3efa4 --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=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 03:31:08,590 truncating revision to first 12 chars 2016-09-29 03:31:08,590 Setting DEBUG logging. 2016-09-29 03:31:08,590 attempt 1/10 2016-09-29 03:31:08,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b67dc49095dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 03:31:09,902 unpacking tar archive at: mozilla-central-b67dc49095dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.709726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 03:31:09.908742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:09.909057) ========= script_repo_revision: b67dc49095dcdb6f806cff7c303496e0d7e3efa4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:09.909468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:09.909776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 03:31:09.918023) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-29 03:31:09.918389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:10 INFO - MultiFileLogger online at 20160929 03:31:10 in /builds/slave/test 03:31:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:31:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:10 INFO - {'append_to_log': False, 03:31:10 INFO - 'base_work_dir': '/builds/slave/test', 03:31:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:31:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:10 INFO - 'branch': 'Firefox-Non-PGO', 03:31:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:10 INFO - 'config_files': ('talos/linux_config.py',), 03:31:10 INFO - 'default_actions': ('clobber', 03:31:10 INFO - 'read-buildbot-config', 03:31:10 INFO - 'download-and-extract', 03:31:10 INFO - 'populate-webroot', 03:31:10 INFO - 'create-virtualenv', 03:31:10 INFO - 'install', 03:31:10 INFO - 'run-tests'), 03:31:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:10 INFO - 'download_minidump_stackwalk': True, 03:31:10 INFO - 'download_symbols': 'ondemand', 03:31:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:10 INFO - 'installer_path': 'installer.exe', 03:31:10 INFO - 'log_level': 'info', 03:31:10 INFO - 'log_name': 'talos', 03:31:10 INFO - 'log_to_console': True, 03:31:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:10 INFO - 'opt_config_files': (), 03:31:10 INFO - 'pip_index': False, 03:31:10 INFO - 'sps_profile': False, 03:31:10 INFO - 'sps_profile_interval': 0, 03:31:10 INFO - 'suite': 'dromaeojs', 03:31:10 INFO - 'system_bits': '32', 03:31:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:10 INFO - 'title': 'talos-linux64-ix-014', 03:31:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:10 INFO - 'use_talos_json': True, 03:31:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:10 INFO - 'work_dir': 'build'} 03:31:10 INFO - [mozharness: 2016-09-29 10:31:10.413898Z] Running clobber step. 03:31:10 INFO - Running pre-action listener: _resource_record_pre_action 03:31:10 INFO - Running main action method: clobber 03:31:10 INFO - rmtree: /builds/slave/test/build 03:31:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:11 INFO - Running post-action listener: _resource_record_post_action 03:31:11 INFO - [mozharness: 2016-09-29 10:31:11.388217Z] Finished clobber step (success) 03:31:11 INFO - [mozharness: 2016-09-29 10:31:11.388316Z] Running read-buildbot-config step. 03:31:11 INFO - Running pre-action listener: _resource_record_pre_action 03:31:11 INFO - Running main action method: read_buildbot_config 03:31:11 INFO - Using buildbot properties: 03:31:11 INFO - { 03:31:11 INFO - "project": "", 03:31:11 INFO - "product": "firefox", 03:31:11 INFO - "script_repo_revision": "production", 03:31:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:31:11 INFO - "repository": "", 03:31:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:31:11 INFO - "buildid": "20160929024420", 03:31:11 INFO - "pgo_build": "False", 03:31:11 INFO - "basedir": "/builds/slave/test", 03:31:11 INFO - "buildnumber": 654, 03:31:11 INFO - "slavename": "talos-linux64-ix-014", 03:31:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:11 INFO - "platform": "ubuntu64_hw", 03:31:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:31:11 INFO - "branch": "mozilla-central", 03:31:11 INFO - "repo_path": "mozilla-central", 03:31:11 INFO - "revision": "b67dc49095dcdb6f806cff7c303496e0d7e3efa4", 03:31:11 INFO - "stage_platform": "linux64", 03:31:11 INFO - "builduid": "8aca712d030a493eabfb55c973f90fa9", 03:31:11 INFO - "slavebuilddir": "test" 03:31:11 INFO - } 03:31:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:31:11 INFO - Running post-action listener: _resource_record_post_action 03:31:11 INFO - [mozharness: 2016-09-29 10:31:11.390747Z] Finished read-buildbot-config step (success) 03:31:11 INFO - [mozharness: 2016-09-29 10:31:11.390835Z] Running download-and-extract step. 03:31:11 INFO - Running pre-action listener: _resource_record_pre_action 03:31:11 INFO - Running main action method: download_and_extract 03:31:11 INFO - mkdir: /builds/slave/test/build/tests 03:31: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')]} 03:31:11 INFO - trying https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:31:11 INFO - Downloading https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:11 INFO - Downloaded 1361 bytes. 03:31:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:31:11 INFO - Using the following test package requirements: 03:31:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:31:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'jsshell-linux-x86_64.zip'], 03:31:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:31:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:11 INFO - Fetch https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:31:12 INFO - Http code: 200 03:31:12 INFO - Content-Encoding: None 03:31:12 INFO - Content-Type: application/zip 03:31:12 INFO - via: 1.1 95da1452a75435200220a7075ca3893f.cloudfront.net (CloudFront) 03:31:12 INFO - x-amz-cf-id: C9w03BpgoeUjLbJPir1mSFk1LetA6l5hurmRBYySZSfrRgLZ9u-3EQ== 03:31:12 INFO - x-amz-version-id: KbOe4_fQUIKyanFkAtFd2OmFCvq7pUZC 03:31:12 INFO - x-cache: Hit from cloudfront 03:31:13 INFO - Expected file size: 20415355 03:31:13 INFO - Obtained file size: 20415355 03:31:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:31:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:17 INFO - Fetch https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:31:17 INFO - Http code: 200 03:31:17 INFO - Content-Encoding: None 03:31:17 INFO - Content-Type: application/zip 03:31:17 INFO - via: 1.1 d01884a3320364227d925bce1a38f0ad.cloudfront.net (CloudFront) 03:31:17 INFO - x-amz-cf-id: rnpY6cHxu7-Kiy6yvMJHhEdi55ZdOH6O2DCWzdBSLr8A1LxIhgZWwA== 03:31:17 INFO - x-amz-version-id: KbOe4_fQUIKyanFkAtFd2OmFCvq7pUZC 03:31:17 INFO - x-cache: Hit from cloudfront 03:31:18 INFO - Expected file size: 20415355 03:31:18 INFO - Obtained file size: 20415355 03:31:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:22 INFO - Fetch https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:31:23 INFO - Http code: 200 03:31:23 INFO - Content-Encoding: None 03:31:23 INFO - Content-Type: application/zip 03:31:23 INFO - via: 1.1 4a7b695b8ae560fe9087da065a2b7812.cloudfront.net (CloudFront) 03:31:23 INFO - x-amz-cf-id: EmTuVV5CvzCAWroQQxpHvtTWgF1MZieB3vV_OJETCMKwhvgxJBUrJA== 03:31:23 INFO - x-amz-version-id: rRH879bbw_Q4Sn_GfSCZdOvhjWwqBHIf 03:31:23 INFO - x-cache: Hit from cloudfront 03:31:23 INFO - Expected file size: 14414067 03:31:23 INFO - Obtained file size: 14414067 03:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:23 INFO - trying https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:31:23 INFO - Downloading https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:26 INFO - Downloaded 55741507 bytes. 03:31:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:31:26 INFO - mkdir: /builds/slave/test/properties 03:31:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:26 INFO - Contents: 03:31:26 INFO - build_url:https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - Running post-action listener: _resource_record_post_action 03:31:27 INFO - Running post-action listener: set_extra_try_arguments 03:31:27 INFO - [mozharness: 2016-09-29 10:31:27.021282Z] Finished download-and-extract step (success) 03:31:27 INFO - [mozharness: 2016-09-29 10:31:27.021507Z] Running populate-webroot step. 03:31:27 INFO - Running pre-action listener: _resource_record_pre_action 03:31:27 INFO - Running main action method: populate_webroot 03:31:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:27 INFO - '--tppagecycles', 03:31:27 INFO - '7'], 03:31:27 INFO - 'tests': ['tsvgm']}}, 03:31:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['damp', 'tps']}, 03:31:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'tests': ['damp', 'tps']}, 03:31:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['dromaeo_dom']}, 03:31:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['basic_compositor_video']}, 03:31:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['a11yr', 03:31:27 INFO - 'ts_paint', 03:31:27 INFO - 'tpaint', 03:31:27 INFO - 'sessionrestore', 03:31:27 INFO - 'sessionrestore_no_auto_restore', 03:31:27 INFO - 'tabpaint']}, 03:31:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['tsvgx', 03:31:27 INFO - 'tsvgr_opacity', 03:31:27 INFO - 'tart', 03:31:27 INFO - 'tscrollx', 03:31:27 INFO - 'cart']}, 03:31:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:27 INFO - 'tsvgr_opacity', 03:31:27 INFO - 'tart', 03:31:27 INFO - 'tscrollx', 03:31:27 INFO - 'cart']}, 03:31:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'talos_options': ['--disable-e10s'], 03:31:27 INFO - 'tests': ['tp5o']}, 03:31:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'tests': ['tp5o']}, 03:31:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'talos_options': ['--disable-e10s', 03:31:27 INFO - '--xperf_path', 03:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:27 INFO - 'tests': ['tp5n']}, 03:31:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:27 INFO - 'talos_options': ['--xperf_path', 03:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:27 INFO - 'tests': ['tp5n']}}, 03:31:27 INFO - 'talos.zip': {'path': '', 03:31:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:27 INFO - Running post-action listener: _resource_record_post_action 03:31:27 INFO - [mozharness: 2016-09-29 10:31:27.040047Z] Finished populate-webroot step (success) 03:31:27 INFO - [mozharness: 2016-09-29 10:31:27.040135Z] Running create-virtualenv step. 03:31:27 INFO - Running pre-action listener: _resource_record_pre_action 03:31:27 INFO - Running main action method: create_virtualenv 03:31:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:27 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 03:31:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:27 INFO - Using real prefix '/usr' 03:31:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:29 INFO - Installing pip.................done. 03:31:29 INFO - Return code: 0 03:31:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:31:29 INFO - Reading from file tmpfile_stdout 03:31:29 INFO - Output received: 03:31:29 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) 03:31:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:29 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')]} 03:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:29 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')]} 03:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:29 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:29 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 03:31:29 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 03:31:29 INFO - Using env: {'DISPLAY': ':0', 03:31:29 INFO - 'HOME': '/home/cltbld', 03:31:29 INFO - 'LANG': 'en_US.UTF-8', 03:31:29 INFO - 'LANGUAGE': 'en_US:en', 03:31:29 INFO - 'LOGNAME': 'cltbld', 03:31:29 INFO - 'MAIL': '/var/mail/cltbld', 03:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:29 INFO - 'MOZ_NO_REMOTE': '1', 03:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:29 INFO - 'NO_EM_RESTART': '1', 03:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:29 INFO - 'PWD': '/builds/slave/test', 03:31:29 INFO - 'SHELL': '/bin/bash', 03:31:29 INFO - 'SHLVL': '1', 03:31:29 INFO - 'TERM': 'linux', 03:31:29 INFO - 'TMOUT': '86400', 03:31:29 INFO - 'USER': 'cltbld', 03:31:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:29 INFO - '_': '/tools/buildbot/bin/python'} 03:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:30 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 03:31:30 INFO - Cleaning up... 03:31:30 INFO - Return code: 0 03:31:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:31:30 INFO - Using env: {'DISPLAY': ':0', 03:31:30 INFO - 'HOME': '/home/cltbld', 03:31:30 INFO - 'LANG': 'en_US.UTF-8', 03:31:30 INFO - 'LANGUAGE': 'en_US:en', 03:31:30 INFO - 'LOGNAME': 'cltbld', 03:31:30 INFO - 'MAIL': '/var/mail/cltbld', 03:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:30 INFO - 'MOZ_NO_REMOTE': '1', 03:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:30 INFO - 'NO_EM_RESTART': '1', 03:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:30 INFO - 'PWD': '/builds/slave/test', 03:31:30 INFO - 'SHELL': '/bin/bash', 03:31:30 INFO - 'SHLVL': '1', 03:31:30 INFO - 'TERM': 'linux', 03:31:30 INFO - 'TMOUT': '86400', 03:31:30 INFO - 'USER': 'cltbld', 03:31:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:30 INFO - '_': '/tools/buildbot/bin/python'} 03:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:30 INFO - Downloading/unpacking psutil>=3.1.1 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:32 INFO - Installing collected packages: psutil 03:31:32 INFO - Running setup.py install for psutil 03:31:32 INFO - building 'psutil._psutil_linux' extension 03:31:32 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 03:31:32 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 03:31:32 INFO - building 'psutil._psutil_posix' extension 03:31:32 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 03:31:32 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 03:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:32 INFO - Successfully installed psutil 03:31:32 INFO - Cleaning up... 03:31:32 INFO - Return code: 0 03:31:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:31:32 INFO - Using env: {'DISPLAY': ':0', 03:31:32 INFO - 'HOME': '/home/cltbld', 03:31:32 INFO - 'LANG': 'en_US.UTF-8', 03:31:32 INFO - 'LANGUAGE': 'en_US:en', 03:31:32 INFO - 'LOGNAME': 'cltbld', 03:31:32 INFO - 'MAIL': '/var/mail/cltbld', 03:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:32 INFO - 'MOZ_NO_REMOTE': '1', 03:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:32 INFO - 'NO_EM_RESTART': '1', 03:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:32 INFO - 'PWD': '/builds/slave/test', 03:31:32 INFO - 'SHELL': '/bin/bash', 03:31:32 INFO - 'SHLVL': '1', 03:31:32 INFO - 'TERM': 'linux', 03:31:32 INFO - 'TMOUT': '86400', 03:31:32 INFO - 'USER': 'cltbld', 03:31:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:32 INFO - '_': '/tools/buildbot/bin/python'} 03:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:35 INFO - Installing collected packages: mozsystemmonitor 03:31:35 INFO - Running setup.py install for mozsystemmonitor 03:31:35 INFO - Successfully installed mozsystemmonitor 03:31:35 INFO - Cleaning up... 03:31:35 INFO - Return code: 0 03:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:31:35 INFO - Using env: {'DISPLAY': ':0', 03:31:35 INFO - 'HOME': '/home/cltbld', 03:31:35 INFO - 'LANG': 'en_US.UTF-8', 03:31:35 INFO - 'LANGUAGE': 'en_US:en', 03:31:35 INFO - 'LOGNAME': 'cltbld', 03:31:35 INFO - 'MAIL': '/var/mail/cltbld', 03:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:35 INFO - 'MOZ_NO_REMOTE': '1', 03:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:35 INFO - 'NO_EM_RESTART': '1', 03:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:35 INFO - 'PWD': '/builds/slave/test', 03:31:35 INFO - 'SHELL': '/bin/bash', 03:31:35 INFO - 'SHLVL': '1', 03:31:35 INFO - 'TERM': 'linux', 03:31:35 INFO - 'TMOUT': '86400', 03:31:35 INFO - 'USER': 'cltbld', 03:31:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:35 INFO - '_': '/tools/buildbot/bin/python'} 03:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:37 INFO - warning: no files found matching '*.txt' 03:31:37 INFO - no previously-included directories found matching 'build' 03:31:37 INFO - no previously-included directories found matching 'dist' 03:31:37 INFO - no previously-included directories found matching '.git*' 03:31:37 INFO - Installing collected packages: jsonschema, functools32 03:31:37 INFO - Running setup.py install for functools32 03:31:37 INFO - warning: no files found matching '*.txt' 03:31:37 INFO - no previously-included directories found matching 'build' 03:31:37 INFO - no previously-included directories found matching 'dist' 03:31:37 INFO - no previously-included directories found matching '.git*' 03:31:37 INFO - Successfully installed jsonschema functools32 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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', '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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:31: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 functools32==3.2.3-2 03:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:38 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:38 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 03:31:38 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 03:31:38 INFO - Using env: {'DISPLAY': ':0', 03:31:38 INFO - 'HOME': '/home/cltbld', 03:31:38 INFO - 'LANG': 'en_US.UTF-8', 03:31:38 INFO - 'LANGUAGE': 'en_US:en', 03:31:38 INFO - 'LOGNAME': 'cltbld', 03:31:38 INFO - 'MAIL': '/var/mail/cltbld', 03:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:38 INFO - 'MOZ_NO_REMOTE': '1', 03:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:38 INFO - 'NO_EM_RESTART': '1', 03:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:38 INFO - 'PWD': '/builds/slave/test', 03:31:38 INFO - 'SHELL': '/bin/bash', 03:31:38 INFO - 'SHLVL': '1', 03:31:38 INFO - 'TERM': 'linux', 03:31:38 INFO - 'TMOUT': '86400', 03:31:38 INFO - 'USER': 'cltbld', 03:31:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:38 INFO - '_': '/tools/buildbot/bin/python'} 03:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:40 INFO - Downloading docopt-0.6.1.tar.gz 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:40 INFO - Running setup.py install for blobuploader 03:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:40 INFO - Running setup.py install for requests 03:31:41 INFO - Running setup.py install for docopt 03:31:41 INFO - Successfully installed blobuploader requests docopt 03:31:41 INFO - Cleaning up... 03:31:41 INFO - Return code: 0 03:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:41 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')]} 03:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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')]} 03:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:41 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 03:31:41 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 03:31:41 INFO - Using env: {'DISPLAY': ':0', 03:31:41 INFO - 'HOME': '/home/cltbld', 03:31:41 INFO - 'LANG': 'en_US.UTF-8', 03:31:41 INFO - 'LANGUAGE': 'en_US:en', 03:31:41 INFO - 'LOGNAME': 'cltbld', 03:31:41 INFO - 'MAIL': '/var/mail/cltbld', 03:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:41 INFO - 'MOZ_NO_REMOTE': '1', 03:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:41 INFO - 'NO_EM_RESTART': '1', 03:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:41 INFO - 'PWD': '/builds/slave/test', 03:31:41 INFO - 'SHELL': '/bin/bash', 03:31:41 INFO - 'SHLVL': '1', 03:31:41 INFO - 'TERM': 'linux', 03:31:41 INFO - 'TMOUT': '86400', 03:31:41 INFO - 'USER': 'cltbld', 03:31:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:41 INFO - '_': '/tools/buildbot/bin/python'} 03:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:41 INFO - Running setup.py (path:/tmp/pip-dGDx67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:41 INFO - Running setup.py (path:/tmp/pip-AO3GpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:41 INFO - Running setup.py (path:/tmp/pip-ItRUri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:41 INFO - Running setup.py (path:/tmp/pip-jurVcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:41 INFO - Running setup.py (path:/tmp/pip-D45CC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:42 INFO - Running setup.py (path:/tmp/pip-Q5n4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:42 INFO - Running setup.py (path:/tmp/pip-1oEJN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:42 INFO - Running setup.py (path:/tmp/pip-B6EBK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:42 INFO - Running setup.py (path:/tmp/pip-OsTtos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:42 INFO - Running setup.py (path:/tmp/pip-f1Hswd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:42 INFO - Running setup.py (path:/tmp/pip-3pEztL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:42 INFO - Running setup.py (path:/tmp/pip-CauK6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:42 INFO - Running setup.py (path:/tmp/pip-Abxb8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:42 INFO - Running setup.py (path:/tmp/pip-42xoDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:42 INFO - Running setup.py (path:/tmp/pip-584_iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:42 INFO - Running setup.py (path:/tmp/pip-RZfHHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:42 INFO - Running setup.py (path:/tmp/pip-AUJxGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:42 INFO - Running setup.py install for manifestparser 03:31:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozcrash 03:31:43 INFO - Running setup.py install for mozdebug 03:31:43 INFO - Running setup.py install for mozdevice 03:31:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozfile 03:31:43 INFO - Running setup.py install for mozhttpd 03:31:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozinfo 03:31:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozInstall 03:31:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozleak 03:31:43 INFO - Running setup.py install for mozlog 03:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for moznetwork 03:31:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Running setup.py install for mozprocess 03:31:44 INFO - Running setup.py install for mozprofile 03:31:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Running setup.py install for mozrunner 03:31:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Running setup.py install for mozscreenshot 03:31:44 INFO - Running setup.py install for moztest 03:31:44 INFO - Running setup.py install for mozversion 03:31:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:44 INFO - Cleaning up... 03:31:44 INFO - Return code: 0 03:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:44 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')]} 03:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:44 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')]} 03:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:44 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:44 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 03:31:44 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 03:31:44 INFO - Using env: {'DISPLAY': ':0', 03:31:44 INFO - 'HOME': '/home/cltbld', 03:31:44 INFO - 'LANG': 'en_US.UTF-8', 03:31:44 INFO - 'LANGUAGE': 'en_US:en', 03:31:44 INFO - 'LOGNAME': 'cltbld', 03:31:44 INFO - 'MAIL': '/var/mail/cltbld', 03:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:44 INFO - 'MOZ_NO_REMOTE': '1', 03:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:44 INFO - 'NO_EM_RESTART': '1', 03:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:44 INFO - 'PWD': '/builds/slave/test', 03:31:44 INFO - 'SHELL': '/bin/bash', 03:31:44 INFO - 'SHLVL': '1', 03:31:44 INFO - 'TERM': 'linux', 03:31:44 INFO - 'TMOUT': '86400', 03:31:44 INFO - 'USER': 'cltbld', 03:31:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:44 INFO - '_': '/tools/buildbot/bin/python'} 03:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:44 INFO - Running setup.py (path:/tmp/pip-VgeMWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:45 INFO - Running setup.py (path:/tmp/pip-4_U9YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:45 INFO - Running setup.py (path:/tmp/pip-zhS7Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:45 INFO - Running setup.py (path:/tmp/pip-lGans1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:45 INFO - Running setup.py (path:/tmp/pip-iWLI5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:45 INFO - Running setup.py (path:/tmp/pip-jLY7p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:45 INFO - Running setup.py (path:/tmp/pip-nY6B7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:45 INFO - Running setup.py (path:/tmp/pip-Fum47D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:45 INFO - Running setup.py (path:/tmp/pip-ykWHW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:45 INFO - Running setup.py (path:/tmp/pip-9qdI9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:45 INFO - Running setup.py (path:/tmp/pip-LTap99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:45 INFO - Running setup.py (path:/tmp/pip-21Lx6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:45 INFO - Running setup.py (path:/tmp/pip-SfLGim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:45 INFO - Running setup.py (path:/tmp/pip-WBrXla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:45 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)) 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:45 INFO - Running setup.py (path:/tmp/pip-LpV392-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:46 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)) 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:46 INFO - Running setup.py (path:/tmp/pip-8S253f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:46 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)) 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:46 INFO - Running setup.py (path:/tmp/pip-ZjGXKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:46 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)) 03:31:46 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)) 03:31:46 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)) 03:31:46 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)) 03:31:46 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)) 03:31:46 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)) 03:31:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:48 INFO - Downloading blessings-1.6.tar.gz 03:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:48 INFO - Installing collected packages: blessings 03:31:48 INFO - Running setup.py install for blessings 03:31:48 INFO - Successfully installed blessings 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:48 INFO - Reading from file tmpfile_stdout 03:31:48 INFO - Current package versions: 03:31:48 INFO - argparse == 1.2.1 03:31:48 INFO - blessings == 1.6 03:31:48 INFO - blobuploader == 1.2.4 03:31:48 INFO - docopt == 0.6.1 03:31:48 INFO - functools32 == 3.2.3-2 03:31:48 INFO - jsonschema == 2.5.1 03:31:48 INFO - manifestparser == 1.1 03:31:48 INFO - mozInstall == 1.12 03:31:48 INFO - mozcrash == 0.17 03:31:48 INFO - mozdebug == 0.1 03:31:48 INFO - mozdevice == 0.48 03:31:48 INFO - mozfile == 1.2 03:31:48 INFO - mozhttpd == 0.7 03:31:48 INFO - mozinfo == 0.9 03:31:48 INFO - mozleak == 0.1 03:31:48 INFO - mozlog == 3.4 03:31:48 INFO - moznetwork == 0.27 03:31:48 INFO - mozprocess == 0.23 03:31:48 INFO - mozprofile == 0.28 03:31:48 INFO - mozrunner == 6.12 03:31:48 INFO - mozscreenshot == 0.1 03:31:48 INFO - mozsystemmonitor == 0.3 03:31:48 INFO - moztest == 0.7 03:31:48 INFO - mozversion == 1.4 03:31:48 INFO - psutil == 3.1.1 03:31:48 INFO - requests == 1.2.3 03:31:48 INFO - wsgiref == 0.1.2 03:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:48 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')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:48 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 03:31:48 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 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:48 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')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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 0x7f847153af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', '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 03:31:48 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 03:31:48 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 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:49 INFO - Cleaning up... 03:31:49 INFO - Return code: 0 03:31:49 INFO - Running post-action listener: _resource_record_post_action 03:31:49 INFO - Running post-action listener: _start_resource_monitoring 03:31:49 INFO - Starting resource monitoring. 03:31:49 INFO - [mozharness: 2016-09-29 10:31:49.040582Z] Finished create-virtualenv step (success) 03:31:49 INFO - [mozharness: 2016-09-29 10:31:49.041041Z] Running install step. 03:31:49 INFO - Running pre-action listener: _resource_record_pre_action 03:31:49 INFO - Running main action method: install 03:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:49 INFO - Reading from file tmpfile_stdout 03:31:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:49 INFO - Reading from file tmpfile_stdout 03:31:49 INFO - Output received: 03:31:49 INFO - Usage: mozinstall [options] installer 03:31:49 INFO - Options: 03:31:49 INFO - -h, --help show this help message and exit 03:31:49 INFO - -d DEST, --destination=DEST 03:31:49 INFO - Directory to install application into. [default: 03:31:49 INFO - "/builds/slave/test"] 03:31:49 INFO - --app=APP Application being installed. [default: firefox] 03:31:49 INFO - mkdir: /builds/slave/test/build/application 03:31:49 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'] 03:31:49 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 03:32:05 INFO - Reading from file tmpfile_stdout 03:32:05 INFO - Output received: 03:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:05 INFO - Running post-action listener: _resource_record_post_action 03:32:05 INFO - [mozharness: 2016-09-29 10:32:05.435590Z] Finished install step (success) 03:32:05 INFO - [mozharness: 2016-09-29 10:32:05.435831Z] Running run-tests step. 03:32:05 INFO - Running pre-action listener: _resource_record_pre_action 03:32:05 INFO - Running main action method: run_tests 03:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:05 INFO - Python 2.7.3 03:32:05 INFO - Return code: 0 03:32:05 INFO - grabbing minidump binary from tooltool 03:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:05 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 0x150bf60>, '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 0x150cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:05 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 03:32:05 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 03:32:05 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 03:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:05 INFO - Return code: 0 03:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 03:32:05 INFO - Using env: {'DISPLAY': ':0', 03:32:05 INFO - 'HOME': '/home/cltbld', 03:32:05 INFO - 'LANG': 'en_US.UTF-8', 03:32:05 INFO - 'LANGUAGE': 'en_US:en', 03:32:05 INFO - 'LOGNAME': 'cltbld', 03:32:05 INFO - 'MAIL': '/var/mail/cltbld', 03:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:05 INFO - 'MOZ_NO_REMOTE': '1', 03:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:05 INFO - 'NO_EM_RESTART': '1', 03:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:05 INFO - 'PWD': '/builds/slave/test', 03:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:05 INFO - 'SHELL': '/bin/bash', 03:32:05 INFO - 'SHLVL': '1', 03:32:05 INFO - 'TERM': 'linux', 03:32:05 INFO - 'TMOUT': '86400', 03:32:05 INFO - 'USER': 'cltbld', 03:32:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465', 03:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:05 INFO - '_': '/tools/buildbot/bin/python'} 03:32:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:32:05 INFO - mozversion application_buildid: 20160929024420 03:32:05 INFO - mozversion application_changeset: b67dc49095dcdb6f806cff7c303496e0d7e3efa4 03:32:05 INFO - mozversion application_display_name: Nightly 03:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:05 INFO - mozversion application_name: Firefox 03:32:05 INFO - mozversion application_remotingname: firefox 03:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:32:05 INFO - mozversion application_vendor: Mozilla 03:32:05 INFO - mozversion application_version: 52.0a1 03:32:05 INFO - mozversion platform_buildid: 20160929024420 03:32:05 INFO - mozversion platform_changeset: b67dc49095dcdb6f806cff7c303496e0d7e3efa4 03:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:32:05 INFO - mozversion platform_version: 52.0a1 03:32:05 INFO - using testdate: 1475145125 03:32:05 INFO - actual date: 1475145125 03:32:05 INFO - starting webserver on 'localhost:43798' 03:32:05 INFO - SUITE-START | Running 2 tests 03:32:05 INFO - TEST-START | dromaeo_css 03:32:05 INFO - operating with platform_type : linux_ 03:32:05 INFO - Initialising browser for dromaeo_css test... 03:32:05 INFO - TEST-INFO | started process 29652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2rFhE/profile http://localhost:43798/getInfo.html) 03:32:10 INFO - PROCESS | 29652 | __metrics Screen width/height:1600/1200 03:32:10 INFO - PROCESS | 29652 | colorDepth:24 03:32:10 INFO - PROCESS | 29652 | Browser inner width/height: 1024/697 03:32:10 INFO - PROCESS | 29652 | __metrics 03:32:10 INFO - PROCESS | 29652 | 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" 03:32:10 INFO - PROCESS | 29652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:32:11 INFO - PROCESS | 29652 | console.error: PushService: 03:32:11 INFO - PROCESS | 29652 | stateChangeProcessEnqueue: Error transitioning state 03:32:11 INFO - PROCESS | 29652 | UnknownError 03:32:11 INFO - TEST-INFO | 29652: exit 0 03:32:11 INFO - Browser initialized. 03:32:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:11 INFO - TEST-INFO | started process 29734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2rFhE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:24 INFO - PROCESS | 29734 | RSS: Main: 174751744 03:32:24 INFO - PROCESS | 29734 | 03:33:15 INFO - PROCESS | 29734 | 1475145195948 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] 03:35:28 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43798/tests/dromaeo/cssquery-ext.html) 03:35:29 INFO - PROCESS | 29734 | RSS: Main: 315224064 03:35:29 INFO - PROCESS | 29734 | 03:38:32 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-ext.html (next: http://localhost:43798/tests/dromaeo/cssquery-jquery.html) 03:38:32 INFO - PROCESS | 29734 | RSS: Main: 284450816 03:38:32 INFO - PROCESS | 29734 | 03:41:34 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43798/tests/dromaeo/cssquery-mootools.html) 03:41:35 INFO - PROCESS | 29734 | RSS: Main: 219828224 03:41:35 INFO - PROCESS | 29734 | 03:44:37 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43798/tests/dromaeo/cssquery-prototype.html) 03:44:38 INFO - PROCESS | 29734 | RSS: Main: 220442624 03:44:38 INFO - PROCESS | 29734 | 03:47:41 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43798/tests/dromaeo/cssquery-yui.html) 03:47:42 INFO - PROCESS | 29734 | RSS: Main: 223399936 03:47:42 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:43798/tests/dromaeo/cssquery-yui.html (next: http://localhost:43798/tests/dromaeo/cssquery-dojo.html) 03:50:45 INFO - PROCESS | 29734 | RSS: Main: 294895616 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | __start_tp_report 03:50:45 INFO - PROCESS | 29734 | _x_x_mozilla_page_load 03:50:45 INFO - PROCESS | 29734 | _x_x_mozilla_page_load_details 03:50:45 INFO - PROCESS | 29734 | |i|pagename|runs| 03:50:45 INFO - PROCESS | 29734 | |0;dojo.html;2557.322309587959;2581.9354516137105;2613.4642398308347;2620.0829709601644;2636.327736427212;4537.978954735191;4615.769211539427;4671.182543054964;4696.436427628681;4700.929486057707;4639.512851150631;4664.300354946759;4665.720056796595;4694.366260554824;4741.786619602118;4227.6617870570435;4254.553271906451;4300.161468513626;4303.827846886136;4317.13657268546;4318.719283246579;4333.2416827055295;4358.2808836541935;4367.541408152146;4406.735595864242;4174.5616710245595;4301.677374196916;4301.870943871689;4336.63138633215;4404.69167158299;4204.915901681949;4264.808083636212;4265.33887247474;4318.1363727254675;4333.58830911063;4281.850135245251;4282.785860706983;4286.442762440894;4345.978270108661;4352.521222665504;4640.187967105743;4667.15991121598;4667.696599721007;4680.765961701935;4712.340272361872;4788.257820037899;4843.927341089851;4852.441969173555;4897.33885925399;4942.456329803718;4964.361760618987;4966.15575352191;4969.652124351297;4979.228219625964;5031.069252188357;4613.654906174766;4619.376384188159;4626.282926146453;4631.560001799824;4683.555062269079;5012.373453318335;5071.543561079447;5075.111855425286;5086.21163719624;5139.640225184276;4892.902141957141;4912.656114072052;4920.163572192736;4967.05625931072;4974.552290293891;5007.899842003139;5015.297858299841;5018.071656743441;5024.020316038411;5084.593232541388;4819.614430845524;4884.1941079722155;4939.48135445773;4947.777350019258;5018.924716129261;4866.46468888422;4896.020795840846;4908.337374454474;4911.45973942866;4916.041371932511;4117.155983023473;4121.670266378683;4122.711410201317;4130.690198235145;4151.8546850860075;3558.733095017884;3629.1471504196493;3630.6913912317223;3682.926341473209;3689.446583012516;4256.042390462121;4265.637420819203;4289.335153051282;4305.634021108241;4322.524522302544;4885.682430641997;4923.753812309442;4927.802887884516;4940.481249468754;4979.900401992012;4189.2459357315975;4248.4477017987465;4250.957490425118;4258.276093064186;4311.4395128633705;4417.889552761207;4421.579949904753;4449.154660614473;4450.221211288012;4503.729776213438;4705.976470117627;4705.976470117627;4709.858704238878;4714.080754252887;4772.0217355442055;4881.51184881509;4977.925331120108;4993.201087826075;4993.975030124826;5001.474845141353;4643.953560464487;4663.253879379283;4677.789499472464;4693.272542755878;4746.501617330268;4888.462269150462;4897.094037603055;4898.044881248123;4904.141775189399;4958.752062396938;4955.8017679292425;4966.826161084345;4967.393366822046;4972;5027.798888044437;4736.905261894812;4785.066911952136;4787.832425865078;4822.614190864792;4835.927461088017;4843.370361852936;4843.46721860588;4844.46710861812;4889.559939605452;4907.386576677915;4757.952420475751;4765.046990601824;4775.8328458505175;4777.689450185727;4847.079054979543;4714.22215334466;4735.550122738335;4757.119932812441;4771.618270538418;4846.781894814812;4650.511696271843;4650.953490465052;4699.859004229878;4705.55297246761;4715.3869996900185 03:50:45 INFO - PROCESS | 29734 | |1;ext.html;534.3000669123448;559.5831105826159;570.5350139636196;579.7014537513181;588.8292395205391;28623.856880715593;38602.61397386025;39979.60020399799;40024.599754002455;44211.55788442115;40256.39615405764;40868.38697419534;40875.59124408755;40904;40912.97717557055;7533.05836770405;7678.808029799244;7681.769546913573;7682.5006374585755;7691.692332306701;7301.415886729049;7528.096628404599;9691.660791872286;9975;9991.400515969066;10034.448105354202;10141.797164056714;10143.340682855627;10145.594176232942;10146.239032072586;9917.404955702681;9955.55200016001;9977.401355918668;9996.350237234592;9996.750081248027;9655.565499552536;9733.270004749602;9733.756656083584;9740.220782337396;9741.464219467927;37680.623193767984;38038.80980595107;38074.23851522954;38109.428358574645;38139.80930095332;2972.4203780262856;3168.358146674418;3547.0954906498678;3555.075680323109;3589.73077019222;28743.28141796451;28913.56629650557;28984.710152898413;29074;29363.55954660682;3442.2599141184764;3573.4997100405963;3626.1478552540134;3635.272945410902;3694.2057457646465;234526;234926;236204;236671;237711;30402.695973039987;31744.841275793475;49951.75024124856;50285;50405.73174207169;33355.499667505006;33483.49774753381;33493.83253083768;33617.327653446795;33662.158446039044;12558.937205313914;12676.746465070832;12678;12683.492660293485;12684.556040538537;9600.087991640783;9600.807983840285;9609.9039009609;9610.231181505464;9911.752206194902;7167.749128780468;7448.292412220831;7733.110692270348;7734.7679569613;7735.806604834812;2983.9552406713915;3000.6699263081046;3025.183200535843;3039.2249976256358;3049.9542506862413;804.9074356449083;865.1694373401605;887.7603047177226;912.8128733609727;954.465499320369;26485.073022444507;27117.186484405498;27210.591841122397;27865;28220.43559128806;892.9553522323857;923.8752768376318;953.756792018031;959.9136077753036;993.6720882108887;14148.434062637585;15046.141233165663;15062.472813451695;15320;15382.53852384408;361242;365755;366051;366465;366535;48282.51717482851;48767;48773.51226487761;48807.51192488101;48837.53487395384;1106.5131342209563;1128.943552822372;1148.8161894097072;1164.85439320085;1165.84843970285;25974.480510390065;27052.864735676194;27246.803056347875;27365.86317068402;27761.305967350978;41591.792041039604;41900.580994189666;41906.16187676168;41932.58067419409;41934.790326048176;260170;260301;261237;261615;262366;22126;25027.74528330152;25410.110646127298;25447.87276063682;25457.10900118487;35091.82454087713;35183;39537.38058736268;43311.783441082596;43378;35175;35189.64810351864;35283.11792205215;35546;36005.45991810073;35055.64944350524;35225.29549408946;35507;35972.10069748173;36135.45796813103;34429.65570344365;34587.4811877817;35145.47281790724;35311.82344088263;35693.64306357007;30899.227519312197;32639.836800815843;32749;33052.83473582617;33341.49987750234;24365.2741605719;24933.252002439956;25110;25128.748712513374;25409 03:50:45 INFO - PROCESS | 29734 | |2;jquery.html;335.8975512468696;342.3204938197679;352.74954782104703;354.6418117701121;370.823858667133;12371.319577423239;15629.374825007;15955.441559545417;16092.517224483256;17194.82805171951;15513.92243038786;15947.441839535619;15984.76022859658;16079.11564863935;16156.272967716452;4910.435299940508;4923.53152577566;4982.551570358667;5057.5701065409485;5126.359205099363;3548.6628770266784;4927.926081108786;5000.299958005882;5005.324281222025;5007.524285192901;3742.9251414971686;4929.33453983713;5120.795168193286;5210.609204309673;5215.061288967984;5229.76714538973;5287.127623942064;5299.496547827931;5304.283921670563;5782.306123265193;5111.028904508132;5124.052050370656;5126.615503837227;5130.256112863651;5133.0503856786245;19647.705284420746;19860;19958.201671933104;20064.899675501674;20216.49458763528;1749.8950062996262;1808.7739032620923;1826.6985947318676;1832.6517961587256;1876.2963888541797;8867.55662216893;9092.909070909272;9244.8613270801;9309.441433513943;9339.813203735956;1612.46788559775;1686.983130168695;1717.5696389608688;1730.56735816046;1743.9215235314314;64453.3554664452;66142.66928665373;67597.66201168962;67806.321936781;69195;9161.77095572616;9405.247580193705;9446;9466;9625.759356016015;12433.37833108341;12535.122541422195;12548.435320410603;12555.623331300076;12565.93717031409;6272.560920735505;6488.67556622167;6672.399484046459;6704.899426508607;6711.966440167866;6151.72317245716;6215.502759779207;6297.622142671363;6363;6366.299707032223;3781.962180378161;3801.486799282117;3846.6345697158727;3935.2916475034194;3983.960160398417;1621.4162901355503;1651.6283836136772;1687.3166367621134;1719.2950890134985;1766.3376233912284;807.172648035768;836.5231817863881;845.4293351987384;851.714675583674;877.4603618774407;15594.454194103151;16744.330226791037;16883.32466701343;16960.491185264462;17156.828431715774;810.4569938141342;833.8332333533317;836.2933321343455;847.6609356257546;876.8342194779013;8847.203751662253;9004.59479323432;9503;9549.140577347933;9611;277674;283877;353341;354218;356567;80583.59708201421;82214;82316.58841705753;83229.58385208035;83387;871.7384784564605;901.0944001278673;904.9547522623974;905.1310741688053;915.9313051521162;15267.847321527086;15348.155851427831;15531.76702349443;15738.842611573738;16185.51443456651;34715.826420867736;35198.64801351954;35937.28125437529;39117.217655646156;40181.598184018956;46325;49556.25665615091;49988;50844.49155508546;51348;7371.8157046074275;7377.151627562899;7535;7574.469787114849;7701.730439434593;11694.122940779305;11812.763744724885;11821.586244481401;11952.342621155572;11996.820047699466;9721.70834874955;9931.900680993387;10000.149987251165;10178.083972442515;10214.387136771817;10015.24885633595;10074.496275186359;10139.340942838691;10375.792484150426;10451.895481045092;9419.905800942177;9883.258755593502;10032.548535316075;10362.792744145225;10584.364938103738;7108.964455177691;7293.9635301823155;7523.699052037857;7551.509151905108;7677.347425468898;8601.311895048257;9663.371880827724;10008.699739007841;10253.74365640865;10345.896541034494 03:50:45 INFO - PROCESS | 29734 | |3;mootools.html;1239.838820953276;1317.907746457748;1350.534065747317;1403.6350548857295;1647.0940982459645;6882.827929301764;7676.193999630035;7962.601869906496;7980.204453997848;8174.305184059363;7950.801229969254;8007.67969281228;8022.67909283628;8024.277814996649;8026.678932842694;2159;2184.6067707812585;2184.8361372897016;2188.4310079379397;2191.41927389242;2157.331227319536;2192.6930229767845;2200.680901269315;2201.020545857094;2207.7461091974387;2177.1617927098023;2187.862311597968;2193.890305484719;2196.033745152128;2229.487217939875;2177.281497105951;2181.149351752818;2181.596404665142;2182.9563408731738;2185.8142057925097;2105.9368218953455;2151.4943988162768;2155.073318473056;2155.137944822068;2172.3808714516445;7675.616219189074;7795.9220407795765;7951.602419878983;7952.642131104114;7959.124496305401;4538.818447262105;4711.740854253015;4721.032188401369;4726.291056341542;4735.928961065587;2855.81437206583;2984.1346009657173;3037.4532584134845;3041.4373340931998;3042.7870049096573;936.3773090894547;949.886013678363;963.2967933408581;964.4165280005636;974.0503009565688;10793.514291856807;10881.183911206612;10904.727381815439;10909.23635345526;10915.781684366348;4020.4773379461067;4061.248668996245;4156.459660244149;4239.788010599457;4256.59562341577;8473.322134229247;8522.403431759718;8539.82920341602;8550.914490855137;8552.95723521391;4622.214223581932;4625.7455839929125;4627.282771170474;4628.421447319085;4629.629629629621;3730.645588669072;3854.8265328060306;3992.740471869319;4313.547077556811;4329.372241025034;3299.5215693724276;3325.235195904907;3465.0990742407157;3476.860925562949;3490.808005559719;978.2516374973151;1026.4508487958906;1028.5011769292037;1031.097789434245;1033.075397519216;748.4124961904879;773.0916173496232;783.4398405140352;789.8815177723272;796.1918652567648;4890.16618767962;5010.749462526859;5031.572316353151;5074.314967479417;5242.816501422432;393.50221969208974;396.50040948404643;397.75538044103246;399.71021009767685;859.7979474823411;3312.6252605169066;3350.246194606194;3377.4427219509;3434.0899661589697;3604.873829415958;9621.326507144433;9904.752381190383;9924.354916930377;9949.55227014786;10008.799824003625;9918.355306905029;9944.055314745232;9946.303758736818;9950.80098398028;9957.302988790716;7421.703131874772;7427.925720742724;7451.844964030584;7561.168271490242;7585.279398457138;5090.745462726923;5176.741162941913;5228.032813929435;5243.764030618555;5255.369355677343;8639.092895245909;9009.828722266064;9111.316651251314;9115.863262050942;9252.213561847318;9039.819203616022;9105;9287.582058807235;9328.440293582407;9406.811863762823;5535.474129957809;5716.342620598684;6267.185265915402;6440.484761218998;6486.383793539606;7005.929940700527;7238.312360325761;7262.237465066092;7401.555906645403;7421.480496365202;6659.188150854323;6801.421879140328;6876.106106206161;7056.576605403692;7068.399186069036;6722.495812813961;6738.898916516158;6887.104676392037;6901.861962760817;6933.341332573397;6113.84715382119;6178.227721534809;6181.938180618136;6190.380961903774;6202.100695399052;4399.450068741407;4431.135928494042;4460.174867649495;4499.5275496073755;4559;4473.910521789611;4486.75322857246;4608.838690645811;4618.584327410549;4709.128811169944 03:50:45 INFO - PROCESS | 29734 | |4;prototype.html;295.0617037819733;298.4538294920296;304.3562864541495;309.3905007135943;312.0155908109914;4777.665563410558;4815.157347464188;4837.790552361909;4858.611311095113;4892.948016176521;4748.5726284634375;4753.4533528644215;4798.7600619969035;4803.111424386491;4804.5435683610085;3809.1810260793923;3811.028187812104;3817.2747178036225;3823.1397935464574;3835.137094153821;3582.785032898021;3813.8665146719873;3830.559485659157;3832.2910261601555;3839.7120215983773;3729.981350093259;3733.0667333166707;3751.3060083884434;3754;3778.4143457763953;3736.23407201523;3737.7570457920147;3741.3265612189794;3749.268892565951;3756.924861502768;3094.313599088502;3155.700208480214;3202.6316973548105;3316.8009919404913;3323.285493618859;4616.930746038812;4648.279516674921;4648.976755116237;4658.254679251304;4680.3447517347595;4244.108737165199;4265.850695225652;4266.552012038722;4267.551907049778;4285.721428107163;4625.791839367236;4675.929861052087;4952.826651067196;4986.8805757553255;4991.550760431543;3591.8742844000335;3594.4967704521387;3601.7658852174527;3618.203995121069;3621.8189090545366;5185.714785686786;5185.896282074337;5193.818216362447;5199.194124910683;5207.953347291839;3586.5696116466193;3651.744377893575;3708.647678470541;3725.9441108383394;3735.5704094029534;3743.21392507571;3751.630654810974;3752.7615886757303;3764.378877485239;3768.1144930941205;4243.639290660329;4278.764667943293;4282.293421585466;4283.31466965284;4291.699581029298;4951.801927922915;4954.925676114861;4956.975215123974;4973.8010479581135;4991.101601711727;1242.5029988004871;1283.4224598930518;1296.500847173845;1299.8635143310005;1301.4122770220315;830.4892491117919;839.1692224697506;854.1629203380721;856.0540602634125;865.5715420866711;3990.2817492850986;4004.2191772604065;4008.5569195089743;4011.4154908810856;4018.4374187613757;4539;4541.68208225421;4553.954460455419;4582.510684027704;4585.592563903977;3958.247932892741;3968.226195891831;3978.5424676162033;3980.482537270136;3997.400389941532;2341.5433990372053;2387.9880600596885;2397.532481166191;2416.7220769611367;2445.4986727720775;4302.182585308781;4615.653825963066;4687.882802929954;4737.976310118427;4878.682625752739;5294.047071527085;5296.285001524822;5306.389765177054;5306.416294207634;5313.698143954756;4825.541573550507;4853.854384368546;4865.197242455026;4900.485449027872;4910.680805747615;4897.877553061059;5133.204353325241;5158.716270605153;5192.610554208374;5204.193350030751;5065.822696205615;5069.847904562869;5071.084126627278;5076.796928122833;5077.568406685473;4714.434267887876;4820.108279968217;4837.887285924327;4865.56209941107;4883.560479556857;3679.3377192105677;3691.132583842741;3697.7041836652465;3705.758570878678;3712.406015037581;5146.639735218499;5167.173252279617;5196.038732834287;5200;5203.427622961547;5031.144705400017;5031.874203144951;5047.646664733434;5048.242763585492;5052.368453943257;4866.221404575251;4951.455339912534;4956.033573453142;4969.981153863521;4989.950100498949;4883.438404583519;4884.65807393479;4885.387822018796;4895.583875370491;4941.110600092018;4928.482509336612;5075.77159027852;5077.238414237894;5086.567641750345;5088.397154896196;4826.613870890391;4830.806767729251;4849.709017458823;4866;4884.90230195387 03:50:45 INFO - PROCESS | 29734 | |5;yui.html;652.4584594786328;662.5130529061139;694.8297667071569;722.7614887087261;750.774767569729;12425.440855161516;13521.729565408687;13523;13523.459061637535;13527.053106282565;12474.501019959214;12498.56255031074;12503.124781265315;12511.812322815142;12630;606.7209083821448;626.3329554024972;749.3068911257093;767.6161919040479;778.2878666020584;760.0651199025202;762.8970089037992;764.4534158076974;767.7850201943437;767.8157242261844;810.1574362662853;810.5420437452821;811.8213992921548;811.8213992921577;812.2283830361151;645.2031740800131;665.6472069803012;771.6141929035482;793.7182300283432;797.131127071489;584.8917950179188;585.8271809816115;586.1354502109397;586.302300262686;586.3432955090326;12798.232106073665;12801.93599031999;12832;12834.614961551168;12844.229346239255;12466.002719782486;12705.174163679423;12901.161424507378;13026.348682565835;13319.667008324772;11673.76652466946;11727.589534366256;11829.52681892732;11854.466549005316;12227.69430764229;3978.1049263915675;3986.202759448122;3986.54154772202;4008.7995600219874;4046.6964977626794;56158.43841561614;58813.41186588122;59454.70272648609;59796.80406391891;60081;10180.592776289013;10373.325733827278;10382.273240873066;10448.164146868232;10583.470826458646;18150.727739083923;18180.727289090675;18234.726479102825;18258.36095736643;18260.26958921628;6980.162380514371;7019.89470157948;7031.437485001187;7111.182214045451;7165.605891676008;3751.268502642013;3776.8300426480873;3805.46723458716;3840.7503512272174;3881.107345310594;2889.2921234297733;2995.2362147652643;3017.4870272053804;3043.46739320618;3043.893463728759;529.9788008479695;532.7842223899327;533.703794394115;546.4289817141097;565.4854082784647;471.42250742839747;477.9880502987453;522.9660072095302;547.460751160107;563.937966823649;6877.65611719412;6969.407600354027;7281;7416.035915330973;7624.19945905683;514.8758444856651;557.6540755467197;564.890707003753;570.1789423230534;578.2020811280406;3633.800140992218;3688.041109311598;3738.140227747579;3745.7077308328585;3852.5376954765607;103148.98041823166;103228.48385758023;103980;105280;105514.47242763737;67662.32337676658;75222;80185.59907200426;87067.12932870591;88184.6772298416;42703;55536.444635553125;65817.67091164514;70996.64501677561;71772;7584.772456826304;7700.807479813049;7767.067951845815;7802.063752349754;7894.092179399443;36734.8163259182;36773.44839827458;42838.35742463803;43533.34699979566;44642.776786115865;58178;59047;59515.40484595099;59730.40269597249;60004;11053.171012173958;11322.660320190407;11390;11606.12954028468;12158.574449894211;10514;10635.787284254426;10658.200634952565;11106.167037472384;11193.216474846682;11485.48315325829;11613.187076904873;11747.823782643438;12134.211276267015;12667.746645066863;10887.18346124028;11171.776564468828;11557.768844623228;11653.126015548698;11683.766324673288;10349.482525873827;10381.584736610452;10829.729256768644;11089.112870970464;11528.942355288169;8886.86669699968;8959.41763785352;9398.20115290208;9483.66807161746;9560.613711012003;9324.347295689508;9814.75463113428;9859.618337354581;9882.851757223503;10005.799884002425 03:50:45 INFO - PROCESS | 29734 | __end_tp_report 03:50:45 INFO - PROCESS | 29734 | __start_cc_report 03:50:45 INFO - PROCESS | 29734 | _x_x_mozilla_cycle_collect,1173 03:50:45 INFO - PROCESS | 29734 | __end_cc_report 03:50:45 INFO - PROCESS | 29734 | __startTimestamp1475146245544__endTimestamp 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | ------- Summary: start ------- 03:50:45 INFO - PROCESS | 29734 | Number of tests: 6 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#0] dojo.html Cycles:165 Average:4585.37 Median:4705.98 stddev:477.87 (10.2%) stddev-sans-first:452.07 03:50:45 INFO - PROCESS | 29734 | Values: 2557.3 2581.9 2613.5 2620.1 2636.3 4538.0 4615.8 4671.2 4696.4 4700.9 4639.5 4664.3 4665.7 4694.4 4741.8 4227.7 4254.6 4300.2 4303.8 4317.1 4318.7 4333.2 4358.3 4367.5 4406.7 4174.6 4301.7 4301.9 4336.6 4404.7 4204.9 4264.8 4265.3 4318.1 4333.6 4281.9 4282.8 4286.4 4346.0 4352.5 4640.2 4667.2 4667.7 4680.8 4712.3 4788.3 4843.9 4852.4 4897.3 4942.5 4964.4 4966.2 4969.7 4979.2 5031.1 4613.7 4619.4 4626.3 4631.6 4683.6 5012.4 5071.5 5075.1 5086.2 5139.6 4892.9 4912.7 4920.2 4967.1 4974.6 5007.9 5015.3 5018.1 5024.0 5084.6 4819.6 4884.2 4939.5 4947.8 5018.9 4866.5 4896.0 4908.3 4911.5 4916.0 4117.2 4121.7 4122.7 4130.7 4151.9 3558.7 3629.1 3630.7 3682.9 3689.4 4256.0 4265.6 4289.3 4305.6 4322.5 4885.7 4923.8 4927.8 4940.5 4979.9 4189.2 4248.4 4251.0 4258.3 4311.4 4417.9 4421.6 4449.2 4450.2 4503.7 4706.0 4706.0 4709.9 4714.1 4772.0 4881.5 4977.9 4993.2 4994.0 5001.5 4644.0 4663.3 4677.8 4693.3 4746.5 4888.5 4897.1 4898.0 4904.1 4958.8 4955.8 4966.8 4967.4 4972.0 5027.8 4736.9 4785.1 4787.8 4822.6 4835.9 4843.4 4843.5 4844.5 4889.6 4907.4 4758.0 4765.0 4775.8 4777.7 4847.1 4714.2 4735.6 4757.1 4771.6 4846.8 4650.5 4651.0 4699.9 4705.6 4715.4 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#1] ext.html Cycles:180 Average:43384.80 Median:19624.36 stddev:76989.10 (392.3%) stddev-sans-first:77137.85 03:50:45 INFO - PROCESS | 29734 | Values: 534.3 559.6 570.5 579.7 588.8 28623.9 38602.6 39979.6 40024.6 44211.6 40256.4 40868.4 40875.6 40904.0 40913.0 7533.1 7678.8 7681.8 7682.5 7691.7 7301.4 7528.1 9691.7 9975.0 9991.4 10034.4 10141.8 10143.3 10145.6 10146.2 9917.4 9955.6 9977.4 9996.4 9996.8 9655.6 9733.3 9733.8 9740.2 9741.5 37680.6 38038.8 38074.2 38109.4 38139.8 2972.4 3168.4 3547.1 3555.1 3589.7 28743.3 28913.6 28984.7 29074.0 29363.6 3442.3 3573.5 3626.1 3635.3 3694.2 234526.0 234926.0 236204.0 236671.0 237711.0 30402.7 31744.8 49951.8 50285.0 50405.7 33355.5 33483.5 33493.8 33617.3 33662.2 12558.9 12676.7 12678.0 12683.5 12684.6 9600.1 9600.8 9609.9 9610.2 9911.8 7167.7 7448.3 7733.1 7734.8 7735.8 2984.0 3000.7 3025.2 3039.2 3050.0 804.9 865.2 887.8 912.8 954.5 26485.1 27117.2 27210.6 27865.0 28220.4 893.0 923.9 953.8 959.9 993.7 14148.4 15046.1 15062.5 15320.0 15382.5 361242.0 365755.0 366051.0 366465.0 366535.0 48282.5 48767.0 48773.5 48807.5 48837.5 1106.5 1128.9 1148.8 1164.9 1165.8 25974.5 27052.9 27246.8 27365.9 27761.3 41591.8 41900.6 41906.2 41932.6 41934.8 260170.0 260301.0 261237.0 261615.0 262366.0 22126.0 25027.7 25410.1 25447.9 25457.1 35091.8 35183.0 39537.4 43311.8 43378.0 35175.0 35189.6 35283.1 35546.0 36005.5 35055.6 35225.3 35507.0 35972.1 36135.5 34429.7 34587.5 35145.5 35311.8 35693.6 30899.2 32639.8 32749.0 33052.8 33341.5 24365.3 24933.3 25110.0 25128.7 25409.0 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#2] jquery.html Cycles:180 Average:22276.70 Median:27242.80 stddev:54671.56 (200.7%) stddev-sans-first:54800.11 03:50:45 INFO - PROCESS | 29734 | Values: 335.9 342.3 352.7 354.6 370.8 12371.3 15629.4 15955.4 16092.5 17194.8 15513.9 15947.4 15984.8 16079.1 16156.3 4910.4 4923.5 4982.6 5057.6 5126.4 3548.7 4927.9 5000.3 5005.3 5007.5 3742.9 4929.3 5120.8 5210.6 5215.1 5229.8 5287.1 5299.5 5304.3 5782.3 5111.0 5124.1 5126.6 5130.3 5133.1 19647.7 19860.0 19958.2 20064.9 20216.5 1749.9 1808.8 1826.7 1832.7 1876.3 8867.6 9092.9 9244.9 9309.4 9339.8 1612.5 1687.0 1717.6 1730.6 1743.9 64453.4 66142.7 67597.7 67806.3 69195.0 9161.8 9405.2 9446.0 9466.0 9625.8 12433.4 12535.1 12548.4 12555.6 12565.9 6272.6 6488.7 6672.4 6704.9 6712.0 6151.7 6215.5 6297.6 6363.0 6366.3 3782.0 3801.5 3846.6 3935.3 3984.0 1621.4 1651.6 1687.3 1719.3 1766.3 807.2 836.5 845.4 851.7 877.5 15594.5 16744.3 16883.3 16960.5 17156.8 810.5 833.8 836.3 847.7 876.8 8847.2 9004.6 9503.0 9549.1 9611.0 277674.0 283877.0 353341.0 354218.0 356567.0 80583.6 82214.0 82316.6 83229.6 83387.0 871.7 901.1 905.0 905.1 915.9 15267.8 15348.2 15531.8 15738.8 16185.5 34715.8 35198.6 35937.3 39117.2 40181.6 46325.0 49556.3 49988.0 50844.5 51348.0 7371.8 7377.2 7535.0 7574.5 7701.7 11694.1 11812.8 11821.6 11952.3 11996.8 9721.7 9931.9 10000.1 10178.1 10214.4 10015.2 10074.5 10139.3 10375.8 10451.9 9419.9 9883.3 10032.5 10362.8 10584.4 7109.0 7294.0 7523.7 7551.5 7677.3 8601.3 9663.4 10008.7 10253.7 10345.9 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#3] mootools.html Cycles:180 Average:5111.33 Median:5021.16 stddev:2941.91 (58.6%) stddev-sans-first:2935.78 03:50:45 INFO - PROCESS | 29734 | Values: 1239.8 1317.9 1350.5 1403.6 1647.1 6882.8 7676.2 7962.6 7980.2 8174.3 7950.8 8007.7 8022.7 8024.3 8026.7 2159.0 2184.6 2184.8 2188.4 2191.4 2157.3 2192.7 2200.7 2201.0 2207.7 2177.2 2187.9 2193.9 2196.0 2229.5 2177.3 2181.1 2181.6 2183.0 2185.8 2105.9 2151.5 2155.1 2155.1 2172.4 7675.6 7795.9 7951.6 7952.6 7959.1 4538.8 4711.7 4721.0 4726.3 4735.9 2855.8 2984.1 3037.5 3041.4 3042.8 936.4 949.9 963.3 964.4 974.1 10793.5 10881.2 10904.7 10909.2 10915.8 4020.5 4061.2 4156.5 4239.8 4256.6 8473.3 8522.4 8539.8 8550.9 8553.0 4622.2 4625.7 4627.3 4628.4 4629.6 3730.6 3854.8 3992.7 4313.5 4329.4 3299.5 3325.2 3465.1 3476.9 3490.8 978.3 1026.5 1028.5 1031.1 1033.1 748.4 773.1 783.4 789.9 796.2 4890.2 5010.7 5031.6 5074.3 5242.8 393.5 396.5 397.8 399.7 859.8 3312.6 3350.2 3377.4 3434.1 3604.9 9621.3 9904.8 9924.4 9949.6 10008.8 9918.4 9944.1 9946.3 9950.8 9957.3 7421.7 7427.9 7451.8 7561.2 7585.3 5090.7 5176.7 5228.0 5243.8 5255.4 8639.1 9009.8 9111.3 9115.9 9252.2 9039.8 9105.0 9287.6 9328.4 9406.8 5535.5 5716.3 6267.2 6440.5 6486.4 7005.9 7238.3 7262.2 7401.6 7421.5 6659.2 6801.4 6876.1 7056.6 7068.4 6722.5 6738.9 6887.1 6901.9 6933.3 6113.8 6178.2 6181.9 6190.4 6202.1 4399.5 4431.1 4460.2 4499.5 4559.0 4473.9 4486.8 4608.8 4618.6 4709.1 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#4] prototype.html Cycles:180 Average:4112.61 Median:4653.62 stddev:1201.21 (25.8%) stddev-sans-first:1169.90 03:50:45 INFO - PROCESS | 29734 | Values: 295.1 298.5 304.4 309.4 312.0 4777.7 4815.2 4837.8 4858.6 4892.9 4748.6 4753.5 4798.8 4803.1 4804.5 3809.2 3811.0 3817.3 3823.1 3835.1 3582.8 3813.9 3830.6 3832.3 3839.7 3730.0 3733.1 3751.3 3754.0 3778.4 3736.2 3737.8 3741.3 3749.3 3756.9 3094.3 3155.7 3202.6 3316.8 3323.3 4616.9 4648.3 4649.0 4658.3 4680.3 4244.1 4265.9 4266.6 4267.6 4285.7 4625.8 4675.9 4952.8 4986.9 4991.6 3591.9 3594.5 3601.8 3618.2 3621.8 5185.7 5185.9 5193.8 5199.2 5208.0 3586.6 3651.7 3708.6 3725.9 3735.6 3743.2 3751.6 3752.8 3764.4 3768.1 4243.6 4278.8 4282.3 4283.3 4291.7 4951.8 4954.9 4957.0 4973.8 4991.1 1242.5 1283.4 1296.5 1299.9 1301.4 830.5 839.2 854.2 856.1 865.6 3990.3 4004.2 4008.6 4011.4 4018.4 4539.0 4541.7 4554.0 4582.5 4585.6 3958.2 3968.2 3978.5 3980.5 3997.4 2341.5 2388.0 2397.5 2416.7 2445.5 4302.2 4615.7 4687.9 4738.0 4878.7 5294.0 5296.3 5306.4 5306.4 5313.7 4825.5 4853.9 4865.2 4900.5 4910.7 4897.9 5133.2 5158.7 5192.6 5204.2 5065.8 5069.8 5071.1 5076.8 5077.6 4714.4 4820.1 4837.9 4865.6 4883.6 3679.3 3691.1 3697.7 3705.8 3712.4 5146.6 5167.2 5196.0 5200.0 5203.4 5031.1 5031.9 5047.6 5048.2 5052.4 4866.2 4951.5 4956.0 4970.0 4990.0 4883.4 4884.7 4885.4 4895.6 4941.1 4928.5 5075.8 5077.2 5086.6 5088.4 4826.6 4830.8 4849.7 4866.0 4884.9 03:50:45 INFO - PROCESS | 29734 | 03:50:45 INFO - PROCESS | 29734 | [#5] yui.html Cycles:180 Average:17065.20 Median:44088.06 stddev:24578.00 (55.7%) stddev-sans-first:24616.05 03:50:45 INFO - PROCESS | 29734 | Values: 652.5 662.5 694.8 722.8 750.8 12425.4 13521.7 13523.0 13523.5 13527.1 12474.5 12498.6 12503.1 12511.8 12630.0 606.7 626.3 749.3 767.6 778.3 760.1 762.9 764.5 767.8 767.8 810.2 810.5 811.8 811.8 812.2 645.2 665.6 771.6 793.7 797.1 584.9 585.8 586.1 586.3 586.3 12798.2 12801.9 12832.0 12834.6 12844.2 12466.0 12705.2 12901.2 13026.3 13319.7 11673.8 11727.6 11829.5 11854.5 12227.7 3978.1 3986.2 3986.5 4008.8 4046.7 56158.4 58813.4 59454.7 59796.8 60081.0 10180.6 10373.3 10382.3 10448.2 10583.5 18150.7 18180.7 18234.7 18258.4 18260.3 6980.2 7019.9 7031.4 7111.2 7165.6 3751.3 3776.8 3805.5 3840.8 3881.1 2889.3 2995.2 3017.5 3043.5 3043.9 530.0 532.8 533.7 546.4 565.5 471.4 478.0 523.0 547.5 563.9 6877.7 6969.4 7281.0 7416.0 7624.2 514.9 557.7 564.9 570.2 578.2 3633.8 3688.0 3738.1 3745.7 3852.5 103149.0 103228.5 103980.0 105280.0 105514.5 67662.3 75222.0 80185.6 87067.1 88184.7 42703.0 55536.4 65817.7 70996.6 71772.0 7584.8 7700.8 7767.1 7802.1 7894.1 36734.8 36773.4 42838.4 43533.3 44642.8 58178.0 59047.0 59515.4 59730.4 60004.0 11053.2 11322.7 11390.0 11606.1 12158.6 10514.0 10635.8 10658.2 11106.2 11193.2 11485.5 11613.2 11747.8 12134.2 12667.7 10887.2 11171.8 11557.8 11653.1 11683.8 10349.5 10381.6 10829.7 11089.1 11528.9 8886.9 8959.4 9398.2 9483.7 9560.6 9324.3 9814.8 9859.6 9882.9 10005.8 03:50:45 INFO - PROCESS | 29734 | -------- Summary: end -------- 03:50:45 INFO - PROCESS | 29734 | 03:50:46 INFO - TEST-INFO | 29734: exit 0 03:50:46 INFO - TEST-OK | dromaeo_css | took 1120816ms 03:50:46 INFO - TEST-START | kraken 03:50:46 INFO - operating with platform_type : linux_ 03:50:46 INFO - Initialising browser for kraken test... 03:50:46 INFO - TEST-INFO | started process 30038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOGyxhw/profile http://localhost:43798/getInfo.html) 03:50:50 INFO - PROCESS | 30038 | __metrics Screen width/height:1600/1200 03:50:50 INFO - PROCESS | 30038 | colorDepth:24 03:50:50 INFO - PROCESS | 30038 | Browser inner width/height: 1024/697 03:50:50 INFO - PROCESS | 30038 | __metrics 03:50:51 INFO - PROCESS | 30038 | 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" 03:50:51 INFO - PROCESS | 30038 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:51 INFO - PROCESS | 30038 | console.error: PushService: 03:50:51 INFO - PROCESS | 30038 | stateChangeProcessEnqueue: Error transitioning state 03:50:51 INFO - PROCESS | 30038 | UnknownError 03:50:52 INFO - TEST-INFO | 30038: exit 0 03:50:52 INFO - Browser initialized. 03:50:52 INFO - Running cycle 1/1 for kraken test... 03:50:52 INFO - TEST-INFO | started process 30121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOGyxhw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:04 INFO - PROCESS | 30121 | RSS: Main: 174878720 03:51:04 INFO - PROCESS | 30121 | 03:51:07 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43798/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:08 INFO - PROCESS | 30121 | RSS: Main: 232939520 03:51:08 INFO - PROCESS | 30121 | 03:51:11 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43798/tests/kraken/driver.html?testName=audio-dft) 03:51:12 INFO - PROCESS | 30121 | RSS: Main: 218066944 03:51:12 INFO - PROCESS | 30121 | 03:51:15 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43798/tests/kraken/driver.html?testName=audio-fft) 03:51:15 INFO - PROCESS | 30121 | RSS: Main: 300109824 03:51:15 INFO - PROCESS | 30121 | 03:51:18 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43798/tests/kraken/driver.html?testName=audio-oscillator) 03:51:18 INFO - PROCESS | 30121 | RSS: Main: 209743872 03:51:18 INFO - PROCESS | 30121 | 03:51:20 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:21 INFO - PROCESS | 30121 | RSS: Main: 213520384 03:51:21 INFO - PROCESS | 30121 | 03:51:24 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43798/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:25 INFO - PROCESS | 30121 | RSS: Main: 250155008 03:51:25 INFO - PROCESS | 30121 | 03:51:28 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43798/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:29 INFO - PROCESS | 30121 | RSS: Main: 244076544 03:51:29 INFO - PROCESS | 30121 | 03:51:32 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43798/tests/kraken/driver.html?testName=json-parse-financial) 03:51:32 INFO - PROCESS | 30121 | RSS: Main: 246960128 03:51:32 INFO - PROCESS | 30121 | 03:51:34 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:35 INFO - PROCESS | 30121 | RSS: Main: 210350080 03:51:35 INFO - PROCESS | 30121 | 03:51:37 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:37 INFO - PROCESS | 30121 | RSS: Main: 218603520 03:51:37 INFO - PROCESS | 30121 | 03:51:39 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:40 INFO - PROCESS | 30121 | RSS: Main: 222777344 03:51:40 INFO - PROCESS | 30121 | 03:51:43 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:44 INFO - PROCESS | 30121 | RSS: Main: 223387648 03:51:44 INFO - PROCESS | 30121 | 03:51:47 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:47 INFO - PROCESS | 30121 | RSS: Main: 221831168 03:51:47 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:43798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43798/tests/kraken/driver.html?testName=ai-astar) 03:51:49 INFO - PROCESS | 30121 | RSS: Main: 271892480 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | __start_tp_report 03:51:49 INFO - PROCESS | 30121 | _x_x_mozilla_page_load 03:51:49 INFO - PROCESS | 30121 | _x_x_mozilla_page_load_details 03:51:49 INFO - PROCESS | 30121 | |i|pagename|runs| 03:51:49 INFO - PROCESS | 30121 | |0;ai-astar;112;112;113;116;114;114;113;114;113;113 03:51:49 INFO - PROCESS | 30121 | |1;audio-beat-detection;162;122;123;169;124;127;124;128;159;124 03:51:49 INFO - PROCESS | 30121 | |2;audio-dft;161;161;162;162;162;163;162;161;162;160 03:51:49 INFO - PROCESS | 30121 | |3;audio-fft;77;76;77;113;77;77;77;76;116;77 03:51:49 INFO - PROCESS | 30121 | |4;audio-oscillator;84;84;118;86;85;86;107;84;84;115 03:51:49 INFO - PROCESS | 30121 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:51:49 INFO - PROCESS | 30121 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;147;147 03:51:49 INFO - PROCESS | 30121 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;94 03:51:49 INFO - PROCESS | 30121 | |8;json-parse-financial;65;63;64;63;65;64;64;64;64;64 03:51:49 INFO - PROCESS | 30121 | |9;json-stringify-tinderbox;67;67;67;67;67;67;69;67;66;68 03:51:49 INFO - PROCESS | 30121 | |10;stanford-crypto-aes;83;82;83;84;84;83;83;83;82;82 03:51:49 INFO - PROCESS | 30121 | |11;stanford-crypto-ccm;136;142;137;134;137;135;133;131;170;143 03:51:49 INFO - PROCESS | 30121 | |12;stanford-crypto-pbkdf2;172;176;173;173;172;173;173;170;172;173 03:51:49 INFO - PROCESS | 30121 | |13;stanford-crypto-sha256-iterative;68;69;70;69;69;68;69;69;68;68 03:51:49 INFO - PROCESS | 30121 | __end_tp_report 03:51:49 INFO - PROCESS | 30121 | __start_cc_report 03:51:49 INFO - PROCESS | 30121 | _x_x_mozilla_cycle_collect,1932 03:51:49 INFO - PROCESS | 30121 | __end_cc_report 03:51:49 INFO - PROCESS | 30121 | __startTimestamp1475146309700__endTimestamp 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | ------- Summary: start ------- 03:51:49 INFO - PROCESS | 30121 | Number of tests: 14 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:1.17 (1.0%) stddev-sans-first:1.13 03:51:49 INFO - PROCESS | 30121 | Values: 112.0 112.0 113.0 116.0 114.0 114.0 113.0 114.0 113.0 113.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:127.50 stddev:18.96 (14.9%) stddev-sans-first:17.66 03:51:49 INFO - PROCESS | 30121 | Values: 162.0 122.0 123.0 169.0 124.0 127.0 124.0 128.0 159.0 124.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 03:51:49 INFO - PROCESS | 30121 | Values: 161.0 161.0 162.0 162.0 162.0 163.0 162.0 161.0 162.0 160.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#3] audio-fft Cycles:10 Average:84.30 Median:77.00 stddev:15.94 (20.7%) stddev-sans-first:16.68 03:51:49 INFO - PROCESS | 30121 | Values: 77.0 76.0 77.0 113.0 77.0 77.0 77.0 76.0 116.0 77.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:14.10 (16.8%) stddev-sans-first:14.55 03:51:49 INFO - PROCESS | 30121 | Values: 84.0 84.0 118.0 86.0 85.0 86.0 107.0 84.0 84.0 115.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:51:49 INFO - PROCESS | 30121 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:51:49 INFO - PROCESS | 30121 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:51:49 INFO - PROCESS | 30121 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 03:51:49 INFO - PROCESS | 30121 | Values: 65.0 63.0 64.0 63.0 65.0 64.0 64.0 64.0 64.0 64.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:51:49 INFO - PROCESS | 30121 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 69.0 67.0 66.0 68.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 03:51:49 INFO - PROCESS | 30121 | Values: 83.0 82.0 83.0 84.0 84.0 83.0 83.0 83.0 82.0 82.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:137.00 stddev:11.24 (8.2%) stddev-sans-first:11.84 03:51:49 INFO - PROCESS | 30121 | Values: 136.0 142.0 137.0 134.0 137.0 135.0 133.0 131.0 170.0 143.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 03:51:49 INFO - PROCESS | 30121 | Values: 172.0 176.0 173.0 173.0 172.0 173.0 173.0 170.0 172.0 173.0 03:51:49 INFO - PROCESS | 30121 | 03:51:49 INFO - PROCESS | 30121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 03:51:49 INFO - PROCESS | 30121 | Values: 68.0 69.0 70.0 69.0 69.0 68.0 69.0 69.0 68.0 68.0 03:51:49 INFO - PROCESS | 30121 | -------- Summary: end -------- 03:51:49 INFO - PROCESS | 30121 | 03:51:50 INFO - TEST-INFO | 30121: exit 0 03:51:51 INFO - TEST-OK | kraken | took 64496ms 03:51:51 INFO - SUITE-END | took 1185s 03:51:51 INFO - Completed test suite (00:19:45) 03:51:51 INFO - javascript benchmark 03:51:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.322309587959, 2581.9354516137105, 2613.4642398308347, 2620.0829709601644, 2636.327736427212, 4537.978954735191, 4615.769211539427, 4671.182543054964, 4696.436427628681, 4700.929486057707, 4639.512851150631, 4664.300354946759, 4665.720056796595, 4694.366260554824, 4741.786619602118, 4227.6617870570435, 4254.553271906451, 4300.161468513626, 4303.827846886136, 4317.13657268546, 4318.719283246579, 4333.2416827055295, 4358.2808836541935, 4367.541408152146, 4406.735595864242, 4174.5616710245595, 4301.677374196916, 4301.870943871689, 4336.63138633215, 4404.69167158299, 4204.915901681949, 4264.808083636212, 4265.33887247474, 4318.1363727254675, 4333.58830911063, 4281.850135245251, 4282.785860706983, 4286.442762440894, 4345.978270108661, 4352.521222665504, 4640.187967105743, 4667.15991121598, 4667.696599721007, 4680.765961701935, 4712.340272361872, 4788.257820037899, 4843.927341089851, 4852.441969173555, 4897.33885925399, 4942.456329803718, 4964.361760618987, 4966.15575352191, 4969.652124351297, 4979.228219625964, 5031.069252188357, 4613.654906174766, 4619.376384188159, 4626.282926146453, 4631.560001799824, 4683.555062269079, 5012.373453318335, 5071.543561079447, 5075.111855425286, 5086.21163719624, 5139.640225184276, 4892.902141957141, 4912.656114072052, 4920.163572192736, 4967.05625931072, 4974.552290293891, 5007.899842003139, 5015.297858299841, 5018.071656743441, 5024.020316038411, 5084.593232541388, 4819.614430845524, 4884.1941079722155, 4939.48135445773, 4947.777350019258, 5018.924716129261, 4866.46468888422, 4896.020795840846, 4908.337374454474, 4911.45973942866, 4916.041371932511, 4117.155983023473, 4121.670266378683, 4122.711410201317, 4130.690198235145, 4151.8546850860075, 3558.733095017884, 3629.1471504196493, 3630.6913912317223, 3682.926341473209, 3689.446583012516, 4256.042390462121, 4265.637420819203, 4289.335153051282, 4305.634021108241, 4322.524522302544, 4885.682430641997, 4923.753812309442, 4927.802887884516, 4940.481249468754, 4979.900401992012, 4189.2459357315975, 4248.4477017987465, 4250.957490425118, 4258.276093064186, 4311.4395128633705, 4417.889552761207, 4421.579949904753, 4449.154660614473, 4450.221211288012, 4503.729776213438, 4705.976470117627, 4705.976470117627, 4709.858704238878, 4714.080754252887, 4772.0217355442055, 4881.51184881509, 4977.925331120108, 4993.201087826075, 4993.975030124826, 5001.474845141353, 4643.953560464487, 4663.253879379283, 4677.789499472464, 4693.272542755878, 4746.501617330268, 4888.462269150462, 4897.094037603055, 4898.044881248123, 4904.141775189399, 4958.752062396938, 4955.8017679292425, 4966.826161084345, 4967.393366822046, 4972.0, 5027.798888044437, 4736.905261894812, 4785.066911952136, 4787.832425865078, 4822.614190864792, 4835.927461088017, 4843.370361852936, 4843.46721860588, 4844.46710861812, 4889.559939605452, 4907.386576677915, 4757.952420475751, 4765.046990601824, 4775.8328458505175, 4777.689450185727, 4847.079054979543, 4714.22215334466, 4735.550122738335, 4757.119932812441, 4771.618270538418, 4846.781894814812, 4650.511696271843, 4650.953490465052, 4699.859004229878, 4705.55297246761, 4715.3869996900185], "value": 4554.924825323266, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3000669123448, 559.5831105826159, 570.5350139636196, 579.7014537513181, 588.8292395205391, 28623.856880715593, 38602.61397386025, 39979.60020399799, 40024.599754002455, 44211.55788442115, 40256.39615405764, 40868.38697419534, 40875.59124408755, 40904.0, 40912.97717557055, 7533.05836770405, 7678.808029799244, 7681.769546913573, 7682.5006374585755, 7691.692332306701, 7301.415886729049, 7528.096628404599, 9691.660791872286, 9975.0, 9991.400515969066, 10034.448105354202, 10141.797164056714, 10143.340682855627, 10145.594176232942, 10146.239032072586, 9917.404955702681, 9955.55200016001, 9977.401355918668, 9996.350237234592, 9996.750081248027, 9655.565499552536, 9733.270004749602, 9733.756656083584, 9740.220782337396, 9741.464219467927, 37680.623193767984, 38038.80980595107, 38074.23851522954, 38109.428358574645, 38139.80930095332, 2972.4203780262856, 3168.358146674418, 3547.0954906498678, 3555.075680323109, 3589.73077019222, 28743.28141796451, 28913.56629650557, 28984.710152898413, 29074.0, 29363.55954660682, 3442.2599141184764, 3573.4997100405963, 3626.1478552540134, 3635.272945410902, 3694.2057457646465, 234526.0, 234926.0, 236204.0, 236671.0, 237711.0, 30402.695973039987, 31744.841275793475, 49951.75024124856, 50285.0, 50405.73174207169, 33355.499667505006, 33483.49774753381, 33493.83253083768, 33617.327653446795, 33662.158446039044, 12558.937205313914, 12676.746465070832, 12678.0, 12683.492660293485, 12684.556040538537, 9600.087991640783, 9600.807983840285, 9609.9039009609, 9610.231181505464, 9911.752206194902, 7167.749128780468, 7448.292412220831, 7733.110692270348, 7734.7679569613, 7735.806604834812, 2983.9552406713915, 3000.6699263081046, 3025.183200535843, 3039.2249976256358, 3049.9542506862413, 804.9074356449083, 865.1694373401605, 887.7603047177226, 912.8128733609727, 954.465499320369, 26485.073022444507, 27117.186484405498, 27210.591841122397, 27865.0, 28220.43559128806, 892.9553522323857, 923.8752768376318, 953.756792018031, 959.9136077753036, 993.6720882108887, 14148.434062637585, 15046.141233165663, 15062.472813451695, 15320.0, 15382.53852384408, 361242.0, 365755.0, 366051.0, 366465.0, 366535.0, 48282.51717482851, 48767.0, 48773.51226487761, 48807.51192488101, 48837.53487395384, 1106.5131342209563, 1128.943552822372, 1148.8161894097072, 1164.85439320085, 1165.84843970285, 25974.480510390065, 27052.864735676194, 27246.803056347875, 27365.86317068402, 27761.305967350978, 41591.792041039604, 41900.580994189666, 41906.16187676168, 41932.58067419409, 41934.790326048176, 260170.0, 260301.0, 261237.0, 261615.0, 262366.0, 22126.0, 25027.74528330152, 25410.110646127298, 25447.87276063682, 25457.10900118487, 35091.82454087713, 35183.0, 39537.38058736268, 43311.783441082596, 43378.0, 35175.0, 35189.64810351864, 35283.11792205215, 35546.0, 36005.45991810073, 35055.64944350524, 35225.29549408946, 35507.0, 35972.10069748173, 36135.45796813103, 34429.65570344365, 34587.4811877817, 35145.47281790724, 35311.82344088263, 35693.64306357007, 30899.227519312197, 32639.836800815843, 32749.0, 33052.83473582617, 33341.49987750234, 24365.2741605719, 24933.252002439956, 25110.0, 25128.748712513374, 25409.0], "value": 16394.955676905993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.8975512468696, 342.3204938197679, 352.74954782104703, 354.6418117701121, 370.823858667133, 12371.319577423239, 15629.374825007, 15955.441559545417, 16092.517224483256, 17194.82805171951, 15513.92243038786, 15947.441839535619, 15984.76022859658, 16079.11564863935, 16156.272967716452, 4910.435299940508, 4923.53152577566, 4982.551570358667, 5057.5701065409485, 5126.359205099363, 3548.6628770266784, 4927.926081108786, 5000.299958005882, 5005.324281222025, 5007.524285192901, 3742.9251414971686, 4929.33453983713, 5120.795168193286, 5210.609204309673, 5215.061288967984, 5229.76714538973, 5287.127623942064, 5299.496547827931, 5304.283921670563, 5782.306123265193, 5111.028904508132, 5124.052050370656, 5126.615503837227, 5130.256112863651, 5133.0503856786245, 19647.705284420746, 19860.0, 19958.201671933104, 20064.899675501674, 20216.49458763528, 1749.8950062996262, 1808.7739032620923, 1826.6985947318676, 1832.6517961587256, 1876.2963888541797, 8867.55662216893, 9092.909070909272, 9244.8613270801, 9309.441433513943, 9339.813203735956, 1612.46788559775, 1686.983130168695, 1717.5696389608688, 1730.56735816046, 1743.9215235314314, 64453.3554664452, 66142.66928665373, 67597.66201168962, 67806.321936781, 69195.0, 9161.77095572616, 9405.247580193705, 9446.0, 9466.0, 9625.759356016015, 12433.37833108341, 12535.122541422195, 12548.435320410603, 12555.623331300076, 12565.93717031409, 6272.560920735505, 6488.67556622167, 6672.399484046459, 6704.899426508607, 6711.966440167866, 6151.72317245716, 6215.502759779207, 6297.622142671363, 6363.0, 6366.299707032223, 3781.962180378161, 3801.486799282117, 3846.6345697158727, 3935.2916475034194, 3983.960160398417, 1621.4162901355503, 1651.6283836136772, 1687.3166367621134, 1719.2950890134985, 1766.3376233912284, 807.172648035768, 836.5231817863881, 845.4293351987384, 851.714675583674, 877.4603618774407, 15594.454194103151, 16744.330226791037, 16883.32466701343, 16960.491185264462, 17156.828431715774, 810.4569938141342, 833.8332333533317, 836.2933321343455, 847.6609356257546, 876.8342194779013, 8847.203751662253, 9004.59479323432, 9503.0, 9549.140577347933, 9611.0, 277674.0, 283877.0, 353341.0, 354218.0, 356567.0, 80583.59708201421, 82214.0, 82316.58841705753, 83229.58385208035, 83387.0, 871.7384784564605, 901.0944001278673, 904.9547522623974, 905.1310741688053, 915.9313051521162, 15267.847321527086, 15348.155851427831, 15531.76702349443, 15738.842611573738, 16185.51443456651, 34715.826420867736, 35198.64801351954, 35937.28125437529, 39117.217655646156, 40181.598184018956, 46325.0, 49556.25665615091, 49988.0, 50844.49155508546, 51348.0, 7371.8157046074275, 7377.151627562899, 7535.0, 7574.469787114849, 7701.730439434593, 11694.122940779305, 11812.763744724885, 11821.586244481401, 11952.342621155572, 11996.820047699466, 9721.70834874955, 9931.900680993387, 10000.149987251165, 10178.083972442515, 10214.387136771817, 10015.24885633595, 10074.496275186359, 10139.340942838691, 10375.792484150426, 10451.895481045092, 9419.905800942177, 9883.258755593502, 10032.548535316075, 10362.792744145225, 10584.364938103738, 7108.964455177691, 7293.9635301823155, 7523.699052037857, 7551.509151905108, 7677.347425468898, 8601.311895048257, 9663.371880827724, 10008.699739007841, 10253.74365640865, 10345.896541034494], "value": 7853.068689635143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.838820953276, 1317.907746457748, 1350.534065747317, 1403.6350548857295, 1647.0940982459645, 6882.827929301764, 7676.193999630035, 7962.601869906496, 7980.204453997848, 8174.305184059363, 7950.801229969254, 8007.67969281228, 8022.67909283628, 8024.277814996649, 8026.678932842694, 2159.0, 2184.6067707812585, 2184.8361372897016, 2188.4310079379397, 2191.41927389242, 2157.331227319536, 2192.6930229767845, 2200.680901269315, 2201.020545857094, 2207.7461091974387, 2177.1617927098023, 2187.862311597968, 2193.890305484719, 2196.033745152128, 2229.487217939875, 2177.281497105951, 2181.149351752818, 2181.596404665142, 2182.9563408731738, 2185.8142057925097, 2105.9368218953455, 2151.4943988162768, 2155.073318473056, 2155.137944822068, 2172.3808714516445, 7675.616219189074, 7795.9220407795765, 7951.602419878983, 7952.642131104114, 7959.124496305401, 4538.818447262105, 4711.740854253015, 4721.032188401369, 4726.291056341542, 4735.928961065587, 2855.81437206583, 2984.1346009657173, 3037.4532584134845, 3041.4373340931998, 3042.7870049096573, 936.3773090894547, 949.886013678363, 963.2967933408581, 964.4165280005636, 974.0503009565688, 10793.514291856807, 10881.183911206612, 10904.727381815439, 10909.23635345526, 10915.781684366348, 4020.4773379461067, 4061.248668996245, 4156.459660244149, 4239.788010599457, 4256.59562341577, 8473.322134229247, 8522.403431759718, 8539.82920341602, 8550.914490855137, 8552.95723521391, 4622.214223581932, 4625.7455839929125, 4627.282771170474, 4628.421447319085, 4629.629629629621, 3730.645588669072, 3854.8265328060306, 3992.740471869319, 4313.547077556811, 4329.372241025034, 3299.5215693724276, 3325.235195904907, 3465.0990742407157, 3476.860925562949, 3490.808005559719, 978.2516374973151, 1026.4508487958906, 1028.5011769292037, 1031.097789434245, 1033.075397519216, 748.4124961904879, 773.0916173496232, 783.4398405140352, 789.8815177723272, 796.1918652567648, 4890.16618767962, 5010.749462526859, 5031.572316353151, 5074.314967479417, 5242.816501422432, 393.50221969208974, 396.50040948404643, 397.75538044103246, 399.71021009767685, 859.7979474823411, 3312.6252605169066, 3350.246194606194, 3377.4427219509, 3434.0899661589697, 3604.873829415958, 9621.326507144433, 9904.752381190383, 9924.354916930377, 9949.55227014786, 10008.799824003625, 9918.355306905029, 9944.055314745232, 9946.303758736818, 9950.80098398028, 9957.302988790716, 7421.703131874772, 7427.925720742724, 7451.844964030584, 7561.168271490242, 7585.279398457138, 5090.745462726923, 5176.741162941913, 5228.032813929435, 5243.764030618555, 5255.369355677343, 8639.092895245909, 9009.828722266064, 9111.316651251314, 9115.863262050942, 9252.213561847318, 9039.819203616022, 9105.0, 9287.582058807235, 9328.440293582407, 9406.811863762823, 5535.474129957809, 5716.342620598684, 6267.185265915402, 6440.484761218998, 6486.383793539606, 7005.929940700527, 7238.312360325761, 7262.237465066092, 7401.555906645403, 7421.480496365202, 6659.188150854323, 6801.421879140328, 6876.106106206161, 7056.576605403692, 7068.399186069036, 6722.495812813961, 6738.898916516158, 6887.104676392037, 6901.861962760817, 6933.341332573397, 6113.84715382119, 6178.227721534809, 6181.938180618136, 6190.380961903774, 6202.100695399052, 4399.450068741407, 4431.135928494042, 4460.174867649495, 4499.5275496073755, 4559.0, 4473.910521789611, 4486.75322857246, 4608.838690645811, 4618.584327410549, 4709.128811169944], "value": 4030.746569386965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.0617037819733, 298.4538294920296, 304.3562864541495, 309.3905007135943, 312.0155908109914, 4777.665563410558, 4815.157347464188, 4837.790552361909, 4858.611311095113, 4892.948016176521, 4748.5726284634375, 4753.4533528644215, 4798.7600619969035, 4803.111424386491, 4804.5435683610085, 3809.1810260793923, 3811.028187812104, 3817.2747178036225, 3823.1397935464574, 3835.137094153821, 3582.785032898021, 3813.8665146719873, 3830.559485659157, 3832.2910261601555, 3839.7120215983773, 3729.981350093259, 3733.0667333166707, 3751.3060083884434, 3754.0, 3778.4143457763953, 3736.23407201523, 3737.7570457920147, 3741.3265612189794, 3749.268892565951, 3756.924861502768, 3094.313599088502, 3155.700208480214, 3202.6316973548105, 3316.8009919404913, 3323.285493618859, 4616.930746038812, 4648.279516674921, 4648.976755116237, 4658.254679251304, 4680.3447517347595, 4244.108737165199, 4265.850695225652, 4266.552012038722, 4267.551907049778, 4285.721428107163, 4625.791839367236, 4675.929861052087, 4952.826651067196, 4986.8805757553255, 4991.550760431543, 3591.8742844000335, 3594.4967704521387, 3601.7658852174527, 3618.203995121069, 3621.8189090545366, 5185.714785686786, 5185.896282074337, 5193.818216362447, 5199.194124910683, 5207.953347291839, 3586.5696116466193, 3651.744377893575, 3708.647678470541, 3725.9441108383394, 3735.5704094029534, 3743.21392507571, 3751.630654810974, 3752.7615886757303, 3764.378877485239, 3768.1144930941205, 4243.639290660329, 4278.764667943293, 4282.293421585466, 4283.31466965284, 4291.699581029298, 4951.801927922915, 4954.925676114861, 4956.975215123974, 4973.8010479581135, 4991.101601711727, 1242.5029988004871, 1283.4224598930518, 1296.500847173845, 1299.8635143310005, 1301.4122770220315, 830.4892491117919, 839.1692224697506, 854.1629203380721, 856.0540602634125, 865.5715420866711, 3990.2817492850986, 4004.2191772604065, 4008.5569195089743, 4011.4154908810856, 4018.4374187613757, 4539.0, 4541.68208225421, 4553.954460455419, 4582.510684027704, 4585.592563903977, 3958.247932892741, 3968.226195891831, 3978.5424676162033, 3980.482537270136, 3997.400389941532, 2341.5433990372053, 2387.9880600596885, 2397.532481166191, 2416.7220769611367, 2445.4986727720775, 4302.182585308781, 4615.653825963066, 4687.882802929954, 4737.976310118427, 4878.682625752739, 5294.047071527085, 5296.285001524822, 5306.389765177054, 5306.416294207634, 5313.698143954756, 4825.541573550507, 4853.854384368546, 4865.197242455026, 4900.485449027872, 4910.680805747615, 4897.877553061059, 5133.204353325241, 5158.716270605153, 5192.610554208374, 5204.193350030751, 5065.822696205615, 5069.847904562869, 5071.084126627278, 5076.796928122833, 5077.568406685473, 4714.434267887876, 4820.108279968217, 4837.887285924327, 4865.56209941107, 4883.560479556857, 3679.3377192105677, 3691.132583842741, 3697.7041836652465, 3705.758570878678, 3712.406015037581, 5146.639735218499, 5167.173252279617, 5196.038732834287, 5200.0, 5203.427622961547, 5031.144705400017, 5031.874203144951, 5047.646664733434, 5048.242763585492, 5052.368453943257, 4866.221404575251, 4951.455339912534, 4956.033573453142, 4969.981153863521, 4989.950100498949, 4883.438404583519, 4884.65807393479, 4885.387822018796, 4895.583875370491, 4941.110600092018, 4928.482509336612, 5075.77159027852, 5077.238414237894, 5086.567641750345, 5088.397154896196, 4826.613870890391, 4830.806767729251, 4849.709017458823, 4866.0, 4884.90230195387], "value": 3734.4804750601356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4584594786328, 662.5130529061139, 694.8297667071569, 722.7614887087261, 750.774767569729, 12425.440855161516, 13521.729565408687, 13523.0, 13523.459061637535, 13527.053106282565, 12474.501019959214, 12498.56255031074, 12503.124781265315, 12511.812322815142, 12630.0, 606.7209083821448, 626.3329554024972, 749.3068911257093, 767.6161919040479, 778.2878666020584, 760.0651199025202, 762.8970089037992, 764.4534158076974, 767.7850201943437, 767.8157242261844, 810.1574362662853, 810.5420437452821, 811.8213992921548, 811.8213992921577, 812.2283830361151, 645.2031740800131, 665.6472069803012, 771.6141929035482, 793.7182300283432, 797.131127071489, 584.8917950179188, 585.8271809816115, 586.1354502109397, 586.302300262686, 586.3432955090326, 12798.232106073665, 12801.93599031999, 12832.0, 12834.614961551168, 12844.229346239255, 12466.002719782486, 12705.174163679423, 12901.161424507378, 13026.348682565835, 13319.667008324772, 11673.76652466946, 11727.589534366256, 11829.52681892732, 11854.466549005316, 12227.69430764229, 3978.1049263915675, 3986.202759448122, 3986.54154772202, 4008.7995600219874, 4046.6964977626794, 56158.43841561614, 58813.41186588122, 59454.70272648609, 59796.80406391891, 60081.0, 10180.592776289013, 10373.325733827278, 10382.273240873066, 10448.164146868232, 10583.470826458646, 18150.727739083923, 18180.727289090675, 18234.726479102825, 18258.36095736643, 18260.26958921628, 6980.162380514371, 7019.89470157948, 7031.437485001187, 7111.182214045451, 7165.605891676008, 3751.268502642013, 3776.8300426480873, 3805.46723458716, 3840.7503512272174, 3881.107345310594, 2889.2921234297733, 2995.2362147652643, 3017.4870272053804, 3043.46739320618, 3043.893463728759, 529.9788008479695, 532.7842223899327, 533.703794394115, 546.4289817141097, 565.4854082784647, 471.42250742839747, 477.9880502987453, 522.9660072095302, 547.460751160107, 563.937966823649, 6877.65611719412, 6969.407600354027, 7281.0, 7416.035915330973, 7624.19945905683, 514.8758444856651, 557.6540755467197, 564.890707003753, 570.1789423230534, 578.2020811280406, 3633.800140992218, 3688.041109311598, 3738.140227747579, 3745.7077308328585, 3852.5376954765607, 103148.98041823166, 103228.48385758023, 103980.0, 105280.0, 105514.47242763737, 67662.32337676658, 75222.0, 80185.59907200426, 87067.12932870591, 88184.6772298416, 42703.0, 55536.444635553125, 65817.67091164514, 70996.64501677561, 71772.0, 7584.772456826304, 7700.807479813049, 7767.067951845815, 7802.063752349754, 7894.092179399443, 36734.8163259182, 36773.44839827458, 42838.35742463803, 43533.34699979566, 44642.776786115865, 58178.0, 59047.0, 59515.40484595099, 59730.40269597249, 60004.0, 11053.171012173958, 11322.660320190407, 11390.0, 11606.12954028468, 12158.574449894211, 10514.0, 10635.787284254426, 10658.200634952565, 11106.167037472384, 11193.216474846682, 11485.48315325829, 11613.187076904873, 11747.823782643438, 12134.211276267015, 12667.746645066863, 10887.18346124028, 11171.776564468828, 11557.768844623228, 11653.126015548698, 11683.766324673288, 10349.482525873827, 10381.584736610452, 10829.729256768644, 11089.112870970464, 11528.942355288169, 8886.86669699968, 8959.41763785352, 9398.20115290208, 9483.66807161746, 9560.613711012003, 9324.347295689508, 9814.75463113428, 9859.618337354581, 9882.851757223503, 10005.799884002425], "value": 6398.357521277858, "unit": "score"}], "name": "dromaeo_css", "value": 6194.323779461908, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 116.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 122.0, 123.0, 169.0, 124.0, 127.0, 124.0, 128.0, 159.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 113.0, 77.0, 77.0, 77.0, 76.0, 116.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 86.0, 85.0, 86.0, 107.0, 84.0, 84.0, 115.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 67.0, 66.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 84.0, 83.0, 83.0, 83.0, 82.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 137.0, 134.0, 137.0, 135.0, 133.0, 131.0, 170.0, 143.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 173.0, 173.0, 172.0, 173.0, 173.0, 170.0, 172.0, 173.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1542.4, "alertThreshold": 2.0}]} 03:51:51 INFO - Return code: 0 03:51:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:51 INFO - # TBPL SUCCESS # 03:51:51 INFO - Running post-action listener: _resource_record_post_action 03:51:51 INFO - [mozharness: 2016-09-29 10:51:51.490078Z] Finished run-tests step (success) 03:51:51 INFO - Running post-run listener: _resource_record_post_run 03:51:51 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392585216; Read time: 24; Write time: 226624 03:51:51 INFO - TinderboxPrint: CPU usage
13.0% 03:51:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 03:51:51 INFO - TinderboxPrint: I/O write bytes / time
392,585,216 / 226,624 03:51:51 INFO - TinderboxPrint: CPU idle
8,340.3 (87.0%) 03:51:51 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 03:51:51 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99778560; Read time: 0; Write time: 75308 03:51:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292806656; Read time: 0; Write time: 151316 03:51:52 INFO - Running post-run listener: _upload_blobber_files 03:51:52 INFO - Blob upload gear active. 03:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:52 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 03:51:52 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:52 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:54 INFO - (blobuploader) - INFO - Done attempting. 03:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:57 INFO - (blobuploader) - INFO - Done attempting. 03:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:58 INFO - (blobuploader) - INFO - Done attempting. 03:51:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:58 INFO - Return code: 0 03:51:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f11f82a3e248d301affa6775c8abe347e6cb08837ead1491c33b3f625bccb54c56b2d5538ccfc65b5fb8b820d2ee4296f696fc221d4200833ccd4106cc8d3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5367e0068ee737ca205aed2ba90f0ce83d4094fa27942b24b2f920706db926c496898b207822a9886bf01389f5c7a86180f8c3c73db787b4b2843dec714c2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/164922a2b387dd3db279e2a9c3e1edbc780599f0420122952f44e9549ce9e02e224027bad497f8f58ee3c30ddbc7fbb829010bca03fc55ac7262b909b34a2e8f"} 03:51:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:58 INFO - Contents: 03:51:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f11f82a3e248d301affa6775c8abe347e6cb08837ead1491c33b3f625bccb54c56b2d5538ccfc65b5fb8b820d2ee4296f696fc221d4200833ccd4106cc8d3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5367e0068ee737ca205aed2ba90f0ce83d4094fa27942b24b2f920706db926c496898b207822a9886bf01389f5c7a86180f8c3c73db787b4b2843dec714c2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/164922a2b387dd3db279e2a9c3e1edbc780599f0420122952f44e9549ce9e02e224027bad497f8f58ee3c30ddbc7fbb829010bca03fc55ac7262b909b34a2e8f"} 03:51:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:58 INFO - Copying logs to upload dir... 03:51:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.169259 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-29 03:51:58.118361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 03:51:58.122399) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f11f82a3e248d301affa6775c8abe347e6cb08837ead1491c33b3f625bccb54c56b2d5538ccfc65b5fb8b820d2ee4296f696fc221d4200833ccd4106cc8d3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5367e0068ee737ca205aed2ba90f0ce83d4094fa27942b24b2f920706db926c496898b207822a9886bf01389f5c7a86180f8c3c73db787b4b2843dec714c2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/164922a2b387dd3db279e2a9c3e1edbc780599f0420122952f44e9549ce9e02e224027bad497f8f58ee3c30ddbc7fbb829010bca03fc55ac7262b909b34a2e8f"} build_url:https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/A1eDlXJoT_CtO6MAUokLqw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f11f82a3e248d301affa6775c8abe347e6cb08837ead1491c33b3f625bccb54c56b2d5538ccfc65b5fb8b820d2ee4296f696fc221d4200833ccd4106cc8d3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5367e0068ee737ca205aed2ba90f0ce83d4094fa27942b24b2f920706db926c496898b207822a9886bf01389f5c7a86180f8c3c73db787b4b2843dec714c2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/164922a2b387dd3db279e2a9c3e1edbc780599f0420122952f44e9549ce9e02e224027bad497f8f58ee3c30ddbc7fbb829010bca03fc55ac7262b909b34a2e8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 03:51:58.149082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:51:58.149449) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475134769.261256-906542465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004360 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 03:51:58.236923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 03:51:58.237479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 03:51:58.237797) ========= ========= Total master_lag: 0.19 =========