builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1477585292.81 results: success (0) buildid: 20161027074334 builduid: 5d8b2f22e8d0404a807b1f47d2c1cf26 revision: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.815245) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.815724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.816007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.830739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.831092) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 09:21:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-10-27 09:21:33 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.944631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.944945) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019547 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.994244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:32.994611) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23cbe1a93a98bb0a9822fd2d079fc259ff262899 --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 23cbe1a93a98bb0a9822fd2d079fc259ff262899 --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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 09:21:33,485 truncating revision to first 12 chars 2016-10-27 09:21:33,485 Setting DEBUG logging. 2016-10-27 09:21:33,485 attempt 1/10 2016-10-27 09:21:33,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23cbe1a93a98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 09:21:33,871 unpacking tar archive at: mozilla-central-23cbe1a93a98/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:33.748419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:33.748745) ========= script_repo_revision: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:33.749133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:33.749422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 09:21:33.758018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-27 09:21:33.758406) ========= /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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:34 INFO - MultiFileLogger online at 20161027 09:21:34 in /builds/slave/test 09:21:34 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 09:21:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:34 INFO - {'append_to_log': False, 09:21:34 INFO - 'base_work_dir': '/builds/slave/test', 09:21:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:21:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:34 INFO - 'branch': 'Firefox-Non-PGO', 09:21:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:34 INFO - 'config_files': ('talos/linux_config.py',), 09:21:34 INFO - 'default_actions': ('clobber', 09:21:34 INFO - 'read-buildbot-config', 09:21:34 INFO - 'download-and-extract', 09:21:34 INFO - 'populate-webroot', 09:21:34 INFO - 'create-virtualenv', 09:21:34 INFO - 'install', 09:21:34 INFO - 'run-tests'), 09:21:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:34 INFO - 'download_minidump_stackwalk': True, 09:21:34 INFO - 'download_symbols': 'ondemand', 09:21:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:34 INFO - 'installer_path': 'installer.exe', 09:21:34 INFO - 'log_level': 'info', 09:21:34 INFO - 'log_name': 'talos', 09:21:34 INFO - 'log_to_console': True, 09:21:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:34 INFO - 'opt_config_files': (), 09:21:34 INFO - 'pip_index': False, 09:21:34 INFO - 'sps_profile': False, 09:21:34 INFO - 'sps_profile_interval': 0, 09:21:34 INFO - 'suite': 'dromaeojs', 09:21:34 INFO - 'system_bits': '32', 09:21:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:34 INFO - 'title': 'talos-linux64-ix-011', 09:21:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:34 INFO - 'use_talos_json': True, 09:21:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:34 INFO - 'work_dir': 'build'} 09:21:34 INFO - [mozharness: 2016-10-27 16:21:34.337486Z] Running clobber step. 09:21:34 INFO - Running pre-action listener: _resource_record_pre_action 09:21:34 INFO - Running main action method: clobber 09:21:34 INFO - rmtree: /builds/slave/test/build 09:21:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:34 INFO - Running post-action listener: _resource_record_post_action 09:21:34 INFO - [mozharness: 2016-10-27 16:21:34.796755Z] Finished clobber step (success) 09:21:34 INFO - [mozharness: 2016-10-27 16:21:34.796855Z] Running read-buildbot-config step. 09:21:34 INFO - Running pre-action listener: _resource_record_pre_action 09:21:34 INFO - Running main action method: read_buildbot_config 09:21:34 INFO - Using buildbot properties: 09:21:34 INFO - { 09:21:34 INFO - "project": "", 09:21:34 INFO - "product": "firefox", 09:21:34 INFO - "script_repo_revision": "production", 09:21:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:21:34 INFO - "repository": "", 09:21:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:21:34 INFO - "buildid": "20161027074334", 09:21:34 INFO - "pgo_build": "False", 09:21:34 INFO - "basedir": "/builds/slave/test", 09:21:34 INFO - "buildnumber": 789, 09:21:34 INFO - "slavename": "talos-linux64-ix-011", 09:21:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:21:34 INFO - "platform": "ubuntu64_hw", 09:21:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:21:34 INFO - "branch": "mozilla-central", 09:21:34 INFO - "repo_path": "mozilla-central", 09:21:34 INFO - "revision": "23cbe1a93a98bb0a9822fd2d079fc259ff262899", 09:21:34 INFO - "stage_platform": "linux64", 09:21:34 INFO - "builduid": "5d8b2f22e8d0404a807b1f47d2c1cf26", 09:21:34 INFO - "slavebuilddir": "test" 09:21:34 INFO - } 09:21:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:21:34 INFO - Running post-action listener: _resource_record_post_action 09:21:34 INFO - [mozharness: 2016-10-27 16:21:34.799270Z] Finished read-buildbot-config step (success) 09:21:34 INFO - [mozharness: 2016-10-27 16:21:34.799359Z] Running download-and-extract step. 09:21:34 INFO - Running pre-action listener: _resource_record_pre_action 09:21:34 INFO - Running main action method: download_and_extract 09:21:34 INFO - mkdir: /builds/slave/test/build/tests 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - trying https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:21:34 INFO - Downloading https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/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 09:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/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 09:21:35 INFO - Downloaded 1361 bytes. 09:21:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:21:35 INFO - Using the following test package requirements: 09:21:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:21:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'jsshell-linux-x86_64.zip'], 09:21:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:21:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:21:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:21:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:35 INFO - Fetch https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:36 INFO - Http code: 200 09:21:36 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 09:21:36 INFO - x-amz-cf-id: MUqdY82jM-PH9uTqtzkvKrtJILMp_3su3bbFzBnpZrnakOMgCM8ClQ== 09:21:36 INFO - x-amz-version-id: nhXqdF5ZH3eitQAdOYELEMfi24fPoleB 09:21:36 INFO - Expected file size: 20424141 09:21:36 INFO - Obtained file size: 20424141 09:21:40 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 09:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:41 INFO - Http code: 200 09:21:41 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:21:41 INFO - x-amz-cf-id: U5_uC1ke6AhUdk28KiMTum7Waa4MpOPs-m12ZeIxOLjEVsH_4GxXsw== 09:21:41 INFO - x-amz-version-id: nhXqdF5ZH3eitQAdOYELEMfi24fPoleB 09:21:41 INFO - Expected file size: 20424141 09:21:41 INFO - Obtained file size: 20424141 09:21:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:45 INFO - Fetch https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:21:46 INFO - Http code: 200 09:21:46 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 09:21:46 INFO - x-amz-cf-id: btDST6136I2Ycg3LeOQOhamvCJ-PtT2YjD7_OcaaiY9MItzkXbshYw== 09:21:46 INFO - x-amz-version-id: 02.f72f.vrB5yDAt3ZIKOhtUKBCKOOXQ 09:21:46 INFO - Expected file size: 14409028 09:21:46 INFO - Obtained file size: 14409028 09:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:46 INFO - trying https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:46 INFO - Downloading https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/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 09:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/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 09:21:47 INFO - Downloaded 55580525 bytes. 09:21:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:47 INFO - mkdir: /builds/slave/test/properties 09:21:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:47 INFO - Contents: 09:21:47 INFO - build_url:https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:48 INFO - Running post-action listener: _resource_record_post_action 09:21:48 INFO - Running post-action listener: set_extra_try_arguments 09:21:48 INFO - [mozharness: 2016-10-27 16:21:48.658922Z] Finished download-and-extract step (success) 09:21:48 INFO - [mozharness: 2016-10-27 16:21:48.659148Z] Running populate-webroot step. 09:21:48 INFO - Running pre-action listener: _resource_record_pre_action 09:21:48 INFO - Running main action method: populate_webroot 09:21:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:48 INFO - '--tppagecycles', 09:21:48 INFO - '7'], 09:21:48 INFO - 'tests': ['tsvgm']}}, 09:21:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['damp', 'tps']}, 09:21:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'tests': ['damp', 'tps']}, 09:21:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['dromaeo_dom']}, 09:21:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['basic_compositor_video']}, 09:21:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['a11yr', 09:21:48 INFO - 'ts_paint', 09:21:48 INFO - 'tpaint', 09:21:48 INFO - 'sessionrestore', 09:21:48 INFO - 'sessionrestore_no_auto_restore', 09:21:48 INFO - 'tabpaint']}, 09:21:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['tsvgx', 09:21:48 INFO - 'tsvgr_opacity', 09:21:48 INFO - 'tart', 09:21:48 INFO - 'tscrollx', 09:21:48 INFO - 'cart']}, 09:21:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:48 INFO - 'tsvgr_opacity', 09:21:48 INFO - 'tart', 09:21:48 INFO - 'tscrollx', 09:21:48 INFO - 'cart']}, 09:21:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'talos_options': ['--disable-e10s'], 09:21:48 INFO - 'tests': ['tp5o']}, 09:21:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'tests': ['tp5o']}, 09:21:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'talos_options': ['--disable-e10s', 09:21:48 INFO - '--xperf_path', 09:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:48 INFO - 'tests': ['tp5n']}, 09:21:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:48 INFO - 'talos_options': ['--xperf_path', 09:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:48 INFO - 'tests': ['tp5n']}}, 09:21:48 INFO - 'talos.zip': {'path': '', 09:21:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:48 INFO - Running post-action listener: _resource_record_post_action 09:21:48 INFO - [mozharness: 2016-10-27 16:21:48.681030Z] Finished populate-webroot step (success) 09:21:48 INFO - [mozharness: 2016-10-27 16:21:48.681117Z] Running create-virtualenv step. 09:21:48 INFO - Running pre-action listener: _resource_record_pre_action 09:21:48 INFO - Running main action method: create_virtualenv 09:21:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:48 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 09:21:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:48 INFO - Using real prefix '/usr' 09:21:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:51 INFO - Installing pip.................done. 09:21:51 INFO - Return code: 0 09:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:51 INFO - Reading from file tmpfile_stdout 09:21:51 INFO - Output received: 09:21:51 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) 09:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:51 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 09:21:51 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 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 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 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:51 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 09:21:51 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 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Downloading/unpacking psutil>=3.1.1 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:53 INFO - Installing collected packages: psutil 09:21:53 INFO - Running setup.py install for psutil 09:21:54 INFO - building 'psutil._psutil_linux' extension 09:21:54 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 09:21:54 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 09:21:54 INFO - building 'psutil._psutil_posix' extension 09:21:54 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 09:21:54 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 09:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:54 INFO - Successfully installed psutil 09:21:54 INFO - Cleaning up... 09:21:54 INFO - Return code: 0 09:21:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:54 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')]} 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:54 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')]} 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:54 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:54 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 09:21:54 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 09:21:54 INFO - Using env: {'DISPLAY': ':0', 09:21:54 INFO - 'HOME': '/home/cltbld', 09:21:54 INFO - 'LANG': 'en_US.UTF-8', 09:21:54 INFO - 'LANGUAGE': 'en_US:en', 09:21:54 INFO - 'LOGNAME': 'cltbld', 09:21:54 INFO - 'MAIL': '/var/mail/cltbld', 09:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:54 INFO - 'MOZ_NO_REMOTE': '1', 09:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:54 INFO - 'NO_EM_RESTART': '1', 09:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:54 INFO - 'PWD': '/builds/slave/test', 09:21:54 INFO - 'SHELL': '/bin/bash', 09:21:54 INFO - 'SHLVL': '1', 09:21:54 INFO - 'TERM': 'linux', 09:21:54 INFO - 'TMOUT': '86400', 09:21:54 INFO - 'USER': 'cltbld', 09:21:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:54 INFO - '_': '/tools/buildbot/bin/python'} 09:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:54 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 09:21:54 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 09:21:54 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 09:21:54 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 09:21:54 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 09:21:54 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 09:21:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:56 INFO - Installing collected packages: mozsystemmonitor 09:21:56 INFO - Running setup.py install for mozsystemmonitor 09:21:56 INFO - Successfully installed mozsystemmonitor 09:21:56 INFO - Cleaning up... 09:21:56 INFO - Return code: 0 09:21:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:56 INFO - Using env: {'DISPLAY': ':0', 09:21:56 INFO - 'HOME': '/home/cltbld', 09:21:56 INFO - 'LANG': 'en_US.UTF-8', 09:21:56 INFO - 'LANGUAGE': 'en_US:en', 09:21:56 INFO - 'LOGNAME': 'cltbld', 09:21:56 INFO - 'MAIL': '/var/mail/cltbld', 09:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:56 INFO - 'MOZ_NO_REMOTE': '1', 09:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:56 INFO - 'NO_EM_RESTART': '1', 09:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:56 INFO - 'PWD': '/builds/slave/test', 09:21:56 INFO - 'SHELL': '/bin/bash', 09:21:56 INFO - 'SHLVL': '1', 09:21:56 INFO - 'TERM': 'linux', 09:21:56 INFO - 'TMOUT': '86400', 09:21:56 INFO - 'USER': 'cltbld', 09:21:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:56 INFO - '_': '/tools/buildbot/bin/python'} 09:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:59 INFO - warning: no files found matching '*.txt' 09:21:59 INFO - no previously-included directories found matching 'build' 09:21:59 INFO - no previously-included directories found matching 'dist' 09:21:59 INFO - no previously-included directories found matching '.git*' 09:21:59 INFO - Installing collected packages: jsonschema, functools32 09:21:59 INFO - Running setup.py install for functools32 09:21:59 INFO - warning: no files found matching '*.txt' 09:21:59 INFO - no previously-included directories found matching 'build' 09:21:59 INFO - no previously-included directories found matching 'dist' 09:21:59 INFO - no previously-included directories found matching '.git*' 09:21:59 INFO - Successfully installed jsonschema functools32 09:21:59 INFO - Cleaning up... 09:21:59 INFO - Return code: 0 09:21:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:21:59 INFO - Using env: {'DISPLAY': ':0', 09:21:59 INFO - 'HOME': '/home/cltbld', 09:21:59 INFO - 'LANG': 'en_US.UTF-8', 09:21:59 INFO - 'LANGUAGE': 'en_US:en', 09:21:59 INFO - 'LOGNAME': 'cltbld', 09:21:59 INFO - 'MAIL': '/var/mail/cltbld', 09:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:59 INFO - 'MOZ_NO_REMOTE': '1', 09:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:59 INFO - 'NO_EM_RESTART': '1', 09:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:59 INFO - 'PWD': '/builds/slave/test', 09:21:59 INFO - 'SHELL': '/bin/bash', 09:21:59 INFO - 'SHLVL': '1', 09:21:59 INFO - 'TERM': 'linux', 09:21:59 INFO - 'TMOUT': '86400', 09:21:59 INFO - 'USER': 'cltbld', 09:21:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:59 INFO - '_': '/tools/buildbot/bin/python'} 09:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:59 INFO - Cleaning up... 09:21:59 INFO - Return code: 0 09:21:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:59 INFO - Using env: {'DISPLAY': ':0', 09:21:59 INFO - 'HOME': '/home/cltbld', 09:21:59 INFO - 'LANG': 'en_US.UTF-8', 09:21:59 INFO - 'LANGUAGE': 'en_US:en', 09:21:59 INFO - 'LOGNAME': 'cltbld', 09:21:59 INFO - 'MAIL': '/var/mail/cltbld', 09:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:59 INFO - 'MOZ_NO_REMOTE': '1', 09:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:59 INFO - 'NO_EM_RESTART': '1', 09:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:59 INFO - 'PWD': '/builds/slave/test', 09:21:59 INFO - 'SHELL': '/bin/bash', 09:21:59 INFO - 'SHLVL': '1', 09:21:59 INFO - 'TERM': 'linux', 09:21:59 INFO - 'TMOUT': '86400', 09:21:59 INFO - 'USER': 'cltbld', 09:21:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:59 INFO - '_': '/tools/buildbot/bin/python'} 09:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:21:59 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 09:22:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:02 INFO - Downloading docopt-0.6.1.tar.gz 09:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:02 INFO - Running setup.py install for blobuploader 09:22:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:02 INFO - Running setup.py install for requests 09:22:03 INFO - Running setup.py install for docopt 09:22:03 INFO - Successfully installed blobuploader requests docopt 09:22:03 INFO - Cleaning up... 09:22:03 INFO - Return code: 0 09:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:03 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:22:03 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 09:22:03 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 09:22:03 INFO - Using env: {'DISPLAY': ':0', 09:22:03 INFO - 'HOME': '/home/cltbld', 09:22:03 INFO - 'LANG': 'en_US.UTF-8', 09:22:03 INFO - 'LANGUAGE': 'en_US:en', 09:22:03 INFO - 'LOGNAME': 'cltbld', 09:22:03 INFO - 'MAIL': '/var/mail/cltbld', 09:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:03 INFO - 'MOZ_NO_REMOTE': '1', 09:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:03 INFO - 'NO_EM_RESTART': '1', 09:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:03 INFO - 'PWD': '/builds/slave/test', 09:22:03 INFO - 'SHELL': '/bin/bash', 09:22:03 INFO - 'SHLVL': '1', 09:22:03 INFO - 'TERM': 'linux', 09:22:03 INFO - 'TMOUT': '86400', 09:22:03 INFO - 'USER': 'cltbld', 09:22:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:03 INFO - '_': '/tools/buildbot/bin/python'} 09:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:03 INFO - Running setup.py (path:/tmp/pip-LlIkDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:03 INFO - Running setup.py (path:/tmp/pip-TbnKqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:03 INFO - Running setup.py (path:/tmp/pip-XD9JA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:03 INFO - Running setup.py (path:/tmp/pip-fKxoD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:03 INFO - Running setup.py (path:/tmp/pip-Pbn444-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:03 INFO - Running setup.py (path:/tmp/pip-8U154H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:03 INFO - Running setup.py (path:/tmp/pip-aK_x4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:04 INFO - Running setup.py (path:/tmp/pip-QgS4og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:04 INFO - Running setup.py (path:/tmp/pip-Z1dCwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:04 INFO - Running setup.py (path:/tmp/pip-ctiNgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:04 INFO - Running setup.py (path:/tmp/pip-SyZPtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:04 INFO - Running setup.py (path:/tmp/pip-Zu6Lka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:04 INFO - Running setup.py (path:/tmp/pip-S_LKnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:04 INFO - Running setup.py (path:/tmp/pip-2IBr77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:04 INFO - Running setup.py (path:/tmp/pip-fCXBjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:04 INFO - Running setup.py (path:/tmp/pip-bUVSs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:04 INFO - Running setup.py (path:/tmp/pip-r_m36e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:04 INFO - Running setup.py install for manifestparser 09:22:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:04 INFO - Running setup.py install for mozcrash 09:22:04 INFO - Running setup.py install for mozdebug 09:22:05 INFO - Running setup.py install for mozdevice 09:22:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for mozfile 09:22:05 INFO - Running setup.py install for mozhttpd 09:22:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for mozinfo 09:22:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for mozInstall 09:22:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for mozleak 09:22:05 INFO - Running setup.py install for mozlog 09:22:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for moznetwork 09:22:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:05 INFO - Running setup.py install for mozprocess 09:22:06 INFO - Running setup.py install for mozprofile 09:22:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:06 INFO - Running setup.py install for mozrunner 09:22:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:06 INFO - Running setup.py install for mozscreenshot 09:22:06 INFO - Running setup.py install for moztest 09:22:06 INFO - Running setup.py install for mozversion 09:22:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:06 INFO - Cleaning up... 09:22:06 INFO - Return code: 0 09:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:06 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')]} 09:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:06 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')]} 09:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:06 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:22:06 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 09:22:06 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 09:22:06 INFO - Using env: {'DISPLAY': ':0', 09:22:06 INFO - 'HOME': '/home/cltbld', 09:22:06 INFO - 'LANG': 'en_US.UTF-8', 09:22:06 INFO - 'LANGUAGE': 'en_US:en', 09:22:06 INFO - 'LOGNAME': 'cltbld', 09:22:06 INFO - 'MAIL': '/var/mail/cltbld', 09:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:06 INFO - 'MOZ_NO_REMOTE': '1', 09:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:06 INFO - 'NO_EM_RESTART': '1', 09:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:06 INFO - 'PWD': '/builds/slave/test', 09:22:06 INFO - 'SHELL': '/bin/bash', 09:22:06 INFO - 'SHLVL': '1', 09:22:06 INFO - 'TERM': 'linux', 09:22:06 INFO - 'TMOUT': '86400', 09:22:06 INFO - 'USER': 'cltbld', 09:22:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:06 INFO - '_': '/tools/buildbot/bin/python'} 09:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:06 INFO - Running setup.py (path:/tmp/pip-v5azfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:06 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)) 09:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:06 INFO - Running setup.py (path:/tmp/pip-N7cXaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:06 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)) 09:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:06 INFO - Running setup.py (path:/tmp/pip-o36i26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:07 INFO - Running setup.py (path:/tmp/pip-SFFIW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:07 INFO - Running setup.py (path:/tmp/pip-meWEjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:07 INFO - Running setup.py (path:/tmp/pip-lidV_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:07 INFO - Running setup.py (path:/tmp/pip-vncnwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:07 INFO - Running setup.py (path:/tmp/pip-QjDSaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:07 INFO - Running setup.py (path:/tmp/pip-uZHMP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:07 INFO - Running setup.py (path:/tmp/pip-uERETD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:07 INFO - Running setup.py (path:/tmp/pip-FPFfwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:07 INFO - Running setup.py (path:/tmp/pip-zfm6a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:07 INFO - Running setup.py (path:/tmp/pip-DLPmhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:07 INFO - Running setup.py (path:/tmp/pip-F5KUaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:07 INFO - Running setup.py (path:/tmp/pip-yAH3n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:07 INFO - Running setup.py (path:/tmp/pip-xVjzEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:07 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)) 09:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:07 INFO - Running setup.py (path:/tmp/pip-mpUhv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:08 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)) 09:22:08 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)) 09:22:08 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)) 09:22:08 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)) 09:22:08 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)) 09:22:08 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)) 09:22:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:09 INFO - Downloading blessings-1.6.tar.gz 09:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:10 INFO - Installing collected packages: blessings 09:22:10 INFO - Running setup.py install for blessings 09:22:10 INFO - Successfully installed blessings 09:22:10 INFO - Cleaning up... 09:22:10 INFO - Return code: 0 09:22:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:10 INFO - Reading from file tmpfile_stdout 09:22:10 INFO - Current package versions: 09:22:10 INFO - argparse == 1.2.1 09:22:10 INFO - blessings == 1.6 09:22:10 INFO - blobuploader == 1.2.4 09:22:10 INFO - docopt == 0.6.1 09:22:10 INFO - functools32 == 3.2.3-2 09:22:10 INFO - jsonschema == 2.5.1 09:22:10 INFO - manifestparser == 1.1 09:22:10 INFO - mozInstall == 1.12 09:22:10 INFO - mozcrash == 0.17 09:22:10 INFO - mozdebug == 0.1 09:22:10 INFO - mozdevice == 0.48 09:22:10 INFO - mozfile == 1.2 09:22:10 INFO - mozhttpd == 0.7 09:22:10 INFO - mozinfo == 0.9 09:22:10 INFO - mozleak == 0.1 09:22:10 INFO - mozlog == 3.4 09:22:10 INFO - moznetwork == 0.27 09:22:10 INFO - mozprocess == 0.23 09:22:10 INFO - mozprofile == 0.28 09:22:10 INFO - mozrunner == 6.12 09:22:10 INFO - mozscreenshot == 0.1 09:22:10 INFO - mozsystemmonitor == 0.3 09:22:10 INFO - moztest == 0.7 09:22:10 INFO - mozversion == 1.4 09:22:10 INFO - psutil == 3.1.1 09:22:10 INFO - requests == 1.2.3 09:22:10 INFO - wsgiref == 0.1.2 09:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:22:10 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 09:22:10 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 09:22:10 INFO - Using env: {'DISPLAY': ':0', 09:22:10 INFO - 'HOME': '/home/cltbld', 09:22:10 INFO - 'LANG': 'en_US.UTF-8', 09:22:10 INFO - 'LANGUAGE': 'en_US:en', 09:22:10 INFO - 'LOGNAME': 'cltbld', 09:22:10 INFO - 'MAIL': '/var/mail/cltbld', 09:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:10 INFO - 'MOZ_NO_REMOTE': '1', 09:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:10 INFO - 'NO_EM_RESTART': '1', 09:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:10 INFO - 'PWD': '/builds/slave/test', 09:22:10 INFO - 'SHELL': '/bin/bash', 09:22:10 INFO - 'SHLVL': '1', 09:22:10 INFO - 'TERM': 'linux', 09:22:10 INFO - 'TMOUT': '86400', 09:22:10 INFO - 'USER': 'cltbld', 09:22:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:10 INFO - '_': '/tools/buildbot/bin/python'} 09:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 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)) 09:22:10 INFO - Cleaning up... 09:22:10 INFO - Return code: 0 09:22:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 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 0x7f339d82df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', '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 09:22:10 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 09:22:10 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 09:22:10 INFO - Using env: {'DISPLAY': ':0', 09:22:10 INFO - 'HOME': '/home/cltbld', 09:22:10 INFO - 'LANG': 'en_US.UTF-8', 09:22:10 INFO - 'LANGUAGE': 'en_US:en', 09:22:10 INFO - 'LOGNAME': 'cltbld', 09:22:10 INFO - 'MAIL': '/var/mail/cltbld', 09:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:10 INFO - 'MOZ_NO_REMOTE': '1', 09:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:10 INFO - 'NO_EM_RESTART': '1', 09:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:10 INFO - 'PWD': '/builds/slave/test', 09:22:10 INFO - 'SHELL': '/bin/bash', 09:22:10 INFO - 'SHLVL': '1', 09:22:10 INFO - 'TERM': 'linux', 09:22:10 INFO - 'TMOUT': '86400', 09:22:10 INFO - 'USER': 'cltbld', 09:22:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:10 INFO - '_': '/tools/buildbot/bin/python'} 09:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:22:10 INFO - Cleaning up... 09:22:10 INFO - Return code: 0 09:22:10 INFO - Running post-action listener: _resource_record_post_action 09:22:10 INFO - Running post-action listener: _start_resource_monitoring 09:22:10 INFO - Starting resource monitoring. 09:22:10 INFO - [mozharness: 2016-10-27 16:22:10.913191Z] Finished create-virtualenv step (success) 09:22:10 INFO - [mozharness: 2016-10-27 16:22:10.913711Z] Running install step. 09:22:10 INFO - Running pre-action listener: _resource_record_pre_action 09:22:10 INFO - Running main action method: install 09:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:11 INFO - Reading from file tmpfile_stdout 09:22:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:11 INFO - Reading from file tmpfile_stdout 09:22:11 INFO - Output received: 09:22:11 INFO - Usage: mozinstall [options] installer 09:22:11 INFO - Options: 09:22:11 INFO - -h, --help show this help message and exit 09:22:11 INFO - -d DEST, --destination=DEST 09:22:11 INFO - Directory to install application into. [default: 09:22:11 INFO - "/builds/slave/test"] 09:22:11 INFO - --app=APP Application being installed. [default: firefox] 09:22:11 INFO - mkdir: /builds/slave/test/build/application 09:22:11 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'] 09:22:11 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 09:22:27 INFO - Reading from file tmpfile_stdout 09:22:27 INFO - Output received: 09:22:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:27 INFO - Running post-action listener: _resource_record_post_action 09:22:27 INFO - [mozharness: 2016-10-27 16:22:27.295816Z] Finished install step (success) 09:22:27 INFO - [mozharness: 2016-10-27 16:22:27.296059Z] Running run-tests step. 09:22:27 INFO - Running pre-action listener: _resource_record_pre_action 09:22:27 INFO - Running main action method: run_tests 09:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:27 INFO - Python 2.7.3 09:22:27 INFO - Return code: 0 09:22:27 INFO - grabbing minidump binary from tooltool 09:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:27 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 0x2083f60>, '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 0x2084d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20851d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:27 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 09:22:27 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 09:22:27 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 09:22:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:27 INFO - Return code: 0 09:22:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:27 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/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:22:27 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/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 09:22:27 INFO - Using env: {'DISPLAY': ':0', 09:22:27 INFO - 'HOME': '/home/cltbld', 09:22:27 INFO - 'LANG': 'en_US.UTF-8', 09:22:27 INFO - 'LANGUAGE': 'en_US:en', 09:22:27 INFO - 'LOGNAME': 'cltbld', 09:22:27 INFO - 'MAIL': '/var/mail/cltbld', 09:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:27 INFO - 'MOZ_NO_REMOTE': '1', 09:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:27 INFO - 'NO_EM_RESTART': '1', 09:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:27 INFO - 'PWD': '/builds/slave/test', 09:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:27 INFO - 'SHELL': '/bin/bash', 09:22:27 INFO - 'SHLVL': '1', 09:22:27 INFO - 'TERM': 'linux', 09:22:27 INFO - 'TMOUT': '86400', 09:22:27 INFO - 'USER': 'cltbld', 09:22:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970', 09:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:27 INFO - '_': '/tools/buildbot/bin/python'} 09:22:27 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/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:22:27 INFO - mozversion application_buildid: 20161027074334 09:22:27 INFO - mozversion application_changeset: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 09:22:27 INFO - mozversion application_display_name: Nightly 09:22:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:27 INFO - mozversion application_name: Firefox 09:22:27 INFO - mozversion application_remotingname: firefox 09:22:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:22:27 INFO - mozversion application_vendor: Mozilla 09:22:27 INFO - mozversion application_version: 52.0a1 09:22:27 INFO - mozversion platform_buildid: 20161027074334 09:22:27 INFO - mozversion platform_changeset: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 09:22:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:22:27 INFO - mozversion platform_version: 52.0a1 09:22:27 INFO - using testdate: 1477585347 09:22:27 INFO - actual date: 1477585347 09:22:27 INFO - starting webserver on 'localhost:40132' 09:22:27 INFO - SUITE-START | Running 2 tests 09:22:27 INFO - TEST-START | dromaeo_css 09:22:27 INFO - operating with platform_type : linux_ 09:22:27 INFO - Initialising browser for dromaeo_css test... 09:22:27 INFO - TEST-INFO | started process 8354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpliJOW8/profile http://localhost:40132/getInfo.html) 09:22:32 INFO - PROCESS | 8354 | __metrics Screen width/height:1600/1200 09:22:32 INFO - PROCESS | 8354 | colorDepth:24 09:22:32 INFO - PROCESS | 8354 | Browser inner width/height: 1024/697 09:22:32 INFO - PROCESS | 8354 | __metrics 09:22:33 INFO - PROCESS | 8354 | 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" 09:22:33 INFO - PROCESS | 8354 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:34 INFO - PROCESS | 8354 | console.error: PushService: 09:22:34 INFO - PROCESS | 8354 | stateChangeProcessEnqueue: Error transitioning state 09:22:34 INFO - PROCESS | 8354 | UnknownError 09:22:35 INFO - TEST-INFO | 8354: exit 0 09:22:35 INFO - Browser initialized. 09:22:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:35 INFO - TEST-INFO | started process 8434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpliJOW8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:47 INFO - PROCESS | 8434 | RSS: Main: 173817856 09:22:47 INFO - PROCESS | 8434 | 09:23:38 INFO - PROCESS | 8434 | 1477585418174 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] 09:25:51 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40132/tests/dromaeo/cssquery-ext.html) 09:25:54 INFO - PROCESS | 8434 | RSS: Main: 369950720 09:25:54 INFO - PROCESS | 8434 | 09:28:57 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-ext.html (next: http://localhost:40132/tests/dromaeo/cssquery-jquery.html) 09:28:57 INFO - PROCESS | 8434 | RSS: Main: 280342528 09:28:57 INFO - PROCESS | 8434 | 09:31:59 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40132/tests/dromaeo/cssquery-mootools.html) 09:32:00 INFO - PROCESS | 8434 | RSS: Main: 216694784 09:32:00 INFO - PROCESS | 8434 | 09:35:02 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40132/tests/dromaeo/cssquery-prototype.html) 09:35:03 INFO - PROCESS | 8434 | RSS: Main: 259837952 09:35:03 INFO - PROCESS | 8434 | 09:38:06 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40132/tests/dromaeo/cssquery-yui.html) 09:38:07 INFO - PROCESS | 8434 | RSS: Main: 219820032 09:38:07 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | Cycle 1(1): loaded http://localhost:40132/tests/dromaeo/cssquery-yui.html (next: http://localhost:40132/tests/dromaeo/cssquery-dojo.html) 09:41:10 INFO - PROCESS | 8434 | RSS: Main: 299663360 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | __start_tp_report 09:41:10 INFO - PROCESS | 8434 | _x_x_mozilla_page_load 09:41:10 INFO - PROCESS | 8434 | _x_x_mozilla_page_load_details 09:41:10 INFO - PROCESS | 8434 | |i|pagename|runs| 09:41:10 INFO - PROCESS | 8434 | |0;dojo.html;2542.4152444937663;2555.8466492010493;2588.5211235921356;2594.753498417651;2609.895604175833;4456.621187199084;4561.521040290771;4587.908241835161;4592.08158368326;4593.770311484425;4487.798049087791;4502.077074199789;4522.728636281825;4529.886752831181;4586.862394128173;4176.812043458051;4208.347706105551;4218.0720241546815;4220.430241917333;4246.532881383061;4211.789410529461;4283.186194623012;4304.526502084768;4310.181065597542;4353.760543170124;4284.143171365739;4294.4202532658;4304.397384366192;4339.262325404688;4347.739135651856;4050.169715208405;4134.297169481165;4137.689673274486;4190.51809041961;4243.27864263076;4218.514870789837;4233.470816147981;4235.131797981407;4237.152569486115;4238.3430568261965;4410.889727756799;4422.491413487426;4489.304157855538;4553.043860789238;4557.339185818038;4677.321788340706;4753.548412900769;4756.096341695067;4756.239001759736;4767.308740232646;4789.521047895218;4791.089692958327;4793.472718001017;4795.352627395292;4835.685680430796;4468.419105516262;4510.1656193604285;4527.320901864747;4574.062317224961;4583.702059366131;4961.3798275215595;4968.577670898014;4972.477889821516;4977.054359671723;5016.272640467112;4783.1390349737385;4785.856424307276;4786.521347865186;4789.090072886141;4851.393575803025;4725.385699858996;4767.976160119247;4769.642276829251;4828.782704778293;4854.466008739036;4855.1260773061185;4860.975695121572;4878.317035615017;4910.459849416561;4920.458749537548;4834.129856625841;4838.661293709407;4848.175810112219;4849.2968519564465;4904.950950490449;4014.538328092307;4044.8179831907637;4045.0494133878515;4149.771762553089;4187.539370669224;3620.0768803954825;3623.7463377563845;3669.4679271505483;3676.5220521332058;3681.815909204529;3910.3156947534067;3923.372260438316;3964.801759911993;3970.662493688011;3971.0866500705;4767.547083027176;4816.109019831342;4821.855344339676;4837.782299796518;4893.951060489349;3778.263238668433;3815.8855234343014;3815.8855234343014;3884.4561761353434;3942.605739426092;4266.466691663542;4307.181635489247;4308.3968244445805;4315.913681726348;4365.781710914505;4522.095580883903;4557.407537020233;4560.88597785058;4585.541445855388;4612.86161415158;4655.534446555317;4789;4790.520947905182;4795.400574928134;4836.516348365135;4496.0558282759675;4515.841945531891;4542.727436353829;4545.090981803719;4551.294549344857;4767.570918617341;4768.57082862544;4772.832950846704;4773.451053128796;4774.880627984328;4824.855254342376;4828.66199366041;4829.613630909448;4833.154198015403;4834.806607735792;4703.129920964632;4712.3873896394625;4713.033828065307;4713.858584242341;4715.764211789328;4636.489986101458;4654.115718013567;4662.463816660992;4684.648651351231;4687.648426368104;4650.86047418578;4662;4693.624510039257;4694.507076756891;4703.412073490814;4704.223803072591;4736.928946065743;4747.8575642730775;4751.097291514601;4807.711537307773;4563.224251877123;4609.677322587387;4646.628269738345;4651.2557990721325;4699.788509517149 09:41:10 INFO - PROCESS | 8434 | |1;ext.html;554.8807006493604;571.1204744693174;575.709266820256;580.3558050563873;584.260909948915;35907.2818543629;37725;37835.432468513;41130.56823351213;41289;39568.40647390291;39880.60119398805;39918.800405998;40019.59980400195;40183.59816401835;7410.777676669709;7617.542947423172;7714.382849372051;7876.724314648988;7878.763637090897;9879.110880020797;10181.643642472478;10182.439965801877;10583.947080264588;10593.523291451864;10318.484075796217;10382.584696612164;10383.896161038369;10388.117010054155;10393.896061039406;10190.541425635864;10226.07965283128;10234.33476824004;10234.437105959169;10236.283460157792;10049.24630652704;10113.69658910234;10117.140043096346;10121.696349109465;10138;36555;36940.458931160276;36958.63041369605;36996.630033699585;37034.259314813826;2962.8074175178544;3077.0768769369324;3161.1158976796796;3175.666555011737;3311.602607687069;27534;27579;27763.722362776516;27784.444311113664;27887.581686274723;3196.6643502432144;3275.2958114005605;3336.1326055225572;3347.815870127142;3350.4471762159214;254870;254936;256181;258245;259954.9999999981;49666.255006174935;49789;50084.499155008714;50126;50165.24752128721;52386.71359436892;52420.21369679458;52523;52538.737306313225;52545.737271313395;14007.369668364949;14228.573142805732;14234.217118058607;14236.501722439665;14236.501722439873;10008.64969726056;10242.53908574116;10242.692719218436;10502.894971050344;10830.566777328819;13041.608751737464;18135.183916723778;18799.15403806832;18921.432357029313;18955.715664265048;5606.887862242732;6852.794416167523;6865.704461858336;6971.721131154697;7267.4549408794555;777.1839568453101;858.888344515209;925.7361651929168;948.8529277961927;1004.2969921055145;25995.870020649774;26766.732332676813;27673.169804905887;27816.443671126464;28059.298517536816;907.9773005674779;952.4904176265665;957.9281553883486;957.9329446938648;959.5250351076122;13550;13761.38073786682;13793.931030344784;13857.168569885838;14199.36102875373;392445;396894;396906;397492;398295;45214.547854521035;45602.31596526055;45609.315860262126;45762.54237457649;45776.313355299695;1013.4881884648353;1105.1876870500175;1164.5050853387106;1182.438341787644;1230.1819290172114;24527.38681532976;27623.861880690467;27793.305167370978;27957.580636290066;28298.71701282961;39186.804065979486;39676.60323396729;39879.40180897347;39931.21341338411;39946.60053399545;290485.73785655526;291696;294460.11079778714;295019;295435;22777.772222277566;23645.881770591037;23649.408764780328;24619.399739016906;24764.752352476244;37878.053048674;37988.62011379851;40750.38874416827;40938.795306023276;42290.154196916505;34846.303073937874;35319.470207947415;35587;35873.46189807207;36546.8172659135;35079.64920350764;35709.64290357063;35797.642023580476;35813.28373432569;35934.281314373045;34313.65686343204;34734.82632586922;35321.823390882884;35554.111147220494;35615;29905.700942991163;31779.36441271208;31970.6802931977;32014.35971280608;32326.35347293088;25144.228365745286;25226.36934076663;25241.368965776004;25270.851977581377;25731.228063158134 09:41:10 INFO - PROCESS | 8434 | |2;jquery.html;330.784989756658;356.8590406789318;359.70683892627505;369.78737226094995;385.99614003859955;12451.626451206466;13517.594472165838;15655.843441565581;16060.518184454455;16705.749413758804;17094.658106837855;17095.91452042741;17100.572485687862;17254.39609613664;17368.13159342034;4059.903825966987;4892.535209155133;5140.357455318085;5177.974110129444;5185.688858668473;4962.5533701966815;5097.082525145473;5103.26002729604;5106.055379754739;5106.131957567204;4885.560299573038;5079.187330027196;5085.5423011928915;5091.389033316007;5097.949020509803;5000.349954505909;5121.974390128063;5132.40977287613;5135.6918584885025;5136.948630513684;4373.868783936487;4453.354263631788;4582.1293954148605;4582.816687332503;4585.289280161547;18866.245350185975;19537.316193933286;20927.476813079644;21070.894645526674;21122.471938201514;1697.9745303820453;1880.28549151323;1888.9622207555772;1999.6800511918168;2421.2494126820566;8565.700200492953;8895.73312800617;9434.245260379153;9437.669681561112;9581.808363832753;1652.7438247071723;1676.9748453773202;1679.2695177597784;1757.490327804935;1796.4610616814903;57711.71144144252;63978;69845;70182.64908675475;72797;9232.584533695865;9422.199113075329;10070.59717611302;10078.244131690153;10598.25812193139;13268.668283292995;13268.867311326763;13276.20342779417;13301.866981330062;13308.068435209443;7015.754448594274;7121;7148.177959534616;7371.410287177013;7418.443616728767;6959.478039147084;7086.433085353159;7218.67515961783;7240.96379518099;7426.591537465383;4093.385992101149;4148.896277593024;4172.395002724588;4367.606915377568;4406.889827754332;1688.662267546471;1724.4395571439331;1728.4728157911957;1745.223375597872;1777.7777777777778;813.7029984055777;847.7838151271386;849.5709666618318;880.8458519759016;890.5858775669216;16622.25199866009;16728.665426691397;17067;17256.050917199424;17812.732809007874;803.6624617660597;838.5765188579728;866.207420210513;871.020102384817;888.036480418753;9301.627934882665;9453.763655908657;9749.853752193723;9782.532620106898;9956;345785;347560;351600;358525;360744;45702.314465283045;74483;75951;77317;78429.60785196151;868.96524139035;871.6164887449629;876.4346996187423;888.6800751729372;895.3016647015338;14913.25433728331;14979.775303370241;15536.145511996496;15732.292046858147;15848.366065357257;33776.66223337735;33785.49321760225;34905;35216;35530.822345888104;46036.53963460323;46355.30467043065;46438;46520.302195467775;46551.76724116358;6703.93296067033;6805.6937437816405;6850.143732033496;6908.512935343373;7078.469114816512;9959.153471954965;10113;10146.340487868265;10505.894941050492;10768.46157692128;8941.597628106882;9066.22937050358;9068;9077.320695671322;9302.441853488812;9005.549722513979;9111.453312801254;9259.212966897889;9321.533923303943;9373.578188981648;8908.86636700463;8915.331350148635;9077.954610226907;9149.862752058858;9617.182539483942;6902.551334163263;6996.370326670624;7082.256363081802;7230.49386542958;7240.456965727486;8698.695545655872;8705.47767133974;8744.387892847439;9220.26237900953;9385.859212111687 09:41:10 INFO - PROCESS | 8434 | |3;mootools.html;1209.5161935225915;1319.432643963096;1364.7406992671392;1421.822272215973;1667.9416220432288;6103.664298463583;6868.862622747542;7081.291870812923;7100;7274.818129546751;6995.125609298838;7093.645317734118;7102.609356485391;7103.076600042;7106.395956343704;2060.062671484475;2089.665653495441;2091.048572899335;2093.769685334612;2097.5175709586806;2099.454141923103;2118.756343020557;2120.6288899442534;2144.8927553622334;2157.4822042709793;2063.9690404643943;2073.3365323096614;2076.09689784944;2099.338708306886;2099.9080478151354;1981.3164458261876;2049.815516603498;2053.1068984991575;2056.8251698605636;2062.102985201427;2022.4236092713654;2032.573159636478;2061.3403710812545;2064.3600483850055;2089.1643342662906;6809.250982391933;6882.655867206619;6890.621015844126;7056.964715176391;7127.679254433563;4331.7184383015;4458.977705111486;4495.078508905666;4500.189965806154;4502.482214545336;2587.560114780492;2739.342557786117;2797.636307280061;2805.8597070146616;2822.731840475152;890.4657205676607;904.1184844776357;909.4406939732017;920.7191806499015;926.1479438916214;9396.577154028017;9585.281103917234;9601.519924003773;9614.663486777928;9632.614695412176;3711.721620878445;3890.4942357493346;3973.4635824163947;3995.300822356076;4038.8586399475876;8199.098099209083;8199.631016604268;8202.630881610341;8203.466774659628;8208;4468.240399132155;4481.35020422037;4482.327650852333;4482.798274077674;4486;3590.982045089758;3696.815159242027;3944.3491823848744;4114.814833332507;4116.259073366823;3358;3477.7217822574135;3495.10874726943;3523.436250200007;3648.4709717090873;1110.5835311758092;1176.5235079792697;1181.9349935753617;1184.8400465936988;1185.0773938264372;726.5749536521195;738.3281214095148;742.907136607924;758.9810254743676;773.9380849532024;4519.796609152596;4993.275974983607;5117.667351622133;5142.61430392722;5196.558292545101;758.1546575568202;773.0800347586354;784.6233807772187;788.5662885413;806.1213277527523;3221.2269055426996;3293.2919422323835;3319.93360132796;3320.684534969174;3393.9490907636405;8262.917370826335;8670.00294966087;8672.349573781992;8675.436096653824;8684;8637.309015278763;8660.17728315809;8661.610227539775;8670.739877803677;8671.219590236782;6715.1941766988275;6716.361945615159;6788.932110678928;6850;6852.862942741117;4902.7058376497525;4918.311436398835;4994.126027945168;5038.697678139177;5050.267711181785;7909.604519774103;7920.405969552422;7927.16764739694;7929.722459713882;7948.403869709679;7840.215978402114;8096.838063238584;8174.264316211569;8196.959015204886;8220.958895205486;5230.8169214077325;5389.0299746046085;5840.737166827588;5891.617044892068;5943.286805583358;6547.836304092436;6859.245482996766;6877.243503214542;7025.824354391181;7035.964820175866;6095.603785753912;6142.754289828536;6271.749130034747;6292.370762923671;6370.713317900798;6114.510839132948;6118.632882027093;6134.938650613615;6150.477209437248;6172.012478003498;5721.342045664802;5823.679697616672;5826.82519524415;5826.970865145647;5827.067669172912;4313.654907607447;4341.913161736685;4351.521332653342;4376.781160941877;4466.2407390743;4142.316517774654;4167.458230430025;4216.367544868294;4244.0663054128045;4355.889248241805 09:41:10 INFO - PROCESS | 8434 | |4;prototype.html;295.8225064961022;300.57318607577247;307.84761543036194;309.31949710636604;309.4831631175936;4694.436667599893;4748.905021899569;4859;4890.168671325874;4920.384951881019;4645.419322584677;4661.627069834413;4746.1727235014505;4769.831391309125;4792.424909010915;3765.5293088363956;3772.585280519805;3774.4338349247696;3775.3581891078447;3782.6028267032048;3577.9821100894587;3774.4338349247696;3784.2999045176593;3787.9810600946957;3818.102745854722;3498.2303893143594;3716.2753263113705;3717.4423836424617;3721.162738383869;3721.79530125843;3726.5341832270965;3729.627037296276;3732.533433320835;3737.196502751894;3738.2336620992633;3296.2583418730833;3297.142742886843;3298.7855789373853;3303.7687361884678;3312.3044160726276;4547.317902314646;4610.239310513761;4618.6536009799065;4661.650376221797;4677.251639737626;4242.766647834368;4260.403543503912;4265.509466411371;4273.9358909616385;4285.485741711014;4931.202973710223;4938.209886418156;4941.728204948727;4945.159322915077;4959.876003099916;3514.9824250878837;3605.278944211142;3606.549181352331;3612.259486805199;3614.7831130132276;5185.611079169077;5195.870103247411;5207.739613019372;5221.660592061542;5225.712585807779;3721.776693398405;3730.6082861299715;3731.160488889978;3732.4774531565604;3733.794641294755;3752.5496940366784;3770.962290377061;3774.6225377462583;3785.470034195215;3790.7915064671156;4155.397467367215;4251.893702657397;4268.893277668083;4274.893127671833;4282.787909068199;4972.254161875675;4972.801087956514;4975.875603109951;5005.524475174925;5006.224035274538;1216.2945491614842;1256.6669832494397;1279.5457612547598;1308.5027689477938;1310.2597032676508;885.1723638398119;915.4004127296631;917.6742256498981;918.2975024106564;929.2983797233181;4067.28822456069;4104.774237416971;4108.753474791522;4115.333290017547;4125.9891326624565;5021.271915572222;5024.522670346311;5024.899502010013;5036.521530454601;5047.899042019139;3889.53325600924;4057.857974970862;4063.0588329320512;4078.4494093297026;4110.958890411118;2648.7616114549783;2689.6100065490787;2694.4372264086783;2701.622172691941;2716.5925111233473;4736.171170045228;4759.452662943806;4766.332713420124;4768.807798050488;4834.299026641188;4929.876753081202;5156.035279714104;5161.458046905096;5178.792848286026;5236.764345604457;4766.380370551737;4771.5467030632035;4772;4778.689385189951;4804.5195480451675;4990.226514890198;5025.39695236574;5031.094403007493;5036.294918711456;5060.84817455477;4853.611711063036;5040.218766091261;5076.949230507796;5103.770330335218;5122.769475373691;4827.637927155407;4853.611711063036;4854.393200849894;4858.82994095205;4867.829625963074;3631.5836823638274;3650.2516984018744;3651.908702282464;3653.3606618842127;3662.285854258394;5052.621053420935;5106.8509585343;5202.245674377118;5211.60912931524;5230.712310822942;4996.450390457119;5000.724525435845;5039.168537191323;5044.798208071783;5054.974725126351;5053.639329845611;5065.910829171746;5071.163258062378;5073.321841664763;5081.974590127025;4736.218523943511;4798.664093513421;4888.633352498506;4952.9846381492425;4993.600511958962;4921.557059864629;4987.9251811223585;5013.8718788272345;5066.316047333563;5080.288759573737;4909.729964851825;4936.950630493649;4937.728424936663;4941.50584941503;4945.332380128637 09:41:10 INFO - PROCESS | 8434 | |5;yui.html;607.6141650052217;611.5596770325367;613.1354789746458;614.9661768602725;622.2626187967259;10702.357858528494;11082.667519974393;11194.160437967164;11331.546738130464;11859.407029648504;11952.880471195285;12175.452104655289;12188.146829721923;12192.268463892173;12195.573154939579;616.7286393986632;638.4732595608618;775.2015424113144;792.9762107136767;804.4971892567146;807.112176605732;810.6635746165334;813.446856137826;816.8570500162477;817.6198067898426;830.7715378270993;835.173178553231;836.0135040652028;836.1387770596295;836.3392919593514;642.4667525953447;662.1689779326914;807.7415227127262;832.4131487301469;834.7328854766478;607.9422454866825;608.6804427675462;609.3114780298234;610.4963405190736;611.8653896142841;10745.301555398873;10787.460626968621;10791.676249712522;10794;10795.568177272979;11184.38485883276;11262.324260544312;11311.208215424924;12103.6368908932;12395.504179832797;9452.716418507456;9481.668141615079;9770.853437198448;9894.06006429388;10747.83878241827;3996.3406038003695;4035.8789236322664;4055.574164712692;4074.8981275468054;4192.559781222989;49185.50814491845;49247.753761231324;49920.750396247786;50083.24875126876;50928.49071509275;9314.161725444743;9336.766580835398;9361.297902657328;9471.384360016576;9859.30984831055;15394.692106157814;15509.146996915279;15554.611134721496;16202;16239;5741.167530708108;5951.226340575784;6026.969865150734;6057.939420605826;6092.573519853657;3670.889873303805;3698.593154752975;3727.869524566627;3728.3848165053005;3730.5336832895887;2699.3926366567757;2790.260580946051;2803.3832556837465;2803.3832556837465;2807.6630804303613;526.9683818970874;543.5950217088294;546.4480874316889;549.0693274899088;564.1594024902865;518.8646487494661;570.8972384970662;605.600303799499;607.441154138194;627.5889292513411;6884.173899132136;7025.227225005246;7111.92888071123;7262.455315851333;7603.65783539742;474.4235753559442;525.2488940814595;578.8089930322983;588.3675049321996;600.1537831657342;3226.8870589529256;3477.930441391158;3509.0700964244497;3565.5186549815444;3592.0660628236847;66129.66935165293;69715.65142174257;71091.64454177696;72911;73328.63335683395;44031.77984110123;63017.68491157606;64394;65312.34687653158;66711.66644166748;56607.716961415754;57802;57949.420505794405;57980.4201957975;61326.38673613385;6781.525293229427;6984.161900571964;7052.576845389293;7172.9641351795;7250.709971601077;39938;40189.397159042055;40613.187736244516;41121.38317925174;42303.788481057396;43161;47808;55405.72297138489;56058.439415605324;56955.71522142363;9654.131128198496;9934.900650993397;9951.651692190739;10061.446620435947;10172;10501.264911456125;10649.041586257274;10732.73168170802;11094.334339939629;11143.888561114285;8504.957475212585;10045.146162575971;10232.948835255776;10497.317674351143;11019.889801101886;10334.224933130195;10577.31247468912;10749.570017199538;10758.300710454108;11161.162912781412;10540.57837686484;10637.414942178255;10649.307794993301;11065.446727663746;11137.881393209915;7954.244346787046;8628.568571571523;8978;9050;9116.817663646823;9024.864627030469;9228.261739060725;9280.535973201178;9476.857847132436;9485 09:41:10 INFO - PROCESS | 8434 | __end_tp_report 09:41:10 INFO - PROCESS | 8434 | __start_cc_report 09:41:10 INFO - PROCESS | 8434 | _x_x_mozilla_cycle_collect,2327 09:41:10 INFO - PROCESS | 8434 | __end_cc_report 09:41:10 INFO - PROCESS | 8434 | __startTimestamp1477586470505__endTimestamp 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | ------- Summary: start ------- 09:41:10 INFO - PROCESS | 8434 | Number of tests: 6 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#0] dojo.html Cycles:165 Average:4464.54 Median:4587.91 stddev:464.80 (10.1%) stddev-sans-first:441.08 09:41:10 INFO - PROCESS | 8434 | Values: 2542.4 2555.8 2588.5 2594.8 2609.9 4456.6 4561.5 4587.9 4592.1 4593.8 4487.8 4502.1 4522.7 4529.9 4586.9 4176.8 4208.3 4218.1 4220.4 4246.5 4211.8 4283.2 4304.5 4310.2 4353.8 4284.1 4294.4 4304.4 4339.3 4347.7 4050.2 4134.3 4137.7 4190.5 4243.3 4218.5 4233.5 4235.1 4237.2 4238.3 4410.9 4422.5 4489.3 4553.0 4557.3 4677.3 4753.5 4756.1 4756.2 4767.3 4789.5 4791.1 4793.5 4795.4 4835.7 4468.4 4510.2 4527.3 4574.1 4583.7 4961.4 4968.6 4972.5 4977.1 5016.3 4783.1 4785.9 4786.5 4789.1 4851.4 4725.4 4768.0 4769.6 4828.8 4854.5 4855.1 4861.0 4878.3 4910.5 4920.5 4834.1 4838.7 4848.2 4849.3 4905.0 4014.5 4044.8 4045.0 4149.8 4187.5 3620.1 3623.7 3669.5 3676.5 3681.8 3910.3 3923.4 3964.8 3970.7 3971.1 4767.5 4816.1 4821.9 4837.8 4894.0 3778.3 3815.9 3815.9 3884.5 3942.6 4266.5 4307.2 4308.4 4315.9 4365.8 4522.1 4557.4 4560.9 4585.5 4612.9 4655.5 4789.0 4790.5 4795.4 4836.5 4496.1 4515.8 4542.7 4545.1 4551.3 4767.6 4768.6 4772.8 4773.5 4774.9 4824.9 4828.7 4829.6 4833.2 4834.8 4703.1 4712.4 4713.0 4713.9 4715.8 4636.5 4654.1 4662.5 4684.6 4687.6 4650.9 4662.0 4693.6 4694.5 4703.4 4704.2 4736.9 4747.9 4751.1 4807.7 4563.2 4609.7 4646.6 4651.3 4699.8 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#1] ext.html Cycles:180 Average:46688.42 Median:3293.45 stddev:84449.28 (2564.2%) stddev-sans-first:84615.15 09:41:10 INFO - PROCESS | 8434 | Values: 554.9 571.1 575.7 580.4 584.3 35907.3 37725.0 37835.4 41130.6 41289.0 39568.4 39880.6 39918.8 40019.6 40183.6 7410.8 7617.5 7714.4 7876.7 7878.8 9879.1 10181.6 10182.4 10583.9 10593.5 10318.5 10382.6 10383.9 10388.1 10393.9 10190.5 10226.1 10234.3 10234.4 10236.3 10049.2 10113.7 10117.1 10121.7 10138.0 36555.0 36940.5 36958.6 36996.6 37034.3 2962.8 3077.1 3161.1 3175.7 3311.6 27534.0 27579.0 27763.7 27784.4 27887.6 3196.7 3275.3 3336.1 3347.8 3350.4 254870.0 254936.0 256181.0 258245.0 259955.0 49666.3 49789.0 50084.5 50126.0 50165.2 52386.7 52420.2 52523.0 52538.7 52545.7 14007.4 14228.6 14234.2 14236.5 14236.5 10008.6 10242.5 10242.7 10502.9 10830.6 13041.6 18135.2 18799.2 18921.4 18955.7 5606.9 6852.8 6865.7 6971.7 7267.5 777.2 858.9 925.7 948.9 1004.3 25995.9 26766.7 27673.2 27816.4 28059.3 908.0 952.5 957.9 957.9 959.5 13550.0 13761.4 13793.9 13857.2 14199.4 392445.0 396894.0 396906.0 397492.0 398295.0 45214.5 45602.3 45609.3 45762.5 45776.3 1013.5 1105.2 1164.5 1182.4 1230.2 24527.4 27623.9 27793.3 27957.6 28298.7 39186.8 39676.6 39879.4 39931.2 39946.6 290485.7 291696.0 294460.1 295019.0 295435.0 22777.8 23645.9 23649.4 24619.4 24764.8 37878.1 37988.6 40750.4 40938.8 42290.2 34846.3 35319.5 35587.0 35873.5 36546.8 35079.6 35709.6 35797.6 35813.3 35934.3 34313.7 34734.8 35321.8 35554.1 35615.0 29905.7 31779.4 31970.7 32014.4 32326.4 25144.2 25226.4 25241.4 25270.9 25731.2 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#2] jquery.html Cycles:180 Average:22508.46 Median:5094.24 stddev:58367.74 (1145.8%) stddev-sans-first:58507.73 09:41:10 INFO - PROCESS | 8434 | Values: 330.8 356.9 359.7 369.8 386.0 12451.6 13517.6 15655.8 16060.5 16705.7 17094.7 17095.9 17100.6 17254.4 17368.1 4059.9 4892.5 5140.4 5178.0 5185.7 4962.6 5097.1 5103.3 5106.1 5106.1 4885.6 5079.2 5085.5 5091.4 5097.9 5000.3 5122.0 5132.4 5135.7 5136.9 4373.9 4453.4 4582.1 4582.8 4585.3 18866.2 19537.3 20927.5 21070.9 21122.5 1698.0 1880.3 1889.0 1999.7 2421.2 8565.7 8895.7 9434.2 9437.7 9581.8 1652.7 1677.0 1679.3 1757.5 1796.5 57711.7 63978.0 69845.0 70182.6 72797.0 9232.6 9422.2 10070.6 10078.2 10598.3 13268.7 13268.9 13276.2 13301.9 13308.1 7015.8 7121.0 7148.2 7371.4 7418.4 6959.5 7086.4 7218.7 7241.0 7426.6 4093.4 4148.9 4172.4 4367.6 4406.9 1688.7 1724.4 1728.5 1745.2 1777.8 813.7 847.8 849.6 880.8 890.6 16622.3 16728.7 17067.0 17256.1 17812.7 803.7 838.6 866.2 871.0 888.0 9301.6 9453.8 9749.9 9782.5 9956.0 345785.0 347560.0 351600.0 358525.0 360744.0 45702.3 74483.0 75951.0 77317.0 78429.6 869.0 871.6 876.4 888.7 895.3 14913.3 14979.8 15536.1 15732.3 15848.4 33776.7 33785.5 34905.0 35216.0 35530.8 46036.5 46355.3 46438.0 46520.3 46551.8 6703.9 6805.7 6850.1 6908.5 7078.5 9959.2 10113.0 10146.3 10505.9 10768.5 8941.6 9066.2 9068.0 9077.3 9302.4 9005.5 9111.5 9259.2 9321.5 9373.6 8908.9 8915.3 9078.0 9149.9 9617.2 6902.6 6996.4 7082.3 7230.5 7240.5 8698.7 8705.5 8744.4 9220.3 9385.9 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#3] mootools.html Cycles:180 Average:4715.14 Median:5309.92 stddev:2548.99 (48.0%) stddev-sans-first:2542.52 09:41:10 INFO - PROCESS | 8434 | Values: 1209.5 1319.4 1364.7 1421.8 1667.9 6103.7 6868.9 7081.3 7100.0 7274.8 6995.1 7093.6 7102.6 7103.1 7106.4 2060.1 2089.7 2091.0 2093.8 2097.5 2099.5 2118.8 2120.6 2144.9 2157.5 2064.0 2073.3 2076.1 2099.3 2099.9 1981.3 2049.8 2053.1 2056.8 2062.1 2022.4 2032.6 2061.3 2064.4 2089.2 6809.3 6882.7 6890.6 7057.0 7127.7 4331.7 4459.0 4495.1 4500.2 4502.5 2587.6 2739.3 2797.6 2805.9 2822.7 890.5 904.1 909.4 920.7 926.1 9396.6 9585.3 9601.5 9614.7 9632.6 3711.7 3890.5 3973.5 3995.3 4038.9 8199.1 8199.6 8202.6 8203.5 8208.0 4468.2 4481.4 4482.3 4482.8 4486.0 3591.0 3696.8 3944.3 4114.8 4116.3 3358.0 3477.7 3495.1 3523.4 3648.5 1110.6 1176.5 1181.9 1184.8 1185.1 726.6 738.3 742.9 759.0 773.9 4519.8 4993.3 5117.7 5142.6 5196.6 758.2 773.1 784.6 788.6 806.1 3221.2 3293.3 3319.9 3320.7 3393.9 8262.9 8670.0 8672.3 8675.4 8684.0 8637.3 8660.2 8661.6 8670.7 8671.2 6715.2 6716.4 6788.9 6850.0 6852.9 4902.7 4918.3 4994.1 5038.7 5050.3 7909.6 7920.4 7927.2 7929.7 7948.4 7840.2 8096.8 8174.3 8197.0 8221.0 5230.8 5389.0 5840.7 5891.6 5943.3 6547.8 6859.2 6877.2 7025.8 7036.0 6095.6 6142.8 6271.7 6292.4 6370.7 6114.5 6118.6 6134.9 6150.5 6172.0 5721.3 5823.7 5826.8 5827.0 5827.1 4313.7 4341.9 4351.5 4376.8 4466.2 4142.3 4167.5 4216.4 4244.1 4355.9 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#4] prototype.html Cycles:180 Average:4134.39 Median:4747.54 stddev:1189.25 (25.0%) stddev-sans-first:1157.16 09:41:10 INFO - PROCESS | 8434 | Values: 295.8 300.6 307.8 309.3 309.5 4694.4 4748.9 4859.0 4890.2 4920.4 4645.4 4661.6 4746.2 4769.8 4792.4 3765.5 3772.6 3774.4 3775.4 3782.6 3578.0 3774.4 3784.3 3788.0 3818.1 3498.2 3716.3 3717.4 3721.2 3721.8 3726.5 3729.6 3732.5 3737.2 3738.2 3296.3 3297.1 3298.8 3303.8 3312.3 4547.3 4610.2 4618.7 4661.7 4677.3 4242.8 4260.4 4265.5 4273.9 4285.5 4931.2 4938.2 4941.7 4945.2 4959.9 3515.0 3605.3 3606.5 3612.3 3614.8 5185.6 5195.9 5207.7 5221.7 5225.7 3721.8 3730.6 3731.2 3732.5 3733.8 3752.5 3771.0 3774.6 3785.5 3790.8 4155.4 4251.9 4268.9 4274.9 4282.8 4972.3 4972.8 4975.9 5005.5 5006.2 1216.3 1256.7 1279.5 1308.5 1310.3 885.2 915.4 917.7 918.3 929.3 4067.3 4104.8 4108.8 4115.3 4126.0 5021.3 5024.5 5024.9 5036.5 5047.9 3889.5 4057.9 4063.1 4078.4 4111.0 2648.8 2689.6 2694.4 2701.6 2716.6 4736.2 4759.5 4766.3 4768.8 4834.3 4929.9 5156.0 5161.5 5178.8 5236.8 4766.4 4771.5 4772.0 4778.7 4804.5 4990.2 5025.4 5031.1 5036.3 5060.8 4853.6 5040.2 5076.9 5103.8 5122.8 4827.6 4853.6 4854.4 4858.8 4867.8 3631.6 3650.3 3651.9 3653.4 3662.3 5052.6 5106.9 5202.2 5211.6 5230.7 4996.5 5000.7 5039.2 5044.8 5055.0 5053.6 5065.9 5071.2 5073.3 5082.0 4736.2 4798.7 4888.6 4953.0 4993.6 4921.6 4987.9 5013.9 5066.3 5080.3 4909.7 4937.0 4937.7 4941.5 4945.3 09:41:10 INFO - PROCESS | 8434 | 09:41:10 INFO - PROCESS | 8434 | [#5] yui.html Cycles:180 Average:14551.53 Median:56781.72 stddev:19257.71 (33.9%) stddev-sans-first:19283.27 09:41:10 INFO - PROCESS | 8434 | Values: 607.6 611.6 613.1 615.0 622.3 10702.4 11082.7 11194.2 11331.5 11859.4 11952.9 12175.5 12188.1 12192.3 12195.6 616.7 638.5 775.2 793.0 804.5 807.1 810.7 813.4 816.9 817.6 830.8 835.2 836.0 836.1 836.3 642.5 662.2 807.7 832.4 834.7 607.9 608.7 609.3 610.5 611.9 10745.3 10787.5 10791.7 10794.0 10795.6 11184.4 11262.3 11311.2 12103.6 12395.5 9452.7 9481.7 9770.9 9894.1 10747.8 3996.3 4035.9 4055.6 4074.9 4192.6 49185.5 49247.8 49920.8 50083.2 50928.5 9314.2 9336.8 9361.3 9471.4 9859.3 15394.7 15509.1 15554.6 16202.0 16239.0 5741.2 5951.2 6027.0 6057.9 6092.6 3670.9 3698.6 3727.9 3728.4 3730.5 2699.4 2790.3 2803.4 2803.4 2807.7 527.0 543.6 546.4 549.1 564.2 518.9 570.9 605.6 607.4 627.6 6884.2 7025.2 7111.9 7262.5 7603.7 474.4 525.2 578.8 588.4 600.2 3226.9 3477.9 3509.1 3565.5 3592.1 66129.7 69715.7 71091.6 72911.0 73328.6 44031.8 63017.7 64394.0 65312.3 66711.7 56607.7 57802.0 57949.4 57980.4 61326.4 6781.5 6984.2 7052.6 7173.0 7250.7 39938.0 40189.4 40613.2 41121.4 42303.8 43161.0 47808.0 55405.7 56058.4 56955.7 9654.1 9934.9 9951.7 10061.4 10172.0 10501.3 10649.0 10732.7 11094.3 11143.9 8505.0 10045.1 10232.9 10497.3 11019.9 10334.2 10577.3 10749.6 10758.3 11161.2 10540.6 10637.4 10649.3 11065.4 11137.9 7954.2 8628.6 8978.0 9050.0 9116.8 9024.9 9228.3 9280.5 9476.9 9485.0 09:41:10 INFO - PROCESS | 8434 | -------- Summary: end -------- 09:41:10 INFO - PROCESS | 8434 | 09:41:11 INFO - TEST-INFO | 8434: exit 0 09:41:11 INFO - TEST-OK | dromaeo_css | took 1124008ms 09:41:11 INFO - TEST-START | kraken 09:41:11 INFO - operating with platform_type : linux_ 09:41:11 INFO - Initialising browser for kraken test... 09:41:11 INFO - TEST-INFO | started process 8738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJWyEjm/profile http://localhost:40132/getInfo.html) 09:41:16 INFO - PROCESS | 8738 | __metrics Screen width/height:1600/1200 09:41:16 INFO - PROCESS | 8738 | colorDepth:24 09:41:16 INFO - PROCESS | 8738 | Browser inner width/height: 1024/697 09:41:16 INFO - PROCESS | 8738 | __metrics 09:41:17 INFO - PROCESS | 8738 | 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" 09:41:17 INFO - PROCESS | 8738 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:18 INFO - PROCESS | 8738 | console.error: PushService: 09:41:18 INFO - PROCESS | 8738 | stateChangeProcessEnqueue: Error transitioning state 09:41:18 INFO - PROCESS | 8738 | UnknownError 09:41:18 INFO - TEST-INFO | 8738: exit 0 09:41:18 INFO - Browser initialized. 09:41:18 INFO - Running cycle 1/1 for kraken test... 09:41:18 INFO - TEST-INFO | started process 8819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJWyEjm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:31 INFO - PROCESS | 8819 | RSS: Main: 173965312 09:41:31 INFO - PROCESS | 8819 | 09:41:33 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40132/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:34 INFO - PROCESS | 8819 | RSS: Main: 230469632 09:41:34 INFO - PROCESS | 8819 | 09:41:37 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40132/tests/kraken/driver.html?testName=audio-dft) 09:41:38 INFO - PROCESS | 8819 | RSS: Main: 217079808 09:41:38 INFO - PROCESS | 8819 | 09:41:41 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40132/tests/kraken/driver.html?testName=audio-fft) 09:41:42 INFO - PROCESS | 8819 | RSS: Main: 299868160 09:41:42 INFO - PROCESS | 8819 | 09:41:44 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40132/tests/kraken/driver.html?testName=audio-oscillator) 09:41:44 INFO - PROCESS | 8819 | RSS: Main: 210907136 09:41:44 INFO - PROCESS | 8819 | 09:41:47 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40132/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:47 INFO - PROCESS | 8819 | RSS: Main: 213028864 09:41:47 INFO - PROCESS | 8819 | 09:41:50 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40132/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:51 INFO - PROCESS | 8819 | RSS: Main: 249561088 09:41:51 INFO - PROCESS | 8819 | 09:41:54 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40132/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:55 INFO - PROCESS | 8819 | RSS: Main: 248553472 09:41:55 INFO - PROCESS | 8819 | 09:41:58 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40132/tests/kraken/driver.html?testName=json-parse-financial) 09:41:58 INFO - PROCESS | 8819 | RSS: Main: 247697408 09:41:58 INFO - PROCESS | 8819 | 09:42:00 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40132/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:01 INFO - PROCESS | 8819 | RSS: Main: 210673664 09:42:01 INFO - PROCESS | 8819 | 09:42:03 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:03 INFO - PROCESS | 8819 | RSS: Main: 217784320 09:42:03 INFO - PROCESS | 8819 | 09:42:05 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:06 INFO - PROCESS | 8819 | RSS: Main: 226934784 09:42:06 INFO - PROCESS | 8819 | 09:42:09 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:10 INFO - PROCESS | 8819 | RSS: Main: 235204608 09:42:10 INFO - PROCESS | 8819 | 09:42:13 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:13 INFO - PROCESS | 8819 | RSS: Main: 232083456 09:42:13 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:40132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40132/tests/kraken/driver.html?testName=ai-astar) 09:42:15 INFO - PROCESS | 8819 | RSS: Main: 283271168 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | __start_tp_report 09:42:15 INFO - PROCESS | 8819 | _x_x_mozilla_page_load 09:42:15 INFO - PROCESS | 8819 | _x_x_mozilla_page_load_details 09:42:15 INFO - PROCESS | 8819 | |i|pagename|runs| 09:42:15 INFO - PROCESS | 8819 | |0;ai-astar;107;115;113;113;113;113;113;115;113;113 09:42:15 INFO - PROCESS | 8819 | |1;audio-beat-detection;151;129;129;175;130;129;128;126;166;130 09:42:15 INFO - PROCESS | 8819 | |2;audio-dft;160;160;162;162;162;162;161;162;161;161 09:42:15 INFO - PROCESS | 8819 | |3;audio-fft;77;77;76;109;78;77;77;77;100;78 09:42:15 INFO - PROCESS | 8819 | |4;audio-oscillator;85;84;117;83;84;84;106;85;85;118 09:42:15 INFO - PROCESS | 8819 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 09:42:15 INFO - PROCESS | 8819 | |6;imaging-darkroom;146;146;146;146;147;146;147;147;146;147 09:42:15 INFO - PROCESS | 8819 | |7;imaging-desaturate;85;84;85;84;84;84;84;85;84;84 09:42:15 INFO - PROCESS | 8819 | |8;json-parse-financial;63;64;63;63;65;64;64;64;64;72 09:42:15 INFO - PROCESS | 8819 | |9;json-stringify-tinderbox;66;66;66;67;66;66;66;67;67;67 09:42:15 INFO - PROCESS | 8819 | |10;stanford-crypto-aes;84;83;84;85;84;84;84;83;83;83 09:42:15 INFO - PROCESS | 8819 | |11;stanford-crypto-ccm;153;141;150;148;139;137;137;150;179;139 09:42:15 INFO - PROCESS | 8819 | |12;stanford-crypto-pbkdf2;176;176;174;178;173;176;178;175;178;181 09:42:15 INFO - PROCESS | 8819 | |13;stanford-crypto-sha256-iterative;71;73;72;74;70;74;70;70;69;72 09:42:15 INFO - PROCESS | 8819 | __end_tp_report 09:42:15 INFO - PROCESS | 8819 | __start_cc_report 09:42:15 INFO - PROCESS | 8819 | _x_x_mozilla_cycle_collect,1990 09:42:15 INFO - PROCESS | 8819 | __end_cc_report 09:42:15 INFO - PROCESS | 8819 | __startTimestamp1477586535635__endTimestamp 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | ------- Summary: start ------- 09:42:15 INFO - PROCESS | 8819 | Number of tests: 14 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:2.20 (1.9%) stddev-sans-first:0.88 09:42:15 INFO - PROCESS | 8819 | Values: 107.0 115.0 113.0 113.0 113.0 113.0 113.0 115.0 113.0 113.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:130.00 stddev:18.01 (13.9%) stddev-sans-first:18.60 09:42:15 INFO - PROCESS | 8819 | Values: 151.0 129.0 129.0 175.0 130.0 129.0 128.0 126.0 166.0 130.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 09:42:15 INFO - PROCESS | 8819 | Values: 160.0 160.0 162.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:11.75 (15.3%) stddev-sans-first:12.29 09:42:15 INFO - PROCESS | 8819 | Values: 77.0 77.0 76.0 109.0 78.0 77.0 77.0 77.0 100.0 78.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:14.55 (17.3%) stddev-sans-first:15.13 09:42:15 INFO - PROCESS | 8819 | Values: 85.0 84.0 117.0 83.0 84.0 84.0 106.0 85.0 85.0 118.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:42:15 INFO - PROCESS | 8819 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:42:15 INFO - PROCESS | 8819 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 09:42:15 INFO - PROCESS | 8819 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:2.67 (4.2%) stddev-sans-first:2.77 09:42:15 INFO - PROCESS | 8819 | Values: 63.0 64.0 63.0 63.0 65.0 64.0 64.0 64.0 64.0 72.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:42:15 INFO - PROCESS | 8819 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 67.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 09:42:15 INFO - PROCESS | 8819 | Values: 84.0 83.0 84.0 85.0 84.0 84.0 84.0 83.0 83.0 83.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:149.00 stddev:12.66 (8.5%) stddev-sans-first:13.26 09:42:15 INFO - PROCESS | 8819 | Values: 153.0 141.0 150.0 148.0 139.0 137.0 137.0 150.0 179.0 139.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:177.00 stddev:2.32 (1.3%) stddev-sans-first:2.46 09:42:15 INFO - PROCESS | 8819 | Values: 176.0 176.0 174.0 178.0 173.0 176.0 178.0 175.0 178.0 181.0 09:42:15 INFO - PROCESS | 8819 | 09:42:15 INFO - PROCESS | 8819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.78 (2.5%) stddev-sans-first:1.88 09:42:15 INFO - PROCESS | 8819 | Values: 71.0 73.0 72.0 74.0 70.0 74.0 70.0 70.0 69.0 72.0 09:42:15 INFO - PROCESS | 8819 | -------- Summary: end -------- 09:42:15 INFO - PROCESS | 8819 | 09:42:16 INFO - TEST-INFO | 8819: exit 0 09:42:17 INFO - TEST-OK | kraken | took 65449ms 09:42:17 INFO - SUITE-END | took 1189s 09:42:17 INFO - Completed test suite (00:19:49) 09:42:17 INFO - javascript benchmark 09:42:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.4152444937663, 2555.8466492010493, 2588.5211235921356, 2594.753498417651, 2609.895604175833, 4456.621187199084, 4561.521040290771, 4587.908241835161, 4592.08158368326, 4593.770311484425, 4487.798049087791, 4502.077074199789, 4522.728636281825, 4529.886752831181, 4586.862394128173, 4176.812043458051, 4208.347706105551, 4218.0720241546815, 4220.430241917333, 4246.532881383061, 4211.789410529461, 4283.186194623012, 4304.526502084768, 4310.181065597542, 4353.760543170124, 4284.143171365739, 4294.4202532658, 4304.397384366192, 4339.262325404688, 4347.739135651856, 4050.169715208405, 4134.297169481165, 4137.689673274486, 4190.51809041961, 4243.27864263076, 4218.514870789837, 4233.470816147981, 4235.131797981407, 4237.152569486115, 4238.3430568261965, 4410.889727756799, 4422.491413487426, 4489.304157855538, 4553.043860789238, 4557.339185818038, 4677.321788340706, 4753.548412900769, 4756.096341695067, 4756.239001759736, 4767.308740232646, 4789.521047895218, 4791.089692958327, 4793.472718001017, 4795.352627395292, 4835.685680430796, 4468.419105516262, 4510.1656193604285, 4527.320901864747, 4574.062317224961, 4583.702059366131, 4961.3798275215595, 4968.577670898014, 4972.477889821516, 4977.054359671723, 5016.272640467112, 4783.1390349737385, 4785.856424307276, 4786.521347865186, 4789.090072886141, 4851.393575803025, 4725.385699858996, 4767.976160119247, 4769.642276829251, 4828.782704778293, 4854.466008739036, 4855.1260773061185, 4860.975695121572, 4878.317035615017, 4910.459849416561, 4920.458749537548, 4834.129856625841, 4838.661293709407, 4848.175810112219, 4849.2968519564465, 4904.950950490449, 4014.538328092307, 4044.8179831907637, 4045.0494133878515, 4149.771762553089, 4187.539370669224, 3620.0768803954825, 3623.7463377563845, 3669.4679271505483, 3676.5220521332058, 3681.815909204529, 3910.3156947534067, 3923.372260438316, 3964.801759911993, 3970.662493688011, 3971.0866500705, 4767.547083027176, 4816.109019831342, 4821.855344339676, 4837.782299796518, 4893.951060489349, 3778.263238668433, 3815.8855234343014, 3815.8855234343014, 3884.4561761353434, 3942.605739426092, 4266.466691663542, 4307.181635489247, 4308.3968244445805, 4315.913681726348, 4365.781710914505, 4522.095580883903, 4557.407537020233, 4560.88597785058, 4585.541445855388, 4612.86161415158, 4655.534446555317, 4789.0, 4790.520947905182, 4795.400574928134, 4836.516348365135, 4496.0558282759675, 4515.841945531891, 4542.727436353829, 4545.090981803719, 4551.294549344857, 4767.570918617341, 4768.57082862544, 4772.832950846704, 4773.451053128796, 4774.880627984328, 4824.855254342376, 4828.66199366041, 4829.613630909448, 4833.154198015403, 4834.806607735792, 4703.129920964632, 4712.3873896394625, 4713.033828065307, 4713.858584242341, 4715.764211789328, 4636.489986101458, 4654.115718013567, 4662.463816660992, 4684.648651351231, 4687.648426368104, 4650.86047418578, 4662.0, 4693.624510039257, 4694.507076756891, 4703.412073490814, 4704.223803072591, 4736.928946065743, 4747.8575642730775, 4751.097291514601, 4807.711537307773, 4563.224251877123, 4609.677322587387, 4646.628269738345, 4651.2557990721325, 4699.788509517149], "value": 4435.409188238824, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8807006493604, 571.1204744693174, 575.709266820256, 580.3558050563873, 584.260909948915, 35907.2818543629, 37725.0, 37835.432468513, 41130.56823351213, 41289.0, 39568.40647390291, 39880.60119398805, 39918.800405998, 40019.59980400195, 40183.59816401835, 7410.777676669709, 7617.542947423172, 7714.382849372051, 7876.724314648988, 7878.763637090897, 9879.110880020797, 10181.643642472478, 10182.439965801877, 10583.947080264588, 10593.523291451864, 10318.484075796217, 10382.584696612164, 10383.896161038369, 10388.117010054155, 10393.896061039406, 10190.541425635864, 10226.07965283128, 10234.33476824004, 10234.437105959169, 10236.283460157792, 10049.24630652704, 10113.69658910234, 10117.140043096346, 10121.696349109465, 10138.0, 36555.0, 36940.458931160276, 36958.63041369605, 36996.630033699585, 37034.259314813826, 2962.8074175178544, 3077.0768769369324, 3161.1158976796796, 3175.666555011737, 3311.602607687069, 27534.0, 27579.0, 27763.722362776516, 27784.444311113664, 27887.581686274723, 3196.6643502432144, 3275.2958114005605, 3336.1326055225572, 3347.815870127142, 3350.4471762159214, 254870.0, 254936.0, 256181.0, 258245.0, 259954.9999999981, 49666.255006174935, 49789.0, 50084.499155008714, 50126.0, 50165.24752128721, 52386.71359436892, 52420.21369679458, 52523.0, 52538.737306313225, 52545.737271313395, 14007.369668364949, 14228.573142805732, 14234.217118058607, 14236.501722439665, 14236.501722439873, 10008.64969726056, 10242.53908574116, 10242.692719218436, 10502.894971050344, 10830.566777328819, 13041.608751737464, 18135.183916723778, 18799.15403806832, 18921.432357029313, 18955.715664265048, 5606.887862242732, 6852.794416167523, 6865.704461858336, 6971.721131154697, 7267.4549408794555, 777.1839568453101, 858.888344515209, 925.7361651929168, 948.8529277961927, 1004.2969921055145, 25995.870020649774, 26766.732332676813, 27673.169804905887, 27816.443671126464, 28059.298517536816, 907.9773005674779, 952.4904176265665, 957.9281553883486, 957.9329446938648, 959.5250351076122, 13550.0, 13761.38073786682, 13793.931030344784, 13857.168569885838, 14199.36102875373, 392445.0, 396894.0, 396906.0, 397492.0, 398295.0, 45214.547854521035, 45602.31596526055, 45609.315860262126, 45762.54237457649, 45776.313355299695, 1013.4881884648353, 1105.1876870500175, 1164.5050853387106, 1182.438341787644, 1230.1819290172114, 24527.38681532976, 27623.861880690467, 27793.305167370978, 27957.580636290066, 28298.71701282961, 39186.804065979486, 39676.60323396729, 39879.40180897347, 39931.21341338411, 39946.60053399545, 290485.73785655526, 291696.0, 294460.11079778714, 295019.0, 295435.0, 22777.772222277566, 23645.881770591037, 23649.408764780328, 24619.399739016906, 24764.752352476244, 37878.053048674, 37988.62011379851, 40750.38874416827, 40938.795306023276, 42290.154196916505, 34846.303073937874, 35319.470207947415, 35587.0, 35873.46189807207, 36546.8172659135, 35079.64920350764, 35709.64290357063, 35797.642023580476, 35813.28373432569, 35934.281314373045, 34313.65686343204, 34734.82632586922, 35321.823390882884, 35554.111147220494, 35615.0, 29905.700942991163, 31779.36441271208, 31970.6802931977, 32014.35971280608, 32326.35347293088, 25144.228365745286, 25226.36934076663, 25241.368965776004, 25270.851977581377, 25731.228063158134], "value": 17588.40570141284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.784989756658, 356.8590406789318, 359.70683892627505, 369.78737226094995, 385.99614003859955, 12451.626451206466, 13517.594472165838, 15655.843441565581, 16060.518184454455, 16705.749413758804, 17094.658106837855, 17095.91452042741, 17100.572485687862, 17254.39609613664, 17368.13159342034, 4059.903825966987, 4892.535209155133, 5140.357455318085, 5177.974110129444, 5185.688858668473, 4962.5533701966815, 5097.082525145473, 5103.26002729604, 5106.055379754739, 5106.131957567204, 4885.560299573038, 5079.187330027196, 5085.5423011928915, 5091.389033316007, 5097.949020509803, 5000.349954505909, 5121.974390128063, 5132.40977287613, 5135.6918584885025, 5136.948630513684, 4373.868783936487, 4453.354263631788, 4582.1293954148605, 4582.816687332503, 4585.289280161547, 18866.245350185975, 19537.316193933286, 20927.476813079644, 21070.894645526674, 21122.471938201514, 1697.9745303820453, 1880.28549151323, 1888.9622207555772, 1999.6800511918168, 2421.2494126820566, 8565.700200492953, 8895.73312800617, 9434.245260379153, 9437.669681561112, 9581.808363832753, 1652.7438247071723, 1676.9748453773202, 1679.2695177597784, 1757.490327804935, 1796.4610616814903, 57711.71144144252, 63978.0, 69845.0, 70182.64908675475, 72797.0, 9232.584533695865, 9422.199113075329, 10070.59717611302, 10078.244131690153, 10598.25812193139, 13268.668283292995, 13268.867311326763, 13276.20342779417, 13301.866981330062, 13308.068435209443, 7015.754448594274, 7121.0, 7148.177959534616, 7371.410287177013, 7418.443616728767, 6959.478039147084, 7086.433085353159, 7218.67515961783, 7240.96379518099, 7426.591537465383, 4093.385992101149, 4148.896277593024, 4172.395002724588, 4367.606915377568, 4406.889827754332, 1688.662267546471, 1724.4395571439331, 1728.4728157911957, 1745.223375597872, 1777.7777777777778, 813.7029984055777, 847.7838151271386, 849.5709666618318, 880.8458519759016, 890.5858775669216, 16622.25199866009, 16728.665426691397, 17067.0, 17256.050917199424, 17812.732809007874, 803.6624617660597, 838.5765188579728, 866.207420210513, 871.020102384817, 888.036480418753, 9301.627934882665, 9453.763655908657, 9749.853752193723, 9782.532620106898, 9956.0, 345785.0, 347560.0, 351600.0, 358525.0, 360744.0, 45702.314465283045, 74483.0, 75951.0, 77317.0, 78429.60785196151, 868.96524139035, 871.6164887449629, 876.4346996187423, 888.6800751729372, 895.3016647015338, 14913.25433728331, 14979.775303370241, 15536.145511996496, 15732.292046858147, 15848.366065357257, 33776.66223337735, 33785.49321760225, 34905.0, 35216.0, 35530.822345888104, 46036.53963460323, 46355.30467043065, 46438.0, 46520.302195467775, 46551.76724116358, 6703.93296067033, 6805.6937437816405, 6850.143732033496, 6908.512935343373, 7078.469114816512, 9959.153471954965, 10113.0, 10146.340487868265, 10505.894941050492, 10768.46157692128, 8941.597628106882, 9066.22937050358, 9068.0, 9077.320695671322, 9302.441853488812, 9005.549722513979, 9111.453312801254, 9259.212966897889, 9321.533923303943, 9373.578188981648, 8908.86636700463, 8915.331350148635, 9077.954610226907, 9149.862752058858, 9617.182539483942, 6902.551334163263, 6996.370326670624, 7082.256363081802, 7230.49386542958, 7240.456965727486, 8698.695545655872, 8705.47767133974, 8744.387892847439, 9220.26237900953, 9385.859212111687], "value": 7793.930893322528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.5161935225915, 1319.432643963096, 1364.7406992671392, 1421.822272215973, 1667.9416220432288, 6103.664298463583, 6868.862622747542, 7081.291870812923, 7100.0, 7274.818129546751, 6995.125609298838, 7093.645317734118, 7102.609356485391, 7103.076600042, 7106.395956343704, 2060.062671484475, 2089.665653495441, 2091.048572899335, 2093.769685334612, 2097.5175709586806, 2099.454141923103, 2118.756343020557, 2120.6288899442534, 2144.8927553622334, 2157.4822042709793, 2063.9690404643943, 2073.3365323096614, 2076.09689784944, 2099.338708306886, 2099.9080478151354, 1981.3164458261876, 2049.815516603498, 2053.1068984991575, 2056.8251698605636, 2062.102985201427, 2022.4236092713654, 2032.573159636478, 2061.3403710812545, 2064.3600483850055, 2089.1643342662906, 6809.250982391933, 6882.655867206619, 6890.621015844126, 7056.964715176391, 7127.679254433563, 4331.7184383015, 4458.977705111486, 4495.078508905666, 4500.189965806154, 4502.482214545336, 2587.560114780492, 2739.342557786117, 2797.636307280061, 2805.8597070146616, 2822.731840475152, 890.4657205676607, 904.1184844776357, 909.4406939732017, 920.7191806499015, 926.1479438916214, 9396.577154028017, 9585.281103917234, 9601.519924003773, 9614.663486777928, 9632.614695412176, 3711.721620878445, 3890.4942357493346, 3973.4635824163947, 3995.300822356076, 4038.8586399475876, 8199.098099209083, 8199.631016604268, 8202.630881610341, 8203.466774659628, 8208.0, 4468.240399132155, 4481.35020422037, 4482.327650852333, 4482.798274077674, 4486.0, 3590.982045089758, 3696.815159242027, 3944.3491823848744, 4114.814833332507, 4116.259073366823, 3358.0, 3477.7217822574135, 3495.10874726943, 3523.436250200007, 3648.4709717090873, 1110.5835311758092, 1176.5235079792697, 1181.9349935753617, 1184.8400465936988, 1185.0773938264372, 726.5749536521195, 738.3281214095148, 742.907136607924, 758.9810254743676, 773.9380849532024, 4519.796609152596, 4993.275974983607, 5117.667351622133, 5142.61430392722, 5196.558292545101, 758.1546575568202, 773.0800347586354, 784.6233807772187, 788.5662885413, 806.1213277527523, 3221.2269055426996, 3293.2919422323835, 3319.93360132796, 3320.684534969174, 3393.9490907636405, 8262.917370826335, 8670.00294966087, 8672.349573781992, 8675.436096653824, 8684.0, 8637.309015278763, 8660.17728315809, 8661.610227539775, 8670.739877803677, 8671.219590236782, 6715.1941766988275, 6716.361945615159, 6788.932110678928, 6850.0, 6852.862942741117, 4902.7058376497525, 4918.311436398835, 4994.126027945168, 5038.697678139177, 5050.267711181785, 7909.604519774103, 7920.405969552422, 7927.16764739694, 7929.722459713882, 7948.403869709679, 7840.215978402114, 8096.838063238584, 8174.264316211569, 8196.959015204886, 8220.958895205486, 5230.8169214077325, 5389.0299746046085, 5840.737166827588, 5891.617044892068, 5943.286805583358, 6547.836304092436, 6859.245482996766, 6877.243503214542, 7025.824354391181, 7035.964820175866, 6095.603785753912, 6142.754289828536, 6271.749130034747, 6292.370762923671, 6370.713317900798, 6114.510839132948, 6118.632882027093, 6134.938650613615, 6150.477209437248, 6172.012478003498, 5721.342045664802, 5823.679697616672, 5826.82519524415, 5826.970865145647, 5827.067669172912, 4313.654907607447, 4341.913161736685, 4351.521332653342, 4376.781160941877, 4466.2407390743, 4142.316517774654, 4167.458230430025, 4216.367544868294, 4244.0663054128045, 4355.889248241805], "value": 3843.5859829673577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8225064961022, 300.57318607577247, 307.84761543036194, 309.31949710636604, 309.4831631175936, 4694.436667599893, 4748.905021899569, 4859.0, 4890.168671325874, 4920.384951881019, 4645.419322584677, 4661.627069834413, 4746.1727235014505, 4769.831391309125, 4792.424909010915, 3765.5293088363956, 3772.585280519805, 3774.4338349247696, 3775.3581891078447, 3782.6028267032048, 3577.9821100894587, 3774.4338349247696, 3784.2999045176593, 3787.9810600946957, 3818.102745854722, 3498.2303893143594, 3716.2753263113705, 3717.4423836424617, 3721.162738383869, 3721.79530125843, 3726.5341832270965, 3729.627037296276, 3732.533433320835, 3737.196502751894, 3738.2336620992633, 3296.2583418730833, 3297.142742886843, 3298.7855789373853, 3303.7687361884678, 3312.3044160726276, 4547.317902314646, 4610.239310513761, 4618.6536009799065, 4661.650376221797, 4677.251639737626, 4242.766647834368, 4260.403543503912, 4265.509466411371, 4273.9358909616385, 4285.485741711014, 4931.202973710223, 4938.209886418156, 4941.728204948727, 4945.159322915077, 4959.876003099916, 3514.9824250878837, 3605.278944211142, 3606.549181352331, 3612.259486805199, 3614.7831130132276, 5185.611079169077, 5195.870103247411, 5207.739613019372, 5221.660592061542, 5225.712585807779, 3721.776693398405, 3730.6082861299715, 3731.160488889978, 3732.4774531565604, 3733.794641294755, 3752.5496940366784, 3770.962290377061, 3774.6225377462583, 3785.470034195215, 3790.7915064671156, 4155.397467367215, 4251.893702657397, 4268.893277668083, 4274.893127671833, 4282.787909068199, 4972.254161875675, 4972.801087956514, 4975.875603109951, 5005.524475174925, 5006.224035274538, 1216.2945491614842, 1256.6669832494397, 1279.5457612547598, 1308.5027689477938, 1310.2597032676508, 885.1723638398119, 915.4004127296631, 917.6742256498981, 918.2975024106564, 929.2983797233181, 4067.28822456069, 4104.774237416971, 4108.753474791522, 4115.333290017547, 4125.9891326624565, 5021.271915572222, 5024.522670346311, 5024.899502010013, 5036.521530454601, 5047.899042019139, 3889.53325600924, 4057.857974970862, 4063.0588329320512, 4078.4494093297026, 4110.958890411118, 2648.7616114549783, 2689.6100065490787, 2694.4372264086783, 2701.622172691941, 2716.5925111233473, 4736.171170045228, 4759.452662943806, 4766.332713420124, 4768.807798050488, 4834.299026641188, 4929.876753081202, 5156.035279714104, 5161.458046905096, 5178.792848286026, 5236.764345604457, 4766.380370551737, 4771.5467030632035, 4772.0, 4778.689385189951, 4804.5195480451675, 4990.226514890198, 5025.39695236574, 5031.094403007493, 5036.294918711456, 5060.84817455477, 4853.611711063036, 5040.218766091261, 5076.949230507796, 5103.770330335218, 5122.769475373691, 4827.637927155407, 4853.611711063036, 4854.393200849894, 4858.82994095205, 4867.829625963074, 3631.5836823638274, 3650.2516984018744, 3651.908702282464, 3653.3606618842127, 3662.285854258394, 5052.621053420935, 5106.8509585343, 5202.245674377118, 5211.60912931524, 5230.712310822942, 4996.450390457119, 5000.724525435845, 5039.168537191323, 5044.798208071783, 5054.974725126351, 5053.639329845611, 5065.910829171746, 5071.163258062378, 5073.321841664763, 5081.974590127025, 4736.218523943511, 4798.664093513421, 4888.633352498506, 4952.9846381492425, 4993.600511958962, 4921.557059864629, 4987.9251811223585, 5013.8718788272345, 5066.316047333563, 5080.288759573737, 4909.729964851825, 4936.950630493649, 4937.728424936663, 4941.50584941503, 4945.332380128637], "value": 3763.7182124285664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.6141650052217, 611.5596770325367, 613.1354789746458, 614.9661768602725, 622.2626187967259, 10702.357858528494, 11082.667519974393, 11194.160437967164, 11331.546738130464, 11859.407029648504, 11952.880471195285, 12175.452104655289, 12188.146829721923, 12192.268463892173, 12195.573154939579, 616.7286393986632, 638.4732595608618, 775.2015424113144, 792.9762107136767, 804.4971892567146, 807.112176605732, 810.6635746165334, 813.446856137826, 816.8570500162477, 817.6198067898426, 830.7715378270993, 835.173178553231, 836.0135040652028, 836.1387770596295, 836.3392919593514, 642.4667525953447, 662.1689779326914, 807.7415227127262, 832.4131487301469, 834.7328854766478, 607.9422454866825, 608.6804427675462, 609.3114780298234, 610.4963405190736, 611.8653896142841, 10745.301555398873, 10787.460626968621, 10791.676249712522, 10794.0, 10795.568177272979, 11184.38485883276, 11262.324260544312, 11311.208215424924, 12103.6368908932, 12395.504179832797, 9452.716418507456, 9481.668141615079, 9770.853437198448, 9894.06006429388, 10747.83878241827, 3996.3406038003695, 4035.8789236322664, 4055.574164712692, 4074.8981275468054, 4192.559781222989, 49185.50814491845, 49247.753761231324, 49920.750396247786, 50083.24875126876, 50928.49071509275, 9314.161725444743, 9336.766580835398, 9361.297902657328, 9471.384360016576, 9859.30984831055, 15394.692106157814, 15509.146996915279, 15554.611134721496, 16202.0, 16239.0, 5741.167530708108, 5951.226340575784, 6026.969865150734, 6057.939420605826, 6092.573519853657, 3670.889873303805, 3698.593154752975, 3727.869524566627, 3728.3848165053005, 3730.5336832895887, 2699.3926366567757, 2790.260580946051, 2803.3832556837465, 2803.3832556837465, 2807.6630804303613, 526.9683818970874, 543.5950217088294, 546.4480874316889, 549.0693274899088, 564.1594024902865, 518.8646487494661, 570.8972384970662, 605.600303799499, 607.441154138194, 627.5889292513411, 6884.173899132136, 7025.227225005246, 7111.92888071123, 7262.455315851333, 7603.65783539742, 474.4235753559442, 525.2488940814595, 578.8089930322983, 588.3675049321996, 600.1537831657342, 3226.8870589529256, 3477.930441391158, 3509.0700964244497, 3565.5186549815444, 3592.0660628236847, 66129.66935165293, 69715.65142174257, 71091.64454177696, 72911.0, 73328.63335683395, 44031.77984110123, 63017.68491157606, 64394.0, 65312.34687653158, 66711.66644166748, 56607.716961415754, 57802.0, 57949.420505794405, 57980.4201957975, 61326.38673613385, 6781.525293229427, 6984.161900571964, 7052.576845389293, 7172.9641351795, 7250.709971601077, 39938.0, 40189.397159042055, 40613.187736244516, 41121.38317925174, 42303.788481057396, 43161.0, 47808.0, 55405.72297138489, 56058.439415605324, 56955.71522142363, 9654.131128198496, 9934.900650993397, 9951.651692190739, 10061.446620435947, 10172.0, 10501.264911456125, 10649.041586257274, 10732.73168170802, 11094.334339939629, 11143.888561114285, 8504.957475212585, 10045.146162575971, 10232.948835255776, 10497.317674351143, 11019.889801101886, 10334.224933130195, 10577.31247468912, 10749.570017199538, 10758.300710454108, 11161.162912781412, 10540.57837686484, 10637.414942178255, 10649.307794993301, 11065.446727663746, 11137.881393209915, 7954.244346787046, 8628.568571571523, 8978.0, 9050.0, 9116.817663646823, 9024.864627030469, 9228.261739060725, 9280.535973201178, 9476.857847132436, 9485.0], "value": 5947.138707998465, "unit": "score"}], "name": "dromaeo_css", "value": 6115.594577244838, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 113.0, 113.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 129.0, 175.0, 130.0, 129.0, 128.0, 126.0, 166.0, 130.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 109.0, 78.0, 77.0, 77.0, 77.0, 100.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 83.0, 84.0, 84.0, 106.0, 85.0, 85.0, 118.0], "value": 93.1, "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, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 72.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 85.0, 84.0, 84.0, 84.0, 83.0, 83.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 141.0, 150.0, 148.0, 139.0, 137.0, 137.0, 150.0, 179.0, 139.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 178.0, 173.0, 176.0, 178.0, 175.0, 178.0, 181.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 72.0, 74.0, 70.0, 74.0, 70.0, 70.0, 69.0, 72.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1546.7, "alertThreshold": 2.0}]} 09:42:17 INFO - Return code: 0 09:42:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:42:17 INFO - # TBPL SUCCESS # 09:42:17 INFO - Running post-action listener: _resource_record_post_action 09:42:17 INFO - [mozharness: 2016-10-27 16:42:17.431313Z] Finished run-tests step (success) 09:42:17 INFO - Running post-run listener: _resource_record_post_run 09:42:17 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388558848; Read time: 16; Write time: 645812 09:42:17 INFO - TinderboxPrint: CPU usage
13.1% 09:42:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:42:17 INFO - TinderboxPrint: I/O write bytes / time
388,558,848 / 645,812 09:42:17 INFO - TinderboxPrint: CPU idle
8,365.6 (86.9%) 09:42:17 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 09:42:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:42:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98942976; Read time: 0; Write time: 128244 09:42:17 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 289615872; Read time: 0; Write time: 517568 09:42:18 INFO - Running post-run listener: _upload_blobber_files 09:42:18 INFO - Blob upload gear active. 09:42:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:18 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 09:42:18 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'] 09:42:18 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 09:42:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:42:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:42:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:19 INFO - (blobuploader) - INFO - Done attempting. 09:42:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:42:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:42:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:20 INFO - (blobuploader) - INFO - Done attempting. 09:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:24 INFO - (blobuploader) - INFO - Done attempting. 09:42:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:24 INFO - Return code: 0 09:42:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530e07a80eea2f895b11f6022fc2ef79394dec34eb75a16a6270abb8a74dbf14772d465692bdfa623611c0676396ab9fa70aa406e61ad43db91b53dddbf2aaed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45780f8030915751709d0b832d77a4d85dffc3ee917e54804deb6b6b29a99958ad9c8c9d85c6a78d642a7b788f1bcc18e610b76d797d753306ab53cddb377c90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec53692ea296f3a55f57d67ef1b5d81398c894ce52e8bc15210342e0257a85ab0a235991bfc2ca2faebcb39e0dbbf23d04e97a7f55b53cff2b2ecb405563abe6"} 09:42:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:24 INFO - Contents: 09:42:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530e07a80eea2f895b11f6022fc2ef79394dec34eb75a16a6270abb8a74dbf14772d465692bdfa623611c0676396ab9fa70aa406e61ad43db91b53dddbf2aaed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45780f8030915751709d0b832d77a4d85dffc3ee917e54804deb6b6b29a99958ad9c8c9d85c6a78d642a7b788f1bcc18e610b76d797d753306ab53cddb377c90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec53692ea296f3a55f57d67ef1b5d81398c894ce52e8bc15210342e0257a85ab0a235991bfc2ca2faebcb39e0dbbf23d04e97a7f55b53cff2b2ecb405563abe6"} 09:42:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:24 INFO - Copying logs to upload dir... 09:42:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.486444 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-27 09:42:24.277410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 09:42:24.281874) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 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/530e07a80eea2f895b11f6022fc2ef79394dec34eb75a16a6270abb8a74dbf14772d465692bdfa623611c0676396ab9fa70aa406e61ad43db91b53dddbf2aaed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45780f8030915751709d0b832d77a4d85dffc3ee917e54804deb6b6b29a99958ad9c8c9d85c6a78d642a7b788f1bcc18e610b76d797d753306ab53cddb377c90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec53692ea296f3a55f57d67ef1b5d81398c894ce52e8bc15210342e0257a85ab0a235991bfc2ca2faebcb39e0dbbf23d04e97a7f55b53cff2b2ecb405563abe6"} build_url:https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/O096ooCuTfSt-ZN77yElUg/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/530e07a80eea2f895b11f6022fc2ef79394dec34eb75a16a6270abb8a74dbf14772d465692bdfa623611c0676396ab9fa70aa406e61ad43db91b53dddbf2aaed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45780f8030915751709d0b832d77a4d85dffc3ee917e54804deb6b6b29a99958ad9c8c9d85c6a78d642a7b788f1bcc18e610b76d797d753306ab53cddb377c90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec53692ea296f3a55f57d67ef1b5d81398c894ce52e8bc15210342e0257a85ab0a235991bfc2ca2faebcb39e0dbbf23d04e97a7f55b53cff2b2ecb405563abe6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 09:42:24.314592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:42:24.314973) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477585292.580492-456434970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:42:24.395253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 09:42:24.398612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 09:42:24.398936) ========= ========= Total master_lag: 0.19 =========