builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1479906683.84 results: success (0) buildid: 20161123024236 builduid: 85a1cea35edb4fd995bfdfa93b1c438a revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:23.842186) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:23.842762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:23.843061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:23.870709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:23.871083) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 05:11:24-- 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% 224M=0s 2016-11-23 05:11:24 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.063351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.063674) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.057492 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.133715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.134130) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 05:11:24,530 truncating revision to first 12 chars 2016-11-23 05:11:24,530 Setting DEBUG logging. 2016-11-23 05:11:24,530 attempt 1/10 2016-11-23 05:11:24,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/e5ed1abefc08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 05:11:24,843 unpacking tar archive at: cedar-e5ed1abefc08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.781316) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.781653) ========= script_repo_revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.782025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.782284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:24.791603) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-23 05:11:24.791886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:25 INFO - MultiFileLogger online at 20161123 05:11:25 in /builds/slave/test 05:11:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 05:11:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:25 INFO - {'append_to_log': False, 05:11:25 INFO - 'base_work_dir': '/builds/slave/test', 05:11:25 INFO - 'blob_upload_branch': 'Cedar', 05:11:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:25 INFO - 'branch': 'Cedar', 05:11:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:25 INFO - 'config_files': ('talos/linux_config.py',), 05:11:25 INFO - 'default_actions': ('clobber', 05:11:25 INFO - 'read-buildbot-config', 05:11:25 INFO - 'download-and-extract', 05:11:25 INFO - 'populate-webroot', 05:11:25 INFO - 'create-virtualenv', 05:11:25 INFO - 'install', 05:11:25 INFO - 'run-tests'), 05:11:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:25 INFO - 'download_minidump_stackwalk': True, 05:11:25 INFO - 'download_symbols': 'ondemand', 05:11:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:25 INFO - 'installer_path': 'installer.exe', 05:11:25 INFO - 'log_level': 'info', 05:11:25 INFO - 'log_name': 'talos', 05:11:25 INFO - 'log_to_console': True, 05:11:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:25 INFO - 'opt_config_files': (), 05:11:25 INFO - 'pip_index': False, 05:11:25 INFO - 'sps_profile': False, 05:11:25 INFO - 'sps_profile_interval': 0, 05:11:25 INFO - 'suite': 'dromaeojs', 05:11:25 INFO - 'system_bits': '32', 05:11:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:25 INFO - 'title': 'talos-linux64-ix-046', 05:11:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:25 INFO - 'use_talos_json': True, 05:11:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:25 INFO - 'work_dir': 'build'} 05:11:25 INFO - [mozharness: 2016-11-23 13:11:25.396488Z] Running clobber step. 05:11:25 INFO - Running pre-action listener: _resource_record_pre_action 05:11:25 INFO - Running main action method: clobber 05:11:25 INFO - rmtree: /builds/slave/test/build 05:11:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:26 INFO - Running post-action listener: _resource_record_post_action 05:11:26 INFO - [mozharness: 2016-11-23 13:11:26.421236Z] Finished clobber step (success) 05:11:26 INFO - [mozharness: 2016-11-23 13:11:26.421334Z] Running read-buildbot-config step. 05:11:26 INFO - Running pre-action listener: _resource_record_pre_action 05:11:26 INFO - Running main action method: read_buildbot_config 05:11:26 INFO - Using buildbot properties: 05:11:26 INFO - { 05:11:26 INFO - "project": "", 05:11:26 INFO - "product": "firefox", 05:11:26 INFO - "script_repo_revision": "default", 05:11:26 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 05:11:26 INFO - "repository": "", 05:11:26 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 05:11:26 INFO - "buildid": "20161123024236", 05:11:26 INFO - "pgo_build": "False", 05:11:26 INFO - "basedir": "/builds/slave/test", 05:11:26 INFO - "buildnumber": 7, 05:11:26 INFO - "slavename": "talos-linux64-ix-046", 05:11:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:11:26 INFO - "platform": "ubuntu64_hw", 05:11:26 INFO - "scheduler": "tests-cedar-linux64-talos", 05:11:26 INFO - "branch": "cedar", 05:11:26 INFO - "repo_path": "projects/cedar", 05:11:26 INFO - "revision": "e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7", 05:11:26 INFO - "stage_platform": "linux64", 05:11:26 INFO - "builduid": "85a1cea35edb4fd995bfdfa93b1c438a", 05:11:26 INFO - "slavebuilddir": "test" 05:11:26 INFO - } 05:11:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:11:26 INFO - Running post-action listener: _resource_record_post_action 05:11:26 INFO - [mozharness: 2016-11-23 13:11:26.423761Z] Finished read-buildbot-config step (success) 05:11:26 INFO - [mozharness: 2016-11-23 13:11:26.423848Z] Running download-and-extract step. 05:11:26 INFO - Running pre-action listener: _resource_record_pre_action 05:11:26 INFO - Running main action method: download_and_extract 05:11:26 INFO - mkdir: /builds/slave/test/build/tests 05:11:26 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')]} 05:11:26 INFO - trying https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:26 INFO - Downloading https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:11:26 INFO - Downloaded 1361 bytes. 05:11:26 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:26 INFO - Using the following test package requirements: 05:11:26 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:26 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:26 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:26 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'jsshell-linux-x86_64.zip'], 05:11:26 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:26 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:26 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:26 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:26 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:26 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:11:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:26 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:11:27 INFO - Http code: 200 05:11:27 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 05:11:27 INFO - x-amz-cf-id: RuSk-pWYFNmLecdyBh3_RwLao9eLMHxRiLArqdF9KGfiEw1iAvYKWg== 05:11:27 INFO - x-amz-version-id: lJC.UN25z4b5NnWRVFD7F4uPfjEtcaPl 05:11:27 INFO - Expected file size: 20201941 05:11:27 INFO - Obtained file size: 20201941 05:11:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:11:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:11:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:11:32 INFO - Http code: 200 05:11:32 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:11:32 INFO - x-amz-cf-id: OeyNv08W4ps3HmAvSh7KWdgyLCw2Km5XqH7TKed9JVSjjn64vzWIhQ== 05:11:32 INFO - x-amz-version-id: lJC.UN25z4b5NnWRVFD7F4uPfjEtcaPl 05:11:32 INFO - Expected file size: 20201941 05:11:32 INFO - Obtained file size: 20201941 05:11:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:37 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:11:37 INFO - Http code: 200 05:11:37 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 05:11:37 INFO - x-amz-cf-id: jwYgoEa-W8Ucv-kPp8PnXY2h6nRMdoEuf9JWZnssDuzI6Vf-lVuH0w== 05:11:37 INFO - x-amz-version-id: fcuN1gxwydgFVsPbjAGFwqv_1eqmf3aT 05:11:37 INFO - Expected file size: 14409506 05:11:37 INFO - Obtained file size: 14409506 05:11: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')]} 05:11:38 INFO - trying https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:38 INFO - Downloading https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:39 INFO - Downloaded 55624268 bytes. 05:11:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:39 INFO - mkdir: /builds/slave/test/properties 05:11:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:39 INFO - Contents: 05:11:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:39 INFO - Running post-action listener: _resource_record_post_action 05:11:39 INFO - Running post-action listener: set_extra_try_arguments 05:11:39 INFO - [mozharness: 2016-11-23 13:11:39.952918Z] Finished download-and-extract step (success) 05:11:39 INFO - [mozharness: 2016-11-23 13:11:39.953223Z] Running populate-webroot step. 05:11:39 INFO - Running pre-action listener: _resource_record_pre_action 05:11:39 INFO - Running main action method: populate_webroot 05:11:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:39 INFO - '--tppagecycles', 05:11:39 INFO - '7'], 05:11:39 INFO - 'tests': ['tsvgm']}}, 05:11:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['damp', 'tps']}, 05:11:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'tests': ['damp', 'tps']}, 05:11:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['dromaeo_dom']}, 05:11:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['basic_compositor_video']}, 05:11:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['a11yr', 05:11:39 INFO - 'ts_paint', 05:11:39 INFO - 'tpaint', 05:11:39 INFO - 'sessionrestore', 05:11:39 INFO - 'sessionrestore_no_auto_restore', 05:11:39 INFO - 'tabpaint']}, 05:11:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['tsvgx', 05:11:39 INFO - 'tsvgr_opacity', 05:11:39 INFO - 'tart', 05:11:39 INFO - 'tscrollx', 05:11:39 INFO - 'cart']}, 05:11:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:39 INFO - 'tsvgr_opacity', 05:11:39 INFO - 'tart', 05:11:39 INFO - 'tscrollx', 05:11:39 INFO - 'cart']}, 05:11:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'talos_options': ['--disable-e10s'], 05:11:39 INFO - 'tests': ['tp5o']}, 05:11:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:11:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'talos_options': ['--disable-e10s', 05:11:39 INFO - '--xperf_path', 05:11:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:39 INFO - 'tests': ['tp5n']}, 05:11:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:11:39 INFO - 'talos_options': ['--xperf_path', 05:11:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:39 INFO - 'tests': ['tp5n']}}, 05:11:39 INFO - 'talos.zip': {'path': '', 05:11:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:39 INFO - Running post-action listener: _resource_record_post_action 05:11:39 INFO - [mozharness: 2016-11-23 13:11:39.975473Z] Finished populate-webroot step (success) 05:11:39 INFO - [mozharness: 2016-11-23 13:11:39.975565Z] Running create-virtualenv step. 05:11:39 INFO - Running pre-action listener: _resource_record_pre_action 05:11:39 INFO - Running main action method: create_virtualenv 05:11:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:39 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 05:11:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:40 INFO - Using real prefix '/usr' 05:11:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:43 INFO - Installing pip.................done. 05:11:43 INFO - Return code: 0 05:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:43 INFO - Reading from file tmpfile_stdout 05:11:43 INFO - Output received: 05:11:43 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) 05:11:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11: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', 'pip>=1.5'] in /builds/slave/test/build 05:11: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 pip>=1.5 05:11:43 INFO - Using env: {'DISPLAY': ':0', 05:11:43 INFO - 'HOME': '/home/cltbld', 05:11:43 INFO - 'LANG': 'en_US.UTF-8', 05:11:43 INFO - 'LANGUAGE': 'en_US:en', 05:11:43 INFO - 'LOGNAME': 'cltbld', 05:11:43 INFO - 'MAIL': '/var/mail/cltbld', 05:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:43 INFO - 'MOZ_NO_REMOTE': '1', 05:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:43 INFO - 'NO_EM_RESTART': '1', 05:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:43 INFO - 'PWD': '/builds/slave/test', 05:11:43 INFO - 'SHELL': '/bin/bash', 05:11:43 INFO - 'SHLVL': '1', 05:11:43 INFO - 'TERM': 'linux', 05:11:43 INFO - 'TMOUT': '86400', 05:11:43 INFO - 'USER': 'cltbld', 05:11:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:43 INFO - '_': '/tools/buildbot/bin/python'} 05:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:43 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 05:11:43 INFO - Cleaning up... 05:11:43 INFO - Return code: 0 05:11:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11: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 psutil>=3.1.1 05:11:43 INFO - Using env: {'DISPLAY': ':0', 05:11:43 INFO - 'HOME': '/home/cltbld', 05:11:43 INFO - 'LANG': 'en_US.UTF-8', 05:11:43 INFO - 'LANGUAGE': 'en_US:en', 05:11:43 INFO - 'LOGNAME': 'cltbld', 05:11:43 INFO - 'MAIL': '/var/mail/cltbld', 05:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:43 INFO - 'MOZ_NO_REMOTE': '1', 05:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:43 INFO - 'NO_EM_RESTART': '1', 05:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:43 INFO - 'PWD': '/builds/slave/test', 05:11:43 INFO - 'SHELL': '/bin/bash', 05:11:43 INFO - 'SHLVL': '1', 05:11:43 INFO - 'TERM': 'linux', 05:11:43 INFO - 'TMOUT': '86400', 05:11:43 INFO - 'USER': 'cltbld', 05:11:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:43 INFO - '_': '/tools/buildbot/bin/python'} 05:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:44 INFO - Downloading/unpacking psutil>=3.1.1 05:11:44 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 05:11:44 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 05:11:44 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 05:11:44 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 05:11:44 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 05:11:44 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 05:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:46 INFO - Installing collected packages: psutil 05:11:46 INFO - Running setup.py install for psutil 05:11:46 INFO - building 'psutil._psutil_linux' extension 05:11:46 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 05:11:47 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 05:11:47 INFO - building 'psutil._psutil_posix' extension 05:11:47 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 05:11:48 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 05:11:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:48 INFO - Successfully installed psutil 05:11:48 INFO - Cleaning up... 05:11:48 INFO - Return code: 0 05:11:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:11:48 INFO - Using env: {'DISPLAY': ':0', 05:11:48 INFO - 'HOME': '/home/cltbld', 05:11:48 INFO - 'LANG': 'en_US.UTF-8', 05:11:48 INFO - 'LANGUAGE': 'en_US:en', 05:11:48 INFO - 'LOGNAME': 'cltbld', 05:11:48 INFO - 'MAIL': '/var/mail/cltbld', 05:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:48 INFO - 'MOZ_NO_REMOTE': '1', 05:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:48 INFO - 'NO_EM_RESTART': '1', 05:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:48 INFO - 'PWD': '/builds/slave/test', 05:11:48 INFO - 'SHELL': '/bin/bash', 05:11:48 INFO - 'SHLVL': '1', 05:11:48 INFO - 'TERM': 'linux', 05:11:48 INFO - 'TMOUT': '86400', 05:11:48 INFO - 'USER': 'cltbld', 05:11:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:48 INFO - '_': '/tools/buildbot/bin/python'} 05:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:48 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 05:11:48 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 05:11:48 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 05:11:48 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 05:11:48 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 05:11:48 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 05:11:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:50 INFO - Installing collected packages: mozsystemmonitor 05:11:50 INFO - Running setup.py install for mozsystemmonitor 05:11:50 INFO - Successfully installed mozsystemmonitor 05:11:50 INFO - Cleaning up... 05:11:50 INFO - Return code: 0 05:11:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11:50 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 05:11:50 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 05:11:50 INFO - Using env: {'DISPLAY': ':0', 05:11:50 INFO - 'HOME': '/home/cltbld', 05:11:50 INFO - 'LANG': 'en_US.UTF-8', 05:11:50 INFO - 'LANGUAGE': 'en_US:en', 05:11:50 INFO - 'LOGNAME': 'cltbld', 05:11:50 INFO - 'MAIL': '/var/mail/cltbld', 05:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:50 INFO - 'MOZ_NO_REMOTE': '1', 05:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:50 INFO - 'NO_EM_RESTART': '1', 05:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:50 INFO - 'PWD': '/builds/slave/test', 05:11:50 INFO - 'SHELL': '/bin/bash', 05:11:50 INFO - 'SHLVL': '1', 05:11:50 INFO - 'TERM': 'linux', 05:11:50 INFO - 'TMOUT': '86400', 05:11:50 INFO - 'USER': 'cltbld', 05:11:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:50 INFO - '_': '/tools/buildbot/bin/python'} 05:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:50 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:52 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 05:11:52 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 05:11:52 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 05:11:52 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 05:11:52 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 05:11:52 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 05:11:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:53 INFO - warning: no files found matching '*.txt' 05:11:53 INFO - no previously-included directories found matching 'build' 05:11:53 INFO - no previously-included directories found matching 'dist' 05:11:53 INFO - no previously-included directories found matching '.git*' 05:11:53 INFO - Installing collected packages: jsonschema, functools32 05:11:53 INFO - Running setup.py install for functools32 05:11:53 INFO - warning: no files found matching '*.txt' 05:11:53 INFO - no previously-included directories found matching 'build' 05:11:53 INFO - no previously-included directories found matching 'dist' 05:11:53 INFO - no previously-included directories found matching '.git*' 05:11:53 INFO - Successfully installed jsonschema functools32 05:11:53 INFO - Cleaning up... 05:11:53 INFO - Return code: 0 05:11:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:11:53 INFO - Using env: {'DISPLAY': ':0', 05:11:53 INFO - 'HOME': '/home/cltbld', 05:11:53 INFO - 'LANG': 'en_US.UTF-8', 05:11:53 INFO - 'LANGUAGE': 'en_US:en', 05:11:53 INFO - 'LOGNAME': 'cltbld', 05:11:53 INFO - 'MAIL': '/var/mail/cltbld', 05:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:53 INFO - 'MOZ_NO_REMOTE': '1', 05:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:53 INFO - 'NO_EM_RESTART': '1', 05:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:53 INFO - 'PWD': '/builds/slave/test', 05:11:53 INFO - 'SHELL': '/bin/bash', 05:11:53 INFO - 'SHLVL': '1', 05:11:53 INFO - 'TERM': 'linux', 05:11:53 INFO - 'TMOUT': '86400', 05:11:53 INFO - 'USER': 'cltbld', 05:11:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:53 INFO - '_': '/tools/buildbot/bin/python'} 05:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:53 INFO - Cleaning up... 05:11:53 INFO - Return code: 0 05:11:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:53 INFO - Using env: {'DISPLAY': ':0', 05:11:53 INFO - 'HOME': '/home/cltbld', 05:11:53 INFO - 'LANG': 'en_US.UTF-8', 05:11:53 INFO - 'LANGUAGE': 'en_US:en', 05:11:53 INFO - 'LOGNAME': 'cltbld', 05:11:53 INFO - 'MAIL': '/var/mail/cltbld', 05:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:53 INFO - 'MOZ_NO_REMOTE': '1', 05:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:53 INFO - 'NO_EM_RESTART': '1', 05:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:53 INFO - 'PWD': '/builds/slave/test', 05:11:53 INFO - 'SHELL': '/bin/bash', 05:11:53 INFO - 'SHLVL': '1', 05:11:53 INFO - 'TERM': 'linux', 05:11:53 INFO - 'TMOUT': '86400', 05:11:53 INFO - 'USER': 'cltbld', 05:11:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:53 INFO - '_': '/tools/buildbot/bin/python'} 05:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:53 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 05:11:53 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 05:11:53 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 05:11:53 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 05:11:53 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 05:11:53 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 05:11:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:55 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 05:11:55 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 05:11:55 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 05:11:55 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 05:11:55 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 05:11:55 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 05:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:56 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 05:11:56 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 05:11:56 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 05:11:56 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 05:11:56 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 05:11:56 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 05:11:56 INFO - Downloading docopt-0.6.1.tar.gz 05:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:56 INFO - Running setup.py install for blobuploader 05:11:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:56 INFO - Running setup.py install for requests 05:11:57 INFO - Running setup.py install for docopt 05:11:57 INFO - Successfully installed blobuploader requests docopt 05:11:57 INFO - Cleaning up... 05:11:57 INFO - Return code: 0 05:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:57 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')]} 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 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')]} 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:11:57 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 05:11:57 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 05:11:57 INFO - Using env: {'DISPLAY': ':0', 05:11:57 INFO - 'HOME': '/home/cltbld', 05:11:57 INFO - 'LANG': 'en_US.UTF-8', 05:11:57 INFO - 'LANGUAGE': 'en_US:en', 05:11:57 INFO - 'LOGNAME': 'cltbld', 05:11:57 INFO - 'MAIL': '/var/mail/cltbld', 05:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:57 INFO - 'MOZ_NO_REMOTE': '1', 05:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:57 INFO - 'NO_EM_RESTART': '1', 05:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:57 INFO - 'PWD': '/builds/slave/test', 05:11:57 INFO - 'SHELL': '/bin/bash', 05:11:57 INFO - 'SHLVL': '1', 05:11:57 INFO - 'TERM': 'linux', 05:11:57 INFO - 'TMOUT': '86400', 05:11:57 INFO - 'USER': 'cltbld', 05:11:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:57 INFO - '_': '/tools/buildbot/bin/python'} 05:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:58 INFO - Running setup.py (path:/tmp/pip-WzUGLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:58 INFO - Running setup.py (path:/tmp/pip-Qrs5Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:58 INFO - Running setup.py (path:/tmp/pip-rdhe6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:58 INFO - Running setup.py (path:/tmp/pip-2yB4Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:58 INFO - Running setup.py (path:/tmp/pip-pDijhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:58 INFO - Running setup.py (path:/tmp/pip-ApCI4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:58 INFO - Running setup.py (path:/tmp/pip-8cs6JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:58 INFO - Running setup.py (path:/tmp/pip-NUrhtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:58 INFO - Running setup.py (path:/tmp/pip-t28cWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:58 INFO - Running setup.py (path:/tmp/pip-pl5vKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:58 INFO - Running setup.py (path:/tmp/pip-EJ73WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:58 INFO - Running setup.py (path:/tmp/pip-X3DqxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:58 INFO - Running setup.py (path:/tmp/pip-Vtqq62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:58 INFO - Running setup.py (path:/tmp/pip-YwqlgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:58 INFO - Running setup.py (path:/tmp/pip-FxWKVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:59 INFO - Running setup.py (path:/tmp/pip-lHjE_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:59 INFO - Running setup.py (path:/tmp/pip-Dc8tHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:59 INFO - Running setup.py install for manifestparser 05:11:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Running setup.py install for mozcrash 05:11:59 INFO - Running setup.py install for mozdebug 05:11:59 INFO - Running setup.py install for mozdevice 05:11:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Running setup.py install for mozfile 05:11:59 INFO - Running setup.py install for mozhttpd 05:11:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Running setup.py install for mozinfo 05:11:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Running setup.py install for mozInstall 05:11:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:59 INFO - Running setup.py install for mozleak 05:12:00 INFO - Running setup.py install for mozlog 05:12:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Running setup.py install for moznetwork 05:12:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Running setup.py install for mozprocess 05:12:00 INFO - Running setup.py install for mozprofile 05:12:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Running setup.py install for mozrunner 05:12:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Running setup.py install for mozscreenshot 05:12:00 INFO - Running setup.py install for moztest 05:12:00 INFO - Running setup.py install for mozversion 05:12:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:00 INFO - Cleaning up... 05:12:00 INFO - Return code: 0 05:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:00 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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:12:00 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 05:12:00 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 05:12:00 INFO - Using env: {'DISPLAY': ':0', 05:12:00 INFO - 'HOME': '/home/cltbld', 05:12:00 INFO - 'LANG': 'en_US.UTF-8', 05:12:00 INFO - 'LANGUAGE': 'en_US:en', 05:12:00 INFO - 'LOGNAME': 'cltbld', 05:12:00 INFO - 'MAIL': '/var/mail/cltbld', 05:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:00 INFO - 'MOZ_NO_REMOTE': '1', 05:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:00 INFO - 'NO_EM_RESTART': '1', 05:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:00 INFO - 'PWD': '/builds/slave/test', 05:12:00 INFO - 'SHELL': '/bin/bash', 05:12:00 INFO - 'SHLVL': '1', 05:12:00 INFO - 'TERM': 'linux', 05:12:00 INFO - 'TMOUT': '86400', 05:12:00 INFO - 'USER': 'cltbld', 05:12:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:00 INFO - '_': '/tools/buildbot/bin/python'} 05:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:01 INFO - Running setup.py (path:/tmp/pip-qEGjUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:01 INFO - Running setup.py (path:/tmp/pip-TqFnBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:01 INFO - Running setup.py (path:/tmp/pip-RKo7uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:01 INFO - Running setup.py (path:/tmp/pip-h9fJMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:01 INFO - Running setup.py (path:/tmp/pip-mlxVXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:01 INFO - Running setup.py (path:/tmp/pip-nsq8na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:01 INFO - Running setup.py (path:/tmp/pip-SaCJdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:01 INFO - Running setup.py (path:/tmp/pip-cnWjaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:01 INFO - Running setup.py (path:/tmp/pip-Zr4rTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:01 INFO - Running setup.py (path:/tmp/pip-LOmIRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:01 INFO - Running setup.py (path:/tmp/pip-DfiMqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:01 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)) 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:01 INFO - Running setup.py (path:/tmp/pip-iK5RtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:02 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)) 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:02 INFO - Running setup.py (path:/tmp/pip-l_pKWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:02 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)) 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:02 INFO - Running setup.py (path:/tmp/pip-0mKOcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:02 INFO - Running setup.py (path:/tmp/pip-pT1b0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:02 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)) 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:02 INFO - Running setup.py (path:/tmp/pip-FWT8tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:02 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)) 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:02 INFO - Running setup.py (path:/tmp/pip-a3N8am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:02 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)) 05:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:02 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)) 05:12:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:04 INFO - Downloading blessings-1.6.tar.gz 05:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:04 INFO - Installing collected packages: blessings 05:12:04 INFO - Running setup.py install for blessings 05:12:04 INFO - Successfully installed blessings 05:12:04 INFO - Cleaning up... 05:12:04 INFO - Return code: 0 05:12:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:04 INFO - Reading from file tmpfile_stdout 05:12:04 INFO - Current package versions: 05:12:04 INFO - argparse == 1.2.1 05:12:04 INFO - blessings == 1.6 05:12:04 INFO - blobuploader == 1.2.4 05:12:04 INFO - docopt == 0.6.1 05:12:04 INFO - functools32 == 3.2.3-2 05:12:04 INFO - jsonschema == 2.5.1 05:12:04 INFO - manifestparser == 1.1 05:12:04 INFO - mozInstall == 1.12 05:12:04 INFO - mozcrash == 1.0 05:12:04 INFO - mozdebug == 0.1 05:12:04 INFO - mozdevice == 0.49 05:12:04 INFO - mozfile == 1.2 05:12:04 INFO - mozhttpd == 0.7 05:12:04 INFO - mozinfo == 0.9 05:12:04 INFO - mozleak == 0.1 05:12:04 INFO - mozlog == 3.4 05:12:04 INFO - moznetwork == 0.27 05:12:04 INFO - mozprocess == 0.23 05:12:04 INFO - mozprofile == 0.28 05:12:04 INFO - mozrunner == 6.13 05:12:04 INFO - mozscreenshot == 0.1 05:12:04 INFO - mozsystemmonitor == 0.3 05:12:04 INFO - moztest == 0.7 05:12:04 INFO - mozversion == 1.4 05:12:04 INFO - psutil == 3.1.1 05:12:04 INFO - requests == 1.2.3 05:12:04 INFO - wsgiref == 0.1.2 05:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:04 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')]} 05:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:04 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')]} 05:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:04 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 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:12:04 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 05:12:04 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 05:12:04 INFO - Using env: {'DISPLAY': ':0', 05:12:04 INFO - 'HOME': '/home/cltbld', 05:12:04 INFO - 'LANG': 'en_US.UTF-8', 05:12:04 INFO - 'LANGUAGE': 'en_US:en', 05:12:04 INFO - 'LOGNAME': 'cltbld', 05:12:04 INFO - 'MAIL': '/var/mail/cltbld', 05:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:04 INFO - 'MOZ_NO_REMOTE': '1', 05:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:04 INFO - 'NO_EM_RESTART': '1', 05:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:04 INFO - 'PWD': '/builds/slave/test', 05:12:04 INFO - 'SHELL': '/bin/bash', 05:12:04 INFO - 'SHLVL': '1', 05:12:04 INFO - 'TERM': 'linux', 05:12:04 INFO - 'TMOUT': '86400', 05:12:04 INFO - 'USER': 'cltbld', 05:12:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:04 INFO - '_': '/tools/buildbot/bin/python'} 05:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 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)) 05:12:05 INFO - Cleaning up... 05:12:05 INFO - Return code: 0 05:12:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b197d9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, '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': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', '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 05:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:05 INFO - Using env: {'DISPLAY': ':0', 05:12:05 INFO - 'HOME': '/home/cltbld', 05:12:05 INFO - 'LANG': 'en_US.UTF-8', 05:12:05 INFO - 'LANGUAGE': 'en_US:en', 05:12:05 INFO - 'LOGNAME': 'cltbld', 05:12:05 INFO - 'MAIL': '/var/mail/cltbld', 05:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:05 INFO - 'MOZ_NO_REMOTE': '1', 05:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:05 INFO - 'NO_EM_RESTART': '1', 05:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:05 INFO - 'PWD': '/builds/slave/test', 05:12:05 INFO - 'SHELL': '/bin/bash', 05:12:05 INFO - 'SHLVL': '1', 05:12:05 INFO - 'TERM': 'linux', 05:12:05 INFO - 'TMOUT': '86400', 05:12:05 INFO - 'USER': 'cltbld', 05:12:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:05 INFO - '_': '/tools/buildbot/bin/python'} 05:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:05 INFO - Cleaning up... 05:12:05 INFO - Return code: 0 05:12:05 INFO - Running post-action listener: _resource_record_post_action 05:12:05 INFO - Running post-action listener: _start_resource_monitoring 05:12:05 INFO - Starting resource monitoring. 05:12:05 INFO - [mozharness: 2016-11-23 13:12:05.323978Z] Finished create-virtualenv step (success) 05:12:05 INFO - [mozharness: 2016-11-23 13:12:05.324897Z] Running install step. 05:12:05 INFO - Running pre-action listener: _resource_record_pre_action 05:12:05 INFO - Running main action method: install 05:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:05 INFO - Reading from file tmpfile_stdout 05:12:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:05 INFO - Reading from file tmpfile_stdout 05:12:05 INFO - Output received: 05:12:05 INFO - Usage: mozinstall [options] installer 05:12:05 INFO - Options: 05:12:05 INFO - -h, --help show this help message and exit 05:12:05 INFO - -d DEST, --destination=DEST 05:12:05 INFO - Directory to install application into. [default: 05:12:05 INFO - "/builds/slave/test"] 05:12:05 INFO - --app=APP Application being installed. [default: firefox] 05:12:05 INFO - mkdir: /builds/slave/test/build/application 05:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:12:21 INFO - Reading from file tmpfile_stdout 05:12:21 INFO - Output received: 05:12:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:21 INFO - Running post-action listener: _resource_record_post_action 05:12:21 INFO - [mozharness: 2016-11-23 13:12:21.646044Z] Finished install step (success) 05:12:21 INFO - [mozharness: 2016-11-23 13:12:21.646286Z] Running run-tests step. 05:12:21 INFO - Running pre-action listener: _resource_record_pre_action 05:12:21 INFO - Running main action method: run_tests 05:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:21 INFO - Python 2.7.3 05:12:21 INFO - Return code: 0 05:12:21 INFO - grabbing minidump binary from tooltool 05:12:21 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')]} 05:12:21 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 0x1214fc0>, '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 0x1215ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:21 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 05:12:21 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 05:12:21 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 05:12:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:21 INFO - Return code: 0 05:12:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:12:21 INFO - Using env: {'DISPLAY': ':0', 05:12:21 INFO - 'HOME': '/home/cltbld', 05:12:21 INFO - 'LANG': 'en_US.UTF-8', 05:12:21 INFO - 'LANGUAGE': 'en_US:en', 05:12:21 INFO - 'LOGNAME': 'cltbld', 05:12:21 INFO - 'MAIL': '/var/mail/cltbld', 05:12:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:21 INFO - 'MOZ_NO_REMOTE': '1', 05:12:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:21 INFO - 'NO_EM_RESTART': '1', 05:12:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:21 INFO - 'PWD': '/builds/slave/test', 05:12:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:21 INFO - 'SHELL': '/bin/bash', 05:12:21 INFO - 'SHLVL': '1', 05:12:21 INFO - 'TERM': 'linux', 05:12:21 INFO - 'TMOUT': '86400', 05:12:21 INFO - 'USER': 'cltbld', 05:12:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066', 05:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:21 INFO - '_': '/tools/buildbot/bin/python'} 05:12:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:12:22 INFO - mozversion application_buildid: 20161123024236 05:12:22 INFO - mozversion application_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 05:12:22 INFO - mozversion application_display_name: Nightly 05:12:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:22 INFO - mozversion application_name: Firefox 05:12:22 INFO - mozversion application_remotingname: firefox 05:12:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 05:12:22 INFO - mozversion application_vendor: Mozilla 05:12:22 INFO - mozversion application_version: 53.0a1 05:12:22 INFO - mozversion platform_buildid: 20161123024236 05:12:22 INFO - mozversion platform_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 05:12:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 05:12:22 INFO - mozversion platform_version: 53.0a1 05:12:22 INFO - using testdate: 1479906742 05:12:22 INFO - actual date: 1479906742 05:12:22 INFO - starting webserver on 'localhost:48973' 05:12:22 INFO - SUITE-START | Running 2 tests 05:12:22 INFO - TEST-START | dromaeo_css 05:12:22 INFO - operating with platform_type : linux_ 05:12:22 INFO - Initialising browser for dromaeo_css test... 05:12:22 INFO - TEST-INFO | started process 3286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfYEDM/profile http://localhost:48973/getInfo.html) 05:12:28 INFO - PROCESS | 3286 | __metrics Screen width/height:1600/1200 05:12:28 INFO - PROCESS | 3286 | colorDepth:24 05:12:28 INFO - PROCESS | 3286 | Browser inner width/height: 1024/697 05:12:28 INFO - PROCESS | 3286 | __metrics 05:12:28 INFO - PROCESS | 3286 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:28 INFO - PROCESS | 3286 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:29 INFO - PROCESS | 3286 | console.error: PushService: 05:12:29 INFO - PROCESS | 3286 | stateChangeProcessEnqueue: Error transitioning state 05:12:29 INFO - PROCESS | 3286 | UnknownError 05:12:29 INFO - TEST-INFO | 3286: exit 0 05:12:29 INFO - Browser initialized. 05:12:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:29 INFO - TEST-INFO | started process 3369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfYEDM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:42 INFO - PROCESS | 3369 | RSS: Main: 174686208 05:12:42 INFO - PROCESS | 3369 | 05:13:34 INFO - PROCESS | 3369 | 1479906814018 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] 05:15:47 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48973/tests/dromaeo/cssquery-ext.html) 05:15:48 INFO - PROCESS | 3369 | RSS: Main: 271540224 05:15:48 INFO - PROCESS | 3369 | 05:18:51 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-ext.html (next: http://localhost:48973/tests/dromaeo/cssquery-jquery.html) 05:18:51 INFO - PROCESS | 3369 | RSS: Main: 274907136 05:18:51 INFO - PROCESS | 3369 | 05:21:54 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48973/tests/dromaeo/cssquery-mootools.html) 05:21:54 INFO - PROCESS | 3369 | RSS: Main: 227536896 05:21:54 INFO - PROCESS | 3369 | 05:24:57 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48973/tests/dromaeo/cssquery-prototype.html) 05:24:57 INFO - PROCESS | 3369 | RSS: Main: 241803264 05:24:57 INFO - PROCESS | 3369 | 05:28:00 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48973/tests/dromaeo/cssquery-yui.html) 05:28:01 INFO - PROCESS | 3369 | RSS: Main: 218947584 05:28:01 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:48973/tests/dromaeo/cssquery-yui.html (next: http://localhost:48973/tests/dromaeo/cssquery-dojo.html) 05:31:04 INFO - PROCESS | 3369 | RSS: Main: 318648320 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | __start_tp_report 05:31:04 INFO - PROCESS | 3369 | _x_x_mozilla_page_load 05:31:04 INFO - PROCESS | 3369 | _x_x_mozilla_page_load_details 05:31:04 INFO - PROCESS | 3369 | |i|pagename|runs| 05:31:04 INFO - PROCESS | 3369 | |0;dojo.html;2563.218218443375;2588.7411258874104;2600.375909781652;2621.947561048779;2632.0787724296497;4403.691741578091;4449.443819522559;4656.743879086649;4690.718556886589;4704.788284527196;4495.100979804044;4709.811607535695;4783.9760801196035;4794.376731024962;4794.592459640926;4256.4679415073115;4276.807543660527;4316.6978311518205;4321.416608757824;4349.956500434987;3903.6291552302628;4268.38108474271;4390.42924419825;4395.450568678915;4432.268675668511;4112.465379500646;4307.806148723315;4315.30955047194;4353.455818022747;4413.227685155101;4133.46264985553;4184.456020717318;4236.428082208893;4251.936220956688;4275.46556680415;4268.530461649216;4273.87178384649;4292.613664770186;4311.525732169459;4341.131773645252;4625.051864367831;4627.305904114376;4659.464161621389;4662.137504561633;4663.883402914954;4698.295255711637;4720.834770783006;4721.362616046824;4794.089123066641;4951.851444456672;4754.643401744848;4810.2683034107695;4824.179889418772;4880.951190488086;4952;4666.626669866402;4711.858644240644;4731.101090792738;4731.787069581877;4736.881577960578;5097;5112.616553758408;5117.8464646060675;5123.769430375642;5158.92261616076;4658.231391820379;4895.828645997444;4902.068606964665;4909.042736666316;4935.062338155739;4794.640401969867;4871.050145221719;4872.756362181876;4879.756012199376;4880.560749532559;4847.079054979543;4860.416749989953;4870.975645121823;4873.31773551703;4926.556609905126;4812.879678008007;4825.469198388175;4847.5394837490385;4854.17479028566;4881.292212629149;3900.804959752001;3979.6816254699556;3987.641112299907;4048.0891799344913;4084.1219137885496;3576.98211508946;3634.582023067328;3663.5970043295215;3664.1022949377575;3664.3953747631876;4298.763568003727;4306.4832220133785;4308.116836048603;4322.78386080701;4348.34774783785;4798.640101992364;4848.80604775805;4997.425296090996;4999.575036121898;5051.26756620288;4205.747655140702;4223.577642235752;4251.17102165081;4256.36154576816;4310.80601372939;4439.755813430293;4442.311441726538;4448.043670610834;4450.065486247924;4486.775661216926;4648.767561621906;4672.672912896064;4673.766311684471;4675.088357770338;4711.599514041345;4790.952090479051;4836.202026665561;4902.313676085279;4927.211646136601;4937.21004639256;4656.928906351491;4657.836975705834;4669.042846216449;4693.530646935279;4709.764511774329;4887.340209071872;4899.608031357554;4903.3554509914065;4914.754262286943;4946.851594452172;4763.809047738066;4801.807927682993;4815.7351345676325;4829.492903245249;4929.408470983505;4898.069366820293;4905.23968784839;4918.2868484068895;4918.508149185196;4951.97524012392;4864.051509955525;4870.342503762088;4881.930491177131;4901.338319326987;4940.036692844861;4615.79228934692;4657.580817726285;4750.8337208197545;4836.056968891033;4873.9025219496125;4816.831410900601;4860.149473841992;4938.827141050046;4973;4979.302897594267;4781.521847815191;4806.519348065165;4824.565789079;4870.878228044327;4875.853724388274 05:31:04 INFO - PROCESS | 3369 | |1;ext.html;541.9810755779134;561.6994907724368;572.2732130194655;574.695411431941;579.6522086747951;27644.447111057765;30410.54384184239;30465.543016854765;30469.54295685561;30470.085897423087;29662.11013669588;38403;39476.60523394765;39497;43683;7452.403807695398;7563.962180189119;7577.355924746404;7577.469577129603;7590.468667193299;7583.582902940336;7667.7316293929725;7671.23287671234;7673.846523069536;7675.69297228113;7717.65270562826;8022.919770802305;9531.95234023829;9786.657466988658;9790.06994335537;9925.503724813767;9980.401175929395;9982.351147175483;9992.600295988188;9996.100350968447;9599.752032235834;9668.323217374787;9673.467959262238;9677.467739274338;9679.370840895319;36993.445098323544;37146.07134821651;37312.62687373146;37334.25331493382;37343.06642333936;3097.504399296124;3244.172735952317;3280.78674886134;3412.0446275043028;3478.5303983962094;27603;27986.440271194664;28113.156605301872;28230.15309540717;29654.110376688735;3435.089701229176;3465.28961562879;3476.8435420406145;3504.877329293488;3532.523109380252;232267;233131.9999999983;233484;233962;235320;51229.7438512805;51646.22530662043;51654.741726291126;51723.224151637754;51755.48244517582;53835.73082134564;53947.19079213815;54244.18633720497;54254.728726356116;54292;13713.382897769625;14086.929565352108;14123.152610843383;14125.78811317831;14133.505327313494;11431.314121152758;11549.538018479167;11554.364509951865;11575.189736718517;11583.07335413165;14284.428622855177;16013.839861601467;16369.345226190819;16381.754273685905;16397.262123204484;5206.505381988705;6011.428914253139;6234.844128896814;6306.4639505642535;6320.41550139834;794.7695168401215;920.1764420843308;926.7775733823834;948.8861336639648;988.7725823060737;24985.37536561564;26345.341366465993;26798.19605411841;27193.72806271912;27507.58738618922;941.5621735892843;943.3443756589242;948.9335746497817;958.2094771813282;965.285688590438;14244.931630127781;14254.717075463259;14600.488982885548;14631.634209144857;14726.042807217496;327220;328756;328889;329634;329944;41706.37440438396;43007;47091.76454117707;47360;52420.21369679458;1160.147291740587;1161.4947497838468;1174.7298121431947;1190.1252579354168;1197.784398808223;26815.061472848356;27581.586276206275;27776;27843;28455.28861778472;41235.96910077272;41537;41672.58327416687;41726.165476690905;41732.58267417287;284936;286232;418429;428072;429224;23993;23995.52008959846;24170.879145604158;24364.87817560901;24383.634245485977;40722.18555628812;40836.387454187614;40981;41153.176936460506;41193;34441.311173776885;34785.304293913476;34932.952011439695;35011;35460.75887343931;34627.4805877907;34790.47814282737;34872.82563587166;34913.65086349104;34955;33301.50047749334;34099.14752131217;34324.14189645279;34847.303053939286;35075.12312192216;26471.867640661672;30398.39203215879;30469.23826904345;30547.389052219274;30749.846250769497;23079.804421980836;23682.763172368745;23689.28932132039;24066.39834004164;24242.272731818073 05:31:04 INFO - PROCESS | 3369 | |2;jquery.html;343.61171875780366;356.7841455919169;369.0791475269204;374.7751349190486;391.56340680141653;12569.245845249292;13040.087193896432;13238.338083095843;13684.17894926305;16663.25015374308;15784;15960.920195399036;15980.200989950485;16007.83992160078;16072.276747546359;4586.807430068189;4736.881577960544;4799.856004319859;4970.950290497103;5019.899602007958;4903.607711383099;4919.680220785655;4937.185364414867;4945.802167913279;4946.480619534951;4670.416197975253;4894.583960363373;4906.730129842857;4918.950810491903;4921.4094308682825;4899.6815207011605;4935.0376676548085;4948.975255123737;4951.777170027357;4952.3809523809705;4464.129494748526;4466.776661166961;4473.530279320689;4473.597376236122;4482.350059241392;11046.502907369188;11620.535178592847;11672.35802030888;11673.357965311905;11719.531218751239;1791.4536066499713;1840.2271046160645;1917.5685470769106;1989.6617575012283;2350.0717216699477;8612.655493780241;9210;9213.617957306391;9351.064893510662;12212.816807747891;1538.9538313850603;1607.3046698984426;1657.2790835986384;1661.1943207544332;1671.1143094160116;64053.67973160151;64784.676076619784;65847.67076164589;67319.66340168317;67660.6616966912;9255.722328330026;9703.272254580934;9818.214542836557;9899.010098990188;9979.151772099453;13510.121842080232;13522.93238533801;13528.729425411437;13540.119892206974;13541.864581354257;7113.901399087178;7128.358447739728;7297.598632075181;7323.707051717872;7326.413886889036;6776.796696099125;6917.584944903322;6934.722611095601;6945.444364450832;7153.105861767279;4151.56408577095;4253.3194688849635;4269.252880745857;4360.7601581913295;4384.421608221038;1737.782777152856;1800.5768644368563;1831.1302131487437;1834.357974708868;1868.364755982945;827.1645637905639;856.7643897928119;903.814717982812;909.2907532124954;943.495230051919;15904.284307205971;15941.760873586905;16260.105694186697;16522.339106435607;17120.57198570046;848.1306660672859;848.7241646464923;866.6490071521044;891.064382398479;898.4519443139679;9264.11990860867;9381;9456.52717364129;9479.383840050376;9549.570269337897;351049;353938;354963;355859.74476520874;358106;48690.75654621704;63795.68102159553;69256.307436926;70787.64606177039;71842.2815771846;876.6430838731494;878.446578655443;898.5237823953315;909.0863681999548;913.1097180249336;14937.626559336104;15179.544613661608;15327;15340.386384544494;15969.760453593437;35085.29829403449;35676.28647427089;36522.44342896078;37139.25721485501;37845;47118.29322560096;49669.503304966485;49821.7770520523;50124.498755011984;50303;6388.425041746265;6774.593524388552;6882.793516194522;6957.060796792571;7064.979942010655;9968.551415186479;11542.249753765978;11562.248453850472;11713.472893719632;12049.578264760692;10053.19574434058;10090.747731306483;10237.692869213935;10418.270721049454;10910.945445272722;10169.79660406773;10262.486875656037;10411.375317480975;10519.368837869752;10626.203034772268;10354;10416.531256093645;10600.734981625521;10694.091002264584;10775.838362424412;6570.342965703582;6737.865242695217;6804.455643548603;6968.128983877015;7039.325056478506;8176.345892328481;10045.949770251102;10061.647842325483;10946.616868409568;10953.945230273797 05:31:04 INFO - PROCESS | 3369 | |3;mootools.html;1324.3775425549989;1364.249662685523;1406.3460490871742;1625.6829918165963;1656.138807819933;6178.938210617893;6426.678666066689;6979.197392299887;7417.369523590488;7430.256974302567;6985.266547012567;7257;7261.382782463484;7453.366463850566;7457.216992215821;2088.48832036151;2119.0993827623274;2120.257909731597;2126.3089495913814;2126.8085872271495;1836.9265229390808;1898.2407037185098;2067;2110.8522403431766;2152.7201463809683;2057.331367305624;2122.1829595605727;2122.564874200785;2125.1286972341345;2133.861299015559;2063.597598468299;2064.1846470644164;2087;2093.968590471144;2113.1019316790303;2141.539568992674;2142.0360837622975;2159.168720042779;2163.718716566852;2163.9026243819067;7283.126024876996;7291.2344203858365;7321.816954576125;7322.414206863491;7328.911260290844;4364.258076127066;4485.865424037284;4487.169873573399;4488.640908727294;4515.729056256602;2684.1276585109918;2851.4154598307296;2910.1415082550698;2918.6351706036744;2923.0353983185496;848.0755975986204;850.9361797865123;862.7886167888845;888.3559419420933;894.4633220067972;9733.707988760349;9848.261380396427;9860.06329398706;9860.359076660066;9864.95067524665;3726.3851464508593;3763.247350529905;3800.3539398302355;3815.809209539512;3882.6893848492055;7551.546907185587;7598.544087354777;7599.202083781234;7600.391968642495;7601.6579253933705;4429.867103986886;4453.153900758845;4453.398791163217;4479.574440428154;4481.596656300949;3971.5829837867186;4172.979135104366;4176.0395109124465;4177.227212965611;4177.415161877339;3023.9546406803915;3049.130997665655;3131.2015436063657;3157.905262842118;3165.240342317827;785.4580339565681;804.9192836517667;895.5790778334173;900.6757567275776;924.7595625137512;730.1639622632057;781.6990458673451;796.6892911764417;800.6117033238875;823.069930978003;4764.95235047652;4895.437024742129;4942.678725882806;4982.701037937735;5062.7468626568525;829.1501211258387;834.1533343656193;842.6797816829566;876.7895705030746;880.348542078857;3083.599132112811;3184.5860038194887;3282.2122690554575;3288.786228895114;3381.7970921744773;8035.638396272182;8431.704890328932;8432.704855330157;8437.198466145706;8439.746807595782;8349.457285276438;8353.289970352587;8393.160683931681;8429;8433.114522975122;6875.7937261882225;7015.543989640657;7037.577745335194;7048.788536343918;7071.575705457689;4768.976155119202;4805.423349198119;4858.92711609319;4957.628177886745;5062.012907483153;8138.389620778347;8190.549519776469;8191;8226.259636632492;8380.371472139492;7904.762857114296;8099;8368.121347258693;8409.159084091787;8434.915650843659;6316.747330106744;6443.679045795694;6448.645324507197;6450.41946224842;6455.709493072729;6852.5203235773015;7025.543339682904;7033.894491582732;7047.788566343018;7109.537880037781;5215.895682086413;6303.338149494237;6449.677516124269;6489.383508566679;6515.348465153446;6229.50163986889;6357.046443033582;6374.203224596926;6428.839279018062;6435.678216089271;5806.65160090396;5826.970865145647;5882.882342353215;5889.087191485327;5918.260217472816;4176.665866730715;4233.534311225824;4244.3633454982;4253.447051883235;4333.1766964276685;4277.37977993183;4319.43847299849;4376.212281789181;4499.5275496072445;4588.334691469785 05:31:04 INFO - PROCESS | 3369 | |4;prototype.html;285.69573404324393;296.38795886494387;296.593666676653;299.06989263390864;301.9033909149073;4800.375951126353;4804.567588916997;4820.783064762085;4859.635527335451;4891.461939186686;4491.505934347219;4579.12996530659;4643.117807616551;4669.6264298856095;4791.904161916759;3746.082209858575;3746.6886589693663;3747.6627103560672;3748.718846086541;3755.530558680172;3768.566614839301;3801.771893686374;3807.2195199984076;3811.390177571589;3836.6547010769027;3542.5040494330815;3623.9094022649383;3704.166562523424;3751.962480375202;3823.7896915669626;3794.9620503794886;3812;3814.732968692179;3818.369968955119;3821.503204583414;3317.170707323169;3365.7643964922463;3368.444206705891;3375.746818988586;3393.4570468725133;4567.566081222279;4676.555727205944;4696.319033740088;4709.693869898446;4709.905801883943;4247.745135291892;4257.76582287974;4281.229378711831;4298.484181898161;4311.762853043081;4982.153033984231;4984.252362145671;4991.301217829507;5005.399352077774;5025.472325405816;3614.1868079681863;3626.4197728363333;3640.2719456108885;3641.8725344612812;3648.890533284006;4972.836815985058;5137.537621614036;5143.485651434827;5168.276441298183;5173.327467429248;3679.056754596312;3681.2821499807815;3684.3184010958057;3730;3733.3280009598534;3747.7001839852746;3766.7551609145867;3775.7923314217983;3791.3554695701796;3798.601146879593;3975.3241948868763;4184.456020717287;4279.315309550457;4290.549492303326;4295.73275883615;4962.181240095416;4971.90056198874;4975.626827987915;4976.353074100344;4979.950200498021;1197.8862008109215;1217.3669691760235;1229.3730197599289;1240.8956029134079;1241.85097788266;817.6034623207739;823.2672921100226;829.1128492513074;843.5360551696542;860.5267103093273;4227.829128153885;4229.45017147775;4243.787810609457;4249.405083288342;4278.294081476583;4888.560029597354;4902.534259245366;4921.040397122527;4930.827421040318;5014.473480284591;4227.682923780729;4268.758901576697;4282.614564689131;4285.292926667065;4295.3342231953475;2645.682518097841;2657.42865283961;2669.265951863253;2669.6529451171614;2669.746374094458;4695.718256904596;4728.763561821896;4732.290156476556;4738.431388233434;4768.546988036131;4986.775595098229;5044.9495505045215;5138.974305128525;5156.5616922562;5169.353830771153;4604.470485894165;4648.721076735339;4695.366125573072;4764.547368000034;4770.117528257353;5044.646874718735;5065.670731402447;5074.213496907985;5080.796768129381;5104.259882317117;4681.602063824477;4892.779824907959;4907.77914993819;4908.754562271801;4934.950650493449;4675.696079754805;4699.342092107039;4760.904781904412;4761.738104404291;4765.880852978703;3590.2101537661674;3598.6041535431605;3599.3521166190335;3613.2954073955325;3632.6730594246646;4961.156603377507;5094.5669618082875;5104.69371837691;5109.718965456936;5113.360829896263;5056.595472362275;5070.543651071422;5076.441591425014;5088.974555127201;5097.884377983096;5066.2400639902835;5067.479756073237;5095.898082038412;5102.1326374515675;5136.152534831711;4843.491433399583;5017.774200161075;5046.855086588259;5050.49495050492;5070.428167268159;4879.487653796442;4980.5019498049905;4992.400911890596;4994.750262486934;5069.797208111634;4841.603406313897;4885.682430641997;4934.8766280843265;4962.652614316963;4963.305137280711 05:31:04 INFO - PROCESS | 3369 | |5;yui.html;612.1705089603587;665.3978149774453;672.3478226120661;676.3844901139963;734.1557209209409;11061.115110791128;11780;11786.82319765202;11787.823182652268;11800.173987820845;12095.516179352815;12139.08956828237;12150.574729884456;12184.208026478294;12210.69473263169;604.8880957022965;619.9504039676838;734.1777209525312;744.2854859335044;758.1016495452906;748.7192302886417;762.1387831750114;762.3596179209463;762.3938968520013;762.645369902995;815.7552734179752;818.1246066708594;818.5947955761876;818.9058258300312;819;629.2669040567779;649.3117295666608;771.7221800151997;810.1857633078747;811.1118325433612;578.5198285423089;581.9970900145472;582.0512564519805;582.0541619867715;582.1442479555047;12103.636890893287;12134;12147.331896745676;12149.93925030378;12150.027997760246;11951.940240298829;12088.33514156721;12446.25322480654;12475.750484990249;12478.251304921643;11113.777724445466;11123.110151187886;11190.608328708457;11479.13906457019;11577.363245021521;3880.798341368354;3943.3296339622334;3969.861054863095;3992.740471869319;4073.2464494068395;48388.758056209845;49467;49654;49947.750261248824;51896.48103518992;9124.45253284805;9190.63237470507;9612.134907858326;9817.803643927082;9832.459214743114;16550.6689866202;16578.08820514859;16761.32954681799;16794.396868485404;16896.239669214916;6128.080787881764;6186.659733714689;6206.131141640174;6236.656983865931;6303.621782693053;3436.742244331685;3497.8251087445524;3500.544929159193;3521.2605352876185;3562.625924277965;2584.211815396322;2657.6412184354863;2667.199840047978;2669.6929853067145;2672.2651270900656;430.67484049542395;433.5361163554966;441.92708203146765;444.54878298527024;465.91613509567924;521.4941506738458;537.7840513727929;547.351388604497;568.6673296121816;568.8748475335419;6740.696668649923;7025.543339682904;7213.531120477152;7378.483506154625;7728.26581474759;559.3651205881273;578.9681567513743;579.956503262257;580.9360970293264;595.5265563876728;3395.0663567518636;3441.4665726812386;3451.11996440906;3628.872989445357;3680.7607505512055;40911.38632920509;40957.59042409597;65034.02448963269;67561;69790.65104674545;37170.44244336337;48572.514274856796;49009.26486102711;57727.4227257722;64125;53061.734691326295;54626.72686636541;54873;55391.72304138453;55768.721156393956;6696.055407395722;6737.629430381376;6762.695678694372;6977.755778547727;7051.541649792747;38241.34649400253;38985.8050709756;39454;39619.60380396159;40087.1982560353;50023;50200;51106.488935110174;51125.23312150246;51374.48625513697;8731;8864.64541418336;8968.68609598661;8997.28021758271;9012.098790120936;10192.44974147075;10201.234907381828;10216.131628811634;10231.181505479693;10385.324953877975;9338.859917101114;9371.484568348533;9414.62341506332;9504.904950950402;9677.322587418814;8880.822383552422;9073.228775553887;9165.54172291396;9545.856812147962;9738.464384458923;9195.448273103635;9507.429554226768;9812.852807207755;9831.5084245786;9989.700308990741;6952.71593588866;7193.496455248082;7427.183009868802;7466.887996679946;7679.616019198906;6764.729410823512;7181.138263408425;7346.595937223504;7795.4543181976715;8114.959425202836 05:31:04 INFO - PROCESS | 3369 | __end_tp_report 05:31:04 INFO - PROCESS | 3369 | __start_cc_report 05:31:04 INFO - PROCESS | 3369 | _x_x_mozilla_cycle_collect,1009 05:31:04 INFO - PROCESS | 3369 | __end_cc_report 05:31:04 INFO - PROCESS | 3369 | __startTimestamp1479907864706__endTimestamp 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | ------- Summary: start ------- 05:31:04 INFO - PROCESS | 3369 | Number of tests: 6 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#0] dojo.html Cycles:165 Average:4567.10 Median:4711.86 stddev:478.52 (10.2%) stddev-sans-first:453.43 05:31:04 INFO - PROCESS | 3369 | Values: 2563.2 2588.7 2600.4 2621.9 2632.1 4403.7 4449.4 4656.7 4690.7 4704.8 4495.1 4709.8 4784.0 4794.4 4794.6 4256.5 4276.8 4316.7 4321.4 4350.0 3903.6 4268.4 4390.4 4395.5 4432.3 4112.5 4307.8 4315.3 4353.5 4413.2 4133.5 4184.5 4236.4 4251.9 4275.5 4268.5 4273.9 4292.6 4311.5 4341.1 4625.1 4627.3 4659.5 4662.1 4663.9 4698.3 4720.8 4721.4 4794.1 4951.9 4754.6 4810.3 4824.2 4881.0 4952.0 4666.6 4711.9 4731.1 4731.8 4736.9 5097.0 5112.6 5117.8 5123.8 5158.9 4658.2 4895.8 4902.1 4909.0 4935.1 4794.6 4871.1 4872.8 4879.8 4880.6 4847.1 4860.4 4871.0 4873.3 4926.6 4812.9 4825.5 4847.5 4854.2 4881.3 3900.8 3979.7 3987.6 4048.1 4084.1 3577.0 3634.6 3663.6 3664.1 3664.4 4298.8 4306.5 4308.1 4322.8 4348.3 4798.6 4848.8 4997.4 4999.6 5051.3 4205.7 4223.6 4251.2 4256.4 4310.8 4439.8 4442.3 4448.0 4450.1 4486.8 4648.8 4672.7 4673.8 4675.1 4711.6 4791.0 4836.2 4902.3 4927.2 4937.2 4656.9 4657.8 4669.0 4693.5 4709.8 4887.3 4899.6 4903.4 4914.8 4946.9 4763.8 4801.8 4815.7 4829.5 4929.4 4898.1 4905.2 4918.3 4918.5 4952.0 4864.1 4870.3 4881.9 4901.3 4940.0 4615.8 4657.6 4750.8 4836.1 4873.9 4816.8 4860.1 4938.8 4973.0 4979.3 4781.5 4806.5 4824.6 4870.9 4875.9 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#1] ext.html Cycles:180 Average:45896.11 Median:34923.30 stddev:83923.18 (240.3%) stddev-sans-first:84089.52 05:31:04 INFO - PROCESS | 3369 | Values: 542.0 561.7 572.3 574.7 579.7 27644.4 30410.5 30465.5 30469.5 30470.1 29662.1 38403.0 39476.6 39497.0 43683.0 7452.4 7564.0 7577.4 7577.5 7590.5 7583.6 7667.7 7671.2 7673.8 7675.7 7717.7 8022.9 9532.0 9786.7 9790.1 9925.5 9980.4 9982.4 9992.6 9996.1 9599.8 9668.3 9673.5 9677.5 9679.4 36993.4 37146.1 37312.6 37334.3 37343.1 3097.5 3244.2 3280.8 3412.0 3478.5 27603.0 27986.4 28113.2 28230.2 29654.1 3435.1 3465.3 3476.8 3504.9 3532.5 232267.0 233132.0 233484.0 233962.0 235320.0 51229.7 51646.2 51654.7 51723.2 51755.5 53835.7 53947.2 54244.2 54254.7 54292.0 13713.4 14086.9 14123.2 14125.8 14133.5 11431.3 11549.5 11554.4 11575.2 11583.1 14284.4 16013.8 16369.3 16381.8 16397.3 5206.5 6011.4 6234.8 6306.5 6320.4 794.8 920.2 926.8 948.9 988.8 24985.4 26345.3 26798.2 27193.7 27507.6 941.6 943.3 948.9 958.2 965.3 14244.9 14254.7 14600.5 14631.6 14726.0 327220.0 328756.0 328889.0 329634.0 329944.0 41706.4 43007.0 47091.8 47360.0 52420.2 1160.1 1161.5 1174.7 1190.1 1197.8 26815.1 27581.6 27776.0 27843.0 28455.3 41236.0 41537.0 41672.6 41726.2 41732.6 284936.0 286232.0 418429.0 428072.0 429224.0 23993.0 23995.5 24170.9 24364.9 24383.6 40722.2 40836.4 40981.0 41153.2 41193.0 34441.3 34785.3 34933.0 35011.0 35460.8 34627.5 34790.5 34872.8 34913.7 34955.0 33301.5 34099.1 34324.1 34847.3 35075.1 26471.9 30398.4 30469.2 30547.4 30749.8 23079.8 23682.8 23689.3 24066.4 24242.3 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#2] jquery.html Cycles:180 Average:22338.57 Median:4470.15 stddev:58558.49 (1310.0%) stddev-sans-first:58699.48 05:31:04 INFO - PROCESS | 3369 | Values: 343.6 356.8 369.1 374.8 391.6 12569.2 13040.1 13238.3 13684.2 16663.3 15784.0 15960.9 15980.2 16007.8 16072.3 4586.8 4736.9 4799.9 4971.0 5019.9 4903.6 4919.7 4937.2 4945.8 4946.5 4670.4 4894.6 4906.7 4919.0 4921.4 4899.7 4935.0 4949.0 4951.8 4952.4 4464.1 4466.8 4473.5 4473.6 4482.4 11046.5 11620.5 11672.4 11673.4 11719.5 1791.5 1840.2 1917.6 1989.7 2350.1 8612.7 9210.0 9213.6 9351.1 12212.8 1539.0 1607.3 1657.3 1661.2 1671.1 64053.7 64784.7 65847.7 67319.7 67660.7 9255.7 9703.3 9818.2 9899.0 9979.2 13510.1 13522.9 13528.7 13540.1 13541.9 7113.9 7128.4 7297.6 7323.7 7326.4 6776.8 6917.6 6934.7 6945.4 7153.1 4151.6 4253.3 4269.3 4360.8 4384.4 1737.8 1800.6 1831.1 1834.4 1868.4 827.2 856.8 903.8 909.3 943.5 15904.3 15941.8 16260.1 16522.3 17120.6 848.1 848.7 866.6 891.1 898.5 9264.1 9381.0 9456.5 9479.4 9549.6 351049.0 353938.0 354963.0 355859.7 358106.0 48690.8 63795.7 69256.3 70787.6 71842.3 876.6 878.4 898.5 909.1 913.1 14937.6 15179.5 15327.0 15340.4 15969.8 35085.3 35676.3 36522.4 37139.3 37845.0 47118.3 49669.5 49821.8 50124.5 50303.0 6388.4 6774.6 6882.8 6957.1 7065.0 9968.6 11542.2 11562.2 11713.5 12049.6 10053.2 10090.7 10237.7 10418.3 10910.9 10169.8 10262.5 10411.4 10519.4 10626.2 10354.0 10416.5 10600.7 10694.1 10775.8 6570.3 6737.9 6804.5 6968.1 7039.3 8176.3 10045.9 10061.6 10946.6 10953.9 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#3] mootools.html Cycles:180 Average:4746.21 Median:6048.60 stddev:2584.59 (42.7%) stddev-sans-first:2579.05 05:31:04 INFO - PROCESS | 3369 | Values: 1324.4 1364.2 1406.3 1625.7 1656.1 6178.9 6426.7 6979.2 7417.4 7430.3 6985.3 7257.0 7261.4 7453.4 7457.2 2088.5 2119.1 2120.3 2126.3 2126.8 1836.9 1898.2 2067.0 2110.9 2152.7 2057.3 2122.2 2122.6 2125.1 2133.9 2063.6 2064.2 2087.0 2094.0 2113.1 2141.5 2142.0 2159.2 2163.7 2163.9 7283.1 7291.2 7321.8 7322.4 7328.9 4364.3 4485.9 4487.2 4488.6 4515.7 2684.1 2851.4 2910.1 2918.6 2923.0 848.1 850.9 862.8 888.4 894.5 9733.7 9848.3 9860.1 9860.4 9865.0 3726.4 3763.2 3800.4 3815.8 3882.7 7551.5 7598.5 7599.2 7600.4 7601.7 4429.9 4453.2 4453.4 4479.6 4481.6 3971.6 4173.0 4176.0 4177.2 4177.4 3024.0 3049.1 3131.2 3157.9 3165.2 785.5 804.9 895.6 900.7 924.8 730.2 781.7 796.7 800.6 823.1 4765.0 4895.4 4942.7 4982.7 5062.7 829.2 834.2 842.7 876.8 880.3 3083.6 3184.6 3282.2 3288.8 3381.8 8035.6 8431.7 8432.7 8437.2 8439.7 8349.5 8353.3 8393.2 8429.0 8433.1 6875.8 7015.5 7037.6 7048.8 7071.6 4769.0 4805.4 4858.9 4957.6 5062.0 8138.4 8190.5 8191.0 8226.3 8380.4 7904.8 8099.0 8368.1 8409.2 8434.9 6316.7 6443.7 6448.6 6450.4 6455.7 6852.5 7025.5 7033.9 7047.8 7109.5 5215.9 6303.3 6449.7 6489.4 6515.3 6229.5 6357.0 6374.2 6428.8 6435.7 5806.7 5827.0 5882.9 5889.1 5918.3 4176.7 4233.5 4244.4 4253.4 4333.2 4277.4 4319.4 4376.2 4499.5 4588.3 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#4] prototype.html Cycles:180 Average:4129.97 Median:4695.54 stddev:1189.43 (25.3%) stddev-sans-first:1157.24 05:31:04 INFO - PROCESS | 3369 | Values: 285.7 296.4 296.6 299.1 301.9 4800.4 4804.6 4820.8 4859.6 4891.5 4491.5 4579.1 4643.1 4669.6 4791.9 3746.1 3746.7 3747.7 3748.7 3755.5 3768.6 3801.8 3807.2 3811.4 3836.7 3542.5 3623.9 3704.2 3752.0 3823.8 3795.0 3812.0 3814.7 3818.4 3821.5 3317.2 3365.8 3368.4 3375.7 3393.5 4567.6 4676.6 4696.3 4709.7 4709.9 4247.7 4257.8 4281.2 4298.5 4311.8 4982.2 4984.3 4991.3 5005.4 5025.5 3614.2 3626.4 3640.3 3641.9 3648.9 4972.8 5137.5 5143.5 5168.3 5173.3 3679.1 3681.3 3684.3 3730.0 3733.3 3747.7 3766.8 3775.8 3791.4 3798.6 3975.3 4184.5 4279.3 4290.5 4295.7 4962.2 4971.9 4975.6 4976.4 4980.0 1197.9 1217.4 1229.4 1240.9 1241.9 817.6 823.3 829.1 843.5 860.5 4227.8 4229.5 4243.8 4249.4 4278.3 4888.6 4902.5 4921.0 4930.8 5014.5 4227.7 4268.8 4282.6 4285.3 4295.3 2645.7 2657.4 2669.3 2669.7 2669.7 4695.7 4728.8 4732.3 4738.4 4768.5 4986.8 5044.9 5139.0 5156.6 5169.4 4604.5 4648.7 4695.4 4764.5 4770.1 5044.6 5065.7 5074.2 5080.8 5104.3 4681.6 4892.8 4907.8 4908.8 4935.0 4675.7 4699.3 4760.9 4761.7 4765.9 3590.2 3598.6 3599.4 3613.3 3632.7 4961.2 5094.6 5104.7 5109.7 5113.4 5056.6 5070.5 5076.4 5089.0 5097.9 5066.2 5067.5 5095.9 5102.1 5136.2 4843.5 5017.8 5046.9 5050.5 5070.4 4879.5 4980.5 4992.4 4994.8 5069.8 4841.6 4885.7 4934.9 4962.7 4963.3 05:31:04 INFO - PROCESS | 3369 | 05:31:04 INFO - PROCESS | 3369 | [#5] yui.html Cycles:180 Average:13630.18 Median:29148.15 stddev:17425.99 (59.8%) stddev-sans-first:17447.45 05:31:04 INFO - PROCESS | 3369 | Values: 612.2 665.4 672.3 676.4 734.2 11061.1 11780.0 11786.8 11787.8 11800.2 12095.5 12139.1 12150.6 12184.2 12210.7 604.9 620.0 734.2 744.3 758.1 748.7 762.1 762.4 762.4 762.6 815.8 818.1 818.6 818.9 819.0 629.3 649.3 771.7 810.2 811.1 578.5 582.0 582.1 582.1 582.1 12103.6 12134.0 12147.3 12149.9 12150.0 11951.9 12088.3 12446.3 12475.8 12478.3 11113.8 11123.1 11190.6 11479.1 11577.4 3880.8 3943.3 3969.9 3992.7 4073.2 48388.8 49467.0 49654.0 49947.8 51896.5 9124.5 9190.6 9612.1 9817.8 9832.5 16550.7 16578.1 16761.3 16794.4 16896.2 6128.1 6186.7 6206.1 6236.7 6303.6 3436.7 3497.8 3500.5 3521.3 3562.6 2584.2 2657.6 2667.2 2669.7 2672.3 430.7 433.5 441.9 444.5 465.9 521.5 537.8 547.4 568.7 568.9 6740.7 7025.5 7213.5 7378.5 7728.3 559.4 579.0 580.0 580.9 595.5 3395.1 3441.5 3451.1 3628.9 3680.8 40911.4 40957.6 65034.0 67561.0 69790.7 37170.4 48572.5 49009.3 57727.4 64125.0 53061.7 54626.7 54873.0 55391.7 55768.7 6696.1 6737.6 6762.7 6977.8 7051.5 38241.3 38985.8 39454.0 39619.6 40087.2 50023.0 50200.0 51106.5 51125.2 51374.5 8731.0 8864.6 8968.7 8997.3 9012.1 10192.4 10201.2 10216.1 10231.2 10385.3 9338.9 9371.5 9414.6 9504.9 9677.3 8880.8 9073.2 9165.5 9545.9 9738.5 9195.4 9507.4 9812.9 9831.5 9989.7 6952.7 7193.5 7427.2 7466.9 7679.6 6764.7 7181.1 7346.6 7795.5 8115.0 05:31:04 INFO - PROCESS | 3369 | -------- Summary: end -------- 05:31:04 INFO - PROCESS | 3369 | 05:31:05 INFO - TEST-INFO | 3369: exit 0 05:31:05 INFO - TEST-OK | dromaeo_css | took 1123626ms 05:31:05 INFO - TEST-START | kraken 05:31:05 INFO - operating with platform_type : linux_ 05:31:05 INFO - Initialising browser for kraken test... 05:31:05 INFO - TEST-INFO | started process 3707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RgKBG/profile http://localhost:48973/getInfo.html) 05:31:10 INFO - PROCESS | 3707 | __metrics Screen width/height:1600/1200 05:31:10 INFO - PROCESS | 3707 | colorDepth:24 05:31:10 INFO - PROCESS | 3707 | Browser inner width/height: 1024/697 05:31:10 INFO - PROCESS | 3707 | __metrics 05:31:10 INFO - PROCESS | 3707 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:31:10 INFO - PROCESS | 3707 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:11 INFO - PROCESS | 3707 | console.error: PushService: 05:31:11 INFO - PROCESS | 3707 | stateChangeProcessEnqueue: Error transitioning state 05:31:11 INFO - PROCESS | 3707 | UnknownError 05:31:11 INFO - TEST-INFO | 3707: exit 0 05:31:11 INFO - Browser initialized. 05:31:11 INFO - Running cycle 1/1 for kraken test... 05:31:12 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RgKBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:24 INFO - PROCESS | 3790 | RSS: Main: 174546944 05:31:24 INFO - PROCESS | 3790 | 05:31:27 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48973/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:28 INFO - PROCESS | 3790 | RSS: Main: 235462656 05:31:28 INFO - PROCESS | 3790 | 05:31:30 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48973/tests/kraken/driver.html?testName=audio-dft) 05:31:31 INFO - PROCESS | 3790 | RSS: Main: 218292224 05:31:31 INFO - PROCESS | 3790 | 05:31:34 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48973/tests/kraken/driver.html?testName=audio-fft) 05:31:35 INFO - PROCESS | 3790 | RSS: Main: 300138496 05:31:35 INFO - PROCESS | 3790 | 05:31:37 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48973/tests/kraken/driver.html?testName=audio-oscillator) 05:31:37 INFO - PROCESS | 3790 | RSS: Main: 211140608 05:31:37 INFO - PROCESS | 3790 | 05:31:40 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48973/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:40 INFO - PROCESS | 3790 | RSS: Main: 214700032 05:31:40 INFO - PROCESS | 3790 | 05:31:43 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48973/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:44 INFO - PROCESS | 3790 | RSS: Main: 253792256 05:31:44 INFO - PROCESS | 3790 | 05:31:47 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48973/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:48 INFO - PROCESS | 3790 | RSS: Main: 253476864 05:31:48 INFO - PROCESS | 3790 | 05:31:51 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48973/tests/kraken/driver.html?testName=json-parse-financial) 05:31:51 INFO - PROCESS | 3790 | RSS: Main: 252719104 05:31:51 INFO - PROCESS | 3790 | 05:31:53 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48973/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:54 INFO - PROCESS | 3790 | RSS: Main: 214384640 05:31:54 INFO - PROCESS | 3790 | 05:31:56 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:56 INFO - PROCESS | 3790 | RSS: Main: 222801920 05:31:56 INFO - PROCESS | 3790 | 05:31:58 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:59 INFO - PROCESS | 3790 | RSS: Main: 229871616 05:31:59 INFO - PROCESS | 3790 | 05:32:02 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:03 INFO - PROCESS | 3790 | RSS: Main: 238342144 05:32:03 INFO - PROCESS | 3790 | 05:32:06 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:07 INFO - PROCESS | 3790 | RSS: Main: 235835392 05:32:07 INFO - PROCESS | 3790 | 05:32:08 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:48973/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48973/tests/kraken/driver.html?testName=ai-astar) 05:32:09 INFO - PROCESS | 3790 | RSS: Main: 286572544 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | __start_tp_report 05:32:09 INFO - PROCESS | 3790 | _x_x_mozilla_page_load 05:32:09 INFO - PROCESS | 3790 | _x_x_mozilla_page_load_details 05:32:09 INFO - PROCESS | 3790 | |i|pagename|runs| 05:32:09 INFO - PROCESS | 3790 | |0;ai-astar;112;117;115;117;116;116;116;116;115;116 05:32:09 INFO - PROCESS | 3790 | |1;audio-beat-detection;157;132;132;175;132;133;132;130;150;131 05:32:09 INFO - PROCESS | 3790 | |2;audio-dft;163;162;162;163;162;160;160;162;160;162 05:32:09 INFO - PROCESS | 3790 | |3;audio-fft;75;77;76;118;77;77;77;76;90;76 05:32:09 INFO - PROCESS | 3790 | |4;audio-oscillator;84;85;110;84;84;84;101;83;84;111 05:32:09 INFO - PROCESS | 3790 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;118;117 05:32:09 INFO - PROCESS | 3790 | |6;imaging-darkroom;146;147;148;147;147;146;146;146;147;147 05:32:09 INFO - PROCESS | 3790 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 05:32:09 INFO - PROCESS | 3790 | |8;json-parse-financial;64;62;63;66;65;67;64;64;64;65 05:32:09 INFO - PROCESS | 3790 | |9;json-stringify-tinderbox;65;65;66;67;65;66;65;65;66;67 05:32:09 INFO - PROCESS | 3790 | |10;stanford-crypto-aes;86;85;85;86;85;88;84;86;85;84 05:32:09 INFO - PROCESS | 3790 | |11;stanford-crypto-ccm;147;145;144;143;140;141;153;142;191;143 05:32:09 INFO - PROCESS | 3790 | |12;stanford-crypto-pbkdf2;180;178;178;178;177;178;187;181;189;178 05:32:09 INFO - PROCESS | 3790 | |13;stanford-crypto-sha256-iterative;69;70;69;72;70;69;69;69;73;68 05:32:09 INFO - PROCESS | 3790 | __end_tp_report 05:32:09 INFO - PROCESS | 3790 | __start_cc_report 05:32:09 INFO - PROCESS | 3790 | _x_x_mozilla_cycle_collect,1946 05:32:09 INFO - PROCESS | 3790 | __end_cc_report 05:32:09 INFO - PROCESS | 3790 | __startTimestamp1479907929138__endTimestamp 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | ------- Summary: start ------- 05:32:09 INFO - PROCESS | 3790 | Number of tests: 14 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:1.43 (1.2%) stddev-sans-first:0.71 05:32:09 INFO - PROCESS | 3790 | Values: 112.0 117.0 115.0 117.0 116.0 116.0 116.0 116.0 115.0 116.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:132.50 stddev:15.27 (11.5%) stddev-sans-first:14.97 05:32:09 INFO - PROCESS | 3790 | Values: 157.0 132.0 132.0 175.0 132.0 133.0 132.0 130.0 150.0 131.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 05:32:09 INFO - PROCESS | 3790 | Values: 163.0 162.0 162.0 163.0 162.0 160.0 160.0 162.0 160.0 162.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:13.40 (17.4%) stddev-sans-first:13.98 05:32:09 INFO - PROCESS | 3790 | Values: 75.0 77.0 76.0 118.0 77.0 77.0 77.0 76.0 90.0 76.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.00 stddev:11.58 (13.8%) stddev-sans-first:12.00 05:32:09 INFO - PROCESS | 3790 | Values: 84.0 85.0 110.0 84.0 84.0 84.0 101.0 83.0 84.0 111.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:32:09 INFO - PROCESS | 3790 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:32:09 INFO - PROCESS | 3790 | Values: 146.0 147.0 148.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:32:09 INFO - PROCESS | 3790 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.43 (2.2%) stddev-sans-first:1.51 05:32:09 INFO - PROCESS | 3790 | Values: 64.0 62.0 63.0 66.0 65.0 67.0 64.0 64.0 64.0 65.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 05:32:09 INFO - PROCESS | 3790 | Values: 65.0 65.0 66.0 67.0 65.0 66.0 65.0 65.0 66.0 67.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 05:32:09 INFO - PROCESS | 3790 | Values: 86.0 85.0 85.0 86.0 85.0 88.0 84.0 86.0 85.0 84.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:144.50 stddev:15.24 (10.5%) stddev-sans-first:16.15 05:32:09 INFO - PROCESS | 3790 | Values: 147.0 145.0 144.0 143.0 140.0 141.0 153.0 142.0 191.0 143.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:179.00 stddev:4.20 (2.3%) stddev-sans-first:4.45 05:32:09 INFO - PROCESS | 3790 | Values: 180.0 178.0 178.0 178.0 177.0 178.0 187.0 181.0 189.0 178.0 05:32:09 INFO - PROCESS | 3790 | 05:32:09 INFO - PROCESS | 3790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.55 (2.2%) stddev-sans-first:1.62 05:32:09 INFO - PROCESS | 3790 | Values: 69.0 70.0 69.0 72.0 70.0 69.0 69.0 69.0 73.0 68.0 05:32:09 INFO - PROCESS | 3790 | -------- Summary: end -------- 05:32:09 INFO - PROCESS | 3790 | 05:32:10 INFO - TEST-INFO | 3790: exit 0 05:32:10 INFO - TEST-OK | kraken | took 64876ms 05:32:10 INFO - SUITE-END | took 1188s 05:32:10 INFO - Completed test suite (00:19:48) 05:32:10 INFO - javascript benchmark 05:32:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.218218443375, 2588.7411258874104, 2600.375909781652, 2621.947561048779, 2632.0787724296497, 4403.691741578091, 4449.443819522559, 4656.743879086649, 4690.718556886589, 4704.788284527196, 4495.100979804044, 4709.811607535695, 4783.9760801196035, 4794.376731024962, 4794.592459640926, 4256.4679415073115, 4276.807543660527, 4316.6978311518205, 4321.416608757824, 4349.956500434987, 3903.6291552302628, 4268.38108474271, 4390.42924419825, 4395.450568678915, 4432.268675668511, 4112.465379500646, 4307.806148723315, 4315.30955047194, 4353.455818022747, 4413.227685155101, 4133.46264985553, 4184.456020717318, 4236.428082208893, 4251.936220956688, 4275.46556680415, 4268.530461649216, 4273.87178384649, 4292.613664770186, 4311.525732169459, 4341.131773645252, 4625.051864367831, 4627.305904114376, 4659.464161621389, 4662.137504561633, 4663.883402914954, 4698.295255711637, 4720.834770783006, 4721.362616046824, 4794.089123066641, 4951.851444456672, 4754.643401744848, 4810.2683034107695, 4824.179889418772, 4880.951190488086, 4952.0, 4666.626669866402, 4711.858644240644, 4731.101090792738, 4731.787069581877, 4736.881577960578, 5097.0, 5112.616553758408, 5117.8464646060675, 5123.769430375642, 5158.92261616076, 4658.231391820379, 4895.828645997444, 4902.068606964665, 4909.042736666316, 4935.062338155739, 4794.640401969867, 4871.050145221719, 4872.756362181876, 4879.756012199376, 4880.560749532559, 4847.079054979543, 4860.416749989953, 4870.975645121823, 4873.31773551703, 4926.556609905126, 4812.879678008007, 4825.469198388175, 4847.5394837490385, 4854.17479028566, 4881.292212629149, 3900.804959752001, 3979.6816254699556, 3987.641112299907, 4048.0891799344913, 4084.1219137885496, 3576.98211508946, 3634.582023067328, 3663.5970043295215, 3664.1022949377575, 3664.3953747631876, 4298.763568003727, 4306.4832220133785, 4308.116836048603, 4322.78386080701, 4348.34774783785, 4798.640101992364, 4848.80604775805, 4997.425296090996, 4999.575036121898, 5051.26756620288, 4205.747655140702, 4223.577642235752, 4251.17102165081, 4256.36154576816, 4310.80601372939, 4439.755813430293, 4442.311441726538, 4448.043670610834, 4450.065486247924, 4486.775661216926, 4648.767561621906, 4672.672912896064, 4673.766311684471, 4675.088357770338, 4711.599514041345, 4790.952090479051, 4836.202026665561, 4902.313676085279, 4927.211646136601, 4937.21004639256, 4656.928906351491, 4657.836975705834, 4669.042846216449, 4693.530646935279, 4709.764511774329, 4887.340209071872, 4899.608031357554, 4903.3554509914065, 4914.754262286943, 4946.851594452172, 4763.809047738066, 4801.807927682993, 4815.7351345676325, 4829.492903245249, 4929.408470983505, 4898.069366820293, 4905.23968784839, 4918.2868484068895, 4918.508149185196, 4951.97524012392, 4864.051509955525, 4870.342503762088, 4881.930491177131, 4901.338319326987, 4940.036692844861, 4615.79228934692, 4657.580817726285, 4750.8337208197545, 4836.056968891033, 4873.9025219496125, 4816.831410900601, 4860.149473841992, 4938.827141050046, 4973.0, 4979.302897594267, 4781.521847815191, 4806.519348065165, 4824.565789079, 4870.878228044327, 4875.853724388274], "value": 4536.912912190011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9810755779134, 561.6994907724368, 572.2732130194655, 574.695411431941, 579.6522086747951, 27644.447111057765, 30410.54384184239, 30465.543016854765, 30469.54295685561, 30470.085897423087, 29662.11013669588, 38403.0, 39476.60523394765, 39497.0, 43683.0, 7452.403807695398, 7563.962180189119, 7577.355924746404, 7577.469577129603, 7590.468667193299, 7583.582902940336, 7667.7316293929725, 7671.23287671234, 7673.846523069536, 7675.69297228113, 7717.65270562826, 8022.919770802305, 9531.95234023829, 9786.657466988658, 9790.06994335537, 9925.503724813767, 9980.401175929395, 9982.351147175483, 9992.600295988188, 9996.100350968447, 9599.752032235834, 9668.323217374787, 9673.467959262238, 9677.467739274338, 9679.370840895319, 36993.445098323544, 37146.07134821651, 37312.62687373146, 37334.25331493382, 37343.06642333936, 3097.504399296124, 3244.172735952317, 3280.78674886134, 3412.0446275043028, 3478.5303983962094, 27603.0, 27986.440271194664, 28113.156605301872, 28230.15309540717, 29654.110376688735, 3435.089701229176, 3465.28961562879, 3476.8435420406145, 3504.877329293488, 3532.523109380252, 232267.0, 233131.9999999983, 233484.0, 233962.0, 235320.0, 51229.7438512805, 51646.22530662043, 51654.741726291126, 51723.224151637754, 51755.48244517582, 53835.73082134564, 53947.19079213815, 54244.18633720497, 54254.728726356116, 54292.0, 13713.382897769625, 14086.929565352108, 14123.152610843383, 14125.78811317831, 14133.505327313494, 11431.314121152758, 11549.538018479167, 11554.364509951865, 11575.189736718517, 11583.07335413165, 14284.428622855177, 16013.839861601467, 16369.345226190819, 16381.754273685905, 16397.262123204484, 5206.505381988705, 6011.428914253139, 6234.844128896814, 6306.4639505642535, 6320.41550139834, 794.7695168401215, 920.1764420843308, 926.7775733823834, 948.8861336639648, 988.7725823060737, 24985.37536561564, 26345.341366465993, 26798.19605411841, 27193.72806271912, 27507.58738618922, 941.5621735892843, 943.3443756589242, 948.9335746497817, 958.2094771813282, 965.285688590438, 14244.931630127781, 14254.717075463259, 14600.488982885548, 14631.634209144857, 14726.042807217496, 327220.0, 328756.0, 328889.0, 329634.0, 329944.0, 41706.37440438396, 43007.0, 47091.76454117707, 47360.0, 52420.21369679458, 1160.147291740587, 1161.4947497838468, 1174.7298121431947, 1190.1252579354168, 1197.784398808223, 26815.061472848356, 27581.586276206275, 27776.0, 27843.0, 28455.28861778472, 41235.96910077272, 41537.0, 41672.58327416687, 41726.165476690905, 41732.58267417287, 284936.0, 286232.0, 418429.0, 428072.0, 429224.0, 23993.0, 23995.52008959846, 24170.879145604158, 24364.87817560901, 24383.634245485977, 40722.18555628812, 40836.387454187614, 40981.0, 41153.176936460506, 41193.0, 34441.311173776885, 34785.304293913476, 34932.952011439695, 35011.0, 35460.75887343931, 34627.4805877907, 34790.47814282737, 34872.82563587166, 34913.65086349104, 34955.0, 33301.50047749334, 34099.14752131217, 34324.14189645279, 34847.303053939286, 35075.12312192216, 26471.867640661672, 30398.39203215879, 30469.23826904345, 30547.389052219274, 30749.846250769497, 23079.804421980836, 23682.763172368745, 23689.28932132039, 24066.39834004164, 24242.272731818073], "value": 17192.56700725464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.61171875780366, 356.7841455919169, 369.0791475269204, 374.7751349190486, 391.56340680141653, 12569.245845249292, 13040.087193896432, 13238.338083095843, 13684.17894926305, 16663.25015374308, 15784.0, 15960.920195399036, 15980.200989950485, 16007.83992160078, 16072.276747546359, 4586.807430068189, 4736.881577960544, 4799.856004319859, 4970.950290497103, 5019.899602007958, 4903.607711383099, 4919.680220785655, 4937.185364414867, 4945.802167913279, 4946.480619534951, 4670.416197975253, 4894.583960363373, 4906.730129842857, 4918.950810491903, 4921.4094308682825, 4899.6815207011605, 4935.0376676548085, 4948.975255123737, 4951.777170027357, 4952.3809523809705, 4464.129494748526, 4466.776661166961, 4473.530279320689, 4473.597376236122, 4482.350059241392, 11046.502907369188, 11620.535178592847, 11672.35802030888, 11673.357965311905, 11719.531218751239, 1791.4536066499713, 1840.2271046160645, 1917.5685470769106, 1989.6617575012283, 2350.0717216699477, 8612.655493780241, 9210.0, 9213.617957306391, 9351.064893510662, 12212.816807747891, 1538.9538313850603, 1607.3046698984426, 1657.2790835986384, 1661.1943207544332, 1671.1143094160116, 64053.67973160151, 64784.676076619784, 65847.67076164589, 67319.66340168317, 67660.6616966912, 9255.722328330026, 9703.272254580934, 9818.214542836557, 9899.010098990188, 9979.151772099453, 13510.121842080232, 13522.93238533801, 13528.729425411437, 13540.119892206974, 13541.864581354257, 7113.901399087178, 7128.358447739728, 7297.598632075181, 7323.707051717872, 7326.413886889036, 6776.796696099125, 6917.584944903322, 6934.722611095601, 6945.444364450832, 7153.105861767279, 4151.56408577095, 4253.3194688849635, 4269.252880745857, 4360.7601581913295, 4384.421608221038, 1737.782777152856, 1800.5768644368563, 1831.1302131487437, 1834.357974708868, 1868.364755982945, 827.1645637905639, 856.7643897928119, 903.814717982812, 909.2907532124954, 943.495230051919, 15904.284307205971, 15941.760873586905, 16260.105694186697, 16522.339106435607, 17120.57198570046, 848.1306660672859, 848.7241646464923, 866.6490071521044, 891.064382398479, 898.4519443139679, 9264.11990860867, 9381.0, 9456.52717364129, 9479.383840050376, 9549.570269337897, 351049.0, 353938.0, 354963.0, 355859.74476520874, 358106.0, 48690.75654621704, 63795.68102159553, 69256.307436926, 70787.64606177039, 71842.2815771846, 876.6430838731494, 878.446578655443, 898.5237823953315, 909.0863681999548, 913.1097180249336, 14937.626559336104, 15179.544613661608, 15327.0, 15340.386384544494, 15969.760453593437, 35085.29829403449, 35676.28647427089, 36522.44342896078, 37139.25721485501, 37845.0, 47118.29322560096, 49669.503304966485, 49821.7770520523, 50124.498755011984, 50303.0, 6388.425041746265, 6774.593524388552, 6882.793516194522, 6957.060796792571, 7064.979942010655, 9968.551415186479, 11542.249753765978, 11562.248453850472, 11713.472893719632, 12049.578264760692, 10053.19574434058, 10090.747731306483, 10237.692869213935, 10418.270721049454, 10910.945445272722, 10169.79660406773, 10262.486875656037, 10411.375317480975, 10519.368837869752, 10626.203034772268, 10354.0, 10416.531256093645, 10600.734981625521, 10694.091002264584, 10775.838362424412, 6570.342965703582, 6737.865242695217, 6804.455643548603, 6968.128983877015, 7039.325056478506, 8176.345892328481, 10045.949770251102, 10061.647842325483, 10946.616868409568, 10953.945230273797], "value": 7752.025859356981, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.3775425549989, 1364.249662685523, 1406.3460490871742, 1625.6829918165963, 1656.138807819933, 6178.938210617893, 6426.678666066689, 6979.197392299887, 7417.369523590488, 7430.256974302567, 6985.266547012567, 7257.0, 7261.382782463484, 7453.366463850566, 7457.216992215821, 2088.48832036151, 2119.0993827623274, 2120.257909731597, 2126.3089495913814, 2126.8085872271495, 1836.9265229390808, 1898.2407037185098, 2067.0, 2110.8522403431766, 2152.7201463809683, 2057.331367305624, 2122.1829595605727, 2122.564874200785, 2125.1286972341345, 2133.861299015559, 2063.597598468299, 2064.1846470644164, 2087.0, 2093.968590471144, 2113.1019316790303, 2141.539568992674, 2142.0360837622975, 2159.168720042779, 2163.718716566852, 2163.9026243819067, 7283.126024876996, 7291.2344203858365, 7321.816954576125, 7322.414206863491, 7328.911260290844, 4364.258076127066, 4485.865424037284, 4487.169873573399, 4488.640908727294, 4515.729056256602, 2684.1276585109918, 2851.4154598307296, 2910.1415082550698, 2918.6351706036744, 2923.0353983185496, 848.0755975986204, 850.9361797865123, 862.7886167888845, 888.3559419420933, 894.4633220067972, 9733.707988760349, 9848.261380396427, 9860.06329398706, 9860.359076660066, 9864.95067524665, 3726.3851464508593, 3763.247350529905, 3800.3539398302355, 3815.809209539512, 3882.6893848492055, 7551.546907185587, 7598.544087354777, 7599.202083781234, 7600.391968642495, 7601.6579253933705, 4429.867103986886, 4453.153900758845, 4453.398791163217, 4479.574440428154, 4481.596656300949, 3971.5829837867186, 4172.979135104366, 4176.0395109124465, 4177.227212965611, 4177.415161877339, 3023.9546406803915, 3049.130997665655, 3131.2015436063657, 3157.905262842118, 3165.240342317827, 785.4580339565681, 804.9192836517667, 895.5790778334173, 900.6757567275776, 924.7595625137512, 730.1639622632057, 781.6990458673451, 796.6892911764417, 800.6117033238875, 823.069930978003, 4764.95235047652, 4895.437024742129, 4942.678725882806, 4982.701037937735, 5062.7468626568525, 829.1501211258387, 834.1533343656193, 842.6797816829566, 876.7895705030746, 880.348542078857, 3083.599132112811, 3184.5860038194887, 3282.2122690554575, 3288.786228895114, 3381.7970921744773, 8035.638396272182, 8431.704890328932, 8432.704855330157, 8437.198466145706, 8439.746807595782, 8349.457285276438, 8353.289970352587, 8393.160683931681, 8429.0, 8433.114522975122, 6875.7937261882225, 7015.543989640657, 7037.577745335194, 7048.788536343918, 7071.575705457689, 4768.976155119202, 4805.423349198119, 4858.92711609319, 4957.628177886745, 5062.012907483153, 8138.389620778347, 8190.549519776469, 8191.0, 8226.259636632492, 8380.371472139492, 7904.762857114296, 8099.0, 8368.121347258693, 8409.159084091787, 8434.915650843659, 6316.747330106744, 6443.679045795694, 6448.645324507197, 6450.41946224842, 6455.709493072729, 6852.5203235773015, 7025.543339682904, 7033.894491582732, 7047.788566343018, 7109.537880037781, 5215.895682086413, 6303.338149494237, 6449.677516124269, 6489.383508566679, 6515.348465153446, 6229.50163986889, 6357.046443033582, 6374.203224596926, 6428.839279018062, 6435.678216089271, 5806.65160090396, 5826.970865145647, 5882.882342353215, 5889.087191485327, 5918.260217472816, 4176.665866730715, 4233.534311225824, 4244.3633454982, 4253.447051883235, 4333.1766964276685, 4277.37977993183, 4319.43847299849, 4376.212281789181, 4499.5275496072445, 4588.334691469785], "value": 3847.195336634061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.69573404324393, 296.38795886494387, 296.593666676653, 299.06989263390864, 301.9033909149073, 4800.375951126353, 4804.567588916997, 4820.783064762085, 4859.635527335451, 4891.461939186686, 4491.505934347219, 4579.12996530659, 4643.117807616551, 4669.6264298856095, 4791.904161916759, 3746.082209858575, 3746.6886589693663, 3747.6627103560672, 3748.718846086541, 3755.530558680172, 3768.566614839301, 3801.771893686374, 3807.2195199984076, 3811.390177571589, 3836.6547010769027, 3542.5040494330815, 3623.9094022649383, 3704.166562523424, 3751.962480375202, 3823.7896915669626, 3794.9620503794886, 3812.0, 3814.732968692179, 3818.369968955119, 3821.503204583414, 3317.170707323169, 3365.7643964922463, 3368.444206705891, 3375.746818988586, 3393.4570468725133, 4567.566081222279, 4676.555727205944, 4696.319033740088, 4709.693869898446, 4709.905801883943, 4247.745135291892, 4257.76582287974, 4281.229378711831, 4298.484181898161, 4311.762853043081, 4982.153033984231, 4984.252362145671, 4991.301217829507, 5005.399352077774, 5025.472325405816, 3614.1868079681863, 3626.4197728363333, 3640.2719456108885, 3641.8725344612812, 3648.890533284006, 4972.836815985058, 5137.537621614036, 5143.485651434827, 5168.276441298183, 5173.327467429248, 3679.056754596312, 3681.2821499807815, 3684.3184010958057, 3730.0, 3733.3280009598534, 3747.7001839852746, 3766.7551609145867, 3775.7923314217983, 3791.3554695701796, 3798.601146879593, 3975.3241948868763, 4184.456020717287, 4279.315309550457, 4290.549492303326, 4295.73275883615, 4962.181240095416, 4971.90056198874, 4975.626827987915, 4976.353074100344, 4979.950200498021, 1197.8862008109215, 1217.3669691760235, 1229.3730197599289, 1240.8956029134079, 1241.85097788266, 817.6034623207739, 823.2672921100226, 829.1128492513074, 843.5360551696542, 860.5267103093273, 4227.829128153885, 4229.45017147775, 4243.787810609457, 4249.405083288342, 4278.294081476583, 4888.560029597354, 4902.534259245366, 4921.040397122527, 4930.827421040318, 5014.473480284591, 4227.682923780729, 4268.758901576697, 4282.614564689131, 4285.292926667065, 4295.3342231953475, 2645.682518097841, 2657.42865283961, 2669.265951863253, 2669.6529451171614, 2669.746374094458, 4695.718256904596, 4728.763561821896, 4732.290156476556, 4738.431388233434, 4768.546988036131, 4986.775595098229, 5044.9495505045215, 5138.974305128525, 5156.5616922562, 5169.353830771153, 4604.470485894165, 4648.721076735339, 4695.366125573072, 4764.547368000034, 4770.117528257353, 5044.646874718735, 5065.670731402447, 5074.213496907985, 5080.796768129381, 5104.259882317117, 4681.602063824477, 4892.779824907959, 4907.77914993819, 4908.754562271801, 4934.950650493449, 4675.696079754805, 4699.342092107039, 4760.904781904412, 4761.738104404291, 4765.880852978703, 3590.2101537661674, 3598.6041535431605, 3599.3521166190335, 3613.2954073955325, 3632.6730594246646, 4961.156603377507, 5094.5669618082875, 5104.69371837691, 5109.718965456936, 5113.360829896263, 5056.595472362275, 5070.543651071422, 5076.441591425014, 5088.974555127201, 5097.884377983096, 5066.2400639902835, 5067.479756073237, 5095.898082038412, 5102.1326374515675, 5136.152534831711, 4843.491433399583, 5017.774200161075, 5046.855086588259, 5050.49495050492, 5070.428167268159, 4879.487653796442, 4980.5019498049905, 4992.400911890596, 4994.750262486934, 5069.797208111634, 4841.603406313897, 4885.682430641997, 4934.8766280843265, 4962.652614316963, 4963.305137280711], "value": 3748.8684738250126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1705089603587, 665.3978149774453, 672.3478226120661, 676.3844901139963, 734.1557209209409, 11061.115110791128, 11780.0, 11786.82319765202, 11787.823182652268, 11800.173987820845, 12095.516179352815, 12139.08956828237, 12150.574729884456, 12184.208026478294, 12210.69473263169, 604.8880957022965, 619.9504039676838, 734.1777209525312, 744.2854859335044, 758.1016495452906, 748.7192302886417, 762.1387831750114, 762.3596179209463, 762.3938968520013, 762.645369902995, 815.7552734179752, 818.1246066708594, 818.5947955761876, 818.9058258300312, 819.0, 629.2669040567779, 649.3117295666608, 771.7221800151997, 810.1857633078747, 811.1118325433612, 578.5198285423089, 581.9970900145472, 582.0512564519805, 582.0541619867715, 582.1442479555047, 12103.636890893287, 12134.0, 12147.331896745676, 12149.93925030378, 12150.027997760246, 11951.940240298829, 12088.33514156721, 12446.25322480654, 12475.750484990249, 12478.251304921643, 11113.777724445466, 11123.110151187886, 11190.608328708457, 11479.13906457019, 11577.363245021521, 3880.798341368354, 3943.3296339622334, 3969.861054863095, 3992.740471869319, 4073.2464494068395, 48388.758056209845, 49467.0, 49654.0, 49947.750261248824, 51896.48103518992, 9124.45253284805, 9190.63237470507, 9612.134907858326, 9817.803643927082, 9832.459214743114, 16550.6689866202, 16578.08820514859, 16761.32954681799, 16794.396868485404, 16896.239669214916, 6128.080787881764, 6186.659733714689, 6206.131141640174, 6236.656983865931, 6303.621782693053, 3436.742244331685, 3497.8251087445524, 3500.544929159193, 3521.2605352876185, 3562.625924277965, 2584.211815396322, 2657.6412184354863, 2667.199840047978, 2669.6929853067145, 2672.2651270900656, 430.67484049542395, 433.5361163554966, 441.92708203146765, 444.54878298527024, 465.91613509567924, 521.4941506738458, 537.7840513727929, 547.351388604497, 568.6673296121816, 568.8748475335419, 6740.696668649923, 7025.543339682904, 7213.531120477152, 7378.483506154625, 7728.26581474759, 559.3651205881273, 578.9681567513743, 579.956503262257, 580.9360970293264, 595.5265563876728, 3395.0663567518636, 3441.4665726812386, 3451.11996440906, 3628.872989445357, 3680.7607505512055, 40911.38632920509, 40957.59042409597, 65034.02448963269, 67561.0, 69790.65104674545, 37170.44244336337, 48572.514274856796, 49009.26486102711, 57727.4227257722, 64125.0, 53061.734691326295, 54626.72686636541, 54873.0, 55391.72304138453, 55768.721156393956, 6696.055407395722, 6737.629430381376, 6762.695678694372, 6977.755778547727, 7051.541649792747, 38241.34649400253, 38985.8050709756, 39454.0, 39619.60380396159, 40087.1982560353, 50023.0, 50200.0, 51106.488935110174, 51125.23312150246, 51374.48625513697, 8731.0, 8864.64541418336, 8968.68609598661, 8997.28021758271, 9012.098790120936, 10192.44974147075, 10201.234907381828, 10216.131628811634, 10231.181505479693, 10385.324953877975, 9338.859917101114, 9371.484568348533, 9414.62341506332, 9504.904950950402, 9677.322587418814, 8880.822383552422, 9073.228775553887, 9165.54172291396, 9545.856812147962, 9738.464384458923, 9195.448273103635, 9507.429554226768, 9812.852807207755, 9831.5084245786, 9989.700308990741, 6952.71593588866, 7193.496455248082, 7427.183009868802, 7466.887996679946, 7679.616019198906, 6764.729410823512, 7181.138263408425, 7346.595937223504, 7795.4543181976715, 8114.959425202836], "value": 5714.914591772327, "unit": "score"}], "name": "dromaeo_css", "value": 6066.484958027408, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 115.0, 117.0, 116.0, 116.0, 116.0, 116.0, 115.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 132.0, 175.0, 132.0, 133.0, 132.0, 130.0, 150.0, 131.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 160.0, 160.0, 162.0, 160.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 118.0, 77.0, 77.0, 77.0, 76.0, 90.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 84.0, 84.0, 84.0, 101.0, 83.0, 84.0, 111.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 66.0, 65.0, 67.0, 64.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 66.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 85.0, 88.0, 84.0, 86.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 144.0, 143.0, 140.0, 141.0, 153.0, 142.0, 191.0, 143.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 178.0, 178.0, 177.0, 178.0, 187.0, 181.0, 189.0, 178.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 72.0, 70.0, 69.0, 69.0, 69.0, 73.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1564.2000000000003, "alertThreshold": 2.0}]} 05:32:10 INFO - Return code: 0 05:32:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:10 INFO - # TBPL SUCCESS # 05:32:10 INFO - Running post-action listener: _resource_record_post_action 05:32:10 INFO - [mozharness: 2016-11-23 13:32:10.933297Z] Finished run-tests step (success) 05:32:10 INFO - Running post-run listener: _resource_record_post_run 05:32:10 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 10612736; Write bytes: 428298240; Read time: 3568; Write time: 406320 05:32:10 INFO - TinderboxPrint: CPU usage
13.1% 05:32:10 INFO - TinderboxPrint: I/O read bytes / time
10,612,736 / 3,568 05:32:10 INFO - TinderboxPrint: I/O write bytes / time
428,298,240 / 406,320 05:32:10 INFO - TinderboxPrint: CPU idle
8,352.3 (86.9%) 05:32:10 INFO - TinderboxPrint: CPU user
1,208.4 (12.6%) 05:32:10 INFO - TinderboxPrint: Swap in / out
0 / 0 05:32:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101482496; Read time: 60; Write time: 112084 05:32:11 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 7991296; Write bytes: 323076096; Read time: 3328; Write time: 289188 05:32:11 INFO - Running post-run listener: _upload_blobber_files 05:32:11 INFO - Blob upload gear active. 05:32:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:11 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 05:32:11 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:32:11 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:32:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:12 INFO - (blobuploader) - INFO - Done attempting. 05:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:13 INFO - (blobuploader) - INFO - Done attempting. 05:32:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:17 INFO - (blobuploader) - INFO - Done attempting. 05:32:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:17 INFO - Return code: 0 05:32:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3b64c836a58472183beebeb7e07449b7057e8d696200d8db66dd6a387e4f14a77c7e29642a44330c6ce5fdbf543e0e41c65daa0286045396021a2b109de995c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e9103df8e9148366c9ea7bfeccc5645e80da0c806fe0bbbb2223ef8ad0b2d66aa1d607ff27bacc58dd4832b27d76ca507d1f64324f3d51b6e4fba127fa7cc8bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/27c7d612814838c911e57876299b65599133f31e62984d18448534b8c32b85a3a0f2acb724722d59f505e7dd115e8640000be4e8928207777788d422df4c5a21"} 05:32:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:17 INFO - Contents: 05:32:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3b64c836a58472183beebeb7e07449b7057e8d696200d8db66dd6a387e4f14a77c7e29642a44330c6ce5fdbf543e0e41c65daa0286045396021a2b109de995c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e9103df8e9148366c9ea7bfeccc5645e80da0c806fe0bbbb2223ef8ad0b2d66aa1d607ff27bacc58dd4832b27d76ca507d1f64324f3d51b6e4fba127fa7cc8bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/27c7d612814838c911e57876299b65599133f31e62984d18448534b8c32b85a3a0f2acb724722d59f505e7dd115e8640000be4e8928207777788d422df4c5a21"} 05:32:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:17 INFO - Copying logs to upload dir... 05:32:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.306008 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-23 05:32:17.526161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:17.530028) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3b64c836a58472183beebeb7e07449b7057e8d696200d8db66dd6a387e4f14a77c7e29642a44330c6ce5fdbf543e0e41c65daa0286045396021a2b109de995c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e9103df8e9148366c9ea7bfeccc5645e80da0c806fe0bbbb2223ef8ad0b2d66aa1d607ff27bacc58dd4832b27d76ca507d1f64324f3d51b6e4fba127fa7cc8bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/27c7d612814838c911e57876299b65599133f31e62984d18448534b8c32b85a3a0f2acb724722d59f505e7dd115e8640000be4e8928207777788d422df4c5a21"} build_url:https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3b64c836a58472183beebeb7e07449b7057e8d696200d8db66dd6a387e4f14a77c7e29642a44330c6ce5fdbf543e0e41c65daa0286045396021a2b109de995c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e9103df8e9148366c9ea7bfeccc5645e80da0c806fe0bbbb2223ef8ad0b2d66aa1d607ff27bacc58dd4832b27d76ca507d1f64324f3d51b6e4fba127fa7cc8bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/27c7d612814838c911e57876299b65599133f31e62984d18448534b8c32b85a3a0f2acb724722d59f505e7dd115e8640000be4e8928207777788d422df4c5a21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:17.556068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:17.556418) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479906683.89272-541315066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004346 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:17.640873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 05:32:17.641225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 05:32:17.641645) ========= ========= Total master_lag: 0.57 =========