builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1480097592.24 results: success (0) buildid: 20161125073220 builduid: 50bdeae365664a379a52137d57f3476a revision: b982373cb0e953976fd45f342910d1d1ea123fbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.236530) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.236932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.237484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.258544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.258833) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 10:13:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-11-25 10:13:13 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.408710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.409004) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.457806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:12.458149) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b982373cb0e953976fd45f342910d1d1ea123fbb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b982373cb0e953976fd45f342910d1d1ea123fbb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 10:13:13,485 truncating revision to first 12 chars 2016-11-25 10:13:13,485 Setting DEBUG logging. 2016-11-25 10:13:13,485 attempt 1/10 2016-11-25 10:13:13,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b982373cb0e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 10:13:13,784 unpacking tar archive at: mozilla-central-b982373cb0e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:13.099248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:13.099579) ========= script_repo_revision: b982373cb0e953976fd45f342910d1d1ea123fbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:13.099975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:13.100271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 10:13:13.108892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-25 10:13:13.109201) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:14 INFO - MultiFileLogger online at 20161125 10:13:14 in /builds/slave/test 10:13:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:14 INFO - {'append_to_log': False, 10:13:14 INFO - 'base_work_dir': '/builds/slave/test', 10:13:14 INFO - 'blob_upload_branch': 'Firefox', 10:13:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:14 INFO - 'branch': 'Firefox', 10:13:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:14 INFO - 'config_files': ('talos/linux_config.py',), 10:13:14 INFO - 'default_actions': ('clobber', 10:13:14 INFO - 'read-buildbot-config', 10:13:14 INFO - 'download-and-extract', 10:13:14 INFO - 'populate-webroot', 10:13:14 INFO - 'create-virtualenv', 10:13:14 INFO - 'install', 10:13:14 INFO - 'run-tests'), 10:13:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:14 INFO - 'download_minidump_stackwalk': True, 10:13:14 INFO - 'download_symbols': 'ondemand', 10:13:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:14 INFO - 'installer_path': 'installer.exe', 10:13:14 INFO - 'log_level': 'info', 10:13:14 INFO - 'log_name': 'talos', 10:13:14 INFO - 'log_to_console': True, 10:13:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:14 INFO - 'opt_config_files': (), 10:13:14 INFO - 'pip_index': False, 10:13:14 INFO - 'sps_profile': False, 10:13:14 INFO - 'sps_profile_interval': 0, 10:13:14 INFO - 'suite': 'dromaeojs', 10:13:14 INFO - 'system_bits': '32', 10:13:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:14 INFO - 'title': 'talos-linux64-ix-060', 10:13:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:14 INFO - 'use_talos_json': True, 10:13:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:14 INFO - 'work_dir': 'build'} 10:13:14 INFO - [mozharness: 2016-11-25 18:13:14.232436Z] Running clobber step. 10:13:14 INFO - Running pre-action listener: _resource_record_pre_action 10:13:14 INFO - Running main action method: clobber 10:13:14 INFO - rmtree: /builds/slave/test/build 10:13:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:14 INFO - Running post-action listener: _resource_record_post_action 10:13:14 INFO - [mozharness: 2016-11-25 18:13:14.692601Z] Finished clobber step (success) 10:13:14 INFO - [mozharness: 2016-11-25 18:13:14.692697Z] Running read-buildbot-config step. 10:13:14 INFO - Running pre-action listener: _resource_record_pre_action 10:13:14 INFO - Running main action method: read_buildbot_config 10:13:14 INFO - Using buildbot properties: 10:13:14 INFO - { 10:13:14 INFO - "project": "", 10:13:14 INFO - "product": "firefox", 10:13:14 INFO - "script_repo_revision": "production", 10:13:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:13:14 INFO - "repository": "", 10:13:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:13:14 INFO - "buildid": "20161125073220", 10:13:14 INFO - "pgo_build": "True", 10:13:14 INFO - "basedir": "/builds/slave/test", 10:13:14 INFO - "buildnumber": 5, 10:13:14 INFO - "slavename": "talos-linux64-ix-060", 10:13:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:13:14 INFO - "platform": "ubuntu64_hw", 10:13:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:14 INFO - "branch": "mozilla-central", 10:13:14 INFO - "repo_path": "mozilla-central", 10:13:14 INFO - "revision": "b982373cb0e953976fd45f342910d1d1ea123fbb", 10:13:14 INFO - "stage_platform": "linux64-pgo", 10:13:14 INFO - "builduid": "50bdeae365664a379a52137d57f3476a", 10:13:14 INFO - "slavebuilddir": "test" 10:13:14 INFO - } 10:13:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:13:14 INFO - Running post-action listener: _resource_record_post_action 10:13:14 INFO - [mozharness: 2016-11-25 18:13:14.695115Z] Finished read-buildbot-config step (success) 10:13:14 INFO - [mozharness: 2016-11-25 18:13:14.695201Z] Running download-and-extract step. 10:13:14 INFO - Running pre-action listener: _resource_record_pre_action 10:13:14 INFO - Running main action method: download_and_extract 10:13:14 INFO - mkdir: /builds/slave/test/build/tests 10:13:14 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')]} 10:13:14 INFO - trying https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:13:14 INFO - Downloading https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/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 10:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/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 10:13:15 INFO - Downloaded 1361 bytes. 10:13:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:13:15 INFO - Using the following test package requirements: 10:13:15 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:15 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:15 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:15 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'jsshell-linux-x86_64.zip'], 10:13:15 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:15 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:15 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:15 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:15 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:15 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:13:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:15 INFO - Fetch https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:15 INFO - Http code: 200 10:13:15 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 10:13:15 INFO - x-amz-cf-id: FVXqtoPzFW1t4e2SdX8-xFJt8Xp6uV1S_hXBGRH2unUPQpX7C7bKkw== 10:13:15 INFO - x-amz-version-id: RlKSGYE6DcVwsbwcMvpKLdGeU8BpVvuh 10:13:16 INFO - Expected file size: 21768323 10:13:16 INFO - Obtained file size: 21768323 10:13:20 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 10:13:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:13:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:20 INFO - Fetch https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:20 INFO - Http code: 200 10:13:20 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 10:13:20 INFO - x-amz-cf-id: 6vSsmFOotJhdDDmQGUU_nKKjfZBxlD12XeSmCnJWN9pwj196qORXrw== 10:13:20 INFO - x-amz-version-id: RlKSGYE6DcVwsbwcMvpKLdGeU8BpVvuh 10:13:20 INFO - Expected file size: 21768323 10:13:20 INFO - Obtained file size: 21768323 10:13:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:13:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:13:25 INFO - Http code: 200 10:13:25 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:13:25 INFO - x-amz-cf-id: gCxbkQ5Mh-AYsNBbH2KdbR0w6gcTqrVGsdjiI-SZTGKS2BRGI9gatA== 10:13:25 INFO - x-amz-version-id: Q8UKSGecpS1RwstGdOCXzHDixGInK5Mo 10:13:25 INFO - Expected file size: 14409702 10:13:25 INFO - Obtained file size: 14409702 10:13: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')]} 10:13:26 INFO - trying https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/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 10:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/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 10:13:27 INFO - Downloaded 59817904 bytes. 10:13:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:27 INFO - mkdir: /builds/slave/test/properties 10:13:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:27 INFO - Contents: 10:13:27 INFO - build_url:https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:27 INFO - Running post-action listener: _resource_record_post_action 10:13:27 INFO - Running post-action listener: set_extra_try_arguments 10:13:27 INFO - [mozharness: 2016-11-25 18:13:27.896384Z] Finished download-and-extract step (success) 10:13:27 INFO - [mozharness: 2016-11-25 18:13:27.896610Z] Running populate-webroot step. 10:13:27 INFO - Running pre-action listener: _resource_record_pre_action 10:13:27 INFO - Running main action method: populate_webroot 10:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:27 INFO - '--tppagecycles', 10:13:27 INFO - '7'], 10:13:27 INFO - 'tests': ['tsvgm']}}, 10:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['damp', 'tps']}, 10:13:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'tests': ['damp', 'tps']}, 10:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['dromaeo_dom']}, 10:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['basic_compositor_video']}, 10:13:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tsvgx', 10:13:27 INFO - 'tsvgr_opacity', 10:13:27 INFO - 'tart', 10:13:27 INFO - 'tscrollx', 10:13:27 INFO - 'cart', 10:13:27 INFO - 'tsvg_static']}, 10:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:27 INFO - 'tsvgr_opacity', 10:13:27 INFO - 'tart', 10:13:27 INFO - 'tscrollx', 10:13:27 INFO - 'cart', 10:13:27 INFO - 'tsvg_static']}, 10:13:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tp5o']}, 10:13:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:13:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s', 10:13:27 INFO - '--xperf_path', 10:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:27 INFO - 'tests': ['tp5n']}, 10:13:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:13:27 INFO - 'talos_options': ['--xperf_path', 10:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:27 INFO - 'tests': ['tp5n']}}, 10:13:27 INFO - 'talos.zip': {'path': '', 10:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:27 INFO - Running post-action listener: _resource_record_post_action 10:13:27 INFO - [mozharness: 2016-11-25 18:13:27.916845Z] Finished populate-webroot step (success) 10:13:27 INFO - [mozharness: 2016-11-25 18:13:27.916931Z] Running create-virtualenv step. 10:13:27 INFO - Running pre-action listener: _resource_record_pre_action 10:13:27 INFO - Running main action method: create_virtualenv 10:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:28 INFO - Using real prefix '/usr' 10:13:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:30 INFO - Installing pip.................done. 10:13:30 INFO - Return code: 0 10:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:30 INFO - Reading from file tmpfile_stdout 10:13:30 INFO - Output received: 10:13:30 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) 10:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:13:30 INFO - Using env: {'DISPLAY': ':0', 10:13:30 INFO - 'HOME': '/home/cltbld', 10:13:30 INFO - 'LANG': 'en_US.UTF-8', 10:13:30 INFO - 'LANGUAGE': 'en_US:en', 10:13:30 INFO - 'LOGNAME': 'cltbld', 10:13:30 INFO - 'MAIL': '/var/mail/cltbld', 10:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:30 INFO - 'MOZ_NO_REMOTE': '1', 10:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:30 INFO - 'NO_EM_RESTART': '1', 10:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:30 INFO - 'PWD': '/builds/slave/test', 10:13:30 INFO - 'SHELL': '/bin/bash', 10:13:30 INFO - 'SHLVL': '1', 10:13:30 INFO - 'TERM': 'linux', 10:13:30 INFO - 'TMOUT': '86400', 10:13:30 INFO - 'USER': 'cltbld', 10:13:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:30 INFO - '_': '/tools/buildbot/bin/python'} 10:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:13:30 INFO - Cleaning up... 10:13:30 INFO - Return code: 0 10:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:30 INFO - Using env: {'DISPLAY': ':0', 10:13:30 INFO - 'HOME': '/home/cltbld', 10:13:30 INFO - 'LANG': 'en_US.UTF-8', 10:13:30 INFO - 'LANGUAGE': 'en_US:en', 10:13:30 INFO - 'LOGNAME': 'cltbld', 10:13:30 INFO - 'MAIL': '/var/mail/cltbld', 10:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:30 INFO - 'MOZ_NO_REMOTE': '1', 10:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:30 INFO - 'NO_EM_RESTART': '1', 10:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:30 INFO - 'PWD': '/builds/slave/test', 10:13:30 INFO - 'SHELL': '/bin/bash', 10:13:30 INFO - 'SHLVL': '1', 10:13:30 INFO - 'TERM': 'linux', 10:13:30 INFO - 'TMOUT': '86400', 10:13:30 INFO - 'USER': 'cltbld', 10:13:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:30 INFO - '_': '/tools/buildbot/bin/python'} 10:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:31 INFO - Downloading/unpacking psutil>=3.1.1 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:33 INFO - Installing collected packages: psutil 10:13:33 INFO - Running setup.py install for psutil 10:13:33 INFO - building 'psutil._psutil_linux' extension 10:13:33 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 10:13:33 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 10:13:33 INFO - building 'psutil._psutil_posix' extension 10:13:33 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 10:13:33 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 10:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:33 INFO - Successfully installed psutil 10:13:33 INFO - Cleaning up... 10:13:33 INFO - Return code: 0 10:13:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:33 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')]} 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 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')]} 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:33 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 10:13:33 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 10:13:33 INFO - Using env: {'DISPLAY': ':0', 10:13:33 INFO - 'HOME': '/home/cltbld', 10:13:33 INFO - 'LANG': 'en_US.UTF-8', 10:13:33 INFO - 'LANGUAGE': 'en_US:en', 10:13:33 INFO - 'LOGNAME': 'cltbld', 10:13:33 INFO - 'MAIL': '/var/mail/cltbld', 10:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:33 INFO - 'MOZ_NO_REMOTE': '1', 10:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:33 INFO - 'NO_EM_RESTART': '1', 10:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:33 INFO - 'PWD': '/builds/slave/test', 10:13:33 INFO - 'SHELL': '/bin/bash', 10:13:33 INFO - 'SHLVL': '1', 10:13:33 INFO - 'TERM': 'linux', 10:13:33 INFO - 'TMOUT': '86400', 10:13:33 INFO - 'USER': 'cltbld', 10:13:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:33 INFO - '_': '/tools/buildbot/bin/python'} 10:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:36 INFO - Installing collected packages: mozsystemmonitor 10:13:36 INFO - Running setup.py install for mozsystemmonitor 10:13:36 INFO - Successfully installed mozsystemmonitor 10:13:36 INFO - Cleaning up... 10:13:36 INFO - Return code: 0 10:13:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:36 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')]} 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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')]} 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:36 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 10:13:36 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 10:13:36 INFO - Using env: {'DISPLAY': ':0', 10:13:36 INFO - 'HOME': '/home/cltbld', 10:13:36 INFO - 'LANG': 'en_US.UTF-8', 10:13:36 INFO - 'LANGUAGE': 'en_US:en', 10:13:36 INFO - 'LOGNAME': 'cltbld', 10:13:36 INFO - 'MAIL': '/var/mail/cltbld', 10:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:36 INFO - 'MOZ_NO_REMOTE': '1', 10:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:36 INFO - 'NO_EM_RESTART': '1', 10:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:36 INFO - 'PWD': '/builds/slave/test', 10:13:36 INFO - 'SHELL': '/bin/bash', 10:13:36 INFO - 'SHLVL': '1', 10:13:36 INFO - 'TERM': 'linux', 10:13:36 INFO - 'TMOUT': '86400', 10:13:36 INFO - 'USER': 'cltbld', 10:13:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:36 INFO - '_': '/tools/buildbot/bin/python'} 10:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Installing collected packages: jsonschema, functools32 10:13:38 INFO - Running setup.py install for functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Successfully installed jsonschema functools32 10:13:38 INFO - Cleaning up... 10:13:38 INFO - Return code: 0 10:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:13:38 INFO - Using env: {'DISPLAY': ':0', 10:13:38 INFO - 'HOME': '/home/cltbld', 10:13:38 INFO - 'LANG': 'en_US.UTF-8', 10:13:38 INFO - 'LANGUAGE': 'en_US:en', 10:13:38 INFO - 'LOGNAME': 'cltbld', 10:13:38 INFO - 'MAIL': '/var/mail/cltbld', 10:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:38 INFO - 'MOZ_NO_REMOTE': '1', 10:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:38 INFO - 'NO_EM_RESTART': '1', 10:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:38 INFO - 'PWD': '/builds/slave/test', 10:13:38 INFO - 'SHELL': '/bin/bash', 10:13:38 INFO - 'SHLVL': '1', 10:13:38 INFO - 'TERM': 'linux', 10:13:38 INFO - 'TMOUT': '86400', 10:13:38 INFO - 'USER': 'cltbld', 10:13:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:38 INFO - '_': '/tools/buildbot/bin/python'} 10:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:39 INFO - Cleaning up... 10:13:39 INFO - Return code: 0 10:13:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:39 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')]} 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:39 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')]} 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:39 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:39 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 10:13:39 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 10:13:39 INFO - Using env: {'DISPLAY': ':0', 10:13:39 INFO - 'HOME': '/home/cltbld', 10:13:39 INFO - 'LANG': 'en_US.UTF-8', 10:13:39 INFO - 'LANGUAGE': 'en_US:en', 10:13:39 INFO - 'LOGNAME': 'cltbld', 10:13:39 INFO - 'MAIL': '/var/mail/cltbld', 10:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:39 INFO - 'MOZ_NO_REMOTE': '1', 10:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:39 INFO - 'NO_EM_RESTART': '1', 10:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:39 INFO - 'PWD': '/builds/slave/test', 10:13:39 INFO - 'SHELL': '/bin/bash', 10:13:39 INFO - 'SHLVL': '1', 10:13:39 INFO - 'TERM': 'linux', 10:13:39 INFO - 'TMOUT': '86400', 10:13:39 INFO - 'USER': 'cltbld', 10:13:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:39 INFO - '_': '/tools/buildbot/bin/python'} 10:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 INFO - Downloading docopt-0.6.1.tar.gz 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:41 INFO - Running setup.py install for blobuploader 10:13:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:42 INFO - Running setup.py install for requests 10:13:42 INFO - Running setup.py install for docopt 10:13:42 INFO - Successfully installed blobuploader requests docopt 10:13:42 INFO - Cleaning up... 10:13:42 INFO - Return code: 0 10:13:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:42 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')]} 10:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 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')]} 10:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:42 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 10:13:42 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 10:13:42 INFO - Using env: {'DISPLAY': ':0', 10:13:42 INFO - 'HOME': '/home/cltbld', 10:13:42 INFO - 'LANG': 'en_US.UTF-8', 10:13:42 INFO - 'LANGUAGE': 'en_US:en', 10:13:42 INFO - 'LOGNAME': 'cltbld', 10:13:42 INFO - 'MAIL': '/var/mail/cltbld', 10:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:42 INFO - 'MOZ_NO_REMOTE': '1', 10:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:42 INFO - 'NO_EM_RESTART': '1', 10:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:42 INFO - 'PWD': '/builds/slave/test', 10:13:42 INFO - 'SHELL': '/bin/bash', 10:13:42 INFO - 'SHLVL': '1', 10:13:42 INFO - 'TERM': 'linux', 10:13:42 INFO - 'TMOUT': '86400', 10:13:42 INFO - 'USER': 'cltbld', 10:13:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:42 INFO - '_': '/tools/buildbot/bin/python'} 10:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:42 INFO - Running setup.py (path:/tmp/pip-jAmLxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:42 INFO - Running setup.py (path:/tmp/pip-c6pj8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:42 INFO - Running setup.py (path:/tmp/pip-NbkXls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:42 INFO - Running setup.py (path:/tmp/pip-SDSDQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:43 INFO - Running setup.py (path:/tmp/pip-eNWFsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:43 INFO - Running setup.py (path:/tmp/pip-2qC9Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:43 INFO - Running setup.py (path:/tmp/pip-QrAw2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:43 INFO - Running setup.py (path:/tmp/pip-aCl1oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:43 INFO - Running setup.py (path:/tmp/pip-45xMZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:43 INFO - Running setup.py (path:/tmp/pip-yTS73j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:43 INFO - Running setup.py (path:/tmp/pip-lgwqsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:43 INFO - Running setup.py (path:/tmp/pip-13Dj5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:43 INFO - Running setup.py (path:/tmp/pip-cIcWkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:43 INFO - Running setup.py (path:/tmp/pip-stj5M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:43 INFO - Running setup.py (path:/tmp/pip-QxiRGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:43 INFO - Running setup.py (path:/tmp/pip-udagnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:43 INFO - Running setup.py (path:/tmp/pip-vxQk1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:43 INFO - Running setup.py install for manifestparser 10:13:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozcrash 10:13:44 INFO - Running setup.py install for mozdebug 10:13:44 INFO - Running setup.py install for mozdevice 10:13:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozfile 10:13:44 INFO - Running setup.py install for mozhttpd 10:13:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozinfo 10:13:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozInstall 10:13:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozleak 10:13:44 INFO - Running setup.py install for mozlog 10:13:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for moznetwork 10:13:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozprocess 10:13:45 INFO - Running setup.py install for mozprofile 10:13:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozrunner 10:13:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozscreenshot 10:13:45 INFO - Running setup.py install for moztest 10:13:45 INFO - Running setup.py install for mozversion 10:13:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:45 INFO - Cleaning up... 10:13:45 INFO - Return code: 0 10:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:45 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')]} 10:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:45 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')]} 10:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:45 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:45 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 10:13:45 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 10:13:45 INFO - Using env: {'DISPLAY': ':0', 10:13:45 INFO - 'HOME': '/home/cltbld', 10:13:45 INFO - 'LANG': 'en_US.UTF-8', 10:13:45 INFO - 'LANGUAGE': 'en_US:en', 10:13:45 INFO - 'LOGNAME': 'cltbld', 10:13:45 INFO - 'MAIL': '/var/mail/cltbld', 10:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:45 INFO - 'MOZ_NO_REMOTE': '1', 10:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:45 INFO - 'NO_EM_RESTART': '1', 10:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:45 INFO - 'PWD': '/builds/slave/test', 10:13:45 INFO - 'SHELL': '/bin/bash', 10:13:45 INFO - 'SHLVL': '1', 10:13:45 INFO - 'TERM': 'linux', 10:13:45 INFO - 'TMOUT': '86400', 10:13:45 INFO - 'USER': 'cltbld', 10:13:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:45 INFO - '_': '/tools/buildbot/bin/python'} 10:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:46 INFO - Running setup.py (path:/tmp/pip-7Rn5nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:46 INFO - Running setup.py (path:/tmp/pip-FdCf48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:46 INFO - Running setup.py (path:/tmp/pip-c1Mf8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:46 INFO - Running setup.py (path:/tmp/pip-v2engb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:46 INFO - Running setup.py (path:/tmp/pip-sWEoSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:46 INFO - Running setup.py (path:/tmp/pip-xMMmIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:46 INFO - Running setup.py (path:/tmp/pip-o3L1TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:46 INFO - Running setup.py (path:/tmp/pip-X7U0Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:46 INFO - Running setup.py (path:/tmp/pip-vI3GE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:46 INFO - Running setup.py (path:/tmp/pip-UwwOmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:46 INFO - Running setup.py (path:/tmp/pip-Wi3YsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:46 INFO - Running setup.py (path:/tmp/pip-nJ2KHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:46 INFO - Running setup.py (path:/tmp/pip-EDnXfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:46 INFO - Running setup.py (path:/tmp/pip-t7Ud0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:47 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)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:47 INFO - Running setup.py (path:/tmp/pip-V8_32Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:47 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)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:47 INFO - Running setup.py (path:/tmp/pip-pzNjXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:47 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)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:47 INFO - Running setup.py (path:/tmp/pip-fsHJLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:49 INFO - Downloading blessings-1.6.tar.gz 10:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:49 INFO - Installing collected packages: blessings 10:13:49 INFO - Running setup.py install for blessings 10:13:49 INFO - Successfully installed blessings 10:13:49 INFO - Cleaning up... 10:13:49 INFO - Return code: 0 10:13:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:49 INFO - Reading from file tmpfile_stdout 10:13:49 INFO - Current package versions: 10:13:49 INFO - argparse == 1.2.1 10:13:49 INFO - blessings == 1.6 10:13:49 INFO - blobuploader == 1.2.4 10:13:49 INFO - docopt == 0.6.1 10:13:49 INFO - functools32 == 3.2.3-2 10:13:49 INFO - jsonschema == 2.5.1 10:13:49 INFO - manifestparser == 1.1 10:13:49 INFO - mozInstall == 1.12 10:13:49 INFO - mozcrash == 1.0 10:13:49 INFO - mozdebug == 0.1 10:13:49 INFO - mozdevice == 0.49 10:13:49 INFO - mozfile == 1.2 10:13:49 INFO - mozhttpd == 0.7 10:13:49 INFO - mozinfo == 0.9 10:13:49 INFO - mozleak == 0.1 10:13:49 INFO - mozlog == 3.4 10:13:49 INFO - moznetwork == 0.27 10:13:49 INFO - mozprocess == 0.23 10:13:49 INFO - mozprofile == 0.28 10:13:49 INFO - mozrunner == 6.13 10:13:49 INFO - mozscreenshot == 0.1 10:13:49 INFO - mozsystemmonitor == 0.3 10:13:49 INFO - moztest == 0.7 10:13:49 INFO - mozversion == 1.4 10:13:49 INFO - psutil == 3.1.1 10:13:49 INFO - requests == 1.2.3 10:13:49 INFO - wsgiref == 0.1.2 10:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:49 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')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 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')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:49 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 10:13:49 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 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 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)) 10:13:49 INFO - Cleaning up... 10:13:49 INFO - Return code: 0 10:13:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:49 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')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 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')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 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 0x7f4339e3de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2790b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', '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 10:13:49 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 10:13:49 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 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:50 INFO - Cleaning up... 10:13:50 INFO - Return code: 0 10:13:50 INFO - Running post-action listener: _resource_record_post_action 10:13:50 INFO - Running post-action listener: _start_resource_monitoring 10:13:50 INFO - Starting resource monitoring. 10:13:50 INFO - [mozharness: 2016-11-25 18:13:50.171355Z] Finished create-virtualenv step (success) 10:13:50 INFO - [mozharness: 2016-11-25 18:13:50.171883Z] Running install step. 10:13:50 INFO - Running pre-action listener: _resource_record_pre_action 10:13:50 INFO - Running main action method: install 10:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:50 INFO - Reading from file tmpfile_stdout 10:13:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:50 INFO - Reading from file tmpfile_stdout 10:13:50 INFO - Output received: 10:13:50 INFO - Usage: mozinstall [options] installer 10:13:50 INFO - Options: 10:13:50 INFO - -h, --help show this help message and exit 10:13:50 INFO - -d DEST, --destination=DEST 10:13:50 INFO - Directory to install application into. [default: 10:13:50 INFO - "/builds/slave/test"] 10:13:50 INFO - --app=APP Application being installed. [default: firefox] 10:13:50 INFO - mkdir: /builds/slave/test/build/application 10:13:50 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'] 10:13:50 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 10:14:07 INFO - Reading from file tmpfile_stdout 10:14:07 INFO - Output received: 10:14:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:07 INFO - Running post-action listener: _resource_record_post_action 10:14:07 INFO - [mozharness: 2016-11-25 18:14:07.446812Z] Finished install step (success) 10:14:07 INFO - [mozharness: 2016-11-25 18:14:07.447053Z] Running run-tests step. 10:14:07 INFO - Running pre-action listener: _resource_record_pre_action 10:14:07 INFO - Running main action method: run_tests 10:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:07 INFO - Python 2.7.3 10:14:07 INFO - Return code: 0 10:14:07 INFO - grabbing minidump binary from tooltool 10:14:07 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')]} 10:14:07 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 0x29bafc0>, '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 0x29bbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:07 INFO - Return code: 0 10:14:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:14:07 INFO - Using env: {'DISPLAY': ':0', 10:14:07 INFO - 'HOME': '/home/cltbld', 10:14:07 INFO - 'LANG': 'en_US.UTF-8', 10:14:07 INFO - 'LANGUAGE': 'en_US:en', 10:14:07 INFO - 'LOGNAME': 'cltbld', 10:14:07 INFO - 'MAIL': '/var/mail/cltbld', 10:14:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:07 INFO - 'MOZ_NO_REMOTE': '1', 10:14:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:07 INFO - 'NO_EM_RESTART': '1', 10:14:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:07 INFO - 'PWD': '/builds/slave/test', 10:14:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:07 INFO - 'SHELL': '/bin/bash', 10:14:07 INFO - 'SHLVL': '1', 10:14:07 INFO - 'TERM': 'linux', 10:14:07 INFO - 'TMOUT': '86400', 10:14:07 INFO - 'USER': 'cltbld', 10:14:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223', 10:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:07 INFO - '_': '/tools/buildbot/bin/python'} 10:14:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:14:07 INFO - mozversion application_buildid: 20161125073220 10:14:07 INFO - mozversion application_changeset: b982373cb0e953976fd45f342910d1d1ea123fbb 10:14:07 INFO - mozversion application_display_name: Nightly 10:14:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:07 INFO - mozversion application_name: Firefox 10:14:07 INFO - mozversion application_remotingname: firefox 10:14:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:07 INFO - mozversion application_vendor: Mozilla 10:14:07 INFO - mozversion application_version: 53.0a1 10:14:07 INFO - mozversion platform_buildid: 20161125073220 10:14:07 INFO - mozversion platform_changeset: b982373cb0e953976fd45f342910d1d1ea123fbb 10:14:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:07 INFO - mozversion platform_version: 53.0a1 10:14:07 INFO - using testdate: 1480097647 10:14:07 INFO - actual date: 1480097647 10:14:07 INFO - starting webserver on 'localhost:47956' 10:14:07 INFO - SUITE-START | Running 2 tests 10:14:07 INFO - TEST-START | dromaeo_css 10:14:07 INFO - operating with platform_type : linux_ 10:14:07 INFO - Initialising browser for dromaeo_css test... 10:14:07 INFO - TEST-INFO | started process 24138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xNEJz/profile http://localhost:47956/getInfo.html) 10:14:11 INFO - PROCESS | 24138 | __metrics Screen width/height:1600/1200 10:14:11 INFO - PROCESS | 24138 | colorDepth:24 10:14:11 INFO - PROCESS | 24138 | Browser inner width/height: 1024/697 10:14:11 INFO - PROCESS | 24138 | __metrics 10:14:12 INFO - PROCESS | 24138 | 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" 10:14:12 INFO - PROCESS | 24138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:13 INFO - PROCESS | 24138 | console.error: PushService: 10:14:13 INFO - PROCESS | 24138 | stateChangeProcessEnqueue: Error transitioning state 10:14:13 INFO - PROCESS | 24138 | UnknownError 10:14:13 INFO - TEST-INFO | 24138: exit 0 10:14:13 INFO - Browser initialized. 10:14:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:13 INFO - TEST-INFO | started process 24224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xNEJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:25 INFO - PROCESS | 24224 | RSS: Main: 174055424 10:14:25 INFO - PROCESS | 24224 | 10:15:17 INFO - PROCESS | 24224 | 1480097717481 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] 10:17:27 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47956/tests/dromaeo/cssquery-ext.html) 10:17:29 INFO - PROCESS | 24224 | RSS: Main: 408432640 10:17:29 INFO - PROCESS | 24224 | 10:20:32 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-ext.html (next: http://localhost:47956/tests/dromaeo/cssquery-jquery.html) 10:20:33 INFO - PROCESS | 24224 | RSS: Main: 287260672 10:20:33 INFO - PROCESS | 24224 | 10:23:35 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47956/tests/dromaeo/cssquery-mootools.html) 10:23:35 INFO - PROCESS | 24224 | RSS: Main: 223158272 10:23:35 INFO - PROCESS | 24224 | 10:26:37 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47956/tests/dromaeo/cssquery-prototype.html) 10:26:38 INFO - PROCESS | 24224 | RSS: Main: 220692480 10:26:38 INFO - PROCESS | 24224 | 10:29:41 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47956/tests/dromaeo/cssquery-yui.html) 10:29:41 INFO - PROCESS | 24224 | RSS: Main: 220360704 10:29:41 INFO - PROCESS | 24224 | 10:32:44 INFO - PROCESS | 24224 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-yui.html (next: http://localhost:47956/tests/dromaeo/cssquery-dojo.html) 10:32:45 INFO - PROCESS | 24224 | RSS: Main: 317345792 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | __start_tp_report 10:32:45 INFO - PROCESS | 24224 | _x_x_mozilla_page_load 10:32:45 INFO - PROCESS | 24224 | _x_x_mozilla_page_load_details 10:32:45 INFO - PROCESS | 24224 | |i|pagename|runs| 10:32:45 INFO - PROCESS | 24224 | |0;dojo.html;3048.3141293209032;3093.025696905476;3106.984465077675;3131.2641529240623;3134.232113132283;5362.088444964355;5437.755301011454;5466.316710411199;5499.092649712793;5533.833984980447;5414.7834086636585;5489.560835133189;5516.062269414199;5518.668879867211;5574.498295153446;4874.244492103712;4906.558409743122;4950.504949505039;4989.176785830352;5000.699958002513;5015.498450154992;5038.244263360507;5046.747662616873;5063.974680126595;5100.464451232623;4803.159447096744;4984.2025275955675;4998.825041123543;5027.069992051483;5114.181730923053;4871.2206047032305;4899.706017638953;4939.481354457766;4958.206686930074;4964;4906.607471402315;4923.827666031708;4927.211646136637;4974.676646017997;4988.82539111133;5415.83752487426;5430.239766432703;5432.076546987022;5448.318960129984;5455.945440545584;5643.746031428595;5696.2594862668;5808.82573522795;5852.151438041503;5860.501857342131;5926.259217597801;5937.614055086406;5952.7321270542925;6022.969885150546;6025.397460253984;5529.419410961831;5531.308586426697;5532.3914369419335;5540.418256083053;5543.1408131739645;5775.768969241268;5823.330317013513;5951.226340575698;6021.6989150542295;6034.064719968412;5540.750666220029;5562.777488900399;5572.108462645957;5584.6090773646265;5673.205751194836;5687.090065589486;5707.429257074343;5717.771289148471;5723.198752174699;5725.942740572541;5610.719464026783;5689.715514224272;5704.686242256716;5705.771769129271;5715.399883012307;5695.772169113272;5718.1136923776885;5741.507208125918;5767.538596912237;5777.682227477445;4376.3654270130655;4384.8246070157475;4388.385626012361;4392.099619578043;4393.989382442056;3917.353636649978;3919.862804801818;3953.2291203215095;3973.7417067890497;3984.920301593952;5536.972315138399;5538.889222215614;5544.750486228129;5547.195656629847;5582.86042848932;5898.64608123514;5923.259592550931;5927.8221653350465;5932.050871860568;5933.58464907461;5367.543758780469;5412.756425960842;5432;5467.9453205467435;5549.139883318092;5055.595552355802;5060.342155519833;5077.543021128116;5088.160453525127;5102.974485127551;5987.43119403656;6029.487493563096;6042.123892035543;6044.939550604614;6050.969745151246;5719.685417301922;5780.566457515619;5835.095560188178;5840.357560668408;5842.532597392284;5941.584089113893;5953.940460595339;5991.460768530853;6034.818955431344;6112.480439162721;5732.942670573241;5734.770609175753;5741.885162296814;5743.3395159557185;5746.597738158456;5840.123981402823;5842.2405087338375;5844.649321040752;5848.912266315923;5853.326867410302;5467.39858615544;5567.47109024642;5595.132754423071;5668.489835914787;5670.574706896917;5628.212050313042;5675.971620141873;5677.630953987978;5677.772889084556;5687.118496633028;5649.4633009864;5651.039323314964;5656.208130861601;5658.094704847204;5669.20631111653;5668.291463567054;5711.857203569778;5712.571557133148;5721.485066344049;5730.767884904765;5510.724463776875;5553.972230138824;5560.332760068818;5581.916271255853;5631.183478395527 10:32:45 INFO - PROCESS | 24224 | |1;ext.html;576.6107877182902;583.1282233061572;585.2099665451641;596.7434003378548;606.0303514376994;40140;41740.37389439157;41864.09242474992;44981.55018449815;45020.54979450205;42860.571394286046;43686;43714;43744.343834842424;43759.12481750363;7658.655360508763;7869.252421019994;8320.126386729396;8543.35924805639;8548.957255213747;9875.308728389016;10195.6941291761;10228.89771102287;10496.895031049668;10500.579976800918;10230.744231394201;10292;10294.073533381994;10295.691129266133;10296.794064118712;10217.897821021768;10241.590336386536;10244.948775256076;10254.282200245985;10262.794744105151;10059.195264378905;10126;10129.949350253275;10149.137323327452;10184.185265178769;40288;40549.39175912364;40607.796961015;40641.593584064074;40695;3403.285310084885;3447.5345828313107;3468.479728040789;3531.2231309112212;3707.258548290353;28547.00427425213;28898.27754306159;29021;29905.25236869074;29972.85013574918;3473.478978153272;3673.430618254148;3705.481232627434;3841.2317536492815;3843.5195600549932;355938;357291;359027.2048639766;359508;359598;58879;59281.40718592845;59370;59401;59448.702756486804;61843.743281821546;61950.69024654848;61997;62034;62086.37913620896;13536.864631353757;13705.520306789214;13738.862611373957;13747.38136783847;13748.243846588533;11120.833187502194;11331.830022549668;11472.827907581393;12238.204516706386;12295.69260768488;17483.737743933852;17544.298228070733;17560.682948778893;17599.73600395995;17637;6302.779402720883;6336.43374433346;6417.197850268716;6565.376289252514;6620.668966551653;971.7522031881966;1017.1405162637707;1038.6157121864808;1041.6614600254948;1128.114430172311;31612.658253145408;31865.840670796963;32161.532539468346;32325.51511727326;32624.83687581547;1045.8483519889573;1058.4813441413805;1085.8696956365286;1113.5100555755441;1124.6738445850613;16676.74984875228;16754.83245167557;16930.661386772197;16941.91529042347;16958.406455774235;141783;142221;142235;142424.28787855993;142884.28557857143;57070.7146464265;57096.14355784666;57201.427985720446;57225.71387143037;57329.713351432976;1205.5961252980173;1228.3980849383738;1288.8002359634272;1306.322701595007;1343.402186027228;29212.415751685272;33297;33406;33483.4977475343;33663.326733465685;49226.75386623044;49977.75011124921;49981.250281245084;49993;50000.74999624979;349567;350506;351325;351949;353307;27006.189814305602;27204.591931121446;27741.583876241468;29001.7099828999;40792.38811417772;45489;45542.77228613836;45935.54064459446;46033.30950035685;46304;39260.6073939257;39605.40591891066;40404.797976011105;40570;41799.58200417957;38727;39442.21115577615;40599;42588.36117458178;44419;38740.41889371605;39985.20029599334;40039.59960400359;40913;41459;34086.31827363488;36477;36642.460783003706;36920.81539592285;37066;27633.447331053667;27776.722232777414;28015.439691205655;28137.71862281433;28251.717482824908 10:32:45 INFO - PROCESS | 24224 | |2;jquery.html;372.19605651792136;384.23728898137193;394.4635295997443;399.21155717458015;415.33131658030567;13153.377602966128;15162.545123646294;16104.35582576697;18898.433047008577;18945.905270473628;18379.816201837977;18479.44561663149;18491.722624160648;18581.349652762157;18956;5435.1847222916585;5712.571557133231;5722.856928576777;5731.168980497825;5735.11105778605;4562.9771851140695;5644.096944488882;5672.971635141818;5678.318601767794;5688.203651488795;5606.046972014747;5607.373861580158;5612.07400778873;5632.295963004624;5637.577181711388;5425.077736784737;5581.860453488675;5604.187392828017;5610.410906854782;5611.410801865786;4989.25161225819;5035.899282014376;5043.3191519145175;5043.747812609355;5048.419431765357;13896.652583685387;14213.431462741479;21450.03474843636;21770.673439898415;22356.664650030263;2165.6101901657694;2264.1735766445295;2291.965620515677;2315.2012555668266;2351.8000969917575;10002.099811017044;10086.445245511493;10181.898181018169;10630.521626526825;10638.57445702171;1813.8186181381889;1817.8909265444115;1906.818852209038;1927.6602761081053;1940.088158565472;78046.6097669508;80746.19253807445;81822;82620.76068858911;86054;10451.84322235167;10677.893221067845;10863.239573229956;10973.122150227962;11250.437478126061;15620.453284135001;15660.843391565939;15668.608284792743;15671.529854104396;15676.137812420198;7673;7889.250521200477;7894.684212631545;8130.471519351223;8163.877541836877;7505.174430812606;7600;7618.162002179756;7799.80500487481;7821.413393995473;4709.799001254658;4758.452777930513;4767.141914455431;4790.880227994328;4797.832075877328;1926.7206255092933;1969.714391413237;1994.554865217934;1996.6805311150147;2048.723422337965;961.5096300886458;986.8174387738292;1030.917536586581;1036.8283839261737;1053.794510070529;18574.44276671675;19455.22179112848;19475.318363857197;19507.414777556696;19794;992.2607657295362;993.3543196921914;1007.8185926533295;1009.3388830316155;1055.9524821383056;10240.743981400376;10507.579696812041;10578.52396642153;10679.825219225879;10816.945915270531;418507;430870;432315;432851;444109;87074;87405.56297218474;88648;89383.55308223417;89599;961.8124465729255;1025.261811495722;1051.495282264502;1054.367379572266;1055.0609957138154;16193.67612647764;16592.336306547604;16905.408310709066;17065.829341706423;17359.91320043442;40773;43043.7847810759;43423;43521.56478435175;46187.76906115448;56435.71782141063;57933.71033144807;59566.70216648889;60598;60755.39244607498;11972.14431763078;12361.320127393079;12568.868801807881;12711.300878451773;12918.547850825176;13540.458381664623;13747.450101995808;13795.448182072605;13803.51687690926;14386.35261413218;11888.28670279786;12009.939950300542;12010.939945300217;12202.206856554296;12453.875461245272;11654.53381864716;11795.351255680676;11809.23239989398;12136.575219867262;12253.590837053853;11979.221350612532;11997.940010300243;12060.879391205975;12156.574519891761;12341.50633974631;11749.236299640495;11768.35274059935;11822.763544728885;11894.226875253082;12014.75970480568;12012.579559715368;12194.268343899394;12220.266783992989;12352.876471235173;12380.752384952431 10:32:45 INFO - PROCESS | 24224 | |3;mootools.html;1324.8542660307357;1409.9999999999998;1444.6027342480818;1543.8764898808097;1717.2873257598098;7204.567725936441;7773.261540153683;8094.716684916014;8111.594420278992;8121.593920303976;7838.137804841463;7967.72112976046;7984.600769961493;8144.226298501648;8145;2029.4520479470534;2085.593309304686;2268.739095004071;2317.698699169114;2318.466752646892;2253.6394176931694;2329.3594261578032;2329.6039673255586;2352.870592117433;2358.174638876397;2281.7147856517936;2281.8859057047166;2300.424893776556;2310.9422264443438;2311.144876395736;2309.9653505197434;2313.9537209255805;2337.520808234308;2341.028473183627;2342.1334106380664;2231.553689262154;2298.494331247123;2298.9310320690406;2303.067257760593;2305.792478676927;7974.720884769064;8067.556284404355;8073.434859559833;8152.714654987106;8160.469569477965;4933.80264789408;5074.517920797518;5077.923831142536;5078.085944529983;5081.466446023188;3135.5453459248283;3304.074859039473;3428.5542879425766;3447.775894566845;3452.5511683481236;1024.4979959819634;1083.6099004358425;1116.7598966222301;1124.5052177042076;1132.0547342968548;10591.523381447776;10639.308444951132;10743.301685390425;11049.17131215154;11097;4434.977825110854;4477.977610111994;4611.054733779567;4619.099275641218;4633.536646335339;9538.570764315622;9570.856437153448;9575.904240957641;9583.233341332676;9586.712398628053;5203.843884683465;5212.635115541952;5214.687118772886;5219.817306394258;5224.660397074178;4545.954540454619;4616.469106052779;4628.120657075145;4780.976095119572;4787.257975013808;3724.6089160637744;3794;3833.9456649421077;3886.8250928708276;3888.183481468923;1241.9379031048593;1255.6546949588935;1256.5790460195938;1288.072587736828;1289.065427565008;828.5443006346485;855.3114742632241;938.9624415023322;941.5951141009294;948.814981078683;5454.53636440899;5488.69812160327;5619.7636519965545;5623.581859800325;5680.091185410314;930.5254320296563;935.5462600638684;935.6725146198776;948.4641177734558;988.8924404666819;3720.441933709911;3754.1177823211524;3885.300645883768;3896.941545876814;3909.9609003909595;9659;10123.088921997056;10133.189344852393;10134.746631334128;10135.391876487434;10018.899811001942;10027.147692446224;10049.346792458613;10053.69838904834;10057.547410366551;7221.205667376585;7524.699012039567;7532;7605.201453847377;7767.961160194162;5474.753636086465;5478.91781623284;5539.529140023144;5647.926893890148;5812.82561523155;8822.426542274732;8870.822583548423;8936.86594701093;8942.37403381757;8982.910170898207;7811.843763124592;8841.115888411108;9020.278377729897;9082;9359.438433694;7031.1211098612675;7393.8890916637365;7404.96297518509;7410.147832999059;7417.147028091623;7755.185705501067;7771.37828973692;7826.373890088893;7862.567558784322;7907.802304942423;6828.5220034597105;6894.827629309308;6982.581045137308;7028.402585780266;7047.753328633473;6838.555493892881;6958.756443524452;7128.037714908421;7170.784876453715;7177.4616903731385;6348;6625.801225963229;6628.502862285444;6634.933650663625;6636.336366363325;4834.8791280218275;4897.877553061202;4926.137925862888;4977.651564390603;5098.388193416666;5063.468335824686;5085.321504216056;5091.592672586258;5095.210242412432;5159.613029022913 10:32:45 INFO - PROCESS | 24224 | |4;prototype.html;318.24893251925465;332.6490552467147;337.45837930122156;341.2288228603356;342.7908975524931;5260.868478288045;5289.709066001368;5289.947100528993;5311.2298716686055;5323.334583177103;5208.848646568818;5216.6869987800665;5224.817131400402;5239.921401178985;5249.580033597313;3933.90165245869;4019.5779443158485;4039.3738970459626;4069.1454794493193;4110.301248787713;4083.7549747015128;4088.3867419886956;4127.422160897477;4128.277551428503;4137.731047481919;4134.255833949888;4139.544650088488;4141.79291035447;4148.128892932473;4161.83352665893;3966.643002129822;3976.622220889011;4121.91756164878;4154.273002224629;4170.35359519275;3666.834992425347;3670.541182352206;3672.706183505313;3681.2821499807546;3741.1395379062697;5098.668586541863;5102.591792656579;5106.208537676666;5112.795488180468;5121.897562048775;4609.562091601292;4693.6949098308505;4730.290456431529;4730.858074257778;4740.170470167742;5450.400455949843;5478.58910581704;5482.588805839578;5493.2034854945805;5507.201455788888;4041.4948131483566;4059.5940405959464;4063.7155399122075;4071.5521292657786;4074.2666320062376;5549.972250138764;5567;5611.344653327237;5693.146028095777;5760.531064578506;4100.17996400721;4100.958990410118;4140.4617399737845;4141.565135660772;4174.853880114181;4178.832846686159;4199.370094485852;4214.978925105354;4215.683823713172;4218.135282267128;4648.48866624671;4675.438947326343;4709.740964246931;4767.833125840579;4784.617230621542;5457.699826509501;5477;5479.5342395896;5486.286782718221;5487.478689524489;1388.5070799866105;1399.1605036977733;1404.683946112137;1405.7910197230374;1408.2747385096684;940.4686352210979;998.1316254858319;1002.293383164867;1004.2919741582167;1008.6671398438498;5086.694798312114;5126.92309615356;5196.298499702491;5329.973350133302;5358.705271210043;5592.440755924375;5621.289948633882;5627.184058311604;5642.702178498968;5657.51911087554;5047.2429135629945;5268.631195816332;5300.648334674634;5347.171188465794;5377.489138531833;2833.1500549835378;2835.787315951312;2879.379764414373;2892.4070565534016;2897.217751207162;5575.916361254584;5600.887982240332;5609.80365687199;5616.623927137795;5641.915371269434;5256.107801191568;5523.917141242885;5530.723463826873;5550.5282051026115;5601.943980560224;5612.550995920316;5625.353084395347;5637.661740295595;5653.349864765604;5659.971700141473;5246.763895624782;5436.266104075899;5450.754716037867;5460.153676180198;5466.726663666721;5407.215953686772;5409.621326507264;5416.539594134385;5421.539169170507;5435.179214963032;5629.437056294338;5645.548356131418;5648.333741546172;5673.659580425187;5678.3753787084215;3862.281284828337;3976.5625781164626;3978.4629075075654;3983.2830090583975;3985.362342025262;5437.483439073281;5438.422857371318;5462.672239665632;5466.91799622998;5496.966122534688;5303.071962406486;5336.279602253801;5344.781915505022;5348.652337598043;5374.758135883816;5039.0929632666475;5318.585573973515;5336.226247194058;5371.382291036424;5389;5226.738663066907;5238.3975842777045;5243.292155558951;5301.867453313544;5341.946580534145;5238.292830467838;5317.202419637086;5343.62594618373;5498.772996936247;5559.360673522435;5364.30264065669;5368.32895888014;5383.892322153457;5432;5446.113559813305 10:32:45 INFO - PROCESS | 24224 | |5;yui.html;741.8516296740653;754.4228665071221;761.4099073218255;772.6175543106167;786.6145588661558;15721;16398.426055088075;16416.507504774847;16426.917865410673;16463.91768041161;14783.926080369583;14906.627334316647;15207.46773862915;15308.923455382735;15329.156896370696;663.2770280394369;787.1459466478877;801.7955421367543;801.8316153607749;802.626778547975;679.8096532970751;783.996080019599;785.3913217256614;805.2631841864687;811.1401913971209;847.1570787066877;850.2135524639715;851.2891735400917;851.9701810436636;852.3479538153317;695.3151146121066;846.0481957797477;846.6147902704286;846.86026805577;847.3602430165247;517.6764522173642;589.8525368657836;598.575011741664;607.398675311443;613.0926229180793;14241.501547445894;14260.572182834532;14279.78580321296;14289.285535723277;14291.213983230919;12968.740625187538;12975.416106275241;13195.60413187606;13321.933390332986;13338.599842004756;11331.716707082307;11421.25761825487;11684.415779211091;11789.233699809485;12327.938360308231;3530.8058056806867;3575.982120089409;3602.7117830573493;3616.475611036385;3670.06413364593;57832.71083644597;59525.107123393616;60677;60788.696056519875;61640.38359616436;10792.514336854703;10930;10941.945290273497;11144.721381965515;11218.495167717472;20805.063772130292;20894.79105208959;21119.683204751942;21178.364649060553;21400.143994240058;7954.125046244909;7976.242256985577;8166.346692264605;8327.20891515305;8361.95819020901;4415.072834704683;4458.175237580993;4476.149531588988;4601.74690392025;4686.882827929329;3539.628339024417;3540.805255710909;3618.203995121069;3620.71034317254;3666.7616604920595;571.5513322042177;574.7902015764299;579.0995002770732;593.4332712259782;594.0821430889287;553.261396036288;629.9622022678655;665.8734840380409;673.6968364236113;674.0529555973865;8931.19619234272;9045.276377889884;9206.079392060741;9481;9887.307888447884;605.5186127029023;629.9930165868423;669.7220653428773;704.6688056613383;734.8677238097087;4350.760708161081;4644.465886423104;4681.749323267178;4716.669833111718;4746.644001699887;79195;84675.5766221165;85988.5700571493;87371.56314218516;88179.11820881837;35049;75801;77759.2224077752;79785.20214797778;82062.58968705237;42613.14773704509;42615.57384426116;47040.7647961758;63342.68328658327;65526;9314.48770317639;9973.30186886911;9986.650467233612;9996.400215987063;10022.098011179029;38843.611563884;40777.796111019255;41166.382504263056;45497;45633;55963.44036559745;59641.70179149076;59687.104693430505;61032;62808;11151.498182581965;11674.416279185836;11706.941465292619;11846.407679616157;12682.239065656091;12652.810207846705;12828.615141545768;13096.21422714602;13239.09499383684;14387.208703521406;12876.291803950873;13640.249786261455;13649.658758531115;13660.304134326167;13886.305684715926;11589.318122893696;11805.76388472243;11923.344216068199;12291.9385403076;12306.75386492283;11588.76822463529;11950.103742219542;12629;12646.30445325516;12657.303848288433;10355.689329319832;10621.946890265499;10979.615713449992;11068.667939961813;11221.66335009951;10031.398116113056;10064.496775161066;10378.377297362182;11057.899454731834;11488.82766758516 10:32:45 INFO - PROCESS | 24224 | __end_tp_report 10:32:45 INFO - PROCESS | 24224 | __start_cc_report 10:32:45 INFO - PROCESS | 24224 | _x_x_mozilla_cycle_collect,2437 10:32:45 INFO - PROCESS | 24224 | __end_cc_report 10:32:45 INFO - PROCESS | 24224 | __startTimestamp1480098765147__endTimestamp 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | ------- Summary: start ------- 10:32:45 INFO - PROCESS | 24224 | Number of tests: 6 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#0] dojo.html Cycles:165 Average:5401.16 Median:5581.92 stddev:616.19 (11.0%) stddev-sans-first:589.79 10:32:45 INFO - PROCESS | 24224 | Values: 3048.3 3093.0 3107.0 3131.3 3134.2 5362.1 5437.8 5466.3 5499.1 5533.8 5414.8 5489.6 5516.1 5518.7 5574.5 4874.2 4906.6 4950.5 4989.2 5000.7 5015.5 5038.2 5046.7 5064.0 5100.5 4803.2 4984.2 4998.8 5027.1 5114.2 4871.2 4899.7 4939.5 4958.2 4964.0 4906.6 4923.8 4927.2 4974.7 4988.8 5415.8 5430.2 5432.1 5448.3 5455.9 5643.7 5696.3 5808.8 5852.2 5860.5 5926.3 5937.6 5952.7 6023.0 6025.4 5529.4 5531.3 5532.4 5540.4 5543.1 5775.8 5823.3 5951.2 6021.7 6034.1 5540.8 5562.8 5572.1 5584.6 5673.2 5687.1 5707.4 5717.8 5723.2 5725.9 5610.7 5689.7 5704.7 5705.8 5715.4 5695.8 5718.1 5741.5 5767.5 5777.7 4376.4 4384.8 4388.4 4392.1 4394.0 3917.4 3919.9 3953.2 3973.7 3984.9 5537.0 5538.9 5544.8 5547.2 5582.9 5898.6 5923.3 5927.8 5932.1 5933.6 5367.5 5412.8 5432.0 5467.9 5549.1 5055.6 5060.3 5077.5 5088.2 5103.0 5987.4 6029.5 6042.1 6044.9 6051.0 5719.7 5780.6 5835.1 5840.4 5842.5 5941.6 5953.9 5991.5 6034.8 6112.5 5732.9 5734.8 5741.9 5743.3 5746.6 5840.1 5842.2 5844.6 5848.9 5853.3 5467.4 5567.5 5595.1 5668.5 5670.6 5628.2 5676.0 5677.6 5677.8 5687.1 5649.5 5651.0 5656.2 5658.1 5669.2 5668.3 5711.9 5712.6 5721.5 5730.8 5510.7 5554.0 5560.3 5581.9 5631.2 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#1] ext.html Cycles:180 Average:46937.14 Median:177740.11 stddev:79408.09 (44.7%) stddev-sans-first:79554.55 10:32:45 INFO - PROCESS | 24224 | Values: 576.6 583.1 585.2 596.7 606.0 40140.0 41740.4 41864.1 44981.6 45020.5 42860.6 43686.0 43714.0 43744.3 43759.1 7658.7 7869.3 8320.1 8543.4 8549.0 9875.3 10195.7 10228.9 10496.9 10500.6 10230.7 10292.0 10294.1 10295.7 10296.8 10217.9 10241.6 10244.9 10254.3 10262.8 10059.2 10126.0 10129.9 10149.1 10184.2 40288.0 40549.4 40607.8 40641.6 40695.0 3403.3 3447.5 3468.5 3531.2 3707.3 28547.0 28898.3 29021.0 29905.3 29972.9 3473.5 3673.4 3705.5 3841.2 3843.5 355938.0 357291.0 359027.2 359508.0 359598.0 58879.0 59281.4 59370.0 59401.0 59448.7 61843.7 61950.7 61997.0 62034.0 62086.4 13536.9 13705.5 13738.9 13747.4 13748.2 11120.8 11331.8 11472.8 12238.2 12295.7 17483.7 17544.3 17560.7 17599.7 17637.0 6302.8 6336.4 6417.2 6565.4 6620.7 971.8 1017.1 1038.6 1041.7 1128.1 31612.7 31865.8 32161.5 32325.5 32624.8 1045.8 1058.5 1085.9 1113.5 1124.7 16676.7 16754.8 16930.7 16941.9 16958.4 141783.0 142221.0 142235.0 142424.3 142884.3 57070.7 57096.1 57201.4 57225.7 57329.7 1205.6 1228.4 1288.8 1306.3 1343.4 29212.4 33297.0 33406.0 33483.5 33663.3 49226.8 49977.8 49981.3 49993.0 50000.7 349567.0 350506.0 351325.0 351949.0 353307.0 27006.2 27204.6 27741.6 29001.7 40792.4 45489.0 45542.8 45935.5 46033.3 46304.0 39260.6 39605.4 40404.8 40570.0 41799.6 38727.0 39442.2 40599.0 42588.4 44419.0 38740.4 39985.2 40039.6 40913.0 41459.0 34086.3 36477.0 36642.5 36920.8 37066.0 27633.4 27776.7 28015.4 28137.7 28251.7 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#2] jquery.html Cycles:180 Average:27380.35 Median:19491.37 stddev:71492.96 (366.8%) stddev-sans-first:71664.76 10:32:45 INFO - PROCESS | 24224 | Values: 372.2 384.2 394.5 399.2 415.3 13153.4 15162.5 16104.4 18898.4 18945.9 18379.8 18479.4 18491.7 18581.3 18956.0 5435.2 5712.6 5722.9 5731.2 5735.1 4563.0 5644.1 5673.0 5678.3 5688.2 5606.0 5607.4 5612.1 5632.3 5637.6 5425.1 5581.9 5604.2 5610.4 5611.4 4989.3 5035.9 5043.3 5043.7 5048.4 13896.7 14213.4 21450.0 21770.7 22356.7 2165.6 2264.2 2292.0 2315.2 2351.8 10002.1 10086.4 10181.9 10630.5 10638.6 1813.8 1817.9 1906.8 1927.7 1940.1 78046.6 80746.2 81822.0 82620.8 86054.0 10451.8 10677.9 10863.2 10973.1 11250.4 15620.5 15660.8 15668.6 15671.5 15676.1 7673.0 7889.3 7894.7 8130.5 8163.9 7505.2 7600.0 7618.2 7799.8 7821.4 4709.8 4758.5 4767.1 4790.9 4797.8 1926.7 1969.7 1994.6 1996.7 2048.7 961.5 986.8 1030.9 1036.8 1053.8 18574.4 19455.2 19475.3 19507.4 19794.0 992.3 993.4 1007.8 1009.3 1056.0 10240.7 10507.6 10578.5 10679.8 10816.9 418507.0 430870.0 432315.0 432851.0 444109.0 87074.0 87405.6 88648.0 89383.6 89599.0 961.8 1025.3 1051.5 1054.4 1055.1 16193.7 16592.3 16905.4 17065.8 17359.9 40773.0 43043.8 43423.0 43521.6 46187.8 56435.7 57933.7 59566.7 60598.0 60755.4 11972.1 12361.3 12568.9 12711.3 12918.5 13540.5 13747.5 13795.4 13803.5 14386.4 11888.3 12009.9 12010.9 12202.2 12453.9 11654.5 11795.4 11809.2 12136.6 12253.6 11979.2 11997.9 12060.9 12156.6 12341.5 11749.2 11768.4 11822.8 11894.2 12014.8 12012.6 12194.3 12220.3 12352.9 12380.8 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#3] mootools.html Cycles:180 Average:5397.23 Median:5093.40 stddev:2922.14 (57.4%) stddev-sans-first:2914.31 10:32:45 INFO - PROCESS | 24224 | Values: 1324.9 1410.0 1444.6 1543.9 1717.3 7204.6 7773.3 8094.7 8111.6 8121.6 7838.1 7967.7 7984.6 8144.2 8145.0 2029.5 2085.6 2268.7 2317.7 2318.5 2253.6 2329.4 2329.6 2352.9 2358.2 2281.7 2281.9 2300.4 2310.9 2311.1 2310.0 2314.0 2337.5 2341.0 2342.1 2231.6 2298.5 2298.9 2303.1 2305.8 7974.7 8067.6 8073.4 8152.7 8160.5 4933.8 5074.5 5077.9 5078.1 5081.5 3135.5 3304.1 3428.6 3447.8 3452.6 1024.5 1083.6 1116.8 1124.5 1132.1 10591.5 10639.3 10743.3 11049.2 11097.0 4435.0 4478.0 4611.1 4619.1 4633.5 9538.6 9570.9 9575.9 9583.2 9586.7 5203.8 5212.6 5214.7 5219.8 5224.7 4546.0 4616.5 4628.1 4781.0 4787.3 3724.6 3794.0 3833.9 3886.8 3888.2 1241.9 1255.7 1256.6 1288.1 1289.1 828.5 855.3 939.0 941.6 948.8 5454.5 5488.7 5619.8 5623.6 5680.1 930.5 935.5 935.7 948.5 988.9 3720.4 3754.1 3885.3 3896.9 3910.0 9659.0 10123.1 10133.2 10134.7 10135.4 10018.9 10027.1 10049.3 10053.7 10057.5 7221.2 7524.7 7532.0 7605.2 7768.0 5474.8 5478.9 5539.5 5647.9 5812.8 8822.4 8870.8 8936.9 8942.4 8982.9 7811.8 8841.1 9020.3 9082.0 9359.4 7031.1 7393.9 7405.0 7410.1 7417.1 7755.2 7771.4 7826.4 7862.6 7907.8 6828.5 6894.8 6982.6 7028.4 7047.8 6838.6 6958.8 7128.0 7170.8 7177.5 6348.0 6625.8 6628.5 6634.9 6636.3 4834.9 4897.9 4926.1 4977.7 5098.4 5063.5 5085.3 5091.6 5095.2 5159.6 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#4] prototype.html Cycles:180 Average:4587.45 Median:5245.03 stddev:1315.96 (25.1%) stddev-sans-first:1280.05 10:32:45 INFO - PROCESS | 24224 | Values: 318.2 332.6 337.5 341.2 342.8 5260.9 5289.7 5289.9 5311.2 5323.3 5208.8 5216.7 5224.8 5239.9 5249.6 3933.9 4019.6 4039.4 4069.1 4110.3 4083.8 4088.4 4127.4 4128.3 4137.7 4134.3 4139.5 4141.8 4148.1 4161.8 3966.6 3976.6 4121.9 4154.3 4170.4 3666.8 3670.5 3672.7 3681.3 3741.1 5098.7 5102.6 5106.2 5112.8 5121.9 4609.6 4693.7 4730.3 4730.9 4740.2 5450.4 5478.6 5482.6 5493.2 5507.2 4041.5 4059.6 4063.7 4071.6 4074.3 5550.0 5567.0 5611.3 5693.1 5760.5 4100.2 4101.0 4140.5 4141.6 4174.9 4178.8 4199.4 4215.0 4215.7 4218.1 4648.5 4675.4 4709.7 4767.8 4784.6 5457.7 5477.0 5479.5 5486.3 5487.5 1388.5 1399.2 1404.7 1405.8 1408.3 940.5 998.1 1002.3 1004.3 1008.7 5086.7 5126.9 5196.3 5330.0 5358.7 5592.4 5621.3 5627.2 5642.7 5657.5 5047.2 5268.6 5300.6 5347.2 5377.5 2833.2 2835.8 2879.4 2892.4 2897.2 5575.9 5600.9 5609.8 5616.6 5641.9 5256.1 5523.9 5530.7 5550.5 5601.9 5612.6 5625.4 5637.7 5653.3 5660.0 5246.8 5436.3 5450.8 5460.2 5466.7 5407.2 5409.6 5416.5 5421.5 5435.2 5629.4 5645.5 5648.3 5673.7 5678.4 3862.3 3976.6 3978.5 3983.3 3985.4 5437.5 5438.4 5462.7 5466.9 5497.0 5303.1 5336.3 5344.8 5348.7 5374.8 5039.1 5318.6 5336.2 5371.4 5389.0 5226.7 5238.4 5243.3 5301.9 5341.9 5238.3 5317.2 5343.6 5498.8 5559.4 5364.3 5368.3 5383.9 5432.0 5446.1 10:32:45 INFO - PROCESS | 24224 | 10:32:45 INFO - PROCESS | 24224 | [#5] yui.html Cycles:180 Average:16855.03 Median:24986.57 stddev:21789.99 (87.2%) stddev-sans-first:21817.53 10:32:45 INFO - PROCESS | 24224 | Values: 741.9 754.4 761.4 772.6 786.6 15721.0 16398.4 16416.5 16426.9 16463.9 14783.9 14906.6 15207.5 15308.9 15329.2 663.3 787.1 801.8 801.8 802.6 679.8 784.0 785.4 805.3 811.1 847.2 850.2 851.3 852.0 852.3 695.3 846.0 846.6 846.9 847.4 517.7 589.9 598.6 607.4 613.1 14241.5 14260.6 14279.8 14289.3 14291.2 12968.7 12975.4 13195.6 13321.9 13338.6 11331.7 11421.3 11684.4 11789.2 12327.9 3530.8 3576.0 3602.7 3616.5 3670.1 57832.7 59525.1 60677.0 60788.7 61640.4 10792.5 10930.0 10941.9 11144.7 11218.5 20805.1 20894.8 21119.7 21178.4 21400.1 7954.1 7976.2 8166.3 8327.2 8362.0 4415.1 4458.2 4476.1 4601.7 4686.9 3539.6 3540.8 3618.2 3620.7 3666.8 571.6 574.8 579.1 593.4 594.1 553.3 630.0 665.9 673.7 674.1 8931.2 9045.3 9206.1 9481.0 9887.3 605.5 630.0 669.7 704.7 734.9 4350.8 4644.5 4681.7 4716.7 4746.6 79195.0 84675.6 85988.6 87371.6 88179.1 35049.0 75801.0 77759.2 79785.2 82062.6 42613.1 42615.6 47040.8 63342.7 65526.0 9314.5 9973.3 9986.7 9996.4 10022.1 38843.6 40777.8 41166.4 45497.0 45633.0 55963.4 59641.7 59687.1 61032.0 62808.0 11151.5 11674.4 11706.9 11846.4 12682.2 12652.8 12828.6 13096.2 13239.1 14387.2 12876.3 13640.2 13649.7 13660.3 13886.3 11589.3 11805.8 11923.3 12291.9 12306.8 11588.8 11950.1 12629.0 12646.3 12657.3 10355.7 10621.9 10979.6 11068.7 11221.7 10031.4 10064.5 10378.4 11057.9 11488.8 10:32:45 INFO - PROCESS | 24224 | -------- Summary: end -------- 10:32:45 INFO - PROCESS | 24224 | 10:32:46 INFO - TEST-INFO | 24224: exit 0 10:32:46 INFO - TEST-OK | dromaeo_css | took 1118330ms 10:32:46 INFO - TEST-START | kraken 10:32:46 INFO - operating with platform_type : linux_ 10:32:46 INFO - Initialising browser for kraken test... 10:32:46 INFO - TEST-INFO | started process 24532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV6U3nj/profile http://localhost:47956/getInfo.html) 10:32:49 INFO - PROCESS | 24532 | __metrics Screen width/height:1600/1200 10:32:49 INFO - PROCESS | 24532 | colorDepth:24 10:32:49 INFO - PROCESS | 24532 | Browser inner width/height: 1024/697 10:32:49 INFO - PROCESS | 24532 | __metrics 10:32:50 INFO - PROCESS | 24532 | 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" 10:32:50 INFO - PROCESS | 24532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:51 INFO - PROCESS | 24532 | console.error: PushService: 10:32:51 INFO - PROCESS | 24532 | stateChangeProcessEnqueue: Error transitioning state 10:32:51 INFO - PROCESS | 24532 | UnknownError 10:32:51 INFO - TEST-INFO | 24532: exit 0 10:32:51 INFO - Browser initialized. 10:32:51 INFO - Running cycle 1/1 for kraken test... 10:32:51 INFO - TEST-INFO | started process 24617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV6U3nj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:04 INFO - PROCESS | 24617 | RSS: Main: 174669824 10:33:04 INFO - PROCESS | 24617 | 10:33:06 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:07 INFO - PROCESS | 24617 | RSS: Main: 235245568 10:33:07 INFO - PROCESS | 24617 | 10:33:10 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-dft) 10:33:10 INFO - PROCESS | 24617 | RSS: Main: 217485312 10:33:10 INFO - PROCESS | 24617 | 10:33:13 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-fft) 10:33:14 INFO - PROCESS | 24617 | RSS: Main: 299769856 10:33:14 INFO - PROCESS | 24617 | 10:33:16 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-oscillator) 10:33:17 INFO - PROCESS | 24617 | RSS: Main: 211390464 10:33:17 INFO - PROCESS | 24617 | 10:33:19 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:19 INFO - PROCESS | 24617 | RSS: Main: 213852160 10:33:19 INFO - PROCESS | 24617 | 10:33:22 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:23 INFO - PROCESS | 24617 | RSS: Main: 253771776 10:33:23 INFO - PROCESS | 24617 | 10:33:26 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:27 INFO - PROCESS | 24617 | RSS: Main: 253698048 10:33:27 INFO - PROCESS | 24617 | 10:33:30 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47956/tests/kraken/driver.html?testName=json-parse-financial) 10:33:30 INFO - PROCESS | 24617 | RSS: Main: 252731392 10:33:30 INFO - PROCESS | 24617 | 10:33:32 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:32 INFO - PROCESS | 24617 | RSS: Main: 214487040 10:33:32 INFO - PROCESS | 24617 | 10:33:34 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:35 INFO - PROCESS | 24617 | RSS: Main: 222420992 10:33:35 INFO - PROCESS | 24617 | 10:33:37 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:37 INFO - PROCESS | 24617 | RSS: Main: 231223296 10:33:37 INFO - PROCESS | 24617 | 10:33:40 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:41 INFO - PROCESS | 24617 | RSS: Main: 239890432 10:33:41 INFO - PROCESS | 24617 | 10:33:44 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:44 INFO - PROCESS | 24617 | RSS: Main: 236474368 10:33:44 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47956/tests/kraken/driver.html?testName=ai-astar) 10:33:46 INFO - PROCESS | 24617 | RSS: Main: 286605312 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | __start_tp_report 10:33:46 INFO - PROCESS | 24617 | _x_x_mozilla_page_load 10:33:46 INFO - PROCESS | 24617 | _x_x_mozilla_page_load_details 10:33:46 INFO - PROCESS | 24617 | |i|pagename|runs| 10:33:46 INFO - PROCESS | 24617 | |0;ai-astar;110;113;114;114;114;113;114;113;116;113 10:33:46 INFO - PROCESS | 24617 | |1;audio-beat-detection;152;123;137;162;128;123;123;123;155;131 10:33:46 INFO - PROCESS | 24617 | |2;audio-dft;162;160;163;160;160;161;160;161;161;162 10:33:46 INFO - PROCESS | 24617 | |3;audio-fft;76;75;77;113;77;77;78;77;91;77 10:33:46 INFO - PROCESS | 24617 | |4;audio-oscillator;83;83;115;83;83;83;94;83;84;113 10:33:46 INFO - PROCESS | 24617 | |5;imaging-gaussian-blur;117;118;119;117;117;118;118;117;118;117 10:33:46 INFO - PROCESS | 24617 | |6;imaging-darkroom;147;148;146;148;146;147;146;148;147;147 10:33:46 INFO - PROCESS | 24617 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;97;96 10:33:46 INFO - PROCESS | 24617 | |8;json-parse-financial;53;51;51;51;52;53;52;52;51;53 10:33:46 INFO - PROCESS | 24617 | |9;json-stringify-tinderbox;61;61;61;62;62;61;62;62;62;62 10:33:46 INFO - PROCESS | 24617 | |10;stanford-crypto-aes;82;83;90;84;81;88;81;81;90;81 10:33:46 INFO - PROCESS | 24617 | |11;stanford-crypto-ccm;137;142;134;147;137;145;145;143;179;139 10:33:46 INFO - PROCESS | 24617 | |12;stanford-crypto-pbkdf2;170;173;168;165;166;173;171;175;167;172 10:33:46 INFO - PROCESS | 24617 | |13;stanford-crypto-sha256-iterative;66;65;64;66;66;64;67;65;66;64 10:33:46 INFO - PROCESS | 24617 | __end_tp_report 10:33:46 INFO - PROCESS | 24617 | __start_cc_report 10:33:46 INFO - PROCESS | 24617 | _x_x_mozilla_cycle_collect,1679 10:33:46 INFO - PROCESS | 24617 | __end_cc_report 10:33:46 INFO - PROCESS | 24617 | __startTimestamp1480098826809__endTimestamp 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | ------- Summary: start ------- 10:33:46 INFO - PROCESS | 24617 | Number of tests: 14 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:0.97 10:33:46 INFO - PROCESS | 24617 | Values: 110.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 116.0 113.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:134.00 stddev:15.12 (11.3%) stddev-sans-first:14.84 10:33:46 INFO - PROCESS | 24617 | Values: 152.0 123.0 137.0 162.0 128.0 123.0 123.0 123.0 155.0 131.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 10:33:46 INFO - PROCESS | 24617 | Values: 162.0 160.0 163.0 160.0 160.0 161.0 160.0 161.0 161.0 162.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.87 (15.4%) stddev-sans-first:12.40 10:33:46 INFO - PROCESS | 24617 | Values: 76.0 75.0 77.0 113.0 77.0 77.0 78.0 77.0 91.0 77.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:12.90 (15.5%) stddev-sans-first:13.41 10:33:46 INFO - PROCESS | 24617 | Values: 83.0 83.0 115.0 83.0 83.0 83.0 94.0 83.0 84.0 113.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:33:46 INFO - PROCESS | 24617 | Values: 117.0 118.0 119.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:33:46 INFO - PROCESS | 24617 | Values: 147.0 148.0 146.0 148.0 146.0 147.0 146.0 148.0 147.0 147.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:33:46 INFO - PROCESS | 24617 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.83 10:33:46 INFO - PROCESS | 24617 | Values: 53.0 51.0 51.0 51.0 52.0 53.0 52.0 52.0 51.0 53.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 10:33:46 INFO - PROCESS | 24617 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.78 (4.5%) stddev-sans-first:3.94 10:33:46 INFO - PROCESS | 24617 | Values: 82.0 83.0 90.0 84.0 81.0 88.0 81.0 81.0 90.0 81.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:144.00 stddev:12.73 (8.8%) stddev-sans-first:13.18 10:33:46 INFO - PROCESS | 24617 | Values: 137.0 142.0 134.0 147.0 137.0 145.0 145.0 143.0 179.0 139.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.50 stddev:3.37 (2.0%) stddev-sans-first:3.57 10:33:46 INFO - PROCESS | 24617 | Values: 170.0 173.0 168.0 165.0 166.0 173.0 171.0 175.0 167.0 172.0 10:33:46 INFO - PROCESS | 24617 | 10:33:46 INFO - PROCESS | 24617 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 10:33:46 INFO - PROCESS | 24617 | Values: 66.0 65.0 64.0 66.0 66.0 64.0 67.0 65.0 66.0 64.0 10:33:46 INFO - PROCESS | 24617 | -------- Summary: end -------- 10:33:46 INFO - PROCESS | 24617 | 10:33:47 INFO - TEST-INFO | 24617: exit 0 10:33:48 INFO - TEST-OK | kraken | took 61975ms 10:33:48 INFO - SUITE-END | took 1180s 10:33:48 INFO - Completed test suite (00:19:40) 10:33:48 INFO - javascript benchmark 10:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.3141293209032, 3093.025696905476, 3106.984465077675, 3131.2641529240623, 3134.232113132283, 5362.088444964355, 5437.755301011454, 5466.316710411199, 5499.092649712793, 5533.833984980447, 5414.7834086636585, 5489.560835133189, 5516.062269414199, 5518.668879867211, 5574.498295153446, 4874.244492103712, 4906.558409743122, 4950.504949505039, 4989.176785830352, 5000.699958002513, 5015.498450154992, 5038.244263360507, 5046.747662616873, 5063.974680126595, 5100.464451232623, 4803.159447096744, 4984.2025275955675, 4998.825041123543, 5027.069992051483, 5114.181730923053, 4871.2206047032305, 4899.706017638953, 4939.481354457766, 4958.206686930074, 4964.0, 4906.607471402315, 4923.827666031708, 4927.211646136637, 4974.676646017997, 4988.82539111133, 5415.83752487426, 5430.239766432703, 5432.076546987022, 5448.318960129984, 5455.945440545584, 5643.746031428595, 5696.2594862668, 5808.82573522795, 5852.151438041503, 5860.501857342131, 5926.259217597801, 5937.614055086406, 5952.7321270542925, 6022.969885150546, 6025.397460253984, 5529.419410961831, 5531.308586426697, 5532.3914369419335, 5540.418256083053, 5543.1408131739645, 5775.768969241268, 5823.330317013513, 5951.226340575698, 6021.6989150542295, 6034.064719968412, 5540.750666220029, 5562.777488900399, 5572.108462645957, 5584.6090773646265, 5673.205751194836, 5687.090065589486, 5707.429257074343, 5717.771289148471, 5723.198752174699, 5725.942740572541, 5610.719464026783, 5689.715514224272, 5704.686242256716, 5705.771769129271, 5715.399883012307, 5695.772169113272, 5718.1136923776885, 5741.507208125918, 5767.538596912237, 5777.682227477445, 4376.3654270130655, 4384.8246070157475, 4388.385626012361, 4392.099619578043, 4393.989382442056, 3917.353636649978, 3919.862804801818, 3953.2291203215095, 3973.7417067890497, 3984.920301593952, 5536.972315138399, 5538.889222215614, 5544.750486228129, 5547.195656629847, 5582.86042848932, 5898.64608123514, 5923.259592550931, 5927.8221653350465, 5932.050871860568, 5933.58464907461, 5367.543758780469, 5412.756425960842, 5432.0, 5467.9453205467435, 5549.139883318092, 5055.595552355802, 5060.342155519833, 5077.543021128116, 5088.160453525127, 5102.974485127551, 5987.43119403656, 6029.487493563096, 6042.123892035543, 6044.939550604614, 6050.969745151246, 5719.685417301922, 5780.566457515619, 5835.095560188178, 5840.357560668408, 5842.532597392284, 5941.584089113893, 5953.940460595339, 5991.460768530853, 6034.818955431344, 6112.480439162721, 5732.942670573241, 5734.770609175753, 5741.885162296814, 5743.3395159557185, 5746.597738158456, 5840.123981402823, 5842.2405087338375, 5844.649321040752, 5848.912266315923, 5853.326867410302, 5467.39858615544, 5567.47109024642, 5595.132754423071, 5668.489835914787, 5670.574706896917, 5628.212050313042, 5675.971620141873, 5677.630953987978, 5677.772889084556, 5687.118496633028, 5649.4633009864, 5651.039323314964, 5656.208130861601, 5658.094704847204, 5669.20631111653, 5668.291463567054, 5711.857203569778, 5712.571557133148, 5721.485066344049, 5730.767884904765, 5510.724463776875, 5553.972230138824, 5560.332760068818, 5581.916271255853, 5631.183478395527], "value": 5358.857252991688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6107877182902, 583.1282233061572, 585.2099665451641, 596.7434003378548, 606.0303514376994, 40140.0, 41740.37389439157, 41864.09242474992, 44981.55018449815, 45020.54979450205, 42860.571394286046, 43686.0, 43714.0, 43744.343834842424, 43759.12481750363, 7658.655360508763, 7869.252421019994, 8320.126386729396, 8543.35924805639, 8548.957255213747, 9875.308728389016, 10195.6941291761, 10228.89771102287, 10496.895031049668, 10500.579976800918, 10230.744231394201, 10292.0, 10294.073533381994, 10295.691129266133, 10296.794064118712, 10217.897821021768, 10241.590336386536, 10244.948775256076, 10254.282200245985, 10262.794744105151, 10059.195264378905, 10126.0, 10129.949350253275, 10149.137323327452, 10184.185265178769, 40288.0, 40549.39175912364, 40607.796961015, 40641.593584064074, 40695.0, 3403.285310084885, 3447.5345828313107, 3468.479728040789, 3531.2231309112212, 3707.258548290353, 28547.00427425213, 28898.27754306159, 29021.0, 29905.25236869074, 29972.85013574918, 3473.478978153272, 3673.430618254148, 3705.481232627434, 3841.2317536492815, 3843.5195600549932, 355938.0, 357291.0, 359027.2048639766, 359508.0, 359598.0, 58879.0, 59281.40718592845, 59370.0, 59401.0, 59448.702756486804, 61843.743281821546, 61950.69024654848, 61997.0, 62034.0, 62086.37913620896, 13536.864631353757, 13705.520306789214, 13738.862611373957, 13747.38136783847, 13748.243846588533, 11120.833187502194, 11331.830022549668, 11472.827907581393, 12238.204516706386, 12295.69260768488, 17483.737743933852, 17544.298228070733, 17560.682948778893, 17599.73600395995, 17637.0, 6302.779402720883, 6336.43374433346, 6417.197850268716, 6565.376289252514, 6620.668966551653, 971.7522031881966, 1017.1405162637707, 1038.6157121864808, 1041.6614600254948, 1128.114430172311, 31612.658253145408, 31865.840670796963, 32161.532539468346, 32325.51511727326, 32624.83687581547, 1045.8483519889573, 1058.4813441413805, 1085.8696956365286, 1113.5100555755441, 1124.6738445850613, 16676.74984875228, 16754.83245167557, 16930.661386772197, 16941.91529042347, 16958.406455774235, 141783.0, 142221.0, 142235.0, 142424.28787855993, 142884.28557857143, 57070.7146464265, 57096.14355784666, 57201.427985720446, 57225.71387143037, 57329.713351432976, 1205.5961252980173, 1228.3980849383738, 1288.8002359634272, 1306.322701595007, 1343.402186027228, 29212.415751685272, 33297.0, 33406.0, 33483.4977475343, 33663.326733465685, 49226.75386623044, 49977.75011124921, 49981.250281245084, 49993.0, 50000.74999624979, 349567.0, 350506.0, 351325.0, 351949.0, 353307.0, 27006.189814305602, 27204.591931121446, 27741.583876241468, 29001.7099828999, 40792.38811417772, 45489.0, 45542.77228613836, 45935.54064459446, 46033.30950035685, 46304.0, 39260.6073939257, 39605.40591891066, 40404.797976011105, 40570.0, 41799.58200417957, 38727.0, 39442.21115577615, 40599.0, 42588.36117458178, 44419.0, 38740.41889371605, 39985.20029599334, 40039.59960400359, 40913.0, 41459.0, 34086.31827363488, 36477.0, 36642.460783003706, 36920.81539592285, 37066.0, 27633.447331053667, 27776.722232777414, 28015.439691205655, 28137.71862281433, 28251.717482824908], "value": 19071.821644046424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.19605651792136, 384.23728898137193, 394.4635295997443, 399.21155717458015, 415.33131658030567, 13153.377602966128, 15162.545123646294, 16104.35582576697, 18898.433047008577, 18945.905270473628, 18379.816201837977, 18479.44561663149, 18491.722624160648, 18581.349652762157, 18956.0, 5435.1847222916585, 5712.571557133231, 5722.856928576777, 5731.168980497825, 5735.11105778605, 4562.9771851140695, 5644.096944488882, 5672.971635141818, 5678.318601767794, 5688.203651488795, 5606.046972014747, 5607.373861580158, 5612.07400778873, 5632.295963004624, 5637.577181711388, 5425.077736784737, 5581.860453488675, 5604.187392828017, 5610.410906854782, 5611.410801865786, 4989.25161225819, 5035.899282014376, 5043.3191519145175, 5043.747812609355, 5048.419431765357, 13896.652583685387, 14213.431462741479, 21450.03474843636, 21770.673439898415, 22356.664650030263, 2165.6101901657694, 2264.1735766445295, 2291.965620515677, 2315.2012555668266, 2351.8000969917575, 10002.099811017044, 10086.445245511493, 10181.898181018169, 10630.521626526825, 10638.57445702171, 1813.8186181381889, 1817.8909265444115, 1906.818852209038, 1927.6602761081053, 1940.088158565472, 78046.6097669508, 80746.19253807445, 81822.0, 82620.76068858911, 86054.0, 10451.84322235167, 10677.893221067845, 10863.239573229956, 10973.122150227962, 11250.437478126061, 15620.453284135001, 15660.843391565939, 15668.608284792743, 15671.529854104396, 15676.137812420198, 7673.0, 7889.250521200477, 7894.684212631545, 8130.471519351223, 8163.877541836877, 7505.174430812606, 7600.0, 7618.162002179756, 7799.80500487481, 7821.413393995473, 4709.799001254658, 4758.452777930513, 4767.141914455431, 4790.880227994328, 4797.832075877328, 1926.7206255092933, 1969.714391413237, 1994.554865217934, 1996.6805311150147, 2048.723422337965, 961.5096300886458, 986.8174387738292, 1030.917536586581, 1036.8283839261737, 1053.794510070529, 18574.44276671675, 19455.22179112848, 19475.318363857197, 19507.414777556696, 19794.0, 992.2607657295362, 993.3543196921914, 1007.8185926533295, 1009.3388830316155, 1055.9524821383056, 10240.743981400376, 10507.579696812041, 10578.52396642153, 10679.825219225879, 10816.945915270531, 418507.0, 430870.0, 432315.0, 432851.0, 444109.0, 87074.0, 87405.56297218474, 88648.0, 89383.55308223417, 89599.0, 961.8124465729255, 1025.261811495722, 1051.495282264502, 1054.367379572266, 1055.0609957138154, 16193.67612647764, 16592.336306547604, 16905.408310709066, 17065.829341706423, 17359.91320043442, 40773.0, 43043.7847810759, 43423.0, 43521.56478435175, 46187.76906115448, 56435.71782141063, 57933.71033144807, 59566.70216648889, 60598.0, 60755.39244607498, 11972.14431763078, 12361.320127393079, 12568.868801807881, 12711.300878451773, 12918.547850825176, 13540.458381664623, 13747.450101995808, 13795.448182072605, 13803.51687690926, 14386.35261413218, 11888.28670279786, 12009.939950300542, 12010.939945300217, 12202.206856554296, 12453.875461245272, 11654.53381864716, 11795.351255680676, 11809.23239989398, 12136.575219867262, 12253.590837053853, 11979.221350612532, 11997.940010300243, 12060.879391205975, 12156.574519891761, 12341.50633974631, 11749.236299640495, 11768.35274059935, 11822.763544728885, 11894.226875253082, 12014.75970480568, 12012.579559715368, 12194.268343899394, 12220.266783992989, 12352.876471235173, 12380.752384952431], "value": 9252.294739508357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.8542660307357, 1409.9999999999998, 1444.6027342480818, 1543.8764898808097, 1717.2873257598098, 7204.567725936441, 7773.261540153683, 8094.716684916014, 8111.594420278992, 8121.593920303976, 7838.137804841463, 7967.72112976046, 7984.600769961493, 8144.226298501648, 8145.0, 2029.4520479470534, 2085.593309304686, 2268.739095004071, 2317.698699169114, 2318.466752646892, 2253.6394176931694, 2329.3594261578032, 2329.6039673255586, 2352.870592117433, 2358.174638876397, 2281.7147856517936, 2281.8859057047166, 2300.424893776556, 2310.9422264443438, 2311.144876395736, 2309.9653505197434, 2313.9537209255805, 2337.520808234308, 2341.028473183627, 2342.1334106380664, 2231.553689262154, 2298.494331247123, 2298.9310320690406, 2303.067257760593, 2305.792478676927, 7974.720884769064, 8067.556284404355, 8073.434859559833, 8152.714654987106, 8160.469569477965, 4933.80264789408, 5074.517920797518, 5077.923831142536, 5078.085944529983, 5081.466446023188, 3135.5453459248283, 3304.074859039473, 3428.5542879425766, 3447.775894566845, 3452.5511683481236, 1024.4979959819634, 1083.6099004358425, 1116.7598966222301, 1124.5052177042076, 1132.0547342968548, 10591.523381447776, 10639.308444951132, 10743.301685390425, 11049.17131215154, 11097.0, 4434.977825110854, 4477.977610111994, 4611.054733779567, 4619.099275641218, 4633.536646335339, 9538.570764315622, 9570.856437153448, 9575.904240957641, 9583.233341332676, 9586.712398628053, 5203.843884683465, 5212.635115541952, 5214.687118772886, 5219.817306394258, 5224.660397074178, 4545.954540454619, 4616.469106052779, 4628.120657075145, 4780.976095119572, 4787.257975013808, 3724.6089160637744, 3794.0, 3833.9456649421077, 3886.8250928708276, 3888.183481468923, 1241.9379031048593, 1255.6546949588935, 1256.5790460195938, 1288.072587736828, 1289.065427565008, 828.5443006346485, 855.3114742632241, 938.9624415023322, 941.5951141009294, 948.814981078683, 5454.53636440899, 5488.69812160327, 5619.7636519965545, 5623.581859800325, 5680.091185410314, 930.5254320296563, 935.5462600638684, 935.6725146198776, 948.4641177734558, 988.8924404666819, 3720.441933709911, 3754.1177823211524, 3885.300645883768, 3896.941545876814, 3909.9609003909595, 9659.0, 10123.088921997056, 10133.189344852393, 10134.746631334128, 10135.391876487434, 10018.899811001942, 10027.147692446224, 10049.346792458613, 10053.69838904834, 10057.547410366551, 7221.205667376585, 7524.699012039567, 7532.0, 7605.201453847377, 7767.961160194162, 5474.753636086465, 5478.91781623284, 5539.529140023144, 5647.926893890148, 5812.82561523155, 8822.426542274732, 8870.822583548423, 8936.86594701093, 8942.37403381757, 8982.910170898207, 7811.843763124592, 8841.115888411108, 9020.278377729897, 9082.0, 9359.438433694, 7031.1211098612675, 7393.8890916637365, 7404.96297518509, 7410.147832999059, 7417.147028091623, 7755.185705501067, 7771.37828973692, 7826.373890088893, 7862.567558784322, 7907.802304942423, 6828.5220034597105, 6894.827629309308, 6982.581045137308, 7028.402585780266, 7047.753328633473, 6838.555493892881, 6958.756443524452, 7128.037714908421, 7170.784876453715, 7177.4616903731385, 6348.0, 6625.801225963229, 6628.502862285444, 6634.933650663625, 6636.336366363325, 4834.8791280218275, 4897.877553061202, 4926.137925862888, 4977.651564390603, 5098.388193416666, 5063.468335824686, 5085.321504216056, 5091.592672586258, 5095.210242412432, 5159.613029022913], "value": 4395.190303810317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.24893251925465, 332.6490552467147, 337.45837930122156, 341.2288228603356, 342.7908975524931, 5260.868478288045, 5289.709066001368, 5289.947100528993, 5311.2298716686055, 5323.334583177103, 5208.848646568818, 5216.6869987800665, 5224.817131400402, 5239.921401178985, 5249.580033597313, 3933.90165245869, 4019.5779443158485, 4039.3738970459626, 4069.1454794493193, 4110.301248787713, 4083.7549747015128, 4088.3867419886956, 4127.422160897477, 4128.277551428503, 4137.731047481919, 4134.255833949888, 4139.544650088488, 4141.79291035447, 4148.128892932473, 4161.83352665893, 3966.643002129822, 3976.622220889011, 4121.91756164878, 4154.273002224629, 4170.35359519275, 3666.834992425347, 3670.541182352206, 3672.706183505313, 3681.2821499807546, 3741.1395379062697, 5098.668586541863, 5102.591792656579, 5106.208537676666, 5112.795488180468, 5121.897562048775, 4609.562091601292, 4693.6949098308505, 4730.290456431529, 4730.858074257778, 4740.170470167742, 5450.400455949843, 5478.58910581704, 5482.588805839578, 5493.2034854945805, 5507.201455788888, 4041.4948131483566, 4059.5940405959464, 4063.7155399122075, 4071.5521292657786, 4074.2666320062376, 5549.972250138764, 5567.0, 5611.344653327237, 5693.146028095777, 5760.531064578506, 4100.17996400721, 4100.958990410118, 4140.4617399737845, 4141.565135660772, 4174.853880114181, 4178.832846686159, 4199.370094485852, 4214.978925105354, 4215.683823713172, 4218.135282267128, 4648.48866624671, 4675.438947326343, 4709.740964246931, 4767.833125840579, 4784.617230621542, 5457.699826509501, 5477.0, 5479.5342395896, 5486.286782718221, 5487.478689524489, 1388.5070799866105, 1399.1605036977733, 1404.683946112137, 1405.7910197230374, 1408.2747385096684, 940.4686352210979, 998.1316254858319, 1002.293383164867, 1004.2919741582167, 1008.6671398438498, 5086.694798312114, 5126.92309615356, 5196.298499702491, 5329.973350133302, 5358.705271210043, 5592.440755924375, 5621.289948633882, 5627.184058311604, 5642.702178498968, 5657.51911087554, 5047.2429135629945, 5268.631195816332, 5300.648334674634, 5347.171188465794, 5377.489138531833, 2833.1500549835378, 2835.787315951312, 2879.379764414373, 2892.4070565534016, 2897.217751207162, 5575.916361254584, 5600.887982240332, 5609.80365687199, 5616.623927137795, 5641.915371269434, 5256.107801191568, 5523.917141242885, 5530.723463826873, 5550.5282051026115, 5601.943980560224, 5612.550995920316, 5625.353084395347, 5637.661740295595, 5653.349864765604, 5659.971700141473, 5246.763895624782, 5436.266104075899, 5450.754716037867, 5460.153676180198, 5466.726663666721, 5407.215953686772, 5409.621326507264, 5416.539594134385, 5421.539169170507, 5435.179214963032, 5629.437056294338, 5645.548356131418, 5648.333741546172, 5673.659580425187, 5678.3753787084215, 3862.281284828337, 3976.5625781164626, 3978.4629075075654, 3983.2830090583975, 3985.362342025262, 5437.483439073281, 5438.422857371318, 5462.672239665632, 5466.91799622998, 5496.966122534688, 5303.071962406486, 5336.279602253801, 5344.781915505022, 5348.652337598043, 5374.758135883816, 5039.0929632666475, 5318.585573973515, 5336.226247194058, 5371.382291036424, 5389.0, 5226.738663066907, 5238.3975842777045, 5243.292155558951, 5301.867453313544, 5341.946580534145, 5238.292830467838, 5317.202419637086, 5343.62594618373, 5498.772996936247, 5559.360673522435, 5364.30264065669, 5368.32895888014, 5383.892322153457, 5432.0, 5446.113559813305], "value": 4172.586516351849, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8516296740653, 754.4228665071221, 761.4099073218255, 772.6175543106167, 786.6145588661558, 15721.0, 16398.426055088075, 16416.507504774847, 16426.917865410673, 16463.91768041161, 14783.926080369583, 14906.627334316647, 15207.46773862915, 15308.923455382735, 15329.156896370696, 663.2770280394369, 787.1459466478877, 801.7955421367543, 801.8316153607749, 802.626778547975, 679.8096532970751, 783.996080019599, 785.3913217256614, 805.2631841864687, 811.1401913971209, 847.1570787066877, 850.2135524639715, 851.2891735400917, 851.9701810436636, 852.3479538153317, 695.3151146121066, 846.0481957797477, 846.6147902704286, 846.86026805577, 847.3602430165247, 517.6764522173642, 589.8525368657836, 598.575011741664, 607.398675311443, 613.0926229180793, 14241.501547445894, 14260.572182834532, 14279.78580321296, 14289.285535723277, 14291.213983230919, 12968.740625187538, 12975.416106275241, 13195.60413187606, 13321.933390332986, 13338.599842004756, 11331.716707082307, 11421.25761825487, 11684.415779211091, 11789.233699809485, 12327.938360308231, 3530.8058056806867, 3575.982120089409, 3602.7117830573493, 3616.475611036385, 3670.06413364593, 57832.71083644597, 59525.107123393616, 60677.0, 60788.696056519875, 61640.38359616436, 10792.514336854703, 10930.0, 10941.945290273497, 11144.721381965515, 11218.495167717472, 20805.063772130292, 20894.79105208959, 21119.683204751942, 21178.364649060553, 21400.143994240058, 7954.125046244909, 7976.242256985577, 8166.346692264605, 8327.20891515305, 8361.95819020901, 4415.072834704683, 4458.175237580993, 4476.149531588988, 4601.74690392025, 4686.882827929329, 3539.628339024417, 3540.805255710909, 3618.203995121069, 3620.71034317254, 3666.7616604920595, 571.5513322042177, 574.7902015764299, 579.0995002770732, 593.4332712259782, 594.0821430889287, 553.261396036288, 629.9622022678655, 665.8734840380409, 673.6968364236113, 674.0529555973865, 8931.19619234272, 9045.276377889884, 9206.079392060741, 9481.0, 9887.307888447884, 605.5186127029023, 629.9930165868423, 669.7220653428773, 704.6688056613383, 734.8677238097087, 4350.760708161081, 4644.465886423104, 4681.749323267178, 4716.669833111718, 4746.644001699887, 79195.0, 84675.5766221165, 85988.5700571493, 87371.56314218516, 88179.11820881837, 35049.0, 75801.0, 77759.2224077752, 79785.20214797778, 82062.58968705237, 42613.14773704509, 42615.57384426116, 47040.7647961758, 63342.68328658327, 65526.0, 9314.48770317639, 9973.30186886911, 9986.650467233612, 9996.400215987063, 10022.098011179029, 38843.611563884, 40777.796111019255, 41166.382504263056, 45497.0, 45633.0, 55963.44036559745, 59641.70179149076, 59687.104693430505, 61032.0, 62808.0, 11151.498182581965, 11674.416279185836, 11706.941465292619, 11846.407679616157, 12682.239065656091, 12652.810207846705, 12828.615141545768, 13096.21422714602, 13239.09499383684, 14387.208703521406, 12876.291803950873, 13640.249786261455, 13649.658758531115, 13660.304134326167, 13886.305684715926, 11589.318122893696, 11805.76388472243, 11923.344216068199, 12291.9385403076, 12306.75386492283, 11588.76822463529, 11950.103742219542, 12629.0, 12646.30445325516, 12657.303848288433, 10355.689329319832, 10621.946890265499, 10979.615713449992, 11068.667939961813, 11221.66335009951, 10031.398116113056, 10064.496775161066, 10378.377297362182, 11057.899454731834, 11488.82766758516], "value": 6947.6506296568205, "unit": "score"}], "name": "dromaeo_css", "value": 7027.972183385292, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 116.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 137.0, 162.0, 128.0, 123.0, 123.0, 123.0, 155.0, 131.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 113.0, 77.0, 77.0, 78.0, 77.0, 91.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 83.0, 83.0, 94.0, 83.0, 84.0, 113.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0, 51.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 90.0, 84.0, 81.0, 88.0, 81.0, 81.0, 90.0, 81.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 134.0, 147.0, 137.0, 145.0, 145.0, 143.0, 179.0, 139.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 168.0, 165.0, 166.0, 173.0, 171.0, 175.0, 167.0, 172.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 66.0, 66.0, 64.0, 67.0, 65.0, 66.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1520.6, "alertThreshold": 2.0}]} 10:33:48 INFO - Return code: 0 10:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:48 INFO - # TBPL SUCCESS # 10:33:48 INFO - Running post-action listener: _resource_record_post_action 10:33:48 INFO - [mozharness: 2016-11-25 18:33:48.602359Z] Finished run-tests step (success) 10:33:48 INFO - Running post-run listener: _resource_record_post_run 10:33:48 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403533824; Read time: 12; Write time: 271672 10:33:48 INFO - TinderboxPrint: CPU usage
13.1% 10:33:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:33:48 INFO - TinderboxPrint: I/O write bytes / time
403,533,824 / 271,672 10:33:48 INFO - TinderboxPrint: CPU idle
8,300.4 (86.8%) 10:33:48 INFO - TinderboxPrint: CPU user
1,207.3 (12.6%) 10:33:48 INFO - TinderboxPrint: Swap in / out
0 / 0 10:33:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114569216; Read time: 0; Write time: 82844 10:33:48 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288964608; Read time: 0; Write time: 188828 10:33:49 INFO - Running post-run listener: _upload_blobber_files 10:33:49 INFO - Blob upload gear active. 10:33:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:49 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 10:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:50 INFO - (blobuploader) - INFO - Done attempting. 10:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:51 INFO - (blobuploader) - INFO - Done attempting. 10:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:56 INFO - (blobuploader) - INFO - Done attempting. 10:33:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:56 INFO - Return code: 0 10:33:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38aa0a0ee18a7ebe9c3eba943fdf8a978a2e2387bf8b54f590031781183c8370a1b7f8add69f565290ba3a863c4e4b8f6c708490f7534454451db4cd5f5a33b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c04992e807b59c4772b7bf87186ab0d0052199038fcb387b7568156299910efa2932cfe3adc18ec45ad24dca5b48189827e32d28c8048ce851cb1e1ff7818a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20f5d34557f48b36bee83ae7846b1205b27f788546e7ef763fdc30c5dbbd733841afe4d5f1967f8f0605b270db07c470d1ae8b4781380d302835f62a0257ee7"} 10:33:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:56 INFO - Contents: 10:33:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38aa0a0ee18a7ebe9c3eba943fdf8a978a2e2387bf8b54f590031781183c8370a1b7f8add69f565290ba3a863c4e4b8f6c708490f7534454451db4cd5f5a33b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c04992e807b59c4772b7bf87186ab0d0052199038fcb387b7568156299910efa2932cfe3adc18ec45ad24dca5b48189827e32d28c8048ce851cb1e1ff7818a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20f5d34557f48b36bee83ae7846b1205b27f788546e7ef763fdc30c5dbbd733841afe4d5f1967f8f0605b270db07c470d1ae8b4781380d302835f62a0257ee7"} 10:33:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:56 INFO - Copying logs to upload dir... 10:33:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.844648 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-25 10:33:55.965820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 10:33:55.969642) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38aa0a0ee18a7ebe9c3eba943fdf8a978a2e2387bf8b54f590031781183c8370a1b7f8add69f565290ba3a863c4e4b8f6c708490f7534454451db4cd5f5a33b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c04992e807b59c4772b7bf87186ab0d0052199038fcb387b7568156299910efa2932cfe3adc18ec45ad24dca5b48189827e32d28c8048ce851cb1e1ff7818a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20f5d34557f48b36bee83ae7846b1205b27f788546e7ef763fdc30c5dbbd733841afe4d5f1967f8f0605b270db07c470d1ae8b4781380d302835f62a0257ee7"} build_url:https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/MEU7J7V-SB2z8UuubJSZpw/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/Firefox/sha512/38aa0a0ee18a7ebe9c3eba943fdf8a978a2e2387bf8b54f590031781183c8370a1b7f8add69f565290ba3a863c4e4b8f6c708490f7534454451db4cd5f5a33b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c04992e807b59c4772b7bf87186ab0d0052199038fcb387b7568156299910efa2932cfe3adc18ec45ad24dca5b48189827e32d28c8048ce851cb1e1ff7818a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20f5d34557f48b36bee83ae7846b1205b27f788546e7ef763fdc30c5dbbd733841afe4d5f1967f8f0605b270db07c470d1ae8b4781380d302835f62a0257ee7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 10:33:55.994615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:33:55.994914) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1480097014.408900-1556214223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 10:33:56.076863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 10:33:56.077168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 10:33:56.077442) ========= ========= Total master_lag: 0.16 =========