builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1477391295.35 results: success (0) buildid: 20161025015208 builduid: 5c426c7c75384d439c5b41ba1193f015 revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.348576) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.349092) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.349402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.364491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.364888) ========= 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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 03:28:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-25 03:28:16 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.485783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.486122) ========= 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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015746 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:15.537550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:28:15.538044) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 03:28:16,437 truncating revision to first 12 chars 2016-10-25 03:28:16,437 Setting DEBUG logging. 2016-10-25 03:28:16,437 attempt 1/10 2016-10-25 03:28:16,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78b863e9fcd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 03:28:17,592 unpacking tar archive at: fx-team-78b863e9fcd9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:28:17.028338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:17.028996) ========= script_repo_revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:17.029772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:17.030258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:28:17.042169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-25 03:28:17.042746) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:18 INFO - MultiFileLogger online at 20161025 03:28:18 in /builds/slave/test 03:28:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:28:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:18 INFO - {'append_to_log': False, 03:28:18 INFO - 'base_work_dir': '/builds/slave/test', 03:28:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:28:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:18 INFO - 'branch': 'Fx-Team-Non-PGO', 03:28:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:18 INFO - 'config_files': ('talos/linux_config.py',), 03:28:18 INFO - 'default_actions': ('clobber', 03:28:18 INFO - 'read-buildbot-config', 03:28:18 INFO - 'download-and-extract', 03:28:18 INFO - 'populate-webroot', 03:28:18 INFO - 'create-virtualenv', 03:28:18 INFO - 'install', 03:28:18 INFO - 'run-tests'), 03:28:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:18 INFO - 'download_minidump_stackwalk': True, 03:28:18 INFO - 'download_symbols': 'ondemand', 03:28:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:18 INFO - 'installer_path': 'installer.exe', 03:28:18 INFO - 'log_level': 'info', 03:28:18 INFO - 'log_name': 'talos', 03:28:18 INFO - 'log_to_console': True, 03:28:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:18 INFO - 'opt_config_files': (), 03:28:18 INFO - 'pip_index': False, 03:28:18 INFO - 'sps_profile': False, 03:28:18 INFO - 'sps_profile_interval': 0, 03:28:18 INFO - 'suite': 'dromaeojs', 03:28:18 INFO - 'system_bits': '32', 03:28:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:18 INFO - 'title': 'talos-linux64-ix-048', 03:28:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:18 INFO - 'use_talos_json': True, 03:28:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:18 INFO - 'work_dir': 'build'} 03:28:18 INFO - [mozharness: 2016-10-25 10:28:18.040225Z] Running clobber step. 03:28:18 INFO - Running pre-action listener: _resource_record_pre_action 03:28:18 INFO - Running main action method: clobber 03:28:18 INFO - rmtree: /builds/slave/test/build 03:28:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:18 INFO - Running post-action listener: _resource_record_post_action 03:28:18 INFO - [mozharness: 2016-10-25 10:28:18.501002Z] Finished clobber step (success) 03:28:18 INFO - [mozharness: 2016-10-25 10:28:18.501103Z] Running read-buildbot-config step. 03:28:18 INFO - Running pre-action listener: _resource_record_pre_action 03:28:18 INFO - Running main action method: read_buildbot_config 03:28:18 INFO - Using buildbot properties: 03:28:18 INFO - { 03:28:18 INFO - "project": "", 03:28:18 INFO - "product": "firefox", 03:28:18 INFO - "script_repo_revision": "production", 03:28:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:28:18 INFO - "repository": "", 03:28:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:28:18 INFO - "buildid": "20161025015208", 03:28:18 INFO - "pgo_build": "False", 03:28:18 INFO - "basedir": "/builds/slave/test", 03:28:18 INFO - "buildnumber": 3401, 03:28:18 INFO - "slavename": "talos-linux64-ix-048", 03:28:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:28:18 INFO - "platform": "ubuntu64_hw", 03:28:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:28:18 INFO - "branch": "fx-team", 03:28:18 INFO - "repo_path": "integration/fx-team", 03:28:18 INFO - "revision": "78b863e9fcd9d44d75c817b6495b4585167ba255", 03:28:18 INFO - "stage_platform": "linux64", 03:28:18 INFO - "builduid": "5c426c7c75384d439c5b41ba1193f015", 03:28:18 INFO - "slavebuilddir": "test" 03:28:18 INFO - } 03:28:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:28:18 INFO - Running post-action listener: _resource_record_post_action 03:28:18 INFO - [mozharness: 2016-10-25 10:28:18.503628Z] Finished read-buildbot-config step (success) 03:28:18 INFO - [mozharness: 2016-10-25 10:28:18.503717Z] Running download-and-extract step. 03:28:18 INFO - Running pre-action listener: _resource_record_pre_action 03:28:18 INFO - Running main action method: download_and_extract 03:28:18 INFO - mkdir: /builds/slave/test/build/tests 03:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:18 INFO - trying https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:28:19 INFO - Downloaded 1361 bytes. 03:28:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:19 INFO - Using the following test package requirements: 03:28:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:28:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'jsshell-linux-x86_64.zip'], 03:28:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:28:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:28:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:28:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:28:19 INFO - Http code: 200 03:28:19 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 03:28:19 INFO - x-amz-cf-id: PvAcDAtWq0jkd0UI14if9WKy9C06AwBlHJirMu-XfeTpC22fPM2MRQ== 03:28:19 INFO - x-amz-version-id: cj6T2QNjvLPCfn_V5FpMv_w30fOD.Hpi 03:28:19 INFO - Expected file size: 20468398 03:28:19 INFO - Obtained file size: 20468398 03:28:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:28:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:28:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:28:24 INFO - Http code: 200 03:28:24 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 03:28:24 INFO - x-amz-cf-id: LHMOKpN454Ngv_aZJnpPg04neEXZ5r3svnDAg5aXJsZkwXjQTJ_-EQ== 03:28:24 INFO - x-amz-version-id: cj6T2QNjvLPCfn_V5FpMv_w30fOD.Hpi 03:28:24 INFO - Expected file size: 20468398 03:28:24 INFO - Obtained file size: 20468398 03:28:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:28:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:28:29 INFO - Http code: 200 03:28:29 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 03:28:29 INFO - x-amz-cf-id: uF5oHP4bS-L4MqQPtaUSGv-lpxZKy2KufJCEGeVthlaGWnD4T6hTrg== 03:28:29 INFO - x-amz-version-id: mgt7qbhrylqfa0b80HoAKkwnSTNvePYF 03:28:30 INFO - Expected file size: 14409028 03:28:30 INFO - Obtained file size: 14409028 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:30 INFO - trying https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:28:31 INFO - Downloaded 55582438 bytes. 03:28:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:31 INFO - mkdir: /builds/slave/test/properties 03:28:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:31 INFO - Contents: 03:28:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:32 INFO - Running post-action listener: _resource_record_post_action 03:28:32 INFO - Running post-action listener: set_extra_try_arguments 03:28:32 INFO - [mozharness: 2016-10-25 10:28:32.116136Z] Finished download-and-extract step (success) 03:28:32 INFO - [mozharness: 2016-10-25 10:28:32.116233Z] Running populate-webroot step. 03:28:32 INFO - Running pre-action listener: _resource_record_pre_action 03:28:32 INFO - Running main action method: populate_webroot 03:28:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:32 INFO - '--tppagecycles', 03:28:32 INFO - '7'], 03:28:32 INFO - 'tests': ['tsvgm']}}, 03:28:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['damp', 'tps']}, 03:28:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'tests': ['damp', 'tps']}, 03:28:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['dromaeo_dom']}, 03:28:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['basic_compositor_video']}, 03:28:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:28:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tsvgx', 03:28:32 INFO - 'tsvgr_opacity', 03:28:32 INFO - 'tart', 03:28:32 INFO - 'tscrollx', 03:28:32 INFO - 'cart']}, 03:28:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:32 INFO - 'tsvgr_opacity', 03:28:32 INFO - 'tart', 03:28:32 INFO - 'tscrollx', 03:28:32 INFO - 'cart']}, 03:28:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tp5o']}, 03:28:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'tests': ['tp5o']}, 03:28:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s', 03:28:32 INFO - '--xperf_path', 03:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:32 INFO - 'tests': ['tp5n']}, 03:28:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:32 INFO - 'talos_options': ['--xperf_path', 03:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:32 INFO - 'tests': ['tp5n']}}, 03:28:32 INFO - 'talos.zip': {'path': '', 03:28:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:32 INFO - Running post-action listener: _resource_record_post_action 03:28:32 INFO - [mozharness: 2016-10-25 10:28:32.131940Z] Finished populate-webroot step (success) 03:28:32 INFO - [mozharness: 2016-10-25 10:28:32.132028Z] Running create-virtualenv step. 03:28:32 INFO - Running pre-action listener: _resource_record_pre_action 03:28:32 INFO - Running main action method: create_virtualenv 03:28:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:32 INFO - Using real prefix '/usr' 03:28:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:34 INFO - Installing pip.................done. 03:28:34 INFO - Return code: 0 03:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:34 INFO - Reading from file tmpfile_stdout 03:28:34 INFO - Output received: 03:28:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:28:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:34 INFO - Using env: {'DISPLAY': ':0', 03:28:34 INFO - 'HOME': '/home/cltbld', 03:28:34 INFO - 'LANG': 'en_US.UTF-8', 03:28:34 INFO - 'LANGUAGE': 'en_US:en', 03:28:34 INFO - 'LOGNAME': 'cltbld', 03:28:34 INFO - 'MAIL': '/var/mail/cltbld', 03:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:34 INFO - 'MOZ_NO_REMOTE': '1', 03:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:34 INFO - 'NO_EM_RESTART': '1', 03:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:34 INFO - 'PWD': '/builds/slave/test', 03:28:34 INFO - 'SHELL': '/bin/bash', 03:28:34 INFO - 'SHLVL': '1', 03:28:34 INFO - 'TERM': 'linux', 03:28:34 INFO - 'TMOUT': '86400', 03:28:34 INFO - 'USER': 'cltbld', 03:28:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:34 INFO - '_': '/tools/buildbot/bin/python'} 03:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:28:35 INFO - Cleaning up... 03:28:35 INFO - Return code: 0 03:28:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:35 INFO - Using env: {'DISPLAY': ':0', 03:28:35 INFO - 'HOME': '/home/cltbld', 03:28:35 INFO - 'LANG': 'en_US.UTF-8', 03:28:35 INFO - 'LANGUAGE': 'en_US:en', 03:28:35 INFO - 'LOGNAME': 'cltbld', 03:28:35 INFO - 'MAIL': '/var/mail/cltbld', 03:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:35 INFO - 'MOZ_NO_REMOTE': '1', 03:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:35 INFO - 'NO_EM_RESTART': '1', 03:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:35 INFO - 'PWD': '/builds/slave/test', 03:28:35 INFO - 'SHELL': '/bin/bash', 03:28:35 INFO - 'SHLVL': '1', 03:28:35 INFO - 'TERM': 'linux', 03:28:35 INFO - 'TMOUT': '86400', 03:28:35 INFO - 'USER': 'cltbld', 03:28:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:35 INFO - '_': '/tools/buildbot/bin/python'} 03:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:35 INFO - Downloading/unpacking psutil>=3.1.1 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:37 INFO - Installing collected packages: psutil 03:28:37 INFO - Running setup.py install for psutil 03:28:37 INFO - building 'psutil._psutil_linux' extension 03:28:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:37 INFO - building 'psutil._psutil_posix' extension 03:28:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:38 INFO - Successfully installed psutil 03:28:38 INFO - Cleaning up... 03:28:38 INFO - Return code: 0 03:28:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:28:38 INFO - Using env: {'DISPLAY': ':0', 03:28:38 INFO - 'HOME': '/home/cltbld', 03:28:38 INFO - 'LANG': 'en_US.UTF-8', 03:28:38 INFO - 'LANGUAGE': 'en_US:en', 03:28:38 INFO - 'LOGNAME': 'cltbld', 03:28:38 INFO - 'MAIL': '/var/mail/cltbld', 03:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:38 INFO - 'MOZ_NO_REMOTE': '1', 03:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:38 INFO - 'NO_EM_RESTART': '1', 03:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:38 INFO - 'PWD': '/builds/slave/test', 03:28:38 INFO - 'SHELL': '/bin/bash', 03:28:38 INFO - 'SHLVL': '1', 03:28:38 INFO - 'TERM': 'linux', 03:28:38 INFO - 'TMOUT': '86400', 03:28:38 INFO - 'USER': 'cltbld', 03:28:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:38 INFO - '_': '/tools/buildbot/bin/python'} 03:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:40 INFO - Installing collected packages: mozsystemmonitor 03:28:40 INFO - Running setup.py install for mozsystemmonitor 03:28:40 INFO - Successfully installed mozsystemmonitor 03:28:40 INFO - Cleaning up... 03:28:40 INFO - Return code: 0 03:28:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:40 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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:40 INFO - Using env: {'DISPLAY': ':0', 03:28:40 INFO - 'HOME': '/home/cltbld', 03:28:40 INFO - 'LANG': 'en_US.UTF-8', 03:28:40 INFO - 'LANGUAGE': 'en_US:en', 03:28:40 INFO - 'LOGNAME': 'cltbld', 03:28:40 INFO - 'MAIL': '/var/mail/cltbld', 03:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:40 INFO - 'MOZ_NO_REMOTE': '1', 03:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:40 INFO - 'NO_EM_RESTART': '1', 03:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:40 INFO - 'PWD': '/builds/slave/test', 03:28:40 INFO - 'SHELL': '/bin/bash', 03:28:40 INFO - 'SHLVL': '1', 03:28:40 INFO - 'TERM': 'linux', 03:28:40 INFO - 'TMOUT': '86400', 03:28:40 INFO - 'USER': 'cltbld', 03:28:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:40 INFO - '_': '/tools/buildbot/bin/python'} 03:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:42 INFO - warning: no files found matching '*.txt' 03:28:42 INFO - no previously-included directories found matching 'build' 03:28:42 INFO - no previously-included directories found matching 'dist' 03:28:42 INFO - no previously-included directories found matching '.git*' 03:28:42 INFO - Installing collected packages: jsonschema, functools32 03:28:42 INFO - Running setup.py install for functools32 03:28:43 INFO - warning: no files found matching '*.txt' 03:28:43 INFO - no previously-included directories found matching 'build' 03:28:43 INFO - no previously-included directories found matching 'dist' 03:28:43 INFO - no previously-included directories found matching '.git*' 03:28:43 INFO - Successfully installed jsonschema functools32 03:28:43 INFO - Cleaning up... 03:28:43 INFO - Return code: 0 03:28:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:43 INFO - Using env: {'DISPLAY': ':0', 03:28:43 INFO - 'HOME': '/home/cltbld', 03:28:43 INFO - 'LANG': 'en_US.UTF-8', 03:28:43 INFO - 'LANGUAGE': 'en_US:en', 03:28:43 INFO - 'LOGNAME': 'cltbld', 03:28:43 INFO - 'MAIL': '/var/mail/cltbld', 03:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:43 INFO - 'MOZ_NO_REMOTE': '1', 03:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:43 INFO - 'NO_EM_RESTART': '1', 03:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:43 INFO - 'PWD': '/builds/slave/test', 03:28:43 INFO - 'SHELL': '/bin/bash', 03:28:43 INFO - 'SHLVL': '1', 03:28:43 INFO - 'TERM': 'linux', 03:28:43 INFO - 'TMOUT': '86400', 03:28:43 INFO - 'USER': 'cltbld', 03:28:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:43 INFO - '_': '/tools/buildbot/bin/python'} 03:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:43 INFO - Cleaning up... 03:28:43 INFO - Return code: 0 03:28:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:43 INFO - Using env: {'DISPLAY': ':0', 03:28:43 INFO - 'HOME': '/home/cltbld', 03:28:43 INFO - 'LANG': 'en_US.UTF-8', 03:28:43 INFO - 'LANGUAGE': 'en_US:en', 03:28:43 INFO - 'LOGNAME': 'cltbld', 03:28:43 INFO - 'MAIL': '/var/mail/cltbld', 03:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:43 INFO - 'MOZ_NO_REMOTE': '1', 03:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:43 INFO - 'NO_EM_RESTART': '1', 03:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:43 INFO - 'PWD': '/builds/slave/test', 03:28:43 INFO - 'SHELL': '/bin/bash', 03:28:43 INFO - 'SHLVL': '1', 03:28:43 INFO - 'TERM': 'linux', 03:28:43 INFO - 'TMOUT': '86400', 03:28:43 INFO - 'USER': 'cltbld', 03:28:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:43 INFO - '_': '/tools/buildbot/bin/python'} 03:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:46 INFO - Downloading docopt-0.6.1.tar.gz 03:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:46 INFO - Running setup.py install for blobuploader 03:28:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:46 INFO - Running setup.py install for requests 03:28:46 INFO - Running setup.py install for docopt 03:28:46 INFO - Successfully installed blobuploader requests docopt 03:28:46 INFO - Cleaning up... 03:28:46 INFO - Return code: 0 03:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:46 INFO - Using env: {'DISPLAY': ':0', 03:28:46 INFO - 'HOME': '/home/cltbld', 03:28:46 INFO - 'LANG': 'en_US.UTF-8', 03:28:46 INFO - 'LANGUAGE': 'en_US:en', 03:28:46 INFO - 'LOGNAME': 'cltbld', 03:28:46 INFO - 'MAIL': '/var/mail/cltbld', 03:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:46 INFO - 'MOZ_NO_REMOTE': '1', 03:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:46 INFO - 'NO_EM_RESTART': '1', 03:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:46 INFO - 'PWD': '/builds/slave/test', 03:28:46 INFO - 'SHELL': '/bin/bash', 03:28:46 INFO - 'SHLVL': '1', 03:28:46 INFO - 'TERM': 'linux', 03:28:46 INFO - 'TMOUT': '86400', 03:28:46 INFO - 'USER': 'cltbld', 03:28:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:46 INFO - '_': '/tools/buildbot/bin/python'} 03:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:47 INFO - Running setup.py (path:/tmp/pip-zlGLEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:47 INFO - Running setup.py (path:/tmp/pip-VFO7vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:47 INFO - Running setup.py (path:/tmp/pip-9eYbh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:47 INFO - Running setup.py (path:/tmp/pip-6772LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:47 INFO - Running setup.py (path:/tmp/pip-d9wtQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:47 INFO - Running setup.py (path:/tmp/pip-SH9vXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:47 INFO - Running setup.py (path:/tmp/pip-A_Elhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:47 INFO - Running setup.py (path:/tmp/pip-o8o_oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:47 INFO - Running setup.py (path:/tmp/pip-7LwavG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:47 INFO - Running setup.py (path:/tmp/pip-GyKIml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:47 INFO - Running setup.py (path:/tmp/pip-7eTttk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:47 INFO - Running setup.py (path:/tmp/pip-hx8uQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:47 INFO - Running setup.py (path:/tmp/pip-MPSFKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:48 INFO - Running setup.py (path:/tmp/pip-t7IEaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:48 INFO - Running setup.py (path:/tmp/pip-IaQJAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:48 INFO - Running setup.py (path:/tmp/pip-gBR3J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:48 INFO - Running setup.py (path:/tmp/pip-9jN1LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:48 INFO - Running setup.py install for manifestparser 03:28:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:48 INFO - Running setup.py install for mozcrash 03:28:48 INFO - Running setup.py install for mozdebug 03:28:48 INFO - Running setup.py install for mozdevice 03:28:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:48 INFO - Running setup.py install for mozfile 03:28:48 INFO - Running setup.py install for mozhttpd 03:28:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:48 INFO - Running setup.py install for mozinfo 03:28:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozInstall 03:28:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozleak 03:28:49 INFO - Running setup.py install for mozlog 03:28:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for moznetwork 03:28:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozprocess 03:28:49 INFO - Running setup.py install for mozprofile 03:28:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozrunner 03:28:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozscreenshot 03:28:49 INFO - Running setup.py install for moztest 03:28:50 INFO - Running setup.py install for mozversion 03:28:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:50 INFO - Cleaning up... 03:28:50 INFO - Return code: 0 03:28:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:50 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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:50 INFO - Using env: {'DISPLAY': ':0', 03:28:50 INFO - 'HOME': '/home/cltbld', 03:28:50 INFO - 'LANG': 'en_US.UTF-8', 03:28:50 INFO - 'LANGUAGE': 'en_US:en', 03:28:50 INFO - 'LOGNAME': 'cltbld', 03:28:50 INFO - 'MAIL': '/var/mail/cltbld', 03:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:50 INFO - 'MOZ_NO_REMOTE': '1', 03:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:50 INFO - 'NO_EM_RESTART': '1', 03:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:50 INFO - 'PWD': '/builds/slave/test', 03:28:50 INFO - 'SHELL': '/bin/bash', 03:28:50 INFO - 'SHLVL': '1', 03:28:50 INFO - 'TERM': 'linux', 03:28:50 INFO - 'TMOUT': '86400', 03:28:50 INFO - 'USER': 'cltbld', 03:28:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:50 INFO - '_': '/tools/buildbot/bin/python'} 03:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:50 INFO - Running setup.py (path:/tmp/pip-u_1RJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:50 INFO - Running setup.py (path:/tmp/pip-DsyKMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:50 INFO - Running setup.py (path:/tmp/pip-kW0Fli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:50 INFO - Running setup.py (path:/tmp/pip-f5oipI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:50 INFO - Running setup.py (path:/tmp/pip-wKVQBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:50 INFO - Running setup.py (path:/tmp/pip-FGFeJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:50 INFO - Running setup.py (path:/tmp/pip-s2Ep_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:50 INFO - Running setup.py (path:/tmp/pip-g44wIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:50 INFO - Running setup.py (path:/tmp/pip-rVodSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:51 INFO - Running setup.py (path:/tmp/pip-Mvg1j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:51 INFO - Running setup.py (path:/tmp/pip-nVF2U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:51 INFO - Running setup.py (path:/tmp/pip-uW_oET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:51 INFO - Running setup.py (path:/tmp/pip-38vO_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:51 INFO - Running setup.py (path:/tmp/pip-Yma6g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:51 INFO - Running setup.py (path:/tmp/pip-a4fAmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:51 INFO - Running setup.py (path:/tmp/pip-5yfFyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:51 INFO - Running setup.py (path:/tmp/pip-tDVzXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:53 INFO - Downloading blessings-1.6.tar.gz 03:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:53 INFO - Installing collected packages: blessings 03:28:53 INFO - Running setup.py install for blessings 03:28:53 INFO - Successfully installed blessings 03:28:53 INFO - Cleaning up... 03:28:53 INFO - Return code: 0 03:28:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:54 INFO - Reading from file tmpfile_stdout 03:28:54 INFO - Current package versions: 03:28:54 INFO - argparse == 1.2.1 03:28:54 INFO - blessings == 1.6 03:28:54 INFO - blobuploader == 1.2.4 03:28:54 INFO - docopt == 0.6.1 03:28:54 INFO - functools32 == 3.2.3-2 03:28:54 INFO - jsonschema == 2.5.1 03:28:54 INFO - manifestparser == 1.1 03:28:54 INFO - mozInstall == 1.12 03:28:54 INFO - mozcrash == 0.17 03:28:54 INFO - mozdebug == 0.1 03:28:54 INFO - mozdevice == 0.48 03:28:54 INFO - mozfile == 1.2 03:28:54 INFO - mozhttpd == 0.7 03:28:54 INFO - mozinfo == 0.9 03:28:54 INFO - mozleak == 0.1 03:28:54 INFO - mozlog == 3.4 03:28:54 INFO - moznetwork == 0.27 03:28:54 INFO - mozprocess == 0.23 03:28:54 INFO - mozprofile == 0.28 03:28:54 INFO - mozrunner == 6.12 03:28:54 INFO - mozscreenshot == 0.1 03:28:54 INFO - mozsystemmonitor == 0.3 03:28:54 INFO - moztest == 0.7 03:28:54 INFO - mozversion == 1.4 03:28:54 INFO - psutil == 3.1.1 03:28:54 INFO - requests == 1.2.3 03:28:54 INFO - wsgiref == 0.1.2 03:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 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 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:54 INFO - Using env: {'DISPLAY': ':0', 03:28:54 INFO - 'HOME': '/home/cltbld', 03:28:54 INFO - 'LANG': 'en_US.UTF-8', 03:28:54 INFO - 'LANGUAGE': 'en_US:en', 03:28:54 INFO - 'LOGNAME': 'cltbld', 03:28:54 INFO - 'MAIL': '/var/mail/cltbld', 03:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:54 INFO - 'MOZ_NO_REMOTE': '1', 03:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:54 INFO - 'NO_EM_RESTART': '1', 03:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:54 INFO - 'PWD': '/builds/slave/test', 03:28:54 INFO - 'SHELL': '/bin/bash', 03:28:54 INFO - 'SHLVL': '1', 03:28:54 INFO - 'TERM': 'linux', 03:28:54 INFO - 'TMOUT': '86400', 03:28:54 INFO - 'USER': 'cltbld', 03:28:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:54 INFO - '_': '/tools/buildbot/bin/python'} 03:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:54 INFO - Cleaning up... 03:28:54 INFO - Return code: 0 03:28:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dd05ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d46ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:54 INFO - Using env: {'DISPLAY': ':0', 03:28:54 INFO - 'HOME': '/home/cltbld', 03:28:54 INFO - 'LANG': 'en_US.UTF-8', 03:28:54 INFO - 'LANGUAGE': 'en_US:en', 03:28:54 INFO - 'LOGNAME': 'cltbld', 03:28:54 INFO - 'MAIL': '/var/mail/cltbld', 03:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:54 INFO - 'MOZ_NO_REMOTE': '1', 03:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:54 INFO - 'NO_EM_RESTART': '1', 03:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:54 INFO - 'PWD': '/builds/slave/test', 03:28:54 INFO - 'SHELL': '/bin/bash', 03:28:54 INFO - 'SHLVL': '1', 03:28:54 INFO - 'TERM': 'linux', 03:28:54 INFO - 'TMOUT': '86400', 03:28:54 INFO - 'USER': 'cltbld', 03:28:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:54 INFO - '_': '/tools/buildbot/bin/python'} 03:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:54 INFO - Cleaning up... 03:28:54 INFO - Return code: 0 03:28:54 INFO - Running post-action listener: _resource_record_post_action 03:28:54 INFO - Running post-action listener: _start_resource_monitoring 03:28:54 INFO - Starting resource monitoring. 03:28:54 INFO - [mozharness: 2016-10-25 10:28:54.504628Z] Finished create-virtualenv step (success) 03:28:54 INFO - [mozharness: 2016-10-25 10:28:54.505093Z] Running install step. 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: install 03:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:54 INFO - Reading from file tmpfile_stdout 03:28:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:54 INFO - Reading from file tmpfile_stdout 03:28:54 INFO - Output received: 03:28:54 INFO - Usage: mozinstall [options] installer 03:28:54 INFO - Options: 03:28:54 INFO - -h, --help show this help message and exit 03:28:54 INFO - -d DEST, --destination=DEST 03:28:54 INFO - Directory to install application into. [default: 03:28:54 INFO - "/builds/slave/test"] 03:28:54 INFO - --app=APP Application being installed. [default: firefox] 03:28:54 INFO - mkdir: /builds/slave/test/build/application 03:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:29:10 INFO - Reading from file tmpfile_stdout 03:29:10 INFO - Output received: 03:29:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:10 INFO - Running post-action listener: _resource_record_post_action 03:29:10 INFO - [mozharness: 2016-10-25 10:29:10.820820Z] Finished install step (success) 03:29:10 INFO - [mozharness: 2016-10-25 10:29:10.821064Z] Running run-tests step. 03:29:10 INFO - Running pre-action listener: _resource_record_pre_action 03:29:10 INFO - Running main action method: run_tests 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:10 INFO - Python 2.7.3 03:29:10 INFO - Return code: 0 03:29:10 INFO - grabbing minidump binary from tooltool 03:29: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')]} 03:29:10 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 0x1d43f60>, '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 0x1d44d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d451d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:29:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:10 INFO - Return code: 0 03:29:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:29:10 INFO - Using env: {'DISPLAY': ':0', 03:29:10 INFO - 'HOME': '/home/cltbld', 03:29:10 INFO - 'LANG': 'en_US.UTF-8', 03:29:10 INFO - 'LANGUAGE': 'en_US:en', 03:29:10 INFO - 'LOGNAME': 'cltbld', 03:29:10 INFO - 'MAIL': '/var/mail/cltbld', 03:29:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:10 INFO - 'MOZ_NO_REMOTE': '1', 03:29:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:10 INFO - 'NO_EM_RESTART': '1', 03:29:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:10 INFO - 'PWD': '/builds/slave/test', 03:29:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:10 INFO - 'SHELL': '/bin/bash', 03:29:10 INFO - 'SHLVL': '1', 03:29:10 INFO - 'TERM': 'linux', 03:29:10 INFO - 'TMOUT': '86400', 03:29:10 INFO - 'USER': 'cltbld', 03:29:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490', 03:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:10 INFO - '_': '/tools/buildbot/bin/python'} 03:29:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:29:11 INFO - mozversion application_buildid: 20161025015208 03:29:11 INFO - mozversion application_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:29:11 INFO - mozversion application_display_name: Nightly 03:29:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:11 INFO - mozversion application_name: Firefox 03:29:11 INFO - mozversion application_remotingname: firefox 03:29:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:29:11 INFO - mozversion application_vendor: Mozilla 03:29:11 INFO - mozversion application_version: 52.0a1 03:29:11 INFO - mozversion platform_buildid: 20161025015208 03:29:11 INFO - mozversion platform_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:29:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:29:11 INFO - mozversion platform_version: 52.0a1 03:29:11 INFO - using testdate: 1477391351 03:29:11 INFO - actual date: 1477391351 03:29:11 INFO - starting webserver on 'localhost:44596' 03:29:11 INFO - SUITE-START | Running 2 tests 03:29:11 INFO - TEST-START | dromaeo_css 03:29:11 INFO - operating with platform_type : linux_ 03:29:11 INFO - Initialising browser for dromaeo_css test... 03:29:11 INFO - TEST-INFO | started process 28361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW69UOs/profile http://localhost:44596/getInfo.html) 03:29:15 INFO - PROCESS | 28361 | __metrics Screen width/height:1600/1200 03:29:15 INFO - PROCESS | 28361 | colorDepth:24 03:29:15 INFO - PROCESS | 28361 | Browser inner width/height: 1024/697 03:29:15 INFO - PROCESS | 28361 | __metrics 03:29:16 INFO - PROCESS | 28361 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:29:16 INFO - PROCESS | 28361 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:16 INFO - PROCESS | 28361 | console.error: PushService: 03:29:16 INFO - PROCESS | 28361 | stateChangeProcessEnqueue: Error transitioning state 03:29:16 INFO - PROCESS | 28361 | UnknownError 03:29:17 INFO - TEST-INFO | 28361: exit 0 03:29:17 INFO - Browser initialized. 03:29:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:17 INFO - TEST-INFO | started process 28443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW69UOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:29 INFO - PROCESS | 28443 | RSS: Main: 173658112 03:29:29 INFO - PROCESS | 28443 | 03:30:21 INFO - PROCESS | 28443 | 1477391421456 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:32:35 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44596/tests/dromaeo/cssquery-ext.html) 03:32:36 INFO - PROCESS | 28443 | RSS: Main: 311410688 03:32:36 INFO - PROCESS | 28443 | 03:35:39 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-ext.html (next: http://localhost:44596/tests/dromaeo/cssquery-jquery.html) 03:35:40 INFO - PROCESS | 28443 | RSS: Main: 274321408 03:35:40 INFO - PROCESS | 28443 | 03:38:42 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44596/tests/dromaeo/cssquery-mootools.html) 03:38:42 INFO - PROCESS | 28443 | RSS: Main: 216948736 03:38:42 INFO - PROCESS | 28443 | 03:41:45 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44596/tests/dromaeo/cssquery-prototype.html) 03:41:45 INFO - PROCESS | 28443 | RSS: Main: 216387584 03:41:45 INFO - PROCESS | 28443 | 03:44:48 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44596/tests/dromaeo/cssquery-yui.html) 03:44:49 INFO - PROCESS | 28443 | RSS: Main: 219734016 03:44:49 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:44596/tests/dromaeo/cssquery-yui.html (next: http://localhost:44596/tests/dromaeo/cssquery-dojo.html) 03:47:52 INFO - PROCESS | 28443 | RSS: Main: 305684480 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | __start_tp_report 03:47:52 INFO - PROCESS | 28443 | _x_x_mozilla_page_load 03:47:52 INFO - PROCESS | 28443 | _x_x_mozilla_page_load_details 03:47:52 INFO - PROCESS | 28443 | |i|pagename|runs| 03:47:52 INFO - PROCESS | 28443 | |0;dojo.html;2543.4150145466538;2552.629868669042;2589.236175328278;2593.740625937405;2595.0917178987356;4440.644748420127;4542.523035081318;4549.385832912556;4550.340200670901;4568.885777855551;4584.74783886887;4593.724376537401;4600.470945841229;4608.815647374109;4608.953910460895;4183.853565125221;4211.4946206455115;4226.387173859788;4247.426597409357;4304.806283717225;4191.7694526801015;4231.534531201565;4232.724872883253;4236.97881510592;4242.172776308621;4222.725522841006;4225.471816022997;4233.83064677414;4265.594768497003;4286.0999190170105;4243.87268381946;4283.850065247701;4322.984098736794;4337.089211265638;4375.256206444912;4118.094019315776;4148.128892932457;4217.704760666755;4230.323148296288;4277.572242775728;4645.349651048856;4647.140279048387;4665.88335291617;4718.221493453576;4729.266963620645;4969.428515720702;4972.950270497285;4989.700617962933;5004.149294619923;5062.493750624908;4754.334393184957;4877.731724755173;4882.7558622068755;4963.726995015273;5022.096022715909;4669.906601867943;4672.649551283599;4673.649476289258;4726.503717109654;4727.527247275314;5094;5102.540771330598;5103.132467480537;5104.821331253388;5160.277561141444;4686.531346865286;4742.170120229015;4893.535114164149;4898.657094003457;4960.181570040975;4881.707097574086;4952.108620448282;4986.925196122061;4988.775505102279;5089;4952.603791696655;4965.155923493015;4976.402831660224;4984.601231901439;5024.070546948826;4918.2376731606655;4934.629902757308;4938.456769755324;4943.209086546207;5004.674696144812;3974.8012599369918;3979.243943650697;4022.597740225954;4116.197341518435;4124.896877578085;3621.94567081494;3644.9817750911075;3668.871589494355;3677.42999835026;3688.2254726507736;4324.329728892027;4337.869863904088;4348.782560871944;4373.037931655031;4382.517923028464;4724.763761811896;4779.761011949388;4796.5203479651755;5033.3205017322925;5033.471485494044;4202.432671589297;4205.894852628709;4212.557681443404;4217.831286748557;4255.127698821734;4397.164538737629;4398.296272596369;4433.623142032899;4446.3552784846015;4452.421185245962;4653.627709783209;4660.86017419478;4663.253879379283;4663.27719203524;4741.2651039089;4710.4347478302825;4934.925976110289;4938;4941.382327209099;5004.574611158092;4548.658850586286;4609.907801844011;4616.099860527299;4622.237330840374;4640.466346370211;4870.147724148189;4872.317875497362;4875.536824001714;4942.159832828356;4954.925676114789;4900.705957642553;4930.901381972269;4937.827176048965;4940.728259945738;4940.975295123501;4653.581177694024;4653.744044077608;4707.435107787088;4853.6602437829015;4859.979404325131;4920.31115643803;4923.679960802537;4934.851954441372;4973.154563724248;4994.575461085703;4827.227643577011;4829.6860704054125;4830.372051633265;4852.092801003542;4888.340074089952;4582.77086145698;4625.629949604091;4927.852164435073;4935.531124543163;5001.549860512571;4568.132054909556;4688.953110468988;4727.787249573708;4742.217534106834;4809.95190048109 03:47:52 INFO - PROCESS | 28443 | |1;ext.html;529.4793003309245;581.1602234770755;581.4941001328842;586.9501092407145;594.6283572767021;27850.44299114019;38091.4286285706;39054.80472597633;39156.80421597888;39176.80411597945;40196.39705404421;40558.39162412566;40639.187216255654;40646.18707625853;40657.18685626293;7794.220577942203;7959.880601790977;7960.203979602052;7963.5221886686695;7965.402594805384;7780;7842.490238134503;7861.882071768928;7867;7868.606569671522;7850.646720897574;7852.685892564319;7900.762977110667;7905.762827115196;7910.485818421784;7806.609669516558;7818.921810781876;7843.372530197627;7854.293113619773;7905.7232996845405;7711.614419279013;7764.107127680332;7770.33952114071;7774.2614451627005;7775.766726998199;37085.814570926974;37116.257674846354;37477;37503.62496375056;37517;2960.674325824179;3062.0660698486954;3098.938021239585;3125.9218519536967;3246.902592922216;28207.153785386472;28280.717192828015;28770.85614571914;28880.27799305013;30221.546676799866;3423.3666771647327;3482.5995010573856;3503.1242189452637;3514.789112653249;3572.7499075064757;176552;177733;177984;178063;178238.10880945643;51576.48423515792;51832.48167518352;51893;51904;51965.22052169221;31502.36995260082;32814.8359258207;32927.67072329294;34862.12844678853;34997.300053999286;12191.634250972485;12212.938935305445;12291.938540307241;12311.815322770166;12424.813627795591;9493.050694930589;9569.3779904306;9574.425534467955;9583.520823958774;9589.90410095904;17542.824571754376;17574.209160587805;17634.647307054045;17652;17654.470365889043;6731.225909020427;6787.898181527281;6935.375816176467;6973.803251975612;7081.964590177016;784.4508843809242;904.4980036080038;932.4312169576552;954.7183580843667;1022.892596277395;27222.863885680446;27280.45439091207;27920;27973.580396294074;28188.85905570459;780.9140994490601;887.316766090107;935.4714586258742;938.938968967015;941.2893265584577;11825.52697892092;14388.784168237486;14727;14739.778903316459;15010.099394036393;373060;376577;376605;376863;377294;48443;48803;48872;49110.75444622825;49122.50877491251;1045.2004216774021;1053.947302634865;1121.3608243301403;1137.971550711239;1183.4910988275124;26863.462730745665;28556.714432855406;28921.56617650779;29123.612131755694;29219.415611688073;40912.79543602263;41512.377314339705;41524.58475415207;41529.37705934474;41571.58428415798;288544;291699;291917;398248;408777;36514.26971460609;36968.26063478769;37146.25707485889;37545.249095018495;37820.083389159234;42058.579414205466;42439.36340954826;42445.78777106218;42885;43249.35125973176;35425.82287088651;35485.82257088801;35513.289734204656;35611.10972225715;36162.4575631371;35343.29313413769;35688;35929;36171.63828361683;36237;35497.290054199286;35770.463443048895;36128.27743445169;36511.26977460489;36685.39662860711;30218;32391.838040809645;32495.837520812245;32863.17842053872;32889.83555082209;25019.74980250174;25438.745612543637;25538.74461255438;25759.356016099;25959 03:47:52 INFO - PROCESS | 28443 | |2;jquery.html;338.4297458781952;339.3772427595362;341.9743519236057;351.7555299067149;370.98516059357627;12560.874391256084;12735.936320318397;13448.66378340542;13584.592462226137;16768;14571.417143314255;14732.116073035626;14915.179665118414;14999.250037498135;15155.090694558334;4910.680805747633;4921.311016457699;5126;5129.307543481638;5133.666311689747;5017.64876458648;5134.152864777326;5137.56330711888;5143.897122057557;5144.948550514503;4936.284238785392;5205.843824685266;5218.269442278084;5274.604404669665;5289.338832645919;5269.8946021079555;5283.154695248761;5289.629725919187;5295.867603309909;5414.972925135388;5170;5196.220566914955;5197.610179236573;5198.532132108091;5198.882240318312;11784.410779461079;11914.404279785977;11976.940115299367;12023.759524809542;12209;1863.5341164708823;1874.3252429125505;1912.531429799694;2061.3506745375307;2360.1503458754833;8262.710805121853;8556.486610803371;8977.371583989123;9034.86447703285;9055.366124371296;1622.7403615421595;1642.8439298266646;1654.751787231925;1716.5965997990463;1727.2141175764996;63812;69296.6535167321;69966.300336997;70289.2971070293;70332.648336758;9148.908510914938;9509.286803489766;9520.761980950532;9858.112769850748;9975.700728978143;12913.677158070936;12933.676658083623;12934.353282335846;12941.352932353533;13010.674733131747;6389.9680501597195;6390.265119511223;6520.152380190545;6531.379518945692;6562.8359291018105;5835.387284335084;5862.237909071879;6029.035354343372;6084.330723620398;6088.299845517822;3755.9436608450897;3856.0745421098736;3910.7066969977363;3916.9020774480296;4149.211649786531;1746.991265043692;1817.2276782367442;1825.4859395663295;1841.7881943576392;1849.306510058728;800.5516910530122;804.0230970293862;833.1626715151234;834.4367551902442;836.7782537627534;14560.708785824225;16097.678046439005;16178.11020393866;16425.178741063137;16960;858.9914100858912;865.9134086591416;868.1708967935606;878.868169774539;893.6068130022769;8730.607122679494;9007.414518056305;9387.906120938704;9471.857922131174;9517.476538790295;283231;288184;288352;390658;393593;77812;82088.58955705183;82275;82400.58799706084;82513.58743206246;859.1365677494204;872.3722385606233;899.7300809757047;900.8333458310234;903.8779764731809;15260.160691162093;15289.464868729541;15741.370345186064;15906.761398579261;16037.797165212422;25467;26313;26826;34970.47544286787;36204.45693314655;51685.483145168066;51877.48122518878;52156;52699.36503174749;54659.45340546703;7300.452466065172;7323.816904577428;7360.742374016883;7454.813629659302;7468.290512401313;9825.656102036395;10206.234532410248;11561.537538498365;11629.651110466699;11805.23265987708;10023.248256380655;10079.647212347532;10179.287449878437;10577.259591828499;10752.731181720519;9834.852477212704;10058.094771470604;10218.846717299099;10402.323848949794;10419.218558608287;10162.39025658463;10381.740456488647;10400.427976461368;10405.739856503647;10461.790764184521;7362.815929601588;7452.776416707507;7671.2712292332135;7682.193369696101;7900.68397264103;9890.85163722559;10337.793244135226;10471.738206544896;10477.790444191225;10541.420221887563 03:47:52 INFO - PROCESS | 28443 | |3;mootools.html;1235.647840365496;1345.2802750528467;1381.92399418032;1420.7939848721935;1653.6751659655904;6382.2341319041725;7010.228874823772;7384.999999999994;7405.703771849133;7574.583397913113;7392.96303518483;7469.141048779392;7470.47706660534;7472.738454154106;7475.514091584043;2108.704781330615;2140.518383363746;2144.5925274197853;2144.742630884296;2146.7638559758416;2077.8753274803485;2133.9146434142617;2135.1459416233474;2135.893205339735;2139.518608313125;2064.0917996081753;2069.3584988653565;2088.728465299509;2100.159936025587;2100.863443876151;2012.7685316188606;2039.1639427834516;2040.9897950510153;2041.3569725536483;2046.9385918422472;1989.5622962948273;1999.320231121411;2016.4253187841541;2018.5760990192077;2023.1199428248758;7052;7162.606056666881;7167.4266058715175;7171.605561694105;7347.926520734778;4341.565843415665;4519.299508576143;4521.231390663595;4521.570450807168;4522.977385113087;2749.917502474929;2959.067893613505;3011.6084908961916;3011.683773203804;3017.834019128969;910.4582773249972;931.1526510875071;932.1377725603857;934.3412893909777;945.0077418710326;9905.80188396228;9970.700878973643;9973.301868869183;9976.800463990752;9995.75010624733;3731.4962480065387;3811.599782022903;3925.8822235332987;4120.093579412524;4131.132462182915;7909.802254943673;7954.642041108164;7955;7961.8407631848195;7968.12350641429;4378.584034516716;4385.934210986838;4386.166628340605;4386.7367957922625;4386.8025938832825;3304.2069903223055;3421.1447138215444;3575.2313252650806;4083.509978802503;4088.2232375848494;3131.1858916681826;3221.6778322168066;3251.7561182911377;3257.5113732939776;3331.267121233325;1007.5415685862915;1008.1632245236436;1014.8274793285011;1017.577705252312;1024.1243736605245;786.5949036246337;793.6785601831267;840.5167028958373;847.7456762971084;851.9787005324916;4860.538248866352;4916.680415772963;5056.949430505648;5069.391672999263;5118.974405128025;382.51993747846274;407.0657840256618;408.85281298732434;876.2945828608032;925.6112432778249;3311.1556553078813;3317;3372.915677108043;3384.2385463270566;3562.305350456688;8905.643774248958;9294.209992150607;9299.302552308603;9300.813983720423;9332.160105590394;9231;9237.030111838294;9247.953760231156;9250.121238482334;9260.259179265642;6625.900611490832;6861.490472096131;6982.441404687613;7033.296670332926;7205.387542058879;5053.646244762831;5125.5136010556525;5138.97430512845;5299.39057008449;5319.920201196907;7997.280244777998;8258.628361723617;8332.33341332704;8346.040205376217;8352.206540378655;8359.832803344021;8375.120612335617;8422.70520531803;8450.239478446969;8458.703945361884;6129.724162412791;6235.906461403173;6241.157443745036;6246.781362652286;6248.968755156195;6877.793666190022;6894.517383783288;6911.7926462206215;6922.757703480354;6943.618101004493;6136.23297087864;6155;6157.445829875153;6163.876722465436;6165.10605962124;6023.277206735044;6153.692315384303;6161.907571386343;6174.320824709368;6281.3404592518955;5870.823875283749;6015.428534289235;6030.4572588467245;6095.969520152371;6202.968985155046;4261.1051679146485;4296.785160741888;4412.977935110304;4453.398791163151;4457.643388528974;4373.409589705349;4392.538783427822;4467.084247729273;4469.7318160910445;4548.4996650367775 03:47:52 INFO - PROCESS | 28443 | |4;prototype.html;290.29168828059534;292.6795159300566;299.9520076787714;303.62047440699126;305.29324613519714;4817.590504807091;4869.001854619803;4873.878153046171;4887.828925987591;4888.657793954425;4761.857144285677;4795.424549054118;4802.351682522858;4803.855884323467;4818.108649899762;3820.2741479118877;3842;3842.4063756963938;3848.730588858781;3860.208657225262;3724.3482390581676;3803.2583646189005;3849.556416343871;3857.402102674076;3868.825902834379;3746.232022435408;3768.4158955361963;3779.848806047755;3792.2794669012937;3807.2385522895393;3736.626337366242;3767.1523907120954;3773.3773927301963;3775.679067279257;3777.848886044555;3125.718685318332;3227.612686477638;3257.5602293690285;3335.8665653373837;3339.7976728377766;4661.953380466186;4668.253079507296;4671.696339737906;4672.6261899047995;4699.859004229878;4286.314189729628;4289.678274129453;4294.604253617586;4297.312430011183;4307.138572285556;4614.930776038362;4741.359916411275;5010.72441015744;5012.721755952245;5040.487853643929;3631.654992775682;3639.1266096137;3651.72612054097;3653.598104208535;3672.4307732301536;5222.63441559091;5242.842714718565;5261.184516399926;5263.999680121529;5268.604854635918;3419.675130862564;3565.9286814264087;3766.851110411351;3776.86780962665;3777.338965680995;3600.4419315006216;3619.3123306571665;3624.7825130492256;3631.2011357501306;3639.090227443139;4169.207850508455;4185.434966279513;4204.306289462204;4206.158768246363;4219.261629214875;4984.3302493664305;4988.451270360258;4995.625328100407;5005.574526165244;5007.774650140753;1231.2858542045592;1273.5860845225338;1282.9992605767516;1283.2685369339574;1286.581860895194;794.2573693596506;806.8305655812345;827.2472050434196;827.3783384566198;830.1905641999002;3973.980130099331;3979.303621866162;3991.1840112748628;4005.6595189409227;4033.495813023372;4535.501094879561;4544.886627718127;4549.203889319422;4556.97721511397;4583.358329833826;3999.7800120993625;4004.5394779600138;4004.959950400517;4021.678265738734;4021.7733591254364;2332.3702600297825;2432.701097462916;2444.5599792037247;2448.7183973843235;2455.72986971433;4329.935050974238;4595.2188128018315;4721.173794585934;4725.881852953635;4910.263460480956;5276.577873770089;5285.445028272053;5304.177852432879;5312.282841816305;5359.3032905722;4884.975575122102;4885.706857588556;4912.1158191525155;4921.31101645777;4938.25926111079;4974.607110009203;5127.359080114986;5156.484351564964;5177.430482646831;5185.559227465556;5091.803426194915;5103.7192954387865;5116.283720279238;5121.285718569165;5142.331496905378;4762;4878.438979517259;4895.46149923501;4914.36113305268;4953.876153096201;3620.185458271973;3635.927281454409;3640.7269454790467;3681.2453447043827;3691.5016472775833;5194.194899790538;5224.9738751306;5236.476352364733;5247.239150323106;5273.182656688219;5046.561729906959;5061.519155680205;5072.873178170576;5101.795928162832;5134.717590532557;4849.684770489906;5036.672616280077;5054.646174767731;5056.696598204119;5069.1635880079375;4920.40955085392;4929.926051109308;4936.259561065725;4986.351774269467;4988.501149884983;4919.581835543876;5032.899342013213;5044.461439261061;5061.7469126544265;5065.758889072201;4872.853814385574;4904.852854414374;4910.8281210157475;4912.287718280758;4944.258361245842 03:47:52 INFO - PROCESS | 28443 | |5;yui.html;636.5194278319868;709.4076446167453;727.0185249912615;729.3435907683088;742.0612924650317;12381.876181238185;12724.872751272485;12987.155834870728;13153.276569788646;13296.335183240848;12131.818022729665;12192.573259935903;12195.085368597347;12213.51145954163;12214.32821194834;788.9132195458509;812.7236739508566;815.282551354807;816.2327412232482;816.2898278497686;628.4501061571125;649.0621052579002;790.6363072986433;808.4300568099476;810.6595230003413;842.4439869686008;843.6541018182546;845.5560830563942;847.1189962439056;847.9406441549094;842.204117109332;842.8187939592956;843.359047124187;843.4433274039166;843.970461033867;484.70190832638025;494.278353603739;601.20940962634;615.2770494668791;615.8491169663416;11484.36835974021;11503.827442588368;11511.309321440656;11611.187216894821;11651.650450486499;11561.30632162073;11696.356700381475;11959.760804783942;12276.570320038756;12419.130660853743;11073.889261107366;11190.66428007161;11274.830877536844;11437.369405036889;11497.252678575866;3972.165845172517;3991.4212439196153;4012.9799351003057;4057.8376864925367;4075.409065685459;51433.48566514324;51516.742416288056;51530;51566.48433515654;51667.48332516664;9488.478133702574;9516.143547080796;9523.428594284365;9798.902010979942;9944;15638.139902305482;16573.58566035859;16606.335746570003;16823;17516;6466.191726034246;6600.735970561123;6671.732370849523;6893.345132212432;6910.30896910315;3690.225052738901;3819.8854034379015;3843.8462461501786;3931.1744533647684;3948.466956960831;2780.902668406596;2876.3384421583155;2901.086157860267;2902.274431392152;2909.505384084711;503.21247248057404;512.139605462826;512.4004914250336;513.8535517377529;520.4899198785212;612.7548980407784;619.9752009919642;621.6798348850346;623.5977794322728;631.7315141065029;6510.25132109804;7046.894296585555;7150;7400.111986561539;7930.5638189898955;508.7863097499059;518.6654607777962;595.597971369324;618.8793185328817;629.0658372317106;3514.982425087909;3816.2939856126704;3824.4263360496147;3840.020794697334;3848.6728628066367;42790;42853.78573107115;43182.56817431848;56021;74101;40609;41190.176196475906;63811.68094159592;64700.67649661721;66529.6673516639;55716.16425753617;57518.712406438535;57660;58367;59198;6852.280510546321;7107.893381599177;7215.67529461165;7246.492745507764;7550.2449755026255;32174.517382238817;33164.83417582897;33461;36687.26625467422;41908.371374428796;32687.836560817042;34398.14004649904;47470.626468675735;49033.26450103323;50041.74979125081;10688.358698478116;10928.94535527349;11036.834447483134;11081.445927703744;11620.418979050844;11651.59219427316;11804.291742495478;11808.11439142085;12225.266484010988;12487.562935297221;11198.664040078811;11330.546778128783;11412.201145919706;11598.71003224926;12112.818307725567;11106.722331941766;11188.776224475629;11664.708382290512;11823.881761182278;11995.520179192734;11171.72070698239;11188.10495160369;11277.21059525858;11319.717007074889;11404.771904561696;9251.167394934218;9260.629574816932;9384;9529.142377186086;9653.855192171983;9575.425474471554;9828.164606008284;9867.605295788087;9965.966225340382;9996.20030397581 03:47:52 INFO - PROCESS | 28443 | __end_tp_report 03:47:52 INFO - PROCESS | 28443 | __start_cc_report 03:47:52 INFO - PROCESS | 28443 | _x_x_mozilla_cycle_collect,1350 03:47:52 INFO - PROCESS | 28443 | __end_cc_report 03:47:52 INFO - PROCESS | 28443 | __startTimestamp1477392472575__endTimestamp 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | ------- Summary: start ------- 03:47:52 INFO - PROCESS | 28443 | Number of tests: 6 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#0] dojo.html Cycles:165 Average:4567.19 Median:4669.91 stddev:490.62 (10.5%) stddev-sans-first:465.74 03:47:52 INFO - PROCESS | 28443 | Values: 2543.4 2552.6 2589.2 2593.7 2595.1 4440.6 4542.5 4549.4 4550.3 4568.9 4584.7 4593.7 4600.5 4608.8 4609.0 4183.9 4211.5 4226.4 4247.4 4304.8 4191.8 4231.5 4232.7 4237.0 4242.2 4222.7 4225.5 4233.8 4265.6 4286.1 4243.9 4283.9 4323.0 4337.1 4375.3 4118.1 4148.1 4217.7 4230.3 4277.6 4645.3 4647.1 4665.9 4718.2 4729.3 4969.4 4973.0 4989.7 5004.1 5062.5 4754.3 4877.7 4882.8 4963.7 5022.1 4669.9 4672.6 4673.6 4726.5 4727.5 5094.0 5102.5 5103.1 5104.8 5160.3 4686.5 4742.2 4893.5 4898.7 4960.2 4881.7 4952.1 4986.9 4988.8 5089.0 4952.6 4965.2 4976.4 4984.6 5024.1 4918.2 4934.6 4938.5 4943.2 5004.7 3974.8 3979.2 4022.6 4116.2 4124.9 3621.9 3645.0 3668.9 3677.4 3688.2 4324.3 4337.9 4348.8 4373.0 4382.5 4724.8 4779.8 4796.5 5033.3 5033.5 4202.4 4205.9 4212.6 4217.8 4255.1 4397.2 4398.3 4433.6 4446.4 4452.4 4653.6 4660.9 4663.3 4663.3 4741.3 4710.4 4934.9 4938.0 4941.4 5004.6 4548.7 4609.9 4616.1 4622.2 4640.5 4870.1 4872.3 4875.5 4942.2 4954.9 4900.7 4930.9 4937.8 4940.7 4941.0 4653.6 4653.7 4707.4 4853.7 4860.0 4920.3 4923.7 4934.9 4973.2 4994.6 4827.2 4829.7 4830.4 4852.1 4888.3 4582.8 4625.6 4927.9 4935.5 5001.5 4568.1 4689.0 4727.8 4742.2 4810.0 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#1] ext.html Cycles:180 Average:44996.10 Median:205268.50 stddev:81979.67 (39.9%) stddev-sans-first:82141.66 03:47:52 INFO - PROCESS | 28443 | Values: 529.5 581.2 581.5 587.0 594.6 27850.4 38091.4 39054.8 39156.8 39176.8 40196.4 40558.4 40639.2 40646.2 40657.2 7794.2 7959.9 7960.2 7963.5 7965.4 7780.0 7842.5 7861.9 7867.0 7868.6 7850.6 7852.7 7900.8 7905.8 7910.5 7806.6 7818.9 7843.4 7854.3 7905.7 7711.6 7764.1 7770.3 7774.3 7775.8 37085.8 37116.3 37477.0 37503.6 37517.0 2960.7 3062.1 3098.9 3125.9 3246.9 28207.2 28280.7 28770.9 28880.3 30221.5 3423.4 3482.6 3503.1 3514.8 3572.7 176552.0 177733.0 177984.0 178063.0 178238.1 51576.5 51832.5 51893.0 51904.0 51965.2 31502.4 32814.8 32927.7 34862.1 34997.3 12191.6 12212.9 12291.9 12311.8 12424.8 9493.1 9569.4 9574.4 9583.5 9589.9 17542.8 17574.2 17634.6 17652.0 17654.5 6731.2 6787.9 6935.4 6973.8 7082.0 784.5 904.5 932.4 954.7 1022.9 27222.9 27280.5 27920.0 27973.6 28188.9 780.9 887.3 935.5 938.9 941.3 11825.5 14388.8 14727.0 14739.8 15010.1 373060.0 376577.0 376605.0 376863.0 377294.0 48443.0 48803.0 48872.0 49110.8 49122.5 1045.2 1053.9 1121.4 1138.0 1183.5 26863.5 28556.7 28921.6 29123.6 29219.4 40912.8 41512.4 41524.6 41529.4 41571.6 288544.0 291699.0 291917.0 398248.0 408777.0 36514.3 36968.3 37146.3 37545.2 37820.1 42058.6 42439.4 42445.8 42885.0 43249.4 35425.8 35485.8 35513.3 35611.1 36162.5 35343.3 35688.0 35929.0 36171.6 36237.0 35497.3 35770.5 36128.3 36511.3 36685.4 30218.0 32391.8 32495.8 32863.2 32889.8 25019.7 25438.7 25538.7 25759.4 25959.0 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#2] jquery.html Cycles:180 Average:22009.02 Median:5071.82 stddev:55628.63 (1096.8%) stddev-sans-first:55760.89 03:47:52 INFO - PROCESS | 28443 | Values: 338.4 339.4 342.0 351.8 371.0 12560.9 12735.9 13448.7 13584.6 16768.0 14571.4 14732.1 14915.2 14999.3 15155.1 4910.7 4921.3 5126.0 5129.3 5133.7 5017.6 5134.2 5137.6 5143.9 5144.9 4936.3 5205.8 5218.3 5274.6 5289.3 5269.9 5283.2 5289.6 5295.9 5415.0 5170.0 5196.2 5197.6 5198.5 5198.9 11784.4 11914.4 11976.9 12023.8 12209.0 1863.5 1874.3 1912.5 2061.4 2360.2 8262.7 8556.5 8977.4 9034.9 9055.4 1622.7 1642.8 1654.8 1716.6 1727.2 63812.0 69296.7 69966.3 70289.3 70332.6 9148.9 9509.3 9520.8 9858.1 9975.7 12913.7 12933.7 12934.4 12941.4 13010.7 6390.0 6390.3 6520.2 6531.4 6562.8 5835.4 5862.2 6029.0 6084.3 6088.3 3755.9 3856.1 3910.7 3916.9 4149.2 1747.0 1817.2 1825.5 1841.8 1849.3 800.6 804.0 833.2 834.4 836.8 14560.7 16097.7 16178.1 16425.2 16960.0 859.0 865.9 868.2 878.9 893.6 8730.6 9007.4 9387.9 9471.9 9517.5 283231.0 288184.0 288352.0 390658.0 393593.0 77812.0 82088.6 82275.0 82400.6 82513.6 859.1 872.4 899.7 900.8 903.9 15260.2 15289.5 15741.4 15906.8 16037.8 25467.0 26313.0 26826.0 34970.5 36204.5 51685.5 51877.5 52156.0 52699.4 54659.5 7300.5 7323.8 7360.7 7454.8 7468.3 9825.7 10206.2 11561.5 11629.7 11805.2 10023.2 10079.6 10179.3 10577.3 10752.7 9834.9 10058.1 10218.8 10402.3 10419.2 10162.4 10381.7 10400.4 10405.7 10461.8 7362.8 7452.8 7671.3 7682.2 7900.7 9890.9 10337.8 10471.7 10477.8 10541.4 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#3] mootools.html Cycles:180 Average:4820.80 Median:5219.18 stddev:2684.16 (51.4%) stddev-sans-first:2678.17 03:47:52 INFO - PROCESS | 28443 | Values: 1235.6 1345.3 1381.9 1420.8 1653.7 6382.2 7010.2 7385.0 7405.7 7574.6 7393.0 7469.1 7470.5 7472.7 7475.5 2108.7 2140.5 2144.6 2144.7 2146.8 2077.9 2133.9 2135.1 2135.9 2139.5 2064.1 2069.4 2088.7 2100.2 2100.9 2012.8 2039.2 2041.0 2041.4 2046.9 1989.6 1999.3 2016.4 2018.6 2023.1 7052.0 7162.6 7167.4 7171.6 7347.9 4341.6 4519.3 4521.2 4521.6 4523.0 2749.9 2959.1 3011.6 3011.7 3017.8 910.5 931.2 932.1 934.3 945.0 9905.8 9970.7 9973.3 9976.8 9995.8 3731.5 3811.6 3925.9 4120.1 4131.1 7909.8 7954.6 7955.0 7961.8 7968.1 4378.6 4385.9 4386.2 4386.7 4386.8 3304.2 3421.1 3575.2 4083.5 4088.2 3131.2 3221.7 3251.8 3257.5 3331.3 1007.5 1008.2 1014.8 1017.6 1024.1 786.6 793.7 840.5 847.7 852.0 4860.5 4916.7 5056.9 5069.4 5119.0 382.5 407.1 408.9 876.3 925.6 3311.2 3317.0 3372.9 3384.2 3562.3 8905.6 9294.2 9299.3 9300.8 9332.2 9231.0 9237.0 9248.0 9250.1 9260.3 6625.9 6861.5 6982.4 7033.3 7205.4 5053.6 5125.5 5139.0 5299.4 5319.9 7997.3 8258.6 8332.3 8346.0 8352.2 8359.8 8375.1 8422.7 8450.2 8458.7 6129.7 6235.9 6241.2 6246.8 6249.0 6877.8 6894.5 6911.8 6922.8 6943.6 6136.2 6155.0 6157.4 6163.9 6165.1 6023.3 6153.7 6161.9 6174.3 6281.3 5870.8 6015.4 6030.5 6096.0 6203.0 4261.1 4296.8 4413.0 4453.4 4457.6 4373.4 4392.5 4467.1 4469.7 4548.5 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#4] prototype.html Cycles:180 Average:4127.74 Median:4672.16 stddev:1215.51 (26.0%) stddev-sans-first:1184.30 03:47:52 INFO - PROCESS | 28443 | Values: 290.3 292.7 300.0 303.6 305.3 4817.6 4869.0 4873.9 4887.8 4888.7 4761.9 4795.4 4802.4 4803.9 4818.1 3820.3 3842.0 3842.4 3848.7 3860.2 3724.3 3803.3 3849.6 3857.4 3868.8 3746.2 3768.4 3779.8 3792.3 3807.2 3736.6 3767.2 3773.4 3775.7 3777.8 3125.7 3227.6 3257.6 3335.9 3339.8 4662.0 4668.3 4671.7 4672.6 4699.9 4286.3 4289.7 4294.6 4297.3 4307.1 4614.9 4741.4 5010.7 5012.7 5040.5 3631.7 3639.1 3651.7 3653.6 3672.4 5222.6 5242.8 5261.2 5264.0 5268.6 3419.7 3565.9 3766.9 3776.9 3777.3 3600.4 3619.3 3624.8 3631.2 3639.1 4169.2 4185.4 4204.3 4206.2 4219.3 4984.3 4988.5 4995.6 5005.6 5007.8 1231.3 1273.6 1283.0 1283.3 1286.6 794.3 806.8 827.2 827.4 830.2 3974.0 3979.3 3991.2 4005.7 4033.5 4535.5 4544.9 4549.2 4557.0 4583.4 3999.8 4004.5 4005.0 4021.7 4021.8 2332.4 2432.7 2444.6 2448.7 2455.7 4329.9 4595.2 4721.2 4725.9 4910.3 5276.6 5285.4 5304.2 5312.3 5359.3 4885.0 4885.7 4912.1 4921.3 4938.3 4974.6 5127.4 5156.5 5177.4 5185.6 5091.8 5103.7 5116.3 5121.3 5142.3 4762.0 4878.4 4895.5 4914.4 4953.9 3620.2 3635.9 3640.7 3681.2 3691.5 5194.2 5225.0 5236.5 5247.2 5273.2 5046.6 5061.5 5072.9 5101.8 5134.7 4849.7 5036.7 5054.6 5056.7 5069.2 4920.4 4929.9 4936.3 4986.4 4988.5 4919.6 5032.9 5044.5 5061.7 5065.8 4872.9 4904.9 4910.8 4912.3 4944.3 03:47:52 INFO - PROCESS | 28443 | 03:47:52 INFO - PROCESS | 28443 | [#5] yui.html Cycles:180 Average:13870.48 Median:25268.01 stddev:17040.89 (67.4%) stddev-sans-first:17059.72 03:47:52 INFO - PROCESS | 28443 | Values: 636.5 709.4 727.0 729.3 742.1 12381.9 12724.9 12987.2 13153.3 13296.3 12131.8 12192.6 12195.1 12213.5 12214.3 788.9 812.7 815.3 816.2 816.3 628.5 649.1 790.6 808.4 810.7 842.4 843.7 845.6 847.1 847.9 842.2 842.8 843.4 843.4 844.0 484.7 494.3 601.2 615.3 615.8 11484.4 11503.8 11511.3 11611.2 11651.7 11561.3 11696.4 11959.8 12276.6 12419.1 11073.9 11190.7 11274.8 11437.4 11497.3 3972.2 3991.4 4013.0 4057.8 4075.4 51433.5 51516.7 51530.0 51566.5 51667.5 9488.5 9516.1 9523.4 9798.9 9944.0 15638.1 16573.6 16606.3 16823.0 17516.0 6466.2 6600.7 6671.7 6893.3 6910.3 3690.2 3819.9 3843.8 3931.2 3948.5 2780.9 2876.3 2901.1 2902.3 2909.5 503.2 512.1 512.4 513.9 520.5 612.8 620.0 621.7 623.6 631.7 6510.3 7046.9 7150.0 7400.1 7930.6 508.8 518.7 595.6 618.9 629.1 3515.0 3816.3 3824.4 3840.0 3848.7 42790.0 42853.8 43182.6 56021.0 74101.0 40609.0 41190.2 63811.7 64700.7 66529.7 55716.2 57518.7 57660.0 58367.0 59198.0 6852.3 7107.9 7215.7 7246.5 7550.2 32174.5 33164.8 33461.0 36687.3 41908.4 32687.8 34398.1 47470.6 49033.3 50041.7 10688.4 10928.9 11036.8 11081.4 11620.4 11651.6 11804.3 11808.1 12225.3 12487.6 11198.7 11330.5 11412.2 11598.7 12112.8 11106.7 11188.8 11664.7 11823.9 11995.5 11171.7 11188.1 11277.2 11319.7 11404.8 9251.2 9260.6 9384.0 9529.1 9653.9 9575.4 9828.2 9867.6 9966.0 9996.2 03:47:52 INFO - PROCESS | 28443 | -------- Summary: end -------- 03:47:52 INFO - PROCESS | 28443 | 03:47:53 INFO - TEST-INFO | 28443: exit 0 03:47:53 INFO - TEST-OK | dromaeo_css | took 1122526ms 03:47:53 INFO - TEST-START | kraken 03:47:53 INFO - operating with platform_type : linux_ 03:47:53 INFO - Initialising browser for kraken test... 03:47:53 INFO - TEST-INFO | started process 28748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkG1jG/profile http://localhost:44596/getInfo.html) 03:47:57 INFO - PROCESS | 28748 | __metrics Screen width/height:1600/1200 03:47:57 INFO - PROCESS | 28748 | colorDepth:24 03:47:57 INFO - PROCESS | 28748 | Browser inner width/height: 1024/697 03:47:57 INFO - PROCESS | 28748 | __metrics 03:47:58 INFO - PROCESS | 28748 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:47:58 INFO - PROCESS | 28748 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:59 INFO - PROCESS | 28748 | console.error: PushService: 03:47:59 INFO - PROCESS | 28748 | stateChangeProcessEnqueue: Error transitioning state 03:47:59 INFO - PROCESS | 28748 | UnknownError 03:47:59 INFO - TEST-INFO | 28748: exit 0 03:47:59 INFO - Browser initialized. 03:47:59 INFO - Running cycle 1/1 for kraken test... 03:47:59 INFO - TEST-INFO | started process 28830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkG1jG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:12 INFO - PROCESS | 28830 | RSS: Main: 173101056 03:48:12 INFO - PROCESS | 28830 | 03:48:14 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44596/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:15 INFO - PROCESS | 28830 | RSS: Main: 237969408 03:48:15 INFO - PROCESS | 28830 | 03:48:18 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44596/tests/kraken/driver.html?testName=audio-dft) 03:48:19 INFO - PROCESS | 28830 | RSS: Main: 216698880 03:48:19 INFO - PROCESS | 28830 | 03:48:22 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44596/tests/kraken/driver.html?testName=audio-fft) 03:48:23 INFO - PROCESS | 28830 | RSS: Main: 299003904 03:48:23 INFO - PROCESS | 28830 | 03:48:25 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44596/tests/kraken/driver.html?testName=audio-oscillator) 03:48:25 INFO - PROCESS | 28830 | RSS: Main: 207843328 03:48:25 INFO - PROCESS | 28830 | 03:48:28 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:28 INFO - PROCESS | 28830 | RSS: Main: 212721664 03:48:28 INFO - PROCESS | 28830 | 03:48:31 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44596/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:32 INFO - PROCESS | 28830 | RSS: Main: 248799232 03:48:32 INFO - PROCESS | 28830 | 03:48:36 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44596/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:36 INFO - PROCESS | 28830 | RSS: Main: 243335168 03:48:36 INFO - PROCESS | 28830 | 03:48:39 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44596/tests/kraken/driver.html?testName=json-parse-financial) 03:48:40 INFO - PROCESS | 28830 | RSS: Main: 245927936 03:48:40 INFO - PROCESS | 28830 | 03:48:41 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:42 INFO - PROCESS | 28830 | RSS: Main: 209186816 03:48:42 INFO - PROCESS | 28830 | 03:48:44 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:44 INFO - PROCESS | 28830 | RSS: Main: 216891392 03:48:44 INFO - PROCESS | 28830 | 03:48:47 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:47 INFO - PROCESS | 28830 | RSS: Main: 226140160 03:48:47 INFO - PROCESS | 28830 | 03:48:50 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:51 INFO - PROCESS | 28830 | RSS: Main: 234921984 03:48:51 INFO - PROCESS | 28830 | 03:48:54 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:54 INFO - PROCESS | 28830 | RSS: Main: 231448576 03:48:54 INFO - PROCESS | 28830 | 03:48:56 INFO - PROCESS | 28830 | Cycle 1(1): loaded http://localhost:44596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44596/tests/kraken/driver.html?testName=ai-astar) 03:48:57 INFO - PROCESS | 28830 | RSS: Main: 281178112 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | __start_tp_report 03:48:57 INFO - PROCESS | 28830 | _x_x_mozilla_page_load 03:48:57 INFO - PROCESS | 28830 | _x_x_mozilla_page_load_details 03:48:57 INFO - PROCESS | 28830 | |i|pagename|runs| 03:48:57 INFO - PROCESS | 28830 | |0;ai-astar;106;114;115;117;114;115;114;115;114;114 03:48:57 INFO - PROCESS | 28830 | |1;audio-beat-detection;158;133;128;167;136;135;138;133;169;128 03:48:57 INFO - PROCESS | 28830 | |2;audio-dft;162;161;163;162;162;160;163;162;162;162 03:48:57 INFO - PROCESS | 28830 | |3;audio-fft;76;75;76;112;77;77;78;77;102;76 03:48:57 INFO - PROCESS | 28830 | |4;audio-oscillator;84;86;117;84;85;85;112;84;83;112 03:48:57 INFO - PROCESS | 28830 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:48:57 INFO - PROCESS | 28830 | |6;imaging-darkroom;148;147;215;148;148;148;147;148;147;147 03:48:57 INFO - PROCESS | 28830 | |7;imaging-desaturate;85;85;85;84;84;84;85;85;85;84 03:48:57 INFO - PROCESS | 28830 | |8;json-parse-financial;61;60;60;60;62;62;64;61;62;64 03:48:57 INFO - PROCESS | 28830 | |9;json-stringify-tinderbox;66;67;66;66;66;67;66;66;66;67 03:48:57 INFO - PROCESS | 28830 | |10;stanford-crypto-aes;91;84;83;83;83;94;91;84;84;88 03:48:57 INFO - PROCESS | 28830 | |11;stanford-crypto-ccm;142;144;145;153;151;142;142;140;182;143 03:48:57 INFO - PROCESS | 28830 | |12;stanford-crypto-pbkdf2;182;183;176;182;175;179;179;174;176;176 03:48:57 INFO - PROCESS | 28830 | |13;stanford-crypto-sha256-iterative;74;72;72;73;71;70;70;73;71;69 03:48:57 INFO - PROCESS | 28830 | __end_tp_report 03:48:57 INFO - PROCESS | 28830 | __start_cc_report 03:48:57 INFO - PROCESS | 28830 | _x_x_mozilla_cycle_collect,1948 03:48:57 INFO - PROCESS | 28830 | __end_cc_report 03:48:57 INFO - PROCESS | 28830 | __startTimestamp1477392537011__endTimestamp 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | ------- Summary: start ------- 03:48:57 INFO - PROCESS | 28830 | Number of tests: 14 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:2.90 (2.5%) stddev-sans-first:1.00 03:48:57 INFO - PROCESS | 28830 | Values: 106.0 114.0 115.0 117.0 114.0 115.0 114.0 115.0 114.0 114.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:137.00 stddev:15.86 (11.6%) stddev-sans-first:15.79 03:48:57 INFO - PROCESS | 28830 | Values: 158.0 133.0 128.0 167.0 136.0 135.0 138.0 133.0 169.0 128.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 03:48:57 INFO - PROCESS | 28830 | Values: 162.0 161.0 163.0 162.0 162.0 160.0 163.0 162.0 162.0 162.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:13.10 (17.1%) stddev-sans-first:13.67 03:48:57 INFO - PROCESS | 28830 | Values: 76.0 75.0 76.0 112.0 77.0 77.0 78.0 77.0 102.0 76.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:14.21 (16.9%) stddev-sans-first:14.68 03:48:57 INFO - PROCESS | 28830 | Values: 84.0 86.0 117.0 84.0 85.0 85.0 112.0 84.0 83.0 112.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:48:57 INFO - PROCESS | 28830 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#6] imaging-darkroom Cycles:10 Average:154.30 Median:148.00 stddev:21.33 (14.4%) stddev-sans-first:22.51 03:48:57 INFO - PROCESS | 28830 | Values: 148.0 147.0 215.0 148.0 148.0 148.0 147.0 148.0 147.0 147.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 03:48:57 INFO - PROCESS | 28830 | Values: 85.0 85.0 85.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:1.51 (2.4%) stddev-sans-first:1.58 03:48:57 INFO - PROCESS | 28830 | Values: 61.0 60.0 60.0 60.0 62.0 62.0 64.0 61.0 62.0 64.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:48:57 INFO - PROCESS | 28830 | Values: 66.0 67.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:4.14 (4.8%) stddev-sans-first:4.06 03:48:57 INFO - PROCESS | 28830 | Values: 91.0 84.0 83.0 83.0 83.0 94.0 91.0 84.0 84.0 88.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:144.50 stddev:12.52 (8.7%) stddev-sans-first:13.06 03:48:57 INFO - PROCESS | 28830 | Values: 142.0 144.0 145.0 153.0 151.0 142.0 142.0 140.0 182.0 143.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:179.00 stddev:3.26 (1.8%) stddev-sans-first:3.15 03:48:57 INFO - PROCESS | 28830 | Values: 182.0 183.0 176.0 182.0 175.0 179.0 179.0 174.0 176.0 176.0 03:48:57 INFO - PROCESS | 28830 | 03:48:57 INFO - PROCESS | 28830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.58 (2.2%) stddev-sans-first:1.39 03:48:57 INFO - PROCESS | 28830 | Values: 74.0 72.0 72.0 73.0 71.0 70.0 70.0 73.0 71.0 69.0 03:48:57 INFO - PROCESS | 28830 | -------- Summary: end -------- 03:48:57 INFO - PROCESS | 28830 | 03:48:58 INFO - TEST-INFO | 28830: exit 0 03:48:58 INFO - TEST-OK | kraken | took 64833ms 03:48:58 INFO - SUITE-END | took 1187s 03:48:58 INFO - Completed test suite (00:19:47) 03:48:58 INFO - javascript benchmark 03:48:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.4150145466538, 2552.629868669042, 2589.236175328278, 2593.740625937405, 2595.0917178987356, 4440.644748420127, 4542.523035081318, 4549.385832912556, 4550.340200670901, 4568.885777855551, 4584.74783886887, 4593.724376537401, 4600.470945841229, 4608.815647374109, 4608.953910460895, 4183.853565125221, 4211.4946206455115, 4226.387173859788, 4247.426597409357, 4304.806283717225, 4191.7694526801015, 4231.534531201565, 4232.724872883253, 4236.97881510592, 4242.172776308621, 4222.725522841006, 4225.471816022997, 4233.83064677414, 4265.594768497003, 4286.0999190170105, 4243.87268381946, 4283.850065247701, 4322.984098736794, 4337.089211265638, 4375.256206444912, 4118.094019315776, 4148.128892932457, 4217.704760666755, 4230.323148296288, 4277.572242775728, 4645.349651048856, 4647.140279048387, 4665.88335291617, 4718.221493453576, 4729.266963620645, 4969.428515720702, 4972.950270497285, 4989.700617962933, 5004.149294619923, 5062.493750624908, 4754.334393184957, 4877.731724755173, 4882.7558622068755, 4963.726995015273, 5022.096022715909, 4669.906601867943, 4672.649551283599, 4673.649476289258, 4726.503717109654, 4727.527247275314, 5094.0, 5102.540771330598, 5103.132467480537, 5104.821331253388, 5160.277561141444, 4686.531346865286, 4742.170120229015, 4893.535114164149, 4898.657094003457, 4960.181570040975, 4881.707097574086, 4952.108620448282, 4986.925196122061, 4988.775505102279, 5089.0, 4952.603791696655, 4965.155923493015, 4976.402831660224, 4984.601231901439, 5024.070546948826, 4918.2376731606655, 4934.629902757308, 4938.456769755324, 4943.209086546207, 5004.674696144812, 3974.8012599369918, 3979.243943650697, 4022.597740225954, 4116.197341518435, 4124.896877578085, 3621.94567081494, 3644.9817750911075, 3668.871589494355, 3677.42999835026, 3688.2254726507736, 4324.329728892027, 4337.869863904088, 4348.782560871944, 4373.037931655031, 4382.517923028464, 4724.763761811896, 4779.761011949388, 4796.5203479651755, 5033.3205017322925, 5033.471485494044, 4202.432671589297, 4205.894852628709, 4212.557681443404, 4217.831286748557, 4255.127698821734, 4397.164538737629, 4398.296272596369, 4433.623142032899, 4446.3552784846015, 4452.421185245962, 4653.627709783209, 4660.86017419478, 4663.253879379283, 4663.27719203524, 4741.2651039089, 4710.4347478302825, 4934.925976110289, 4938.0, 4941.382327209099, 5004.574611158092, 4548.658850586286, 4609.907801844011, 4616.099860527299, 4622.237330840374, 4640.466346370211, 4870.147724148189, 4872.317875497362, 4875.536824001714, 4942.159832828356, 4954.925676114789, 4900.705957642553, 4930.901381972269, 4937.827176048965, 4940.728259945738, 4940.975295123501, 4653.581177694024, 4653.744044077608, 4707.435107787088, 4853.6602437829015, 4859.979404325131, 4920.31115643803, 4923.679960802537, 4934.851954441372, 4973.154563724248, 4994.575461085703, 4827.227643577011, 4829.6860704054125, 4830.372051633265, 4852.092801003542, 4888.340074089952, 4582.77086145698, 4625.629949604091, 4927.852164435073, 4935.531124543163, 5001.549860512571, 4568.132054909556, 4688.953110468988, 4727.787249573708, 4742.217534106834, 4809.95190048109], "value": 4535.47153465201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.4793003309245, 581.1602234770755, 581.4941001328842, 586.9501092407145, 594.6283572767021, 27850.44299114019, 38091.4286285706, 39054.80472597633, 39156.80421597888, 39176.80411597945, 40196.39705404421, 40558.39162412566, 40639.187216255654, 40646.18707625853, 40657.18685626293, 7794.220577942203, 7959.880601790977, 7960.203979602052, 7963.5221886686695, 7965.402594805384, 7780.0, 7842.490238134503, 7861.882071768928, 7867.0, 7868.606569671522, 7850.646720897574, 7852.685892564319, 7900.762977110667, 7905.762827115196, 7910.485818421784, 7806.609669516558, 7818.921810781876, 7843.372530197627, 7854.293113619773, 7905.7232996845405, 7711.614419279013, 7764.107127680332, 7770.33952114071, 7774.2614451627005, 7775.766726998199, 37085.814570926974, 37116.257674846354, 37477.0, 37503.62496375056, 37517.0, 2960.674325824179, 3062.0660698486954, 3098.938021239585, 3125.9218519536967, 3246.902592922216, 28207.153785386472, 28280.717192828015, 28770.85614571914, 28880.27799305013, 30221.546676799866, 3423.3666771647327, 3482.5995010573856, 3503.1242189452637, 3514.789112653249, 3572.7499075064757, 176552.0, 177733.0, 177984.0, 178063.0, 178238.10880945643, 51576.48423515792, 51832.48167518352, 51893.0, 51904.0, 51965.22052169221, 31502.36995260082, 32814.8359258207, 32927.67072329294, 34862.12844678853, 34997.300053999286, 12191.634250972485, 12212.938935305445, 12291.938540307241, 12311.815322770166, 12424.813627795591, 9493.050694930589, 9569.3779904306, 9574.425534467955, 9583.520823958774, 9589.90410095904, 17542.824571754376, 17574.209160587805, 17634.647307054045, 17652.0, 17654.470365889043, 6731.225909020427, 6787.898181527281, 6935.375816176467, 6973.803251975612, 7081.964590177016, 784.4508843809242, 904.4980036080038, 932.4312169576552, 954.7183580843667, 1022.892596277395, 27222.863885680446, 27280.45439091207, 27920.0, 27973.580396294074, 28188.85905570459, 780.9140994490601, 887.316766090107, 935.4714586258742, 938.938968967015, 941.2893265584577, 11825.52697892092, 14388.784168237486, 14727.0, 14739.778903316459, 15010.099394036393, 373060.0, 376577.0, 376605.0, 376863.0, 377294.0, 48443.0, 48803.0, 48872.0, 49110.75444622825, 49122.50877491251, 1045.2004216774021, 1053.947302634865, 1121.3608243301403, 1137.971550711239, 1183.4910988275124, 26863.462730745665, 28556.714432855406, 28921.56617650779, 29123.612131755694, 29219.415611688073, 40912.79543602263, 41512.377314339705, 41524.58475415207, 41529.37705934474, 41571.58428415798, 288544.0, 291699.0, 291917.0, 398248.0, 408777.0, 36514.26971460609, 36968.26063478769, 37146.25707485889, 37545.249095018495, 37820.083389159234, 42058.579414205466, 42439.36340954826, 42445.78777106218, 42885.0, 43249.35125973176, 35425.82287088651, 35485.82257088801, 35513.289734204656, 35611.10972225715, 36162.4575631371, 35343.29313413769, 35688.0, 35929.0, 36171.63828361683, 36237.0, 35497.290054199286, 35770.463443048895, 36128.27743445169, 36511.26977460489, 36685.39662860711, 30218.0, 32391.838040809645, 32495.837520812245, 32863.17842053872, 32889.83555082209, 25019.74980250174, 25438.745612543637, 25538.74461255438, 25759.356016099, 25959.0], "value": 17021.72873186006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4297458781952, 339.3772427595362, 341.9743519236057, 351.7555299067149, 370.98516059357627, 12560.874391256084, 12735.936320318397, 13448.66378340542, 13584.592462226137, 16768.0, 14571.417143314255, 14732.116073035626, 14915.179665118414, 14999.250037498135, 15155.090694558334, 4910.680805747633, 4921.311016457699, 5126.0, 5129.307543481638, 5133.666311689747, 5017.64876458648, 5134.152864777326, 5137.56330711888, 5143.897122057557, 5144.948550514503, 4936.284238785392, 5205.843824685266, 5218.269442278084, 5274.604404669665, 5289.338832645919, 5269.8946021079555, 5283.154695248761, 5289.629725919187, 5295.867603309909, 5414.972925135388, 5170.0, 5196.220566914955, 5197.610179236573, 5198.532132108091, 5198.882240318312, 11784.410779461079, 11914.404279785977, 11976.940115299367, 12023.759524809542, 12209.0, 1863.5341164708823, 1874.3252429125505, 1912.531429799694, 2061.3506745375307, 2360.1503458754833, 8262.710805121853, 8556.486610803371, 8977.371583989123, 9034.86447703285, 9055.366124371296, 1622.7403615421595, 1642.8439298266646, 1654.751787231925, 1716.5965997990463, 1727.2141175764996, 63812.0, 69296.6535167321, 69966.300336997, 70289.2971070293, 70332.648336758, 9148.908510914938, 9509.286803489766, 9520.761980950532, 9858.112769850748, 9975.700728978143, 12913.677158070936, 12933.676658083623, 12934.353282335846, 12941.352932353533, 13010.674733131747, 6389.9680501597195, 6390.265119511223, 6520.152380190545, 6531.379518945692, 6562.8359291018105, 5835.387284335084, 5862.237909071879, 6029.035354343372, 6084.330723620398, 6088.299845517822, 3755.9436608450897, 3856.0745421098736, 3910.7066969977363, 3916.9020774480296, 4149.211649786531, 1746.991265043692, 1817.2276782367442, 1825.4859395663295, 1841.7881943576392, 1849.306510058728, 800.5516910530122, 804.0230970293862, 833.1626715151234, 834.4367551902442, 836.7782537627534, 14560.708785824225, 16097.678046439005, 16178.11020393866, 16425.178741063137, 16960.0, 858.9914100858912, 865.9134086591416, 868.1708967935606, 878.868169774539, 893.6068130022769, 8730.607122679494, 9007.414518056305, 9387.906120938704, 9471.857922131174, 9517.476538790295, 283231.0, 288184.0, 288352.0, 390658.0, 393593.0, 77812.0, 82088.58955705183, 82275.0, 82400.58799706084, 82513.58743206246, 859.1365677494204, 872.3722385606233, 899.7300809757047, 900.8333458310234, 903.8779764731809, 15260.160691162093, 15289.464868729541, 15741.370345186064, 15906.761398579261, 16037.797165212422, 25467.0, 26313.0, 26826.0, 34970.47544286787, 36204.45693314655, 51685.483145168066, 51877.48122518878, 52156.0, 52699.36503174749, 54659.45340546703, 7300.452466065172, 7323.816904577428, 7360.742374016883, 7454.813629659302, 7468.290512401313, 9825.656102036395, 10206.234532410248, 11561.537538498365, 11629.651110466699, 11805.23265987708, 10023.248256380655, 10079.647212347532, 10179.287449878437, 10577.259591828499, 10752.731181720519, 9834.852477212704, 10058.094771470604, 10218.846717299099, 10402.323848949794, 10419.218558608287, 10162.39025658463, 10381.740456488647, 10400.427976461368, 10405.739856503647, 10461.790764184521, 7362.815929601588, 7452.776416707507, 7671.2712292332135, 7682.193369696101, 7900.68397264103, 9890.85163722559, 10337.793244135226, 10471.738206544896, 10477.790444191225, 10541.420221887563], "value": 7734.51135191313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.647840365496, 1345.2802750528467, 1381.92399418032, 1420.7939848721935, 1653.6751659655904, 6382.2341319041725, 7010.228874823772, 7384.999999999994, 7405.703771849133, 7574.583397913113, 7392.96303518483, 7469.141048779392, 7470.47706660534, 7472.738454154106, 7475.514091584043, 2108.704781330615, 2140.518383363746, 2144.5925274197853, 2144.742630884296, 2146.7638559758416, 2077.8753274803485, 2133.9146434142617, 2135.1459416233474, 2135.893205339735, 2139.518608313125, 2064.0917996081753, 2069.3584988653565, 2088.728465299509, 2100.159936025587, 2100.863443876151, 2012.7685316188606, 2039.1639427834516, 2040.9897950510153, 2041.3569725536483, 2046.9385918422472, 1989.5622962948273, 1999.320231121411, 2016.4253187841541, 2018.5760990192077, 2023.1199428248758, 7052.0, 7162.606056666881, 7167.4266058715175, 7171.605561694105, 7347.926520734778, 4341.565843415665, 4519.299508576143, 4521.231390663595, 4521.570450807168, 4522.977385113087, 2749.917502474929, 2959.067893613505, 3011.6084908961916, 3011.683773203804, 3017.834019128969, 910.4582773249972, 931.1526510875071, 932.1377725603857, 934.3412893909777, 945.0077418710326, 9905.80188396228, 9970.700878973643, 9973.301868869183, 9976.800463990752, 9995.75010624733, 3731.4962480065387, 3811.599782022903, 3925.8822235332987, 4120.093579412524, 4131.132462182915, 7909.802254943673, 7954.642041108164, 7955.0, 7961.8407631848195, 7968.12350641429, 4378.584034516716, 4385.934210986838, 4386.166628340605, 4386.7367957922625, 4386.8025938832825, 3304.2069903223055, 3421.1447138215444, 3575.2313252650806, 4083.509978802503, 4088.2232375848494, 3131.1858916681826, 3221.6778322168066, 3251.7561182911377, 3257.5113732939776, 3331.267121233325, 1007.5415685862915, 1008.1632245236436, 1014.8274793285011, 1017.577705252312, 1024.1243736605245, 786.5949036246337, 793.6785601831267, 840.5167028958373, 847.7456762971084, 851.9787005324916, 4860.538248866352, 4916.680415772963, 5056.949430505648, 5069.391672999263, 5118.974405128025, 382.51993747846274, 407.0657840256618, 408.85281298732434, 876.2945828608032, 925.6112432778249, 3311.1556553078813, 3317.0, 3372.915677108043, 3384.2385463270566, 3562.305350456688, 8905.643774248958, 9294.209992150607, 9299.302552308603, 9300.813983720423, 9332.160105590394, 9231.0, 9237.030111838294, 9247.953760231156, 9250.121238482334, 9260.259179265642, 6625.900611490832, 6861.490472096131, 6982.441404687613, 7033.296670332926, 7205.387542058879, 5053.646244762831, 5125.5136010556525, 5138.97430512845, 5299.39057008449, 5319.920201196907, 7997.280244777998, 8258.628361723617, 8332.33341332704, 8346.040205376217, 8352.206540378655, 8359.832803344021, 8375.120612335617, 8422.70520531803, 8450.239478446969, 8458.703945361884, 6129.724162412791, 6235.906461403173, 6241.157443745036, 6246.781362652286, 6248.968755156195, 6877.793666190022, 6894.517383783288, 6911.7926462206215, 6922.757703480354, 6943.618101004493, 6136.23297087864, 6155.0, 6157.445829875153, 6163.876722465436, 6165.10605962124, 6023.277206735044, 6153.692315384303, 6161.907571386343, 6174.320824709368, 6281.3404592518955, 5870.823875283749, 6015.428534289235, 6030.4572588467245, 6095.969520152371, 6202.968985155046, 4261.1051679146485, 4296.785160741888, 4412.977935110304, 4453.398791163151, 4457.643388528974, 4373.409589705349, 4392.538783427822, 4467.084247729273, 4469.7318160910445, 4548.4996650367775], "value": 3872.574855504328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.29168828059534, 292.6795159300566, 299.9520076787714, 303.62047440699126, 305.29324613519714, 4817.590504807091, 4869.001854619803, 4873.878153046171, 4887.828925987591, 4888.657793954425, 4761.857144285677, 4795.424549054118, 4802.351682522858, 4803.855884323467, 4818.108649899762, 3820.2741479118877, 3842.0, 3842.4063756963938, 3848.730588858781, 3860.208657225262, 3724.3482390581676, 3803.2583646189005, 3849.556416343871, 3857.402102674076, 3868.825902834379, 3746.232022435408, 3768.4158955361963, 3779.848806047755, 3792.2794669012937, 3807.2385522895393, 3736.626337366242, 3767.1523907120954, 3773.3773927301963, 3775.679067279257, 3777.848886044555, 3125.718685318332, 3227.612686477638, 3257.5602293690285, 3335.8665653373837, 3339.7976728377766, 4661.953380466186, 4668.253079507296, 4671.696339737906, 4672.6261899047995, 4699.859004229878, 4286.314189729628, 4289.678274129453, 4294.604253617586, 4297.312430011183, 4307.138572285556, 4614.930776038362, 4741.359916411275, 5010.72441015744, 5012.721755952245, 5040.487853643929, 3631.654992775682, 3639.1266096137, 3651.72612054097, 3653.598104208535, 3672.4307732301536, 5222.63441559091, 5242.842714718565, 5261.184516399926, 5263.999680121529, 5268.604854635918, 3419.675130862564, 3565.9286814264087, 3766.851110411351, 3776.86780962665, 3777.338965680995, 3600.4419315006216, 3619.3123306571665, 3624.7825130492256, 3631.2011357501306, 3639.090227443139, 4169.207850508455, 4185.434966279513, 4204.306289462204, 4206.158768246363, 4219.261629214875, 4984.3302493664305, 4988.451270360258, 4995.625328100407, 5005.574526165244, 5007.774650140753, 1231.2858542045592, 1273.5860845225338, 1282.9992605767516, 1283.2685369339574, 1286.581860895194, 794.2573693596506, 806.8305655812345, 827.2472050434196, 827.3783384566198, 830.1905641999002, 3973.980130099331, 3979.303621866162, 3991.1840112748628, 4005.6595189409227, 4033.495813023372, 4535.501094879561, 4544.886627718127, 4549.203889319422, 4556.97721511397, 4583.358329833826, 3999.7800120993625, 4004.5394779600138, 4004.959950400517, 4021.678265738734, 4021.7733591254364, 2332.3702600297825, 2432.701097462916, 2444.5599792037247, 2448.7183973843235, 2455.72986971433, 4329.935050974238, 4595.2188128018315, 4721.173794585934, 4725.881852953635, 4910.263460480956, 5276.577873770089, 5285.445028272053, 5304.177852432879, 5312.282841816305, 5359.3032905722, 4884.975575122102, 4885.706857588556, 4912.1158191525155, 4921.31101645777, 4938.25926111079, 4974.607110009203, 5127.359080114986, 5156.484351564964, 5177.430482646831, 5185.559227465556, 5091.803426194915, 5103.7192954387865, 5116.283720279238, 5121.285718569165, 5142.331496905378, 4762.0, 4878.438979517259, 4895.46149923501, 4914.36113305268, 4953.876153096201, 3620.185458271973, 3635.927281454409, 3640.7269454790467, 3681.2453447043827, 3691.5016472775833, 5194.194899790538, 5224.9738751306, 5236.476352364733, 5247.239150323106, 5273.182656688219, 5046.561729906959, 5061.519155680205, 5072.873178170576, 5101.795928162832, 5134.717590532557, 4849.684770489906, 5036.672616280077, 5054.646174767731, 5056.696598204119, 5069.1635880079375, 4920.40955085392, 4929.926051109308, 4936.259561065725, 4986.351774269467, 4988.501149884983, 4919.581835543876, 5032.899342013213, 5044.461439261061, 5061.7469126544265, 5065.758889072201, 4872.853814385574, 4904.852854414374, 4910.8281210157475, 4912.287718280758, 4944.258361245842], "value": 3740.5684249088713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.5194278319868, 709.4076446167453, 727.0185249912615, 729.3435907683088, 742.0612924650317, 12381.876181238185, 12724.872751272485, 12987.155834870728, 13153.276569788646, 13296.335183240848, 12131.818022729665, 12192.573259935903, 12195.085368597347, 12213.51145954163, 12214.32821194834, 788.9132195458509, 812.7236739508566, 815.282551354807, 816.2327412232482, 816.2898278497686, 628.4501061571125, 649.0621052579002, 790.6363072986433, 808.4300568099476, 810.6595230003413, 842.4439869686008, 843.6541018182546, 845.5560830563942, 847.1189962439056, 847.9406441549094, 842.204117109332, 842.8187939592956, 843.359047124187, 843.4433274039166, 843.970461033867, 484.70190832638025, 494.278353603739, 601.20940962634, 615.2770494668791, 615.8491169663416, 11484.36835974021, 11503.827442588368, 11511.309321440656, 11611.187216894821, 11651.650450486499, 11561.30632162073, 11696.356700381475, 11959.760804783942, 12276.570320038756, 12419.130660853743, 11073.889261107366, 11190.66428007161, 11274.830877536844, 11437.369405036889, 11497.252678575866, 3972.165845172517, 3991.4212439196153, 4012.9799351003057, 4057.8376864925367, 4075.409065685459, 51433.48566514324, 51516.742416288056, 51530.0, 51566.48433515654, 51667.48332516664, 9488.478133702574, 9516.143547080796, 9523.428594284365, 9798.902010979942, 9944.0, 15638.139902305482, 16573.58566035859, 16606.335746570003, 16823.0, 17516.0, 6466.191726034246, 6600.735970561123, 6671.732370849523, 6893.345132212432, 6910.30896910315, 3690.225052738901, 3819.8854034379015, 3843.8462461501786, 3931.1744533647684, 3948.466956960831, 2780.902668406596, 2876.3384421583155, 2901.086157860267, 2902.274431392152, 2909.505384084711, 503.21247248057404, 512.139605462826, 512.4004914250336, 513.8535517377529, 520.4899198785212, 612.7548980407784, 619.9752009919642, 621.6798348850346, 623.5977794322728, 631.7315141065029, 6510.25132109804, 7046.894296585555, 7150.0, 7400.111986561539, 7930.5638189898955, 508.7863097499059, 518.6654607777962, 595.597971369324, 618.8793185328817, 629.0658372317106, 3514.982425087909, 3816.2939856126704, 3824.4263360496147, 3840.020794697334, 3848.6728628066367, 42790.0, 42853.78573107115, 43182.56817431848, 56021.0, 74101.0, 40609.0, 41190.176196475906, 63811.68094159592, 64700.67649661721, 66529.6673516639, 55716.16425753617, 57518.712406438535, 57660.0, 58367.0, 59198.0, 6852.280510546321, 7107.893381599177, 7215.67529461165, 7246.492745507764, 7550.2449755026255, 32174.517382238817, 33164.83417582897, 33461.0, 36687.26625467422, 41908.371374428796, 32687.836560817042, 34398.14004649904, 47470.626468675735, 49033.26450103323, 50041.74979125081, 10688.358698478116, 10928.94535527349, 11036.834447483134, 11081.445927703744, 11620.418979050844, 11651.59219427316, 11804.291742495478, 11808.11439142085, 12225.266484010988, 12487.562935297221, 11198.664040078811, 11330.546778128783, 11412.201145919706, 11598.71003224926, 12112.818307725567, 11106.722331941766, 11188.776224475629, 11664.708382290512, 11823.881761182278, 11995.520179192734, 11171.72070698239, 11188.10495160369, 11277.21059525858, 11319.717007074889, 11404.771904561696, 9251.167394934218, 9260.629574816932, 9384.0, 9529.142377186086, 9653.855192171983, 9575.425474471554, 9828.164606008284, 9867.605295788087, 9965.966225340382, 9996.20030397581], "value": 6086.531124098934, "unit": "score"}], "name": "dromaeo_css", "value": 6122.135535614437, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 117.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 128.0, 167.0, 136.0, 135.0, 138.0, 133.0, 169.0, 128.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 160.0, 163.0, 162.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 112.0, 77.0, 77.0, 78.0, 77.0, 102.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 84.0, 85.0, 85.0, 112.0, 84.0, 83.0, 112.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 215.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 154.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 62.0, 62.0, 64.0, 61.0, 62.0, 64.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 83.0, 83.0, 83.0, 94.0, 91.0, 84.0, 84.0, 88.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 145.0, 153.0, 151.0, 142.0, 142.0, 140.0, 182.0, 143.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 176.0, 182.0, 175.0, 179.0, 179.0, 174.0, 176.0, 176.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 73.0, 71.0, 70.0, 70.0, 73.0, 71.0, 69.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1562.4000000000003, "alertThreshold": 2.0}]} 03:48:58 INFO - Return code: 0 03:48:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:58 INFO - # TBPL SUCCESS # 03:48:58 INFO - Running post-action listener: _resource_record_post_action 03:48:58 INFO - [mozharness: 2016-10-25 10:48:58.817252Z] Finished run-tests step (success) 03:48:58 INFO - Running post-run listener: _resource_record_post_run 03:48:58 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394309632; Read time: 16; Write time: 428392 03:48:58 INFO - TinderboxPrint: CPU usage
13.1% 03:48:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:48:58 INFO - TinderboxPrint: I/O write bytes / time
394,309,632 / 428,392 03:48:58 INFO - TinderboxPrint: CPU idle
8,348.2 (86.9%) 03:48:58 INFO - TinderboxPrint: CPU user
1,207.3 (12.6%) 03:48:58 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104169472; Read time: 0; Write time: 129076 03:48:58 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290140160; Read time: 0; Write time: 299316 03:48:59 INFO - Running post-run listener: _upload_blobber_files 03:48:59 INFO - Blob upload gear active. 03:48:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:03 INFO - (blobuploader) - INFO - Done attempting. 03:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:05 INFO - (blobuploader) - INFO - Done attempting. 03:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:06 INFO - (blobuploader) - INFO - Done attempting. 03:49:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:06 INFO - Return code: 0 03:49:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d388aa53d192ad71bcdf11eba9bb65a1b07c11eccd0ed691136b57e6d6ca58c7a7f63ecf8f8315d0fdab0c6fcd652dbf48064cafacca077d9db0898032cead99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6392e9cf71415278a2ca15e751def666d6743b6146866100d62ebaebccf1dff84398cf539f2466abe5c7e0953a41179af526462f56fa534a27ee314a0725209c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/926b7a7c54901fa2f000878b9f4b21cb33527bc00bf851a60e9337aa41bfd40c0dfdcfca53a7b69f261584d6b273709e74dabab6299e227e573d9f9389d945ac"} 03:49:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:06 INFO - Contents: 03:49:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d388aa53d192ad71bcdf11eba9bb65a1b07c11eccd0ed691136b57e6d6ca58c7a7f63ecf8f8315d0fdab0c6fcd652dbf48064cafacca077d9db0898032cead99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6392e9cf71415278a2ca15e751def666d6743b6146866100d62ebaebccf1dff84398cf539f2466abe5c7e0953a41179af526462f56fa534a27ee314a0725209c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/926b7a7c54901fa2f000878b9f4b21cb33527bc00bf851a60e9337aa41bfd40c0dfdcfca53a7b69f261584d6b273709e74dabab6299e227e573d9f9389d945ac"} 03:49:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:06 INFO - Copying logs to upload dir... 03:49:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.403805 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-25 03:49:05.451756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:49:05.455816) ========= 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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d388aa53d192ad71bcdf11eba9bb65a1b07c11eccd0ed691136b57e6d6ca58c7a7f63ecf8f8315d0fdab0c6fcd652dbf48064cafacca077d9db0898032cead99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6392e9cf71415278a2ca15e751def666d6743b6146866100d62ebaebccf1dff84398cf539f2466abe5c7e0953a41179af526462f56fa534a27ee314a0725209c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/926b7a7c54901fa2f000878b9f4b21cb33527bc00bf851a60e9337aa41bfd40c0dfdcfca53a7b69f261584d6b273709e74dabab6299e227e573d9f9389d945ac"} build_url:https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/ItitD3FzTM-eUt0oYQOYdg/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/Fx-Team-Non-PGO/sha512/d388aa53d192ad71bcdf11eba9bb65a1b07c11eccd0ed691136b57e6d6ca58c7a7f63ecf8f8315d0fdab0c6fcd652dbf48064cafacca077d9db0898032cead99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6392e9cf71415278a2ca15e751def666d6743b6146866100d62ebaebccf1dff84398cf539f2466abe5c7e0953a41179af526462f56fa534a27ee314a0725209c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/926b7a7c54901fa2f000878b9f4b21cb33527bc00bf851a60e9337aa41bfd40c0dfdcfca53a7b69f261584d6b273709e74dabab6299e227e573d9f9389d945ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:49:05.481527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:49:05.481877) ========= 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=fa44defc139c4ba8574fe040000001db-1477391295.413817-634938490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:49:05.566313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:49:05.566640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:49:05.566957) ========= ========= Total master_lag: 0.17 =========