builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1478700706.3 results: success (0) buildid: 20161109044522 builduid: cd6c6be1202b418fa97516b9c30bde20 revision: 3466e6bc9874e5d7e53649d594ab70af9af2e358 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.299046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.300056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.300775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.317039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.317715) ========= 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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-09 06:11:46-- 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% 220M=0s 2016-11-09 06:11:46 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.443178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.443531) ========= 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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:46.496002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 06:11:46.496361) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 3466e6bc9874e5d7e53649d594ab70af9af2e358 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 3466e6bc9874e5d7e53649d594ab70af9af2e358 --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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-09 06:11:46,852 truncating revision to first 12 chars 2016-11-09 06:11:46,852 Setting DEBUG logging. 2016-11-09 06:11:46,852 attempt 1/10 2016-11-09 06:11:46,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/3466e6bc9874?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 06:11:47,795 unpacking tar archive at: larch-3466e6bc9874/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 06:11:47.793235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:47.793633) ========= script_repo_revision: 3466e6bc9874e5d7e53649d594ab70af9af2e358 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:47.794131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:47.794459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 06:11:47.805618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-09 06:11:47.806151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:48 INFO - MultiFileLogger online at 20161109 06:11:48 in /builds/slave/test 06:11:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 06:11:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:48 INFO - {'append_to_log': False, 06:11:48 INFO - 'base_work_dir': '/builds/slave/test', 06:11:48 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 06:11:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:48 INFO - 'branch': 'Larch-Non-PGO', 06:11:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:48 INFO - 'config_files': ('talos/linux_config.py',), 06:11:48 INFO - 'default_actions': ('clobber', 06:11:48 INFO - 'read-buildbot-config', 06:11:48 INFO - 'download-and-extract', 06:11:48 INFO - 'populate-webroot', 06:11:48 INFO - 'create-virtualenv', 06:11:48 INFO - 'install', 06:11:48 INFO - 'run-tests'), 06:11:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:48 INFO - 'download_minidump_stackwalk': True, 06:11:48 INFO - 'download_symbols': 'ondemand', 06:11:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:48 INFO - 'installer_path': 'installer.exe', 06:11:48 INFO - 'log_level': 'info', 06:11:48 INFO - 'log_name': 'talos', 06:11:48 INFO - 'log_to_console': True, 06:11:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:48 INFO - 'opt_config_files': (), 06:11:48 INFO - 'pip_index': False, 06:11:48 INFO - 'sps_profile': False, 06:11:48 INFO - 'sps_profile_interval': 0, 06:11:48 INFO - 'suite': 'dromaeojs', 06:11:48 INFO - 'system_bits': '32', 06:11:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:48 INFO - 'title': 'talos-linux64-ix-060', 06:11:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:48 INFO - 'use_talos_json': True, 06:11:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:48 INFO - 'work_dir': 'build'} 06:11:48 INFO - [mozharness: 2016-11-09 14:11:48.260025Z] Running clobber step. 06:11:48 INFO - Running pre-action listener: _resource_record_pre_action 06:11:48 INFO - Running main action method: clobber 06:11:48 INFO - rmtree: /builds/slave/test/build 06:11:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:48 INFO - Running post-action listener: _resource_record_post_action 06:11:48 INFO - [mozharness: 2016-11-09 14:11:48.715935Z] Finished clobber step (success) 06:11:48 INFO - [mozharness: 2016-11-09 14:11:48.716034Z] Running read-buildbot-config step. 06:11:48 INFO - Running pre-action listener: _resource_record_pre_action 06:11:48 INFO - Running main action method: read_buildbot_config 06:11:48 INFO - Using buildbot properties: 06:11:48 INFO - { 06:11:48 INFO - "project": "", 06:11:48 INFO - "product": "firefox", 06:11:48 INFO - "script_repo_revision": "production", 06:11:48 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 06:11:48 INFO - "repository": "", 06:11:48 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 06:11:48 INFO - "buildid": "20161109044522", 06:11:48 INFO - "pgo_build": "False", 06:11:48 INFO - "basedir": "/builds/slave/test", 06:11:48 INFO - "buildnumber": 2, 06:11:48 INFO - "slavename": "talos-linux64-ix-060", 06:11:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:11:48 INFO - "platform": "ubuntu64_hw", 06:11:48 INFO - "scheduler": "tests-larch-linux64-talos", 06:11:48 INFO - "branch": "larch", 06:11:48 INFO - "repo_path": "projects/larch", 06:11:48 INFO - "revision": "3466e6bc9874e5d7e53649d594ab70af9af2e358", 06:11:48 INFO - "stage_platform": "linux64", 06:11:48 INFO - "builduid": "cd6c6be1202b418fa97516b9c30bde20", 06:11:48 INFO - "slavebuilddir": "test" 06:11:48 INFO - } 06:11:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:11:48 INFO - Running post-action listener: _resource_record_post_action 06:11:48 INFO - [mozharness: 2016-11-09 14:11:48.718437Z] Finished read-buildbot-config step (success) 06:11:48 INFO - [mozharness: 2016-11-09 14:11:48.718523Z] Running download-and-extract step. 06:11:48 INFO - Running pre-action listener: _resource_record_pre_action 06:11:48 INFO - Running main action method: download_and_extract 06:11:48 INFO - mkdir: /builds/slave/test/build/tests 06:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:48 INFO - trying https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:11:48 INFO - Downloading https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/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 06:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/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 06:11:49 INFO - Downloaded 1361 bytes. 06:11:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:11:49 INFO - Using the following test package requirements: 06:11:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:11:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:11:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:11:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'jsshell-linux-x86_64.zip'], 06:11:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:11:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:11:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:11:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:11:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:11:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:11:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:11:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:11:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:49 INFO - Fetch https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:11:49 INFO - Http code: 200 06:11:49 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 06:11:49 INFO - x-amz-cf-id: I3J4TzavnR3Oj_2gi-gotgtzFIY9aEoAV8pdR8tmvR5CJ5qy4D-Tjg== 06:11:49 INFO - x-amz-version-id: T_FP28alrKRbKD8oR879fi71ZuOyelRR 06:11:50 INFO - Expected file size: 20353689 06:11:50 INFO - Obtained file size: 20353689 06:11:54 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 06:11:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:11:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:54 INFO - Fetch https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:11:54 INFO - Http code: 200 06:11:54 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 06:11:54 INFO - x-amz-cf-id: Rr5jQXfuDKVfsUEfQgp8HCsmcVk7EIzPNy7gfhlNpTSf8eHgolXbYQ== 06:11:54 INFO - x-amz-version-id: T_FP28alrKRbKD8oR879fi71ZuOyelRR 06:11:55 INFO - Expected file size: 20353689 06:11:55 INFO - Obtained file size: 20353689 06:11:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:11:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:11:59 INFO - Fetch https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:11:59 INFO - Http code: 200 06:11:59 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 06:11:59 INFO - x-amz-cf-id: BQgsriVQUe1CvtbGhhXQ8dTTUpnz_ODcf50mOzyfWUnxkWcgFXkadA== 06:11:59 INFO - x-amz-version-id: P8ky__anOCrIZqil7PjTK2pxIFyrFc1C 06:12:00 INFO - Expected file size: 14409038 06:12:00 INFO - Obtained file size: 14409038 06:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:00 INFO - trying https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:12:00 INFO - Downloading https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/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 06:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/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 06:12:01 INFO - Downloaded 55904559 bytes. 06:12:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:12:01 INFO - mkdir: /builds/slave/test/properties 06:12:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:12:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:12:01 INFO - Contents: 06:12:01 INFO - build_url:https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:12:02 INFO - Running post-action listener: _resource_record_post_action 06:12:02 INFO - Running post-action listener: set_extra_try_arguments 06:12:02 INFO - [mozharness: 2016-11-09 14:12:02.222273Z] Finished download-and-extract step (success) 06:12:02 INFO - [mozharness: 2016-11-09 14:12:02.222499Z] Running populate-webroot step. 06:12:02 INFO - Running pre-action listener: _resource_record_pre_action 06:12:02 INFO - Running main action method: populate_webroot 06:12:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:12:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:12:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:12:02 INFO - '--tppagecycles', 06:12:02 INFO - '7'], 06:12:02 INFO - 'tests': ['tsvgm']}}, 06:12:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:12:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:12:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:12:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:12:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['damp', 'tps']}, 06:12:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'tests': ['damp', 'tps']}, 06:12:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['dromaeo_dom']}, 06:12:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:12:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['basic_compositor_video']}, 06:12:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:12:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['a11yr', 06:12:02 INFO - 'ts_paint', 06:12:02 INFO - 'tpaint', 06:12:02 INFO - 'sessionrestore', 06:12:02 INFO - 'sessionrestore_no_auto_restore', 06:12:02 INFO - 'tabpaint']}, 06:12:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['tsvgx', 06:12:02 INFO - 'tsvgr_opacity', 06:12:02 INFO - 'tart', 06:12:02 INFO - 'tscrollx', 06:12:02 INFO - 'cart']}, 06:12:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:12:02 INFO - 'tsvgr_opacity', 06:12:02 INFO - 'tart', 06:12:02 INFO - 'tscrollx', 06:12:02 INFO - 'cart']}, 06:12:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'talos_options': ['--disable-e10s'], 06:12:02 INFO - 'tests': ['tp5o']}, 06:12:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'tests': ['tp5o']}, 06:12:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'talos_options': ['--disable-e10s', 06:12:02 INFO - '--xperf_path', 06:12:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:02 INFO - 'tests': ['tp5n']}, 06:12:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:02 INFO - 'talos_options': ['--xperf_path', 06:12:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:02 INFO - 'tests': ['tp5n']}}, 06:12:02 INFO - 'talos.zip': {'path': '', 06:12:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:12:02 INFO - Running post-action listener: _resource_record_post_action 06:12:02 INFO - [mozharness: 2016-11-09 14:12:02.244028Z] Finished populate-webroot step (success) 06:12:02 INFO - [mozharness: 2016-11-09 14:12:02.244115Z] Running create-virtualenv step. 06:12:02 INFO - Running pre-action listener: _resource_record_pre_action 06:12:02 INFO - Running main action method: create_virtualenv 06:12:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:12:02 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 06:12:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:12:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:12:02 INFO - Using real prefix '/usr' 06:12:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:12:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:12:04 INFO - Installing pip.................done. 06:12:04 INFO - Return code: 0 06:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:12:05 INFO - Reading from file tmpfile_stdout 06:12:05 INFO - Output received: 06:12:05 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) 06:12:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:12:05 INFO - Using env: {'DISPLAY': ':0', 06:12:05 INFO - 'HOME': '/home/cltbld', 06:12:05 INFO - 'LANG': 'en_US.UTF-8', 06:12:05 INFO - 'LANGUAGE': 'en_US:en', 06:12:05 INFO - 'LOGNAME': 'cltbld', 06:12:05 INFO - 'MAIL': '/var/mail/cltbld', 06:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:05 INFO - 'MOZ_NO_REMOTE': '1', 06:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:05 INFO - 'NO_EM_RESTART': '1', 06:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:05 INFO - 'PWD': '/builds/slave/test', 06:12:05 INFO - 'SHELL': '/bin/bash', 06:12:05 INFO - 'SHLVL': '1', 06:12:05 INFO - 'TERM': 'linux', 06:12:05 INFO - 'TMOUT': '86400', 06:12:05 INFO - 'USER': 'cltbld', 06:12:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:05 INFO - '_': '/tools/buildbot/bin/python'} 06:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:05 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 06:12:05 INFO - Cleaning up... 06:12:05 INFO - Return code: 0 06:12:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:12:05 INFO - Using env: {'DISPLAY': ':0', 06:12:05 INFO - 'HOME': '/home/cltbld', 06:12:05 INFO - 'LANG': 'en_US.UTF-8', 06:12:05 INFO - 'LANGUAGE': 'en_US:en', 06:12:05 INFO - 'LOGNAME': 'cltbld', 06:12:05 INFO - 'MAIL': '/var/mail/cltbld', 06:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:05 INFO - 'MOZ_NO_REMOTE': '1', 06:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:05 INFO - 'NO_EM_RESTART': '1', 06:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:05 INFO - 'PWD': '/builds/slave/test', 06:12:05 INFO - 'SHELL': '/bin/bash', 06:12:05 INFO - 'SHLVL': '1', 06:12:05 INFO - 'TERM': 'linux', 06:12:05 INFO - 'TMOUT': '86400', 06:12:05 INFO - 'USER': 'cltbld', 06:12:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:05 INFO - '_': '/tools/buildbot/bin/python'} 06:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:05 INFO - Downloading/unpacking psutil>=3.1.1 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:12:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:07 INFO - Installing collected packages: psutil 06:12:07 INFO - Running setup.py install for psutil 06:12:07 INFO - building 'psutil._psutil_linux' extension 06:12:07 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 06:12:07 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 06:12:07 INFO - building 'psutil._psutil_posix' extension 06:12:07 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 06:12:07 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 06:12:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:08 INFO - Successfully installed psutil 06:12:08 INFO - Cleaning up... 06:12:08 INFO - Return code: 0 06:12:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:08 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:08 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 06:12:08 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 06:12:08 INFO - Using env: {'DISPLAY': ':0', 06:12:08 INFO - 'HOME': '/home/cltbld', 06:12:08 INFO - 'LANG': 'en_US.UTF-8', 06:12:08 INFO - 'LANGUAGE': 'en_US:en', 06:12:08 INFO - 'LOGNAME': 'cltbld', 06:12:08 INFO - 'MAIL': '/var/mail/cltbld', 06:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:08 INFO - 'MOZ_NO_REMOTE': '1', 06:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:08 INFO - 'NO_EM_RESTART': '1', 06:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:08 INFO - 'PWD': '/builds/slave/test', 06:12:08 INFO - 'SHELL': '/bin/bash', 06:12:08 INFO - 'SHLVL': '1', 06:12:08 INFO - 'TERM': 'linux', 06:12:08 INFO - 'TMOUT': '86400', 06:12:08 INFO - 'USER': 'cltbld', 06:12:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:08 INFO - '_': '/tools/buildbot/bin/python'} 06:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:12:10 INFO - Installing collected packages: mozsystemmonitor 06:12:10 INFO - Running setup.py install for mozsystemmonitor 06:12:10 INFO - Successfully installed mozsystemmonitor 06:12:10 INFO - Cleaning up... 06:12:10 INFO - Return code: 0 06:12:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12: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==2.5.1'] in /builds/slave/test/build 06:12: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==2.5.1 06:12:10 INFO - Using env: {'DISPLAY': ':0', 06:12:10 INFO - 'HOME': '/home/cltbld', 06:12:10 INFO - 'LANG': 'en_US.UTF-8', 06:12:10 INFO - 'LANGUAGE': 'en_US:en', 06:12:10 INFO - 'LOGNAME': 'cltbld', 06:12:10 INFO - 'MAIL': '/var/mail/cltbld', 06:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:10 INFO - 'MOZ_NO_REMOTE': '1', 06:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:10 INFO - 'NO_EM_RESTART': '1', 06:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:10 INFO - 'PWD': '/builds/slave/test', 06:12:10 INFO - 'SHELL': '/bin/bash', 06:12:10 INFO - 'SHLVL': '1', 06:12:10 INFO - 'TERM': 'linux', 06:12:10 INFO - 'TMOUT': '86400', 06:12:10 INFO - 'USER': 'cltbld', 06:12:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:10 INFO - '_': '/tools/buildbot/bin/python'} 06:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:12:10 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 06:12:10 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 06:12:10 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 06:12:10 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 06:12:10 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 06:12:10 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 06:12:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:13 INFO - warning: no files found matching '*.txt' 06:12:13 INFO - no previously-included directories found matching 'build' 06:12:13 INFO - no previously-included directories found matching 'dist' 06:12:13 INFO - no previously-included directories found matching '.git*' 06:12:13 INFO - Installing collected packages: jsonschema, functools32 06:12:13 INFO - Running setup.py install for functools32 06:12:13 INFO - warning: no files found matching '*.txt' 06:12:13 INFO - no previously-included directories found matching 'build' 06:12:13 INFO - no previously-included directories found matching 'dist' 06:12:13 INFO - no previously-included directories found matching '.git*' 06:12:13 INFO - Successfully installed jsonschema functools32 06:12:13 INFO - Cleaning up... 06:12:13 INFO - Return code: 0 06:12:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:12:13 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')]} 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 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')]} 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:13 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 06:12:13 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 06:12:13 INFO - Using env: {'DISPLAY': ':0', 06:12:13 INFO - 'HOME': '/home/cltbld', 06:12:13 INFO - 'LANG': 'en_US.UTF-8', 06:12:13 INFO - 'LANGUAGE': 'en_US:en', 06:12:13 INFO - 'LOGNAME': 'cltbld', 06:12:13 INFO - 'MAIL': '/var/mail/cltbld', 06:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:13 INFO - 'MOZ_NO_REMOTE': '1', 06:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:13 INFO - 'NO_EM_RESTART': '1', 06:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:13 INFO - 'PWD': '/builds/slave/test', 06:12:13 INFO - 'SHELL': '/bin/bash', 06:12:13 INFO - 'SHLVL': '1', 06:12:13 INFO - 'TERM': 'linux', 06:12:13 INFO - 'TMOUT': '86400', 06:12:13 INFO - 'USER': 'cltbld', 06:12:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:13 INFO - '_': '/tools/buildbot/bin/python'} 06:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:12:13 INFO - Cleaning up... 06:12:13 INFO - Return code: 0 06:12:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:13 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')]} 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 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')]} 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:13 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 06:12:13 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 06:12:13 INFO - Using env: {'DISPLAY': ':0', 06:12:13 INFO - 'HOME': '/home/cltbld', 06:12:13 INFO - 'LANG': 'en_US.UTF-8', 06:12:13 INFO - 'LANGUAGE': 'en_US:en', 06:12:13 INFO - 'LOGNAME': 'cltbld', 06:12:13 INFO - 'MAIL': '/var/mail/cltbld', 06:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:13 INFO - 'MOZ_NO_REMOTE': '1', 06:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:13 INFO - 'NO_EM_RESTART': '1', 06:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:13 INFO - 'PWD': '/builds/slave/test', 06:12:13 INFO - 'SHELL': '/bin/bash', 06:12:13 INFO - 'SHLVL': '1', 06:12:13 INFO - 'TERM': 'linux', 06:12:13 INFO - 'TMOUT': '86400', 06:12:13 INFO - 'USER': 'cltbld', 06:12:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:13 INFO - '_': '/tools/buildbot/bin/python'} 06:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:15 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 06:12:15 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 06:12:15 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 06:12:15 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 06:12:15 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 06:12:15 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 06:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:16 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 06:12:16 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 06:12:16 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 06:12:16 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 06:12:16 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 06:12:16 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 06:12:16 INFO - Downloading docopt-0.6.1.tar.gz 06:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:16 INFO - Running setup.py install for blobuploader 06:12:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:16 INFO - Running setup.py install for requests 06:12:16 INFO - Running setup.py install for docopt 06:12:16 INFO - Successfully installed blobuploader requests docopt 06:12:16 INFO - Cleaning up... 06:12:17 INFO - Return code: 0 06:12:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:17 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')]} 06:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:17 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')]} 06:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:17 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:17 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 06:12:17 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 06:12:17 INFO - Using env: {'DISPLAY': ':0', 06:12:17 INFO - 'HOME': '/home/cltbld', 06:12:17 INFO - 'LANG': 'en_US.UTF-8', 06:12:17 INFO - 'LANGUAGE': 'en_US:en', 06:12:17 INFO - 'LOGNAME': 'cltbld', 06:12:17 INFO - 'MAIL': '/var/mail/cltbld', 06:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:17 INFO - 'MOZ_NO_REMOTE': '1', 06:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:17 INFO - 'NO_EM_RESTART': '1', 06:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:17 INFO - 'PWD': '/builds/slave/test', 06:12:17 INFO - 'SHELL': '/bin/bash', 06:12:17 INFO - 'SHLVL': '1', 06:12:17 INFO - 'TERM': 'linux', 06:12:17 INFO - 'TMOUT': '86400', 06:12:17 INFO - 'USER': 'cltbld', 06:12:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:17 INFO - '_': '/tools/buildbot/bin/python'} 06:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:17 INFO - Running setup.py (path:/tmp/pip-g6F7Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:17 INFO - Running setup.py (path:/tmp/pip-MlgY4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:17 INFO - Running setup.py (path:/tmp/pip-4gyQzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:17 INFO - Running setup.py (path:/tmp/pip-_TTuSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:17 INFO - Running setup.py (path:/tmp/pip-_8nbKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:17 INFO - Running setup.py (path:/tmp/pip-xi41rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:17 INFO - Running setup.py (path:/tmp/pip-ALKz5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:17 INFO - Running setup.py (path:/tmp/pip-QyXRgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:17 INFO - Running setup.py (path:/tmp/pip-hNt9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:17 INFO - Running setup.py (path:/tmp/pip-l0gRPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:17 INFO - Running setup.py (path:/tmp/pip-JqHgB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:18 INFO - Running setup.py (path:/tmp/pip-3VEYyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:18 INFO - Running setup.py (path:/tmp/pip-O6A6rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:18 INFO - Running setup.py (path:/tmp/pip-DtgJSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:18 INFO - Running setup.py (path:/tmp/pip-TDM4cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:18 INFO - Running setup.py (path:/tmp/pip-tZOAo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:18 INFO - Running setup.py (path:/tmp/pip-OAUaRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:18 INFO - Running setup.py install for manifestparser 06:12:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:18 INFO - Running setup.py install for mozcrash 06:12:18 INFO - Running setup.py install for mozdebug 06:12:18 INFO - Running setup.py install for mozdevice 06:12:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:18 INFO - Running setup.py install for mozfile 06:12:18 INFO - Running setup.py install for mozhttpd 06:12:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozinfo 06:12:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozInstall 06:12:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozleak 06:12:19 INFO - Running setup.py install for mozlog 06:12:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for moznetwork 06:12:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozprocess 06:12:19 INFO - Running setup.py install for mozprofile 06:12:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozrunner 06:12:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:19 INFO - Running setup.py install for mozscreenshot 06:12:20 INFO - Running setup.py install for moztest 06:12:20 INFO - Running setup.py install for mozversion 06:12:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:20 INFO - Cleaning up... 06:12:20 INFO - Return code: 0 06:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:20 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:20 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 06:12:20 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 06:12:20 INFO - Using env: {'DISPLAY': ':0', 06:12:20 INFO - 'HOME': '/home/cltbld', 06:12:20 INFO - 'LANG': 'en_US.UTF-8', 06:12:20 INFO - 'LANGUAGE': 'en_US:en', 06:12:20 INFO - 'LOGNAME': 'cltbld', 06:12:20 INFO - 'MAIL': '/var/mail/cltbld', 06:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:20 INFO - 'MOZ_NO_REMOTE': '1', 06:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:20 INFO - 'NO_EM_RESTART': '1', 06:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:20 INFO - 'PWD': '/builds/slave/test', 06:12:20 INFO - 'SHELL': '/bin/bash', 06:12:20 INFO - 'SHLVL': '1', 06:12:20 INFO - 'TERM': 'linux', 06:12:20 INFO - 'TMOUT': '86400', 06:12:20 INFO - 'USER': 'cltbld', 06:12:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:20 INFO - '_': '/tools/buildbot/bin/python'} 06:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:20 INFO - Running setup.py (path:/tmp/pip-m6hVvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:20 INFO - Running setup.py (path:/tmp/pip-3TB01z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:20 INFO - Running setup.py (path:/tmp/pip-MBMW6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:20 INFO - Running setup.py (path:/tmp/pip-VEbvAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:20 INFO - Running setup.py (path:/tmp/pip-17ZzvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:20 INFO - Running setup.py (path:/tmp/pip-2cqzT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:20 INFO - Running setup.py (path:/tmp/pip-PlOMo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:20 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)) 06:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:20 INFO - Running setup.py (path:/tmp/pip-Yaewtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:21 INFO - Running setup.py (path:/tmp/pip-GCFObt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:21 INFO - Running setup.py (path:/tmp/pip-FNGYyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:21 INFO - Running setup.py (path:/tmp/pip-8jMMPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:21 INFO - Running setup.py (path:/tmp/pip-QnaHMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:21 INFO - Running setup.py (path:/tmp/pip-VjDBUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:21 INFO - Running setup.py (path:/tmp/pip-tXLGGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:21 INFO - Running setup.py (path:/tmp/pip-PZcqhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:21 INFO - Running setup.py (path:/tmp/pip-o9bhLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:21 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)) 06:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:21 INFO - Running setup.py (path:/tmp/pip-cuOFPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:21 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)) 06:12:21 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)) 06:12:21 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)) 06:12:21 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)) 06:12:21 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)) 06:12:21 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)) 06:12:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:21 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 06:12:21 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 06:12:21 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 06:12:21 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 06:12:21 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 06:12:21 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 06:12:23 INFO - Downloading blessings-1.6.tar.gz 06:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:23 INFO - Installing collected packages: blessings 06:12:23 INFO - Running setup.py install for blessings 06:12:23 INFO - Successfully installed blessings 06:12:23 INFO - Cleaning up... 06:12:23 INFO - Return code: 0 06:12:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:24 INFO - Reading from file tmpfile_stdout 06:12:24 INFO - Current package versions: 06:12:24 INFO - argparse == 1.2.1 06:12:24 INFO - blessings == 1.6 06:12:24 INFO - blobuploader == 1.2.4 06:12:24 INFO - docopt == 0.6.1 06:12:24 INFO - functools32 == 3.2.3-2 06:12:24 INFO - jsonschema == 2.5.1 06:12:24 INFO - manifestparser == 1.1 06:12:24 INFO - mozInstall == 1.12 06:12:24 INFO - mozcrash == 0.17 06:12:24 INFO - mozdebug == 0.1 06:12:24 INFO - mozdevice == 0.48 06:12:24 INFO - mozfile == 1.2 06:12:24 INFO - mozhttpd == 0.7 06:12:24 INFO - mozinfo == 0.9 06:12:24 INFO - mozleak == 0.1 06:12:24 INFO - mozlog == 3.4 06:12:24 INFO - moznetwork == 0.27 06:12:24 INFO - mozprocess == 0.23 06:12:24 INFO - mozprofile == 0.28 06:12:24 INFO - mozrunner == 6.12 06:12:24 INFO - mozscreenshot == 0.1 06:12:24 INFO - mozsystemmonitor == 0.3 06:12:24 INFO - moztest == 0.7 06:12:24 INFO - mozversion == 1.4 06:12:24 INFO - psutil == 3.1.1 06:12:24 INFO - requests == 1.2.3 06:12:24 INFO - wsgiref == 0.1.2 06:12:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:24 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')]} 06:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 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')]} 06:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:24 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 06:12:24 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 06:12:24 INFO - Using env: {'DISPLAY': ':0', 06:12:24 INFO - 'HOME': '/home/cltbld', 06:12:24 INFO - 'LANG': 'en_US.UTF-8', 06:12:24 INFO - 'LANGUAGE': 'en_US:en', 06:12:24 INFO - 'LOGNAME': 'cltbld', 06:12:24 INFO - 'MAIL': '/var/mail/cltbld', 06:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:24 INFO - 'MOZ_NO_REMOTE': '1', 06:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:24 INFO - 'NO_EM_RESTART': '1', 06:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:24 INFO - 'PWD': '/builds/slave/test', 06:12:24 INFO - 'SHELL': '/bin/bash', 06:12:24 INFO - 'SHLVL': '1', 06:12:24 INFO - 'TERM': 'linux', 06:12:24 INFO - 'TMOUT': '86400', 06:12:24 INFO - 'USER': 'cltbld', 06:12:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:24 INFO - '_': '/tools/buildbot/bin/python'} 06:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 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)) 06:12:24 INFO - Cleaning up... 06:12:24 INFO - Return code: 0 06:12:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:24 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')]} 06:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 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')]} 06:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 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 0x7f58a89fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c41ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', '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 06:12:24 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 06:12:24 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 06:12:24 INFO - Using env: {'DISPLAY': ':0', 06:12:24 INFO - 'HOME': '/home/cltbld', 06:12:24 INFO - 'LANG': 'en_US.UTF-8', 06:12:24 INFO - 'LANGUAGE': 'en_US:en', 06:12:24 INFO - 'LOGNAME': 'cltbld', 06:12:24 INFO - 'MAIL': '/var/mail/cltbld', 06:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:24 INFO - 'MOZ_NO_REMOTE': '1', 06:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:24 INFO - 'NO_EM_RESTART': '1', 06:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:24 INFO - 'PWD': '/builds/slave/test', 06:12:24 INFO - 'SHELL': '/bin/bash', 06:12:24 INFO - 'SHLVL': '1', 06:12:24 INFO - 'TERM': 'linux', 06:12:24 INFO - 'TMOUT': '86400', 06:12:24 INFO - 'USER': 'cltbld', 06:12:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:24 INFO - '_': '/tools/buildbot/bin/python'} 06:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:24 INFO - Cleaning up... 06:12:24 INFO - Return code: 0 06:12:24 INFO - Running post-action listener: _resource_record_post_action 06:12:24 INFO - Running post-action listener: _start_resource_monitoring 06:12:24 INFO - Starting resource monitoring. 06:12:24 INFO - [mozharness: 2016-11-09 14:12:24.620031Z] Finished create-virtualenv step (success) 06:12:24 INFO - [mozharness: 2016-11-09 14:12:24.620542Z] Running install step. 06:12:24 INFO - Running pre-action listener: _resource_record_pre_action 06:12:24 INFO - Running main action method: install 06:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:24 INFO - Reading from file tmpfile_stdout 06:12:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:24 INFO - Reading from file tmpfile_stdout 06:12:24 INFO - Output received: 06:12:24 INFO - Usage: mozinstall [options] installer 06:12:24 INFO - Options: 06:12:24 INFO - -h, --help show this help message and exit 06:12:24 INFO - -d DEST, --destination=DEST 06:12:24 INFO - Directory to install application into. [default: 06:12:24 INFO - "/builds/slave/test"] 06:12:24 INFO - --app=APP Application being installed. [default: firefox] 06:12:24 INFO - mkdir: /builds/slave/test/build/application 06:12:24 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'] 06:12:24 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 06:12:41 INFO - Reading from file tmpfile_stdout 06:12:41 INFO - Output received: 06:12:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:41 INFO - Running post-action listener: _resource_record_post_action 06:12:41 INFO - [mozharness: 2016-11-09 14:12:41.038899Z] Finished install step (success) 06:12:41 INFO - [mozharness: 2016-11-09 14:12:41.039140Z] Running run-tests step. 06:12:41 INFO - Running pre-action listener: _resource_record_pre_action 06:12:41 INFO - Running main action method: run_tests 06:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:41 INFO - Python 2.7.3 06:12:41 INFO - Return code: 0 06:12:41 INFO - grabbing minidump binary from tooltool 06:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:41 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 0x1c3ef60>, '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 0x1c3fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c401d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:41 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 06:12:41 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 06:12:41 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 06:12:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:41 INFO - Return code: 0 06:12:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 06:12:41 INFO - Using env: {'DISPLAY': ':0', 06:12:41 INFO - 'HOME': '/home/cltbld', 06:12:41 INFO - 'LANG': 'en_US.UTF-8', 06:12:41 INFO - 'LANGUAGE': 'en_US:en', 06:12:41 INFO - 'LOGNAME': 'cltbld', 06:12:41 INFO - 'MAIL': '/var/mail/cltbld', 06:12:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:41 INFO - 'MOZ_NO_REMOTE': '1', 06:12:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:41 INFO - 'NO_EM_RESTART': '1', 06:12:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:41 INFO - 'PWD': '/builds/slave/test', 06:12:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:41 INFO - 'SHELL': '/bin/bash', 06:12:41 INFO - 'SHLVL': '1', 06:12:41 INFO - 'TERM': 'linux', 06:12:41 INFO - 'TMOUT': '86400', 06:12:41 INFO - 'USER': 'cltbld', 06:12:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242', 06:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:41 INFO - '_': '/tools/buildbot/bin/python'} 06:12:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:12:41 INFO - mozversion application_buildid: 20161109044522 06:12:41 INFO - mozversion application_changeset: 3466e6bc9874e5d7e53649d594ab70af9af2e358 06:12:41 INFO - mozversion application_display_name: Nightly 06:12:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:41 INFO - mozversion application_name: Firefox 06:12:41 INFO - mozversion application_remotingname: firefox 06:12:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 06:12:41 INFO - mozversion application_vendor: Mozilla 06:12:41 INFO - mozversion application_version: 52.0a1 06:12:41 INFO - mozversion platform_buildid: 20161109044522 06:12:41 INFO - mozversion platform_changeset: 3466e6bc9874e5d7e53649d594ab70af9af2e358 06:12:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 06:12:41 INFO - mozversion platform_version: 52.0a1 06:12:41 INFO - using testdate: 1478700761 06:12:41 INFO - actual date: 1478700761 06:12:41 INFO - starting webserver on 'localhost:58660' 06:12:41 INFO - SUITE-START | Running 2 tests 06:12:41 INFO - TEST-START | dromaeo_css 06:12:41 INFO - operating with platform_type : linux_ 06:12:41 INFO - Initialising browser for dromaeo_css test... 06:12:41 INFO - TEST-INFO | started process 2100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41PKK2/profile http://localhost:58660/getInfo.html) 06:12:45 INFO - PROCESS | 2100 | __metrics Screen width/height:1600/1200 06:12:45 INFO - PROCESS | 2100 | colorDepth:24 06:12:45 INFO - PROCESS | 2100 | Browser inner width/height: 1024/697 06:12:45 INFO - PROCESS | 2100 | __metrics 06:12:46 INFO - PROCESS | 2100 | 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" 06:12:46 INFO - PROCESS | 2100 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:47 INFO - TEST-INFO | 2100: exit 0 06:12:47 INFO - Browser initialized. 06:12:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:47 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41PKK2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:00 INFO - PROCESS | 2184 | RSS: Main: 176181248 06:13:00 INFO - PROCESS | 2184 | 06:13:51 INFO - PROCESS | 2184 | 1478700831682 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] 06:16:05 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58660/tests/dromaeo/cssquery-ext.html) 06:16:07 INFO - PROCESS | 2184 | RSS: Main: 318750720 06:16:07 INFO - PROCESS | 2184 | 06:19:09 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-ext.html (next: http://localhost:58660/tests/dromaeo/cssquery-jquery.html) 06:19:10 INFO - PROCESS | 2184 | RSS: Main: 279322624 06:19:10 INFO - PROCESS | 2184 | 06:22:12 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58660/tests/dromaeo/cssquery-mootools.html) 06:22:13 INFO - PROCESS | 2184 | RSS: Main: 225480704 06:22:13 INFO - PROCESS | 2184 | 06:25:15 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58660/tests/dromaeo/cssquery-prototype.html) 06:25:15 INFO - PROCESS | 2184 | RSS: Main: 224055296 06:25:15 INFO - PROCESS | 2184 | 06:28:18 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58660/tests/dromaeo/cssquery-yui.html) 06:28:19 INFO - PROCESS | 2184 | RSS: Main: 225304576 06:28:19 INFO - PROCESS | 2184 | 06:31:22 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-yui.html (next: http://localhost:58660/tests/dromaeo/cssquery-dojo.html) 06:31:23 INFO - PROCESS | 2184 | RSS: Main: 317042688 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | __start_tp_report 06:31:23 INFO - PROCESS | 2184 | _x_x_mozilla_page_load 06:31:23 INFO - PROCESS | 2184 | _x_x_mozilla_page_load_details 06:31:23 INFO - PROCESS | 2184 | |i|pagename|runs| 06:31:23 INFO - PROCESS | 2184 | |0;dojo.html;2549.247971848305;2564;2581.4191806843455;2600.42790586071;2614.307208589723;4530.7281563106235;4589.472210695771;4608.654350923682;4665.276882083278;4692.460367057789;4616.561426664462;4622.5377462253755;4622.560856718615;4626.3523106765;4640.535946405358;4233.132207897382;4260.936085958698;4262.126264115849;4290.935635965448;4350.36919646651;4380.255356589388;4397.494288156871;4398.670099742532;4411.779411029452;4418.801153948064;4266.12544428393;4279.1227798301425;4294.184105020052;4314.892127696801;4400.8019639116155;4370.4318438603095;4371.519132895379;4376.146651402978;4383.430154079949;4386.078923426085;4210.094829611618;4258.74447533149;4261.893452663678;4272.743635381887;4277.657787377002;4421.579949904753;4574.542545745432;4640.048789998043;4641.582257596799;4676.8363107291425;4966.701997880139;4980.128477516457;5039.924401133986;5041.899162016776;5042.4201216860165;4856.53862883022;5063.620228482841;5067.847964561069;5068.619853510964;5112.309838171836;4567.748773817406;4636.6058884995155;4641.466231383434;4667.673262871566;4677.438707355139;5106.693598384109;5112.616553758483;5131.846044618667;5134.332536770271;5181.171012638035;4915.11527924977;4937.160682683881;4938.851834444972;4939.333190019302;4988.251762235694;4848.878778030577;4905.705657660552;4906.90186196274;4932;4935.87660308488;4961.603071754251;4964;4997.30037794709;5000.549950504472;5007.549320561094;4930.211166213388;4938.135826230396;4938.358013458227;4938.827141050046;4986.576141027981;4106.137711080647;4130.772807495617;4202.789860507023;4213.557576454489;4243.872683819491;3666.834992425294;3682.779033258013;3704.073981504624;3709.9072523186596;3771.7548359356556;4255.404243405926;4267.701260911706;4275.422817919541;4278.507971583245;4323.740575565476;4977.377827771528;4989.326440930428;5027.924581131286;5034.421041580265;5078.289039534468;4153.626173644387;4196.118815048874;4247.617714405718;4286.442762440863;4288.463942007249;4547;4547.295169248771;4548.95451045492;4564.97717511417;4599.0342028174455;4712.316714076508;4717.528247175255;4721.7403042832975;4725.527447255385;4763.595094417014;4910;4973.353464049796;4980.128477516492;5066.012127635223;5073.2897394365555;4632.444106707217;4672.9532704673875;4687.67186296956;4701.553352431513;4731.6214702823;4962.379702537183;4965.577925876341;4966.379202599675;4967.925481117713;5006.924896126634;4893.045856058035;5014.373203349582;5027.3464449621315;5027.673201242053;5074.162763144188;4815.349927759848;4849.078675051729;4856.68431551948;4881.8535443936735;4951.405831300267;4881.096997055556;4892.706437613754;4896.510348965075;4897.779599917941;4902.240152776325;4779.446679829;4813.566778989908;4829.710217386968;4833.468318485035;4884.8290309838985;4819.566239038503;4877.487863774252;4881.682690625098;4901.264810278487;4911.607071434205;4822.228443449031;4823.1800593899825;4831.758412079312;4844.0554091951735;4878.9512104878495 06:31:23 INFO - PROCESS | 2184 | |1;ext.html;550.4660479335045;550.4660479335046;559.42099926576;562.6989560585083;573.160320131008;27875.581866271998;28434.289142771442;38723.22553548928;39229;39518.802405988004;39913;40357;40363.59636403635;40425.19149617006;40468.79765601168;7534.0582427196605;7710.691572337099;7715.845683086335;7718.305352518272;7719.72980945667;7548.622568871535;7601.8479630407355;7629.618519074052;7632.771016869475;7635.312821846032;7641.732539361124;7686.846263074735;7688.077430708323;7693.30760231579;7697.8075548111465;7580.393568514533;7616.314531692146;7620.504667196615;7623.428242881806;7629.8855517167285;7561.621918904033;7628.19903910087;7630.351420129296;7634.694612215505;7635.350995165418;38010.42984355209;38365.424518632244;38371.424428633596;38433.61566384328;38459.42310865339;2909.011698425203;3097.132802815215;3178.8092714436975;3222.548843161959;3316.3864685033345;27866.16401507958;27986.3003424914;28002;28087.15738527827;28089.719102808915;3369.090345606697;3536.1159710072484;3537.8231088445473;3566.5185199997927;3647.3981793004123;232447.83776081182;233294;233373;233400;234443;50218.49781502138;50496.747516262185;50558.49441505538;50611;50618.74690626597;52928.73535632297;53020.73489632527;53022.469775302525;53031.734841325546;53073.734631326595;13801.516946907012;13848.09987350839;13865.098768580212;13898.791518127236;14034.85965140356;10729.409882456539;10809.729756755987;10813.567457301777;10813.837792432962;10818.729531761768;13017.479300827861;15034.849651503564;15105.54683359501;15132.167730774692;15365.308561114776;4873.257602063609;5500.147477141049;5618.887622247532;5685.346185188673;5737.196792449061;835.4527784301292;869.3262721390846;872.9476231426135;893.5710858787688;947.516766449116;24462.266132015713;26849.86575067112;27365.179044628694;27490.17529474119;27539.86230068877;921.8432866412726;941.2328951904176;941.9105185007413;958.4632605740808;961.1685891703626;14177.503787367392;14371.712565748627;14533.927330363493;14574.271286435636;14807;330043;331275;332614;333211;333565;48111;48356.7582162094;48410;48457.75771121122;48486.5151348482;1059.8251288537458;1099.598646494024;1148.5405837664835;1169.6198735411026;1181.6041626055369;25000;27920.441591167655;28014.43971120607;28604.124710785713;28668;40422.1915561693;40812.38781418222;40938.38592421057;40969;40976.1804763909;221106;221538;221668;221940;222678;23407.53184936326;24120.758792412555;24143.15498957528;34986.82506587451;35372.646273536935;39081.609183908935;40634.79682601686;40643.7967810159;40934.18131637291;41039.1792164161;34148.31703365968;34422.82788586041;34530;34682.30635387329;34818.30363392668;33663.83168084144;34300.48549271813;34339.313213735084;34685.65314346925;34936.47595286022;34518;34520.48219276663;34720;34764.47853282152;36545.26909461849;27394.315142121606;28975;31029.224269393446;31259.374812504077;31914;24313.878430607732;24558.263252102464;24663.630045548973;25004.249872503853;25095.49809003773 06:31:23 INFO - PROCESS | 2184 | |2;jquery.html;348.36597392745216;361.2828535357317;366.60223657331795;370.81273956651887;385.1468996173475;12497.750044999095;13035.348232588369;15470.845291547095;16213.918930405362;16328.75506867398;15994.60013499663;16153.43462978796;16161;16194.947328423645;16233.512994610152;4767.833125840579;4836.733979631128;4916.385451818523;4943.8516844494725;4944.035912996967;3686.3548878946212;3876.7673939563715;4848.781804818792;4943.876403089934;5528.834134975958;5716.1997320375185;5834.329052158992;5839.883202335951;5843.006688862883;5846.386129456409;5576.553875689935;5717.714114294268;5739.225204597367;5739.885202295973;5827.329857066449;5044.218146187347;5093.923591146136;5104.668196567249;5109.770060347256;5118.564921981636;19056.333028343943;19151.80848191514;19705.802941970684;19740.90129549343;19796.70304945427;1790.5881647221213;1924.7112933060152;2007.1469625409288;2156.1914282144194;2321.5472982768365;8646.005709343443;8931.910680893174;9222.170004699608;9409.811803763954;9446.055394460567;1549.7752825840303;1614.1041721844372;1619.5141457562802;1752.4041825779168;1820.8907465552109;65659.67170164119;66057.66971165162;68063.31936680619;70071.64964175198;73074.63462682706;9405;9514.47670378122;9728.464934428674;9908.108270255567;10062.899371006342;13522.053456258163;13523.188608683511;13528.59414217575;13546.661333466545;13550.84817790479;6744.730210791611;7125.92874071263;7147.89278160828;7233.457490688114;7295.161056478573;6715.764948226789;6746.730130794714;6926.549774264657;6956.0609317741455;6991.335823096798;4178.582141785858;4187.895302617398;4230.386593943861;4248.2565551029065;4267.317229243368;1822.4714832698369;1829.2591500442343;1835.651226267005;1846.7876194237836;1878.5303674081479;792.6868886789802;807.7051876065194;814.5316443045273;840.2185967050701;851.9318454523623;14977.475788347356;15599.142047187514;15808.209589520478;15881.205939702968;16525.091119988276;821.6261600971544;850.9064002959669;862.6376921692904;868.8740132680726;893.066745251214;8757.605907734167;8848.026717061119;9206.125418085272;9260.120288572574;9264.95367523158;345245;365031;365393;365993;367673;71964.64017679983;76088.23911760922;78211.60894195492;79285.20714792893;79304;870.9630279117371;875.1554749666602;896.0278098263327;897.4032268541478;897.6768363389175;14249.857501424853;14379.20914349679;14529.709405812036;14632.780508292171;15166.924165379103;35470.11324716903;36255.27489450249;36641.81679091587;36988.260234794616;37072.44391334078;47250.291245632034;47945;48049.75975120102;48277.275840861716;48286.5171348282;7468.103827540513;7469.7385591504035;7475.2151024141685;7489.66296516669;7554.811129721581;10633.415162166155;11005.284656497302;11075.335479871233;11122.666320010412;11178.55285788592;9257.703921451137;9734.513274336396;9795.167410770164;9863.802723945624;10204.336718113596;9877.753056173653;9884.604615815288;10088.646897358558;10147.543360548942;10244.282900197213;9949.204063674744;9962.651307204213;10183.592656293962;10187.694369168938;10367.844482332923;7322.194558598657;7343.8531229376185;7412.518186317872;7470.663820127998;7510.934493014464;8855.424397414148;9718.75703107428;9991;10005.349652272578;10323.432211228153 06:31:23 INFO - PROCESS | 2184 | |3;mootools.html;1217.2818037357956;1355.966100847479;1400.4818217259615;1471.5953112893953;1693.1788082779842;6196.2564492260935;6520.739170433183;6840.2133754618235;7009.439244860411;7031.1211098612675;7019.262977387378;7075.575465472062;7083.043789088471;7085.504014718972;7085.610291433969;2097.5595125023765;2123.7132987046707;2125.2667829598763;2125.404886631738;2129.116416687073;2063.350044735911;2131.3179782469615;2151.429871084164;2154.041451554059;2154.062982602565;2080.240712140073;2084.405944305873;2101.2120454829437;2101.8423618228617;2145.9248926287582;2022.9986156852378;2046;2049.733534640502;2049.86675866069;2050.7744148143693;2078.7609424916177;2078.98960505198;2100.432883121564;2110.6306396380573;2112.9577408451746;6977.616231107287;7040.788776336718;7049.259827718119;7053.294670532906;7330.157031941341;4534.5692159245145;4685.20351540239;4692.319613656035;4715.127701375257;4719.976400118012;2761.8895244190207;3022.304869879918;3073.2470544716466;3073.9538906916414;3080.291532947412;927.1979737527058;950.6245033211911;954.0268925695821;964.686476895005;982.0425085541611;9894.9505252474;10008.049235322633;10009.649662261785;10027.699169024942;10037.29738918276;4023.2154729827403;4171.186618609403;4317.395564620955;4323.2434323993175;4415.712978656377;7942.722004729807;8024.317932975646;8028.438009339407;8030.478018928751;8036.4776289541;4652.209124448852;4655.441347038377;4657.4876763555985;4662.184117779443;4662.953370466252;3464.6881780639865;3560.8219589020446;3736.981315093407;4308.138372325548;4316.374125751749;3337.6829201225846;3349.296647703961;3422.8117453539794;3460.6885380315894;3465.3242617689307;1065.169168048923;1074.4520294649628;1078.5577913055608;1079.6329248055542;1081.1512962324537;738.7229788829189;745.1654147354997;770.7726220764888;777.2421888658625;818.2553875972836;4719.10337035962;4851.126797176542;4982.526659967298;4988.4263309719845;5254.474552544715;794.4756460735887;844.3793811548506;860.5912191708888;861.1216559109673;866.5320726807579;3212.8072315661134;3232;3238.498032804919;3263.7552183586326;3358;8798;8958;9069.59186836594;9079.046700096394;9095.636174552943;8812.471251724788;9024.413413128126;9029.729108126767;9031.954840225757;9040.457572545669;6996.720131194696;7169.068021157216;7176.174739904874;7178;7182.856342873113;4811.109944660249;4878.193966992495;5001.524855138756;5048.1165795984825;5098.133317335987;8221.835563288581;8363.080061193143;8366.414350995372;8391.16088391156;8459.407841451039;8427;8561.914380856111;8569.614367353359;8623.094575069528;8657.870131948152;5999.4900433463645;6104.633721976696;6104.69476526163;6105.572609917263;6205.782797602063;6985.441164706913;7095.858082838211;7130.821729456805;7154;7169.068021157216;6462.7091780870915;6563.1796025496815;6569.605823650596;6574.539782215199;6576.112224849584;6244.718987645476;6299.212598425197;6355.936440635534;6417.550771445954;6473.935260647333;5851.795187168429;5974.492168165754;5991.041433370814;5995.640261584319;6004;4284.571542845691;4304.74171549708;4345;4408.845690400821;4443.022535042285;4404.4494438195225;4407.515173330995;4465.12929978651;4582.9541704582525;4612.907741845212 06:31:23 INFO - PROCESS | 2184 | |4;prototype.html;283.2084324313544;292.93116117712333;297.58784084043606;303.4810474089307;304.71356924490976;4741.431028276607;4771.689840160388;4782.426108866936;4802.255650374198;4806;4671.182543054969;4714.292856071591;4716.36329095572;4733.502982186872;4737.644676649248;3515.261795023042;3592.8383222755037;3620.9094772630633;3668.651478109589;3695.7412981091334;3693.261347730465;3697.6302369762943;3703.592604813482;3712.7215458840697;3715.3683873741393;3635.981820090896;3646.5988741238443;3656.195636959878;3660.4875317455444;3666.5966743658178;3499.6675315844955;3535.4696795480627;3605.9098522537015;3643.7631553949172;3658.32321020612;3212.983935080333;3231.804232433991;3236.886708965175;3240.493170675624;3243.3026899216784;4545.818167273305;4551.658625603093;4552.68131230814;4559.658025648089;4559.863204103882;3835;4072.165206132736;4088.7751173685438;4095.754254744695;4116.711830171889;4851.175300198975;4860.586850117709;4871.488493708145;4877.902441951142;4878.658493905428;3426.3832510148163;3434.5191673165778;3436.1409647588102;3446.724262059029;3448.1724386147393;4983.401991761012;5129.461406552296;5143.922841157386;5153.536181743623;5157.8452646420665;3519;3521.6478352164577;3524.7356448266482;3528.629493903103;3535.3636345458062;3568.715262505496;3579.3736096183065;3582.7492075554983;3583.8208089595414;3588.7667301625834;4087.4277601135864;4102.200070986189;4104;4114.5679703630685;4125.752454852658;4709.364235828188;4857.465678775332;4907.116718990616;4922.704637721748;4929.383827021622;1184.4788293150987;1189.8096304591397;1190.4642910690052;1211.8545774507115;1213.6783752305469;785.6346798738614;806.1938061938062;816.1267443835159;822.3914303415429;825.4015838517028;4164.416981622575;4191.952011997001;4263.829446822155;4331.45856767904;4336.005437498786;5033.270175824485;5060.1903695408555;5060.7216603086445;5065.645404821701;5072.898542029138;4333.743214467769;4337.891552711144;4342.240107981091;4345.630621397217;4354.646921870142;2493.4140476987895;2574.819762616636;2581.096616184358;2583.6899572051097;2614.3398941672176;4507.6168525675685;4545.045630378969;4551;4558.997020655451;4616.469106052847;4978.701277923336;4993.525615066563;5007.349044624176;5008.84973450797;5016.774245158977;4457.8439754608435;4571.519990401027;4743;4768.856934292046;4779.115863565252;5062.746862656926;5089.923651145162;5099.745012749422;5104.285400044071;5116.74416279192;5004.824831131039;5021.899562008666;5036.057452206432;5036.823711170092;5061.898762024665;4662.696924699883;4730.668853180382;4755.145493257702;4759.381280433521;4760.452547956891;3540.345036168317;3545.2023294758474;3561.893143205708;3570.500389836327;3582.1760994971823;5112.590992720648;5114.2840002400435;5118.616103792156;5120.48795120485;5130.820421285237;4770.235013045195;4892.951070489249;4895.265710143507;4899.191633380452;5002.6498145130945;4878.463369029475;4878.853634390974;4884.389451318585;4887;4896.6327525436445;4829.468758436639;4830.903381932412;4832.226843704991;4835.468098509232;4853.563179313879;4737.742727475579;4887.36464259644;4914.238293064581;4950.678205916748;4965.205567109245;4796.208625576741;4806.53400712786;4814.446338671098;4818.518148185153;4830.227163653799 06:31:23 INFO - PROCESS | 2184 | |5;yui.html;663.3399767231602;665.2283351312478;693.7086423702044;697.6686074114793;707.2927072927072;12516;13043.478260869553;13100.082994190387;13144.47422103116;13156.868431315685;12185.817212741817;12322.691932701664;12335.753284934319;12340.136190466648;12343.382830858465;614.4869034356318;632.2823595219413;700.1178515071022;713.1371041040321;751.2975368030882;753.6457864803533;756.3646536908996;756.4440136499668;756.9280918312779;757.0801476206408;805.3275514945028;806.5967016491754;806.8426656801926;807.1524898856206;807.1524898856206;632.0677001422888;650.2229835346762;653.2389765922694;654.7839213059679;798.8162722573811;562.3476766950319;582.9475347218771;584.3484514766047;584.3659629302213;584.9210356601847;11522.539098436053;11549.13381496391;11909.285442873455;11948.402579871059;11971.940140299243;11755.235909665844;11941;12226.877731222663;12286.631401057894;12328.5068597256;10645.361278323326;10843.240973131884;11050.447477626087;11154.776904461865;11595.304281743123;3948.763074215556;3962.821673024692;3991.640752332304;4080.0819815541563;4091.7954102295066;47713.76143119297;48008.27987580224;48263.75868120637;48430.27354589684;49013;9919.950400247953;9963.402195868272;9978.800423991479;10082.49587520621;10150.695479135638;17238.741418878726;17394.043327617102;17409.390671326444;17508.912455437643;17515.912420437817;6274.686265686697;6342.207224096988;6429.935700643027;6592.945128779373;6699.39705426514;3618.2944325856733;3688.926221475609;3693.741438099361;3700.833462494194;3757.3800322946954;2622.763951244397;2689.623452716621;2695.393536454282;2698.1500827239356;2698.2984424049887;456.91002235101;458.5025247606318;469.786247257497;473.4602553089481;477.3388856433864;459.35231323833233;472.03490678302535;509.9770510327044;510.2321006884615;549.2941570082425;6927.411170050501;7035.824104397431;7072.135785007081;7376.704931802775;7488.288612581796;443.68276682171756;463.8237469761469;466.7129715225112;511.7799346281135;527.3592585009233;3354.530365748797;3422.1102513346214;3578.928421431609;3601.9639803602154;3651.050726811048;41611.58388416137;41852.58147418548;41869.1626167475;41938.580614193466;54413.11737652485;35309.29381412357;36112.63887361145;36158.81920590433;57122.63633735755;58259;50686.493135068915;51470.22794658083;51996.48003519992;52532.47467525276;53299.20051199235;7793.922060779547;8000.95999520022;8055.959720201361;8066.959665201636;8149.8370032600205;36156;37253.25493490169;37780.05549861275;38387.80806095952;39040.21919561536;29706.40587188201;35958.64041359658;47634.52365476301;48745.268820967;50182.749086254335;9932.453715045742;10007.249456290661;10344.741381465523;10525.263231573716;10948.343099413742;11392.658220253406;11550.013381838513;11645.941770291094;12134.757304853676;12332.445039973401;10256.28206025601;10906.563737450413;10963.451827408757;11143.721406964567;11146;11120.88879111231;11523.942380288045;11546.364949927834;11563.132765042823;11813.76372472563;10296.17630589536;10615.31000484966;10660.307080039773;10780.730481738019;10952.890471095187;9477.431354118775;9533.570989305637;9633.759156021155;9674.613015479583;9706.660266890625;9376.531173441164;9389.577469014048;9592.280578956466;9796.265280104164;9806.166475849634 06:31:23 INFO - PROCESS | 2184 | __end_tp_report 06:31:23 INFO - PROCESS | 2184 | __start_cc_report 06:31:23 INFO - PROCESS | 2184 | _x_x_mozilla_cycle_collect,1414 06:31:23 INFO - PROCESS | 2184 | __end_cc_report 06:31:23 INFO - PROCESS | 2184 | __startTimestamp1478701883012__endTimestamp 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | ------- Summary: start ------- 06:31:23 INFO - PROCESS | 2184 | Number of tests: 6 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#0] dojo.html Cycles:165 Average:4616.18 Median:4725.53 stddev:489.67 (10.4%) stddev-sans-first:463.55 06:31:23 INFO - PROCESS | 2184 | Values: 2549.2 2564.0 2581.4 2600.4 2614.3 4530.7 4589.5 4608.7 4665.3 4692.5 4616.6 4622.5 4622.6 4626.4 4640.5 4233.1 4260.9 4262.1 4290.9 4350.4 4380.3 4397.5 4398.7 4411.8 4418.8 4266.1 4279.1 4294.2 4314.9 4400.8 4370.4 4371.5 4376.1 4383.4 4386.1 4210.1 4258.7 4261.9 4272.7 4277.7 4421.6 4574.5 4640.0 4641.6 4676.8 4966.7 4980.1 5039.9 5041.9 5042.4 4856.5 5063.6 5067.8 5068.6 5112.3 4567.7 4636.6 4641.5 4667.7 4677.4 5106.7 5112.6 5131.8 5134.3 5181.2 4915.1 4937.2 4938.9 4939.3 4988.3 4848.9 4905.7 4906.9 4932.0 4935.9 4961.6 4964.0 4997.3 5000.5 5007.5 4930.2 4938.1 4938.4 4938.8 4986.6 4106.1 4130.8 4202.8 4213.6 4243.9 3666.8 3682.8 3704.1 3709.9 3771.8 4255.4 4267.7 4275.4 4278.5 4323.7 4977.4 4989.3 5027.9 5034.4 5078.3 4153.6 4196.1 4247.6 4286.4 4288.5 4547.0 4547.3 4549.0 4565.0 4599.0 4712.3 4717.5 4721.7 4725.5 4763.6 4910.0 4973.4 4980.1 5066.0 5073.3 4632.4 4673.0 4687.7 4701.6 4731.6 4962.4 4965.6 4966.4 4967.9 5006.9 4893.0 5014.4 5027.3 5027.7 5074.2 4815.3 4849.1 4856.7 4881.9 4951.4 4881.1 4892.7 4896.5 4897.8 4902.2 4779.4 4813.6 4829.7 4833.5 4884.8 4819.6 4877.5 4881.7 4901.3 4911.6 4822.2 4823.2 4831.8 4844.1 4879.0 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#1] ext.html Cycles:180 Average:41978.57 Median:19261.47 stddev:69953.85 (363.2%) stddev-sans-first:70080.94 06:31:23 INFO - PROCESS | 2184 | Values: 550.5 550.5 559.4 562.7 573.2 27875.6 28434.3 38723.2 39229.0 39518.8 39913.0 40357.0 40363.6 40425.2 40468.8 7534.1 7710.7 7715.8 7718.3 7719.7 7548.6 7601.8 7629.6 7632.8 7635.3 7641.7 7686.8 7688.1 7693.3 7697.8 7580.4 7616.3 7620.5 7623.4 7629.9 7561.6 7628.2 7630.4 7634.7 7635.4 38010.4 38365.4 38371.4 38433.6 38459.4 2909.0 3097.1 3178.8 3222.5 3316.4 27866.2 27986.3 28002.0 28087.2 28089.7 3369.1 3536.1 3537.8 3566.5 3647.4 232447.8 233294.0 233373.0 233400.0 234443.0 50218.5 50496.7 50558.5 50611.0 50618.7 52928.7 53020.7 53022.5 53031.7 53073.7 13801.5 13848.1 13865.1 13898.8 14034.9 10729.4 10809.7 10813.6 10813.8 10818.7 13017.5 15034.8 15105.5 15132.2 15365.3 4873.3 5500.1 5618.9 5685.3 5737.2 835.5 869.3 872.9 893.6 947.5 24462.3 26849.9 27365.2 27490.2 27539.9 921.8 941.2 941.9 958.5 961.2 14177.5 14371.7 14533.9 14574.3 14807.0 330043.0 331275.0 332614.0 333211.0 333565.0 48111.0 48356.8 48410.0 48457.8 48486.5 1059.8 1099.6 1148.5 1169.6 1181.6 25000.0 27920.4 28014.4 28604.1 28668.0 40422.2 40812.4 40938.4 40969.0 40976.2 221106.0 221538.0 221668.0 221940.0 222678.0 23407.5 24120.8 24143.2 34986.8 35372.6 39081.6 40634.8 40643.8 40934.2 41039.2 34148.3 34422.8 34530.0 34682.3 34818.3 33663.8 34300.5 34339.3 34685.7 34936.5 34518.0 34520.5 34720.0 34764.5 36545.3 27394.3 28975.0 31029.2 31259.4 31914.0 24313.9 24558.3 24663.6 25004.2 25095.5 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#2] jquery.html Cycles:180 Average:23123.23 Median:4930.12 stddev:59958.74 (1216.2%) stddev-sans-first:60102.55 06:31:23 INFO - PROCESS | 2184 | Values: 348.4 361.3 366.6 370.8 385.1 12497.8 13035.3 15470.8 16213.9 16328.8 15994.6 16153.4 16161.0 16194.9 16233.5 4767.8 4836.7 4916.4 4943.9 4944.0 3686.4 3876.8 4848.8 4943.9 5528.8 5716.2 5834.3 5839.9 5843.0 5846.4 5576.6 5717.7 5739.2 5739.9 5827.3 5044.2 5093.9 5104.7 5109.8 5118.6 19056.3 19151.8 19705.8 19740.9 19796.7 1790.6 1924.7 2007.1 2156.2 2321.5 8646.0 8931.9 9222.2 9409.8 9446.1 1549.8 1614.1 1619.5 1752.4 1820.9 65659.7 66057.7 68063.3 70071.6 73074.6 9405.0 9514.5 9728.5 9908.1 10062.9 13522.1 13523.2 13528.6 13546.7 13550.8 6744.7 7125.9 7147.9 7233.5 7295.2 6715.8 6746.7 6926.5 6956.1 6991.3 4178.6 4187.9 4230.4 4248.3 4267.3 1822.5 1829.3 1835.7 1846.8 1878.5 792.7 807.7 814.5 840.2 851.9 14977.5 15599.1 15808.2 15881.2 16525.1 821.6 850.9 862.6 868.9 893.1 8757.6 8848.0 9206.1 9260.1 9265.0 345245.0 365031.0 365393.0 365993.0 367673.0 71964.6 76088.2 78211.6 79285.2 79304.0 871.0 875.2 896.0 897.4 897.7 14249.9 14379.2 14529.7 14632.8 15166.9 35470.1 36255.3 36641.8 36988.3 37072.4 47250.3 47945.0 48049.8 48277.3 48286.5 7468.1 7469.7 7475.2 7489.7 7554.8 10633.4 11005.3 11075.3 11122.7 11178.6 9257.7 9734.5 9795.2 9863.8 10204.3 9877.8 9884.6 10088.6 10147.5 10244.3 9949.2 9962.7 10183.6 10187.7 10367.8 7322.2 7343.9 7412.5 7470.7 7510.9 8855.4 9718.8 9991.0 10005.3 10323.4 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#3] mootools.html Cycles:180 Average:4847.19 Median:5024.82 stddev:2645.80 (52.7%) stddev-sans-first:2639.16 06:31:23 INFO - PROCESS | 2184 | Values: 1217.3 1356.0 1400.5 1471.6 1693.2 6196.3 6520.7 6840.2 7009.4 7031.1 7019.3 7075.6 7083.0 7085.5 7085.6 2097.6 2123.7 2125.3 2125.4 2129.1 2063.4 2131.3 2151.4 2154.0 2154.1 2080.2 2084.4 2101.2 2101.8 2145.9 2023.0 2046.0 2049.7 2049.9 2050.8 2078.8 2079.0 2100.4 2110.6 2113.0 6977.6 7040.8 7049.3 7053.3 7330.2 4534.6 4685.2 4692.3 4715.1 4720.0 2761.9 3022.3 3073.2 3074.0 3080.3 927.2 950.6 954.0 964.7 982.0 9895.0 10008.0 10009.6 10027.7 10037.3 4023.2 4171.2 4317.4 4323.2 4415.7 7942.7 8024.3 8028.4 8030.5 8036.5 4652.2 4655.4 4657.5 4662.2 4663.0 3464.7 3560.8 3737.0 4308.1 4316.4 3337.7 3349.3 3422.8 3460.7 3465.3 1065.2 1074.5 1078.6 1079.6 1081.2 738.7 745.2 770.8 777.2 818.3 4719.1 4851.1 4982.5 4988.4 5254.5 794.5 844.4 860.6 861.1 866.5 3212.8 3232.0 3238.5 3263.8 3358.0 8798.0 8958.0 9069.6 9079.0 9095.6 8812.5 9024.4 9029.7 9032.0 9040.5 6996.7 7169.1 7176.2 7178.0 7182.9 4811.1 4878.2 5001.5 5048.1 5098.1 8221.8 8363.1 8366.4 8391.2 8459.4 8427.0 8561.9 8569.6 8623.1 8657.9 5999.5 6104.6 6104.7 6105.6 6205.8 6985.4 7095.9 7130.8 7154.0 7169.1 6462.7 6563.2 6569.6 6574.5 6576.1 6244.7 6299.2 6355.9 6417.6 6473.9 5851.8 5974.5 5991.0 5995.6 6004.0 4284.6 4304.7 4345.0 4408.8 4443.0 4404.4 4407.5 4465.1 4583.0 4612.9 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#4] prototype.html Cycles:180 Average:4055.56 Median:4593.99 stddev:1191.10 (25.9%) stddev-sans-first:1160.30 06:31:23 INFO - PROCESS | 2184 | Values: 283.2 292.9 297.6 303.5 304.7 4741.4 4771.7 4782.4 4802.3 4806.0 4671.2 4714.3 4716.4 4733.5 4737.6 3515.3 3592.8 3620.9 3668.7 3695.7 3693.3 3697.6 3703.6 3712.7 3715.4 3636.0 3646.6 3656.2 3660.5 3666.6 3499.7 3535.5 3605.9 3643.8 3658.3 3213.0 3231.8 3236.9 3240.5 3243.3 4545.8 4551.7 4552.7 4559.7 4559.9 3835.0 4072.2 4088.8 4095.8 4116.7 4851.2 4860.6 4871.5 4877.9 4878.7 3426.4 3434.5 3436.1 3446.7 3448.2 4983.4 5129.5 5143.9 5153.5 5157.8 3519.0 3521.6 3524.7 3528.6 3535.4 3568.7 3579.4 3582.7 3583.8 3588.8 4087.4 4102.2 4104.0 4114.6 4125.8 4709.4 4857.5 4907.1 4922.7 4929.4 1184.5 1189.8 1190.5 1211.9 1213.7 785.6 806.2 816.1 822.4 825.4 4164.4 4192.0 4263.8 4331.5 4336.0 5033.3 5060.2 5060.7 5065.6 5072.9 4333.7 4337.9 4342.2 4345.6 4354.6 2493.4 2574.8 2581.1 2583.7 2614.3 4507.6 4545.0 4551.0 4559.0 4616.5 4978.7 4993.5 5007.3 5008.8 5016.8 4457.8 4571.5 4743.0 4768.9 4779.1 5062.7 5089.9 5099.7 5104.3 5116.7 5004.8 5021.9 5036.1 5036.8 5061.9 4662.7 4730.7 4755.1 4759.4 4760.5 3540.3 3545.2 3561.9 3570.5 3582.2 5112.6 5114.3 5118.6 5120.5 5130.8 4770.2 4893.0 4895.3 4899.2 5002.6 4878.5 4878.9 4884.4 4887.0 4896.6 4829.5 4830.9 4832.2 4835.5 4853.6 4737.7 4887.4 4914.2 4950.7 4965.2 4796.2 4806.5 4814.4 4818.5 4830.2 06:31:23 INFO - PROCESS | 2184 | 06:31:23 INFO - PROCESS | 2184 | [#5] yui.html Cycles:180 Average:13130.12 Median:450.30 stddev:15276.26 (3392.5%) stddev-sans-first:15290.42 06:31:23 INFO - PROCESS | 2184 | Values: 663.3 665.2 693.7 697.7 707.3 12516.0 13043.5 13100.1 13144.5 13156.9 12185.8 12322.7 12335.8 12340.1 12343.4 614.5 632.3 700.1 713.1 751.3 753.6 756.4 756.4 756.9 757.1 805.3 806.6 806.8 807.2 807.2 632.1 650.2 653.2 654.8 798.8 562.3 582.9 584.3 584.4 584.9 11522.5 11549.1 11909.3 11948.4 11971.9 11755.2 11941.0 12226.9 12286.6 12328.5 10645.4 10843.2 11050.4 11154.8 11595.3 3948.8 3962.8 3991.6 4080.1 4091.8 47713.8 48008.3 48263.8 48430.3 49013.0 9920.0 9963.4 9978.8 10082.5 10150.7 17238.7 17394.0 17409.4 17508.9 17515.9 6274.7 6342.2 6429.9 6592.9 6699.4 3618.3 3688.9 3693.7 3700.8 3757.4 2622.8 2689.6 2695.4 2698.2 2698.3 456.9 458.5 469.8 473.5 477.3 459.4 472.0 510.0 510.2 549.3 6927.4 7035.8 7072.1 7376.7 7488.3 443.7 463.8 466.7 511.8 527.4 3354.5 3422.1 3578.9 3602.0 3651.1 41611.6 41852.6 41869.2 41938.6 54413.1 35309.3 36112.6 36158.8 57122.6 58259.0 50686.5 51470.2 51996.5 52532.5 53299.2 7793.9 8001.0 8056.0 8067.0 8149.8 36156.0 37253.3 37780.1 38387.8 39040.2 29706.4 35958.6 47634.5 48745.3 50182.7 9932.5 10007.2 10344.7 10525.3 10948.3 11392.7 11550.0 11645.9 12134.8 12332.4 10256.3 10906.6 10963.5 11143.7 11146.0 11120.9 11523.9 11546.4 11563.1 11813.8 10296.2 10615.3 10660.3 10780.7 10952.9 9477.4 9533.6 9633.8 9674.6 9706.7 9376.5 9389.6 9592.3 9796.3 9806.2 06:31:23 INFO - PROCESS | 2184 | -------- Summary: end -------- 06:31:23 INFO - PROCESS | 2184 | 06:31:24 INFO - TEST-INFO | 2184: exit 0 06:31:24 INFO - TEST-OK | dromaeo_css | took 1122717ms 06:31:24 INFO - TEST-START | kraken 06:31:24 INFO - operating with platform_type : linux_ 06:31:24 INFO - Initialising browser for kraken test... 06:31:24 INFO - TEST-INFO | started process 2585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9usfJq/profile http://localhost:58660/getInfo.html) 06:31:28 INFO - PROCESS | 2585 | __metrics Screen width/height:1600/1200 06:31:28 INFO - PROCESS | 2585 | colorDepth:24 06:31:28 INFO - PROCESS | 2585 | Browser inner width/height: 1024/697 06:31:28 INFO - PROCESS | 2585 | __metrics 06:31:29 INFO - PROCESS | 2585 | 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" 06:31:29 INFO - PROCESS | 2585 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:31:29 INFO - PROCESS | 2585 | console.error: PushService: 06:31:29 INFO - PROCESS | 2585 | stateChangeProcessEnqueue: Error transitioning state 06:31:29 INFO - PROCESS | 2585 | UnknownError 06:31:30 INFO - TEST-INFO | 2585: exit 0 06:31:30 INFO - Browser initialized. 06:31:30 INFO - Running cycle 1/1 for kraken test... 06:31:30 INFO - TEST-INFO | started process 2665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9usfJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:42 INFO - PROCESS | 2665 | RSS: Main: 179118080 06:31:42 INFO - PROCESS | 2665 | 06:31:45 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:46 INFO - PROCESS | 2665 | RSS: Main: 231747584 06:31:46 INFO - PROCESS | 2665 | 06:31:49 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-dft) 06:31:49 INFO - PROCESS | 2665 | RSS: Main: 219131904 06:31:49 INFO - PROCESS | 2665 | 06:31:53 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-fft) 06:31:53 INFO - PROCESS | 2665 | RSS: Main: 300425216 06:31:53 INFO - PROCESS | 2665 | 06:31:55 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-oscillator) 06:31:56 INFO - PROCESS | 2665 | RSS: Main: 211755008 06:31:56 INFO - PROCESS | 2665 | 06:31:58 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:59 INFO - PROCESS | 2665 | RSS: Main: 215420928 06:31:59 INFO - PROCESS | 2665 | 06:32:02 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-darkroom) 06:32:03 INFO - PROCESS | 2665 | RSS: Main: 251506688 06:32:03 INFO - PROCESS | 2665 | 06:32:06 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-desaturate) 06:32:07 INFO - PROCESS | 2665 | RSS: Main: 245608448 06:32:07 INFO - PROCESS | 2665 | 06:32:09 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58660/tests/kraken/driver.html?testName=json-parse-financial) 06:32:10 INFO - PROCESS | 2665 | RSS: Main: 247726080 06:32:10 INFO - PROCESS | 2665 | 06:32:12 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:12 INFO - PROCESS | 2665 | RSS: Main: 211386368 06:32:12 INFO - PROCESS | 2665 | 06:32:14 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:15 INFO - PROCESS | 2665 | RSS: Main: 217993216 06:32:15 INFO - PROCESS | 2665 | 06:32:17 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:18 INFO - PROCESS | 2665 | RSS: Main: 227467264 06:32:18 INFO - PROCESS | 2665 | 06:32:20 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:21 INFO - PROCESS | 2665 | RSS: Main: 235610112 06:32:21 INFO - PROCESS | 2665 | 06:32:24 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:25 INFO - PROCESS | 2665 | RSS: Main: 232652800 06:32:25 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58660/tests/kraken/driver.html?testName=ai-astar) 06:32:27 INFO - PROCESS | 2665 | RSS: Main: 283561984 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | __start_tp_report 06:32:27 INFO - PROCESS | 2665 | _x_x_mozilla_page_load 06:32:27 INFO - PROCESS | 2665 | _x_x_mozilla_page_load_details 06:32:27 INFO - PROCESS | 2665 | |i|pagename|runs| 06:32:27 INFO - PROCESS | 2665 | |0;ai-astar;106;115;116;116;116;125;115;114;116;115 06:32:27 INFO - PROCESS | 2665 | |1;audio-beat-detection;151;128;132;180;131;130;129;130;170;127 06:32:27 INFO - PROCESS | 2665 | |2;audio-dft;162;162;162;161;165;161;161;160;160;161 06:32:27 INFO - PROCESS | 2665 | |3;audio-fft;76;76;76;102;77;75;76;77;99;76 06:32:27 INFO - PROCESS | 2665 | |4;audio-oscillator;83;84;122;85;84;84;109;83;83;112 06:32:27 INFO - PROCESS | 2665 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;118 06:32:27 INFO - PROCESS | 2665 | |6;imaging-darkroom;148;147;148;147;148;148;148;147;147;148 06:32:27 INFO - PROCESS | 2665 | |7;imaging-desaturate;85;85;85;85;85;84;85;85;85;85 06:32:27 INFO - PROCESS | 2665 | |8;json-parse-financial;63;63;63;62;62;63;63;63;63;62 06:32:27 INFO - PROCESS | 2665 | |9;json-stringify-tinderbox;66;66;66;66;66;65;65;66;66;67 06:32:27 INFO - PROCESS | 2665 | |10;stanford-crypto-aes;90;84;85;90;83;85;90;83;83;88 06:32:27 INFO - PROCESS | 2665 | |11;stanford-crypto-ccm;148;141;152;149;141;143;139;145;186;149 06:32:27 INFO - PROCESS | 2665 | |12;stanford-crypto-pbkdf2;179;177;185;180;179;184;178;177;174;178 06:32:27 INFO - PROCESS | 2665 | |13;stanford-crypto-sha256-iterative;70;71;69;73;73;73;70;68;68;69 06:32:27 INFO - PROCESS | 2665 | __end_tp_report 06:32:27 INFO - PROCESS | 2665 | __start_cc_report 06:32:27 INFO - PROCESS | 2665 | _x_x_mozilla_cycle_collect,1955 06:32:27 INFO - PROCESS | 2665 | __end_cc_report 06:32:27 INFO - PROCESS | 2665 | __startTimestamp1478701947393__endTimestamp 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | ------- Summary: start ------- 06:32:27 INFO - PROCESS | 2665 | Number of tests: 14 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:4.53 (3.9%) stddev-sans-first:3.28 06:32:27 INFO - PROCESS | 2665 | Values: 106.0 115.0 116.0 116.0 116.0 125.0 115.0 114.0 116.0 115.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:131.50 stddev:19.42 (14.8%) stddev-sans-first:20.24 06:32:27 INFO - PROCESS | 2665 | Values: 151.0 128.0 132.0 180.0 131.0 130.0 129.0 130.0 170.0 127.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 06:32:27 INFO - PROCESS | 2665 | Values: 162.0 162.0 162.0 161.0 165.0 161.0 161.0 160.0 160.0 161.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.32 (13.6%) stddev-sans-first:10.78 06:32:27 INFO - PROCESS | 2665 | Values: 76.0 76.0 76.0 102.0 77.0 75.0 76.0 77.0 99.0 76.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.50 stddev:15.15 (18.1%) stddev-sans-first:15.64 06:32:27 INFO - PROCESS | 2665 | Values: 83.0 84.0 122.0 85.0 84.0 84.0 109.0 83.0 83.0 112.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:32:27 INFO - PROCESS | 2665 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:32:27 INFO - PROCESS | 2665 | Values: 148.0 147.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 148.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:32:27 INFO - PROCESS | 2665 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:32:27 INFO - PROCESS | 2665 | Values: 63.0 63.0 63.0 62.0 62.0 63.0 63.0 63.0 63.0 62.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:32:27 INFO - PROCESS | 2665 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 67.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:3.07 (3.6%) stddev-sans-first:2.92 06:32:27 INFO - PROCESS | 2665 | Values: 90.0 84.0 85.0 90.0 83.0 85.0 90.0 83.0 83.0 88.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:148.50 stddev:13.57 (9.1%) stddev-sans-first:14.39 06:32:27 INFO - PROCESS | 2665 | Values: 148.0 141.0 152.0 149.0 141.0 143.0 139.0 145.0 186.0 149.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.00 stddev:3.28 (1.8%) stddev-sans-first:3.48 06:32:27 INFO - PROCESS | 2665 | Values: 179.0 177.0 185.0 180.0 179.0 184.0 178.0 177.0 174.0 178.0 06:32:27 INFO - PROCESS | 2665 | 06:32:27 INFO - PROCESS | 2665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.01 (2.9%) stddev-sans-first:2.13 06:32:27 INFO - PROCESS | 2665 | Values: 70.0 71.0 69.0 73.0 73.0 73.0 70.0 68.0 68.0 69.0 06:32:27 INFO - PROCESS | 2665 | -------- Summary: end -------- 06:32:27 INFO - PROCESS | 2665 | 06:32:28 INFO - TEST-INFO | 2665: exit 0 06:32:28 INFO - TEST-OK | kraken | took 64776ms 06:32:28 INFO - SUITE-END | took 1187s 06:32:29 INFO - Completed test suite (00:19:47) 06:32:29 INFO - javascript benchmark 06:32:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2549.247971848305, 2564.0, 2581.4191806843455, 2600.42790586071, 2614.307208589723, 4530.7281563106235, 4589.472210695771, 4608.654350923682, 4665.276882083278, 4692.460367057789, 4616.561426664462, 4622.5377462253755, 4622.560856718615, 4626.3523106765, 4640.535946405358, 4233.132207897382, 4260.936085958698, 4262.126264115849, 4290.935635965448, 4350.36919646651, 4380.255356589388, 4397.494288156871, 4398.670099742532, 4411.779411029452, 4418.801153948064, 4266.12544428393, 4279.1227798301425, 4294.184105020052, 4314.892127696801, 4400.8019639116155, 4370.4318438603095, 4371.519132895379, 4376.146651402978, 4383.430154079949, 4386.078923426085, 4210.094829611618, 4258.74447533149, 4261.893452663678, 4272.743635381887, 4277.657787377002, 4421.579949904753, 4574.542545745432, 4640.048789998043, 4641.582257596799, 4676.8363107291425, 4966.701997880139, 4980.128477516457, 5039.924401133986, 5041.899162016776, 5042.4201216860165, 4856.53862883022, 5063.620228482841, 5067.847964561069, 5068.619853510964, 5112.309838171836, 4567.748773817406, 4636.6058884995155, 4641.466231383434, 4667.673262871566, 4677.438707355139, 5106.693598384109, 5112.616553758483, 5131.846044618667, 5134.332536770271, 5181.171012638035, 4915.11527924977, 4937.160682683881, 4938.851834444972, 4939.333190019302, 4988.251762235694, 4848.878778030577, 4905.705657660552, 4906.90186196274, 4932.0, 4935.87660308488, 4961.603071754251, 4964.0, 4997.30037794709, 5000.549950504472, 5007.549320561094, 4930.211166213388, 4938.135826230396, 4938.358013458227, 4938.827141050046, 4986.576141027981, 4106.137711080647, 4130.772807495617, 4202.789860507023, 4213.557576454489, 4243.872683819491, 3666.834992425294, 3682.779033258013, 3704.073981504624, 3709.9072523186596, 3771.7548359356556, 4255.404243405926, 4267.701260911706, 4275.422817919541, 4278.507971583245, 4323.740575565476, 4977.377827771528, 4989.326440930428, 5027.924581131286, 5034.421041580265, 5078.289039534468, 4153.626173644387, 4196.118815048874, 4247.617714405718, 4286.442762440863, 4288.463942007249, 4547.0, 4547.295169248771, 4548.95451045492, 4564.97717511417, 4599.0342028174455, 4712.316714076508, 4717.528247175255, 4721.7403042832975, 4725.527447255385, 4763.595094417014, 4910.0, 4973.353464049796, 4980.128477516492, 5066.012127635223, 5073.2897394365555, 4632.444106707217, 4672.9532704673875, 4687.67186296956, 4701.553352431513, 4731.6214702823, 4962.379702537183, 4965.577925876341, 4966.379202599675, 4967.925481117713, 5006.924896126634, 4893.045856058035, 5014.373203349582, 5027.3464449621315, 5027.673201242053, 5074.162763144188, 4815.349927759848, 4849.078675051729, 4856.68431551948, 4881.8535443936735, 4951.405831300267, 4881.096997055556, 4892.706437613754, 4896.510348965075, 4897.779599917941, 4902.240152776325, 4779.446679829, 4813.566778989908, 4829.710217386968, 4833.468318485035, 4884.8290309838985, 4819.566239038503, 4877.487863774252, 4881.682690625098, 4901.264810278487, 4911.607071434205, 4822.228443449031, 4823.1800593899825, 4831.758412079312, 4844.0554091951735, 4878.9512104878495], "value": 4584.356162789119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4660479335045, 550.4660479335046, 559.42099926576, 562.6989560585083, 573.160320131008, 27875.581866271998, 28434.289142771442, 38723.22553548928, 39229.0, 39518.802405988004, 39913.0, 40357.0, 40363.59636403635, 40425.19149617006, 40468.79765601168, 7534.0582427196605, 7710.691572337099, 7715.845683086335, 7718.305352518272, 7719.72980945667, 7548.622568871535, 7601.8479630407355, 7629.618519074052, 7632.771016869475, 7635.312821846032, 7641.732539361124, 7686.846263074735, 7688.077430708323, 7693.30760231579, 7697.8075548111465, 7580.393568514533, 7616.314531692146, 7620.504667196615, 7623.428242881806, 7629.8855517167285, 7561.621918904033, 7628.19903910087, 7630.351420129296, 7634.694612215505, 7635.350995165418, 38010.42984355209, 38365.424518632244, 38371.424428633596, 38433.61566384328, 38459.42310865339, 2909.011698425203, 3097.132802815215, 3178.8092714436975, 3222.548843161959, 3316.3864685033345, 27866.16401507958, 27986.3003424914, 28002.0, 28087.15738527827, 28089.719102808915, 3369.090345606697, 3536.1159710072484, 3537.8231088445473, 3566.5185199997927, 3647.3981793004123, 232447.83776081182, 233294.0, 233373.0, 233400.0, 234443.0, 50218.49781502138, 50496.747516262185, 50558.49441505538, 50611.0, 50618.74690626597, 52928.73535632297, 53020.73489632527, 53022.469775302525, 53031.734841325546, 53073.734631326595, 13801.516946907012, 13848.09987350839, 13865.098768580212, 13898.791518127236, 14034.85965140356, 10729.409882456539, 10809.729756755987, 10813.567457301777, 10813.837792432962, 10818.729531761768, 13017.479300827861, 15034.849651503564, 15105.54683359501, 15132.167730774692, 15365.308561114776, 4873.257602063609, 5500.147477141049, 5618.887622247532, 5685.346185188673, 5737.196792449061, 835.4527784301292, 869.3262721390846, 872.9476231426135, 893.5710858787688, 947.516766449116, 24462.266132015713, 26849.86575067112, 27365.179044628694, 27490.17529474119, 27539.86230068877, 921.8432866412726, 941.2328951904176, 941.9105185007413, 958.4632605740808, 961.1685891703626, 14177.503787367392, 14371.712565748627, 14533.927330363493, 14574.271286435636, 14807.0, 330043.0, 331275.0, 332614.0, 333211.0, 333565.0, 48111.0, 48356.7582162094, 48410.0, 48457.75771121122, 48486.5151348482, 1059.8251288537458, 1099.598646494024, 1148.5405837664835, 1169.6198735411026, 1181.6041626055369, 25000.0, 27920.441591167655, 28014.43971120607, 28604.124710785713, 28668.0, 40422.1915561693, 40812.38781418222, 40938.38592421057, 40969.0, 40976.1804763909, 221106.0, 221538.0, 221668.0, 221940.0, 222678.0, 23407.53184936326, 24120.758792412555, 24143.15498957528, 34986.82506587451, 35372.646273536935, 39081.609183908935, 40634.79682601686, 40643.7967810159, 40934.18131637291, 41039.1792164161, 34148.31703365968, 34422.82788586041, 34530.0, 34682.30635387329, 34818.30363392668, 33663.83168084144, 34300.48549271813, 34339.313213735084, 34685.65314346925, 34936.47595286022, 34518.0, 34520.48219276663, 34720.0, 34764.47853282152, 36545.26909461849, 27394.315142121606, 28975.0, 31029.224269393446, 31259.374812504077, 31914.0, 24313.878430607732, 24558.263252102464, 24663.630045548973, 25004.249872503853, 25095.49809003773], "value": 16666.45612008434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.36597392745216, 361.2828535357317, 366.60223657331795, 370.81273956651887, 385.1468996173475, 12497.750044999095, 13035.348232588369, 15470.845291547095, 16213.918930405362, 16328.75506867398, 15994.60013499663, 16153.43462978796, 16161.0, 16194.947328423645, 16233.512994610152, 4767.833125840579, 4836.733979631128, 4916.385451818523, 4943.8516844494725, 4944.035912996967, 3686.3548878946212, 3876.7673939563715, 4848.781804818792, 4943.876403089934, 5528.834134975958, 5716.1997320375185, 5834.329052158992, 5839.883202335951, 5843.006688862883, 5846.386129456409, 5576.553875689935, 5717.714114294268, 5739.225204597367, 5739.885202295973, 5827.329857066449, 5044.218146187347, 5093.923591146136, 5104.668196567249, 5109.770060347256, 5118.564921981636, 19056.333028343943, 19151.80848191514, 19705.802941970684, 19740.90129549343, 19796.70304945427, 1790.5881647221213, 1924.7112933060152, 2007.1469625409288, 2156.1914282144194, 2321.5472982768365, 8646.005709343443, 8931.910680893174, 9222.170004699608, 9409.811803763954, 9446.055394460567, 1549.7752825840303, 1614.1041721844372, 1619.5141457562802, 1752.4041825779168, 1820.8907465552109, 65659.67170164119, 66057.66971165162, 68063.31936680619, 70071.64964175198, 73074.63462682706, 9405.0, 9514.47670378122, 9728.464934428674, 9908.108270255567, 10062.899371006342, 13522.053456258163, 13523.188608683511, 13528.59414217575, 13546.661333466545, 13550.84817790479, 6744.730210791611, 7125.92874071263, 7147.89278160828, 7233.457490688114, 7295.161056478573, 6715.764948226789, 6746.730130794714, 6926.549774264657, 6956.0609317741455, 6991.335823096798, 4178.582141785858, 4187.895302617398, 4230.386593943861, 4248.2565551029065, 4267.317229243368, 1822.4714832698369, 1829.2591500442343, 1835.651226267005, 1846.7876194237836, 1878.5303674081479, 792.6868886789802, 807.7051876065194, 814.5316443045273, 840.2185967050701, 851.9318454523623, 14977.475788347356, 15599.142047187514, 15808.209589520478, 15881.205939702968, 16525.091119988276, 821.6261600971544, 850.9064002959669, 862.6376921692904, 868.8740132680726, 893.066745251214, 8757.605907734167, 8848.026717061119, 9206.125418085272, 9260.120288572574, 9264.95367523158, 345245.0, 365031.0, 365393.0, 365993.0, 367673.0, 71964.64017679983, 76088.23911760922, 78211.60894195492, 79285.20714792893, 79304.0, 870.9630279117371, 875.1554749666602, 896.0278098263327, 897.4032268541478, 897.6768363389175, 14249.857501424853, 14379.20914349679, 14529.709405812036, 14632.780508292171, 15166.924165379103, 35470.11324716903, 36255.27489450249, 36641.81679091587, 36988.260234794616, 37072.44391334078, 47250.291245632034, 47945.0, 48049.75975120102, 48277.275840861716, 48286.5171348282, 7468.103827540513, 7469.7385591504035, 7475.2151024141685, 7489.66296516669, 7554.811129721581, 10633.415162166155, 11005.284656497302, 11075.335479871233, 11122.666320010412, 11178.55285788592, 9257.703921451137, 9734.513274336396, 9795.167410770164, 9863.802723945624, 10204.336718113596, 9877.753056173653, 9884.604615815288, 10088.646897358558, 10147.543360548942, 10244.282900197213, 9949.204063674744, 9962.651307204213, 10183.592656293962, 10187.694369168938, 10367.844482332923, 7322.194558598657, 7343.8531229376185, 7412.518186317872, 7470.663820127998, 7510.934493014464, 8855.424397414148, 9718.75703107428, 9991.0, 10005.349652272578, 10323.432211228153], "value": 7951.797803644215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.2818037357956, 1355.966100847479, 1400.4818217259615, 1471.5953112893953, 1693.1788082779842, 6196.2564492260935, 6520.739170433183, 6840.2133754618235, 7009.439244860411, 7031.1211098612675, 7019.262977387378, 7075.575465472062, 7083.043789088471, 7085.504014718972, 7085.610291433969, 2097.5595125023765, 2123.7132987046707, 2125.2667829598763, 2125.404886631738, 2129.116416687073, 2063.350044735911, 2131.3179782469615, 2151.429871084164, 2154.041451554059, 2154.062982602565, 2080.240712140073, 2084.405944305873, 2101.2120454829437, 2101.8423618228617, 2145.9248926287582, 2022.9986156852378, 2046.0, 2049.733534640502, 2049.86675866069, 2050.7744148143693, 2078.7609424916177, 2078.98960505198, 2100.432883121564, 2110.6306396380573, 2112.9577408451746, 6977.616231107287, 7040.788776336718, 7049.259827718119, 7053.294670532906, 7330.157031941341, 4534.5692159245145, 4685.20351540239, 4692.319613656035, 4715.127701375257, 4719.976400118012, 2761.8895244190207, 3022.304869879918, 3073.2470544716466, 3073.9538906916414, 3080.291532947412, 927.1979737527058, 950.6245033211911, 954.0268925695821, 964.686476895005, 982.0425085541611, 9894.9505252474, 10008.049235322633, 10009.649662261785, 10027.699169024942, 10037.29738918276, 4023.2154729827403, 4171.186618609403, 4317.395564620955, 4323.2434323993175, 4415.712978656377, 7942.722004729807, 8024.317932975646, 8028.438009339407, 8030.478018928751, 8036.4776289541, 4652.209124448852, 4655.441347038377, 4657.4876763555985, 4662.184117779443, 4662.953370466252, 3464.6881780639865, 3560.8219589020446, 3736.981315093407, 4308.138372325548, 4316.374125751749, 3337.6829201225846, 3349.296647703961, 3422.8117453539794, 3460.6885380315894, 3465.3242617689307, 1065.169168048923, 1074.4520294649628, 1078.5577913055608, 1079.6329248055542, 1081.1512962324537, 738.7229788829189, 745.1654147354997, 770.7726220764888, 777.2421888658625, 818.2553875972836, 4719.10337035962, 4851.126797176542, 4982.526659967298, 4988.4263309719845, 5254.474552544715, 794.4756460735887, 844.3793811548506, 860.5912191708888, 861.1216559109673, 866.5320726807579, 3212.8072315661134, 3232.0, 3238.498032804919, 3263.7552183586326, 3358.0, 8798.0, 8958.0, 9069.59186836594, 9079.046700096394, 9095.636174552943, 8812.471251724788, 9024.413413128126, 9029.729108126767, 9031.954840225757, 9040.457572545669, 6996.720131194696, 7169.068021157216, 7176.174739904874, 7178.0, 7182.856342873113, 4811.109944660249, 4878.193966992495, 5001.524855138756, 5048.1165795984825, 5098.133317335987, 8221.835563288581, 8363.080061193143, 8366.414350995372, 8391.16088391156, 8459.407841451039, 8427.0, 8561.914380856111, 8569.614367353359, 8623.094575069528, 8657.870131948152, 5999.4900433463645, 6104.633721976696, 6104.69476526163, 6105.572609917263, 6205.782797602063, 6985.441164706913, 7095.858082838211, 7130.821729456805, 7154.0, 7169.068021157216, 6462.7091780870915, 6563.1796025496815, 6569.605823650596, 6574.539782215199, 6576.112224849584, 6244.718987645476, 6299.212598425197, 6355.936440635534, 6417.550771445954, 6473.935260647333, 5851.795187168429, 5974.492168165754, 5991.041433370814, 5995.640261584319, 6004.0, 4284.571542845691, 4304.74171549708, 4345.0, 4408.845690400821, 4443.022535042285, 4404.4494438195225, 4407.515173330995, 4465.12929978651, 4582.9541704582525, 4612.907741845212], "value": 3938.6157532976426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.2084324313544, 292.93116117712333, 297.58784084043606, 303.4810474089307, 304.71356924490976, 4741.431028276607, 4771.689840160388, 4782.426108866936, 4802.255650374198, 4806.0, 4671.182543054969, 4714.292856071591, 4716.36329095572, 4733.502982186872, 4737.644676649248, 3515.261795023042, 3592.8383222755037, 3620.9094772630633, 3668.651478109589, 3695.7412981091334, 3693.261347730465, 3697.6302369762943, 3703.592604813482, 3712.7215458840697, 3715.3683873741393, 3635.981820090896, 3646.5988741238443, 3656.195636959878, 3660.4875317455444, 3666.5966743658178, 3499.6675315844955, 3535.4696795480627, 3605.9098522537015, 3643.7631553949172, 3658.32321020612, 3212.983935080333, 3231.804232433991, 3236.886708965175, 3240.493170675624, 3243.3026899216784, 4545.818167273305, 4551.658625603093, 4552.68131230814, 4559.658025648089, 4559.863204103882, 3835.0, 4072.165206132736, 4088.7751173685438, 4095.754254744695, 4116.711830171889, 4851.175300198975, 4860.586850117709, 4871.488493708145, 4877.902441951142, 4878.658493905428, 3426.3832510148163, 3434.5191673165778, 3436.1409647588102, 3446.724262059029, 3448.1724386147393, 4983.401991761012, 5129.461406552296, 5143.922841157386, 5153.536181743623, 5157.8452646420665, 3519.0, 3521.6478352164577, 3524.7356448266482, 3528.629493903103, 3535.3636345458062, 3568.715262505496, 3579.3736096183065, 3582.7492075554983, 3583.8208089595414, 3588.7667301625834, 4087.4277601135864, 4102.200070986189, 4104.0, 4114.5679703630685, 4125.752454852658, 4709.364235828188, 4857.465678775332, 4907.116718990616, 4922.704637721748, 4929.383827021622, 1184.4788293150987, 1189.8096304591397, 1190.4642910690052, 1211.8545774507115, 1213.6783752305469, 785.6346798738614, 806.1938061938062, 816.1267443835159, 822.3914303415429, 825.4015838517028, 4164.416981622575, 4191.952011997001, 4263.829446822155, 4331.45856767904, 4336.005437498786, 5033.270175824485, 5060.1903695408555, 5060.7216603086445, 5065.645404821701, 5072.898542029138, 4333.743214467769, 4337.891552711144, 4342.240107981091, 4345.630621397217, 4354.646921870142, 2493.4140476987895, 2574.819762616636, 2581.096616184358, 2583.6899572051097, 2614.3398941672176, 4507.6168525675685, 4545.045630378969, 4551.0, 4558.997020655451, 4616.469106052847, 4978.701277923336, 4993.525615066563, 5007.349044624176, 5008.84973450797, 5016.774245158977, 4457.8439754608435, 4571.519990401027, 4743.0, 4768.856934292046, 4779.115863565252, 5062.746862656926, 5089.923651145162, 5099.745012749422, 5104.285400044071, 5116.74416279192, 5004.824831131039, 5021.899562008666, 5036.057452206432, 5036.823711170092, 5061.898762024665, 4662.696924699883, 4730.668853180382, 4755.145493257702, 4759.381280433521, 4760.452547956891, 3540.345036168317, 3545.2023294758474, 3561.893143205708, 3570.500389836327, 3582.1760994971823, 5112.590992720648, 5114.2840002400435, 5118.616103792156, 5120.48795120485, 5130.820421285237, 4770.235013045195, 4892.951070489249, 4895.265710143507, 4899.191633380452, 5002.6498145130945, 4878.463369029475, 4878.853634390974, 4884.389451318585, 4887.0, 4896.6327525436445, 4829.468758436639, 4830.903381932412, 4832.226843704991, 4835.468098509232, 4853.563179313879, 4737.742727475579, 4887.36464259644, 4914.238293064581, 4950.678205916748, 4965.205567109245, 4796.208625576741, 4806.53400712786, 4814.446338671098, 4818.518148185153, 4830.227163653799], "value": 3676.1698247773343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.3399767231602, 665.2283351312478, 693.7086423702044, 697.6686074114793, 707.2927072927072, 12516.0, 13043.478260869553, 13100.082994190387, 13144.47422103116, 13156.868431315685, 12185.817212741817, 12322.691932701664, 12335.753284934319, 12340.136190466648, 12343.382830858465, 614.4869034356318, 632.2823595219413, 700.1178515071022, 713.1371041040321, 751.2975368030882, 753.6457864803533, 756.3646536908996, 756.4440136499668, 756.9280918312779, 757.0801476206408, 805.3275514945028, 806.5967016491754, 806.8426656801926, 807.1524898856206, 807.1524898856206, 632.0677001422888, 650.2229835346762, 653.2389765922694, 654.7839213059679, 798.8162722573811, 562.3476766950319, 582.9475347218771, 584.3484514766047, 584.3659629302213, 584.9210356601847, 11522.539098436053, 11549.13381496391, 11909.285442873455, 11948.402579871059, 11971.940140299243, 11755.235909665844, 11941.0, 12226.877731222663, 12286.631401057894, 12328.5068597256, 10645.361278323326, 10843.240973131884, 11050.447477626087, 11154.776904461865, 11595.304281743123, 3948.763074215556, 3962.821673024692, 3991.640752332304, 4080.0819815541563, 4091.7954102295066, 47713.76143119297, 48008.27987580224, 48263.75868120637, 48430.27354589684, 49013.0, 9919.950400247953, 9963.402195868272, 9978.800423991479, 10082.49587520621, 10150.695479135638, 17238.741418878726, 17394.043327617102, 17409.390671326444, 17508.912455437643, 17515.912420437817, 6274.686265686697, 6342.207224096988, 6429.935700643027, 6592.945128779373, 6699.39705426514, 3618.2944325856733, 3688.926221475609, 3693.741438099361, 3700.833462494194, 3757.3800322946954, 2622.763951244397, 2689.623452716621, 2695.393536454282, 2698.1500827239356, 2698.2984424049887, 456.91002235101, 458.5025247606318, 469.786247257497, 473.4602553089481, 477.3388856433864, 459.35231323833233, 472.03490678302535, 509.9770510327044, 510.2321006884615, 549.2941570082425, 6927.411170050501, 7035.824104397431, 7072.135785007081, 7376.704931802775, 7488.288612581796, 443.68276682171756, 463.8237469761469, 466.7129715225112, 511.7799346281135, 527.3592585009233, 3354.530365748797, 3422.1102513346214, 3578.928421431609, 3601.9639803602154, 3651.050726811048, 41611.58388416137, 41852.58147418548, 41869.1626167475, 41938.580614193466, 54413.11737652485, 35309.29381412357, 36112.63887361145, 36158.81920590433, 57122.63633735755, 58259.0, 50686.493135068915, 51470.22794658083, 51996.48003519992, 52532.47467525276, 53299.20051199235, 7793.922060779547, 8000.95999520022, 8055.959720201361, 8066.959665201636, 8149.8370032600205, 36156.0, 37253.25493490169, 37780.05549861275, 38387.80806095952, 39040.21919561536, 29706.40587188201, 35958.64041359658, 47634.52365476301, 48745.268820967, 50182.749086254335, 9932.453715045742, 10007.249456290661, 10344.741381465523, 10525.263231573716, 10948.343099413742, 11392.658220253406, 11550.013381838513, 11645.941770291094, 12134.757304853676, 12332.445039973401, 10256.28206025601, 10906.563737450413, 10963.451827408757, 11143.721406964567, 11146.0, 11120.88879111231, 11523.942380288045, 11546.364949927834, 11563.132765042823, 11813.76372472563, 10296.17630589536, 10615.31000484966, 10660.307080039773, 10780.730481738019, 10952.890471095187, 9477.431354118775, 9533.570989305637, 9633.759156021155, 9674.613015479583, 9706.660266890625, 9376.531173441164, 9389.577469014048, 9592.280578956466, 9796.265280104164, 9806.166475849634], "value": 5822.786196081209, "unit": "score"}], "name": "dromaeo_css", "value": 6094.217656345642, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 116.0, 116.0, 116.0, 125.0, 115.0, 114.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 132.0, 180.0, 131.0, 130.0, 129.0, 130.0, 170.0, 127.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 165.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 102.0, 77.0, 75.0, 76.0, 77.0, 99.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 122.0, 85.0, 84.0, 84.0, 109.0, 83.0, 83.0, 112.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 85.0, 90.0, 83.0, 85.0, 90.0, 83.0, 83.0, 88.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 152.0, 149.0, 141.0, 143.0, 139.0, 145.0, 186.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 185.0, 180.0, 179.0, 184.0, 178.0, 177.0, 174.0, 178.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 73.0, 73.0, 73.0, 70.0, 68.0, 68.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1555.0, "alertThreshold": 2.0}]} 06:32:29 INFO - Return code: 0 06:32:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:29 INFO - # TBPL SUCCESS # 06:32:29 INFO - Running post-action listener: _resource_record_post_action 06:32:29 INFO - [mozharness: 2016-11-09 14:32:29.193584Z] Finished run-tests step (success) 06:32:29 INFO - Running post-run listener: _resource_record_post_run 06:32:29 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401121280; Read time: 12; Write time: 214900 06:32:29 INFO - TinderboxPrint: CPU usage
13.0% 06:32:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:32:29 INFO - TinderboxPrint: I/O write bytes / time
401,121,280 / 214,900 06:32:29 INFO - TinderboxPrint: CPU idle
8,353.4 (86.9%) 06:32:29 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 06:32:29 INFO - TinderboxPrint: Swap in / out
0 / 0 06:32:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110432256; Read time: 0; Write time: 53732 06:32:29 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290689024; Read time: 0; Write time: 161168 06:32:29 INFO - Running post-run listener: _upload_blobber_files 06:32:29 INFO - Blob upload gear active. 06:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:29 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 06:32:29 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:29 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:30 INFO - (blobuploader) - INFO - Done attempting. 06:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:31 INFO - (blobuploader) - INFO - Done attempting. 06:32:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:35 INFO - (blobuploader) - INFO - Done attempting. 06:32:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:35 INFO - Return code: 0 06:32:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15947059159b1119444c61afd54d3e8f7ae1bee8adb7e09ed3c68114d592f8cb2e8c2cd7e9d5e9a5bba14b65c9059544f1958a5400824f8ddb7c4f5f0419188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9fbf3bac78091598ad7daabe32cc7fbd1f60904989a476dc1ac99a8788234137994cfa050b93ad2deb7103376a5400c5df7999dad72fb7ba37124ad5d78cd53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/bf105696247cc5dc800b597a07cf332ce6c8f6e47914c93888daee0bb580a82900056f075d9e82ff8815c48547277e90ab1280ccbc7662fa70c8f3cc7cae57d4"} 06:32:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:35 INFO - Contents: 06:32:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15947059159b1119444c61afd54d3e8f7ae1bee8adb7e09ed3c68114d592f8cb2e8c2cd7e9d5e9a5bba14b65c9059544f1958a5400824f8ddb7c4f5f0419188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9fbf3bac78091598ad7daabe32cc7fbd1f60904989a476dc1ac99a8788234137994cfa050b93ad2deb7103376a5400c5df7999dad72fb7ba37124ad5d78cd53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/bf105696247cc5dc800b597a07cf332ce6c8f6e47914c93888daee0bb580a82900056f075d9e82ff8815c48547277e90ab1280ccbc7662fa70c8f3cc7cae57d4"} 06:32:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:35 INFO - Copying logs to upload dir... 06:32:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.752661 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-09 06:32:35.576139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:32:35.580230) ========= 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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15947059159b1119444c61afd54d3e8f7ae1bee8adb7e09ed3c68114d592f8cb2e8c2cd7e9d5e9a5bba14b65c9059544f1958a5400824f8ddb7c4f5f0419188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9fbf3bac78091598ad7daabe32cc7fbd1f60904989a476dc1ac99a8788234137994cfa050b93ad2deb7103376a5400c5df7999dad72fb7ba37124ad5d78cd53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/bf105696247cc5dc800b597a07cf332ce6c8f6e47914c93888daee0bb580a82900056f075d9e82ff8815c48547277e90ab1280ccbc7662fa70c8f3cc7cae57d4"} build_url:https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/N94Gpw3ZRlKlJaZrpoo7rw/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/Larch-Non-PGO/sha512/15947059159b1119444c61afd54d3e8f7ae1bee8adb7e09ed3c68114d592f8cb2e8c2cd7e9d5e9a5bba14b65c9059544f1958a5400824f8ddb7c4f5f0419188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9fbf3bac78091598ad7daabe32cc7fbd1f60904989a476dc1ac99a8788234137994cfa050b93ad2deb7103376a5400c5df7999dad72fb7ba37124ad5d78cd53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/bf105696247cc5dc800b597a07cf332ce6c8f6e47914c93888daee0bb580a82900056f075d9e82ff8815c48547277e90ab1280ccbc7662fa70c8f3cc7cae57d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:32:35.606429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:32:35.606803) ========= 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=337fe3f4b1febe37b85fccc40000019e-1478700705.925467-1268307242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:32:35.691311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:32:35.691715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:32:35.692051) ========= ========= Total master_lag: 0.18 =========