builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1484241654.77 results: success (0) buildid: 20170112072417 builduid: 7e33201cb6a94468a1006151bb08bb16 revision: 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.773537) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.774101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.774406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.791516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.791948) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 09:20:55-- 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% 216M=0s 2017-01-12 09:20:55 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.902117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.902434) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017314 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:54.953155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 09:20:54.953565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 --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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 09:20:55,708 truncating revision to first 12 chars 2017-01-12 09:20:55,708 Setting DEBUG logging. 2017-01-12 09:20:55,708 attempt 1/10 2017-01-12 09:20:55,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6a7701e2bb8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 09:20:56,386 unpacking tar archive at: mozilla-aurora-6a7701e2bb8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.237706 ========= master_lag: 0.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 09:20:56.991693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:56.995404) ========= script_repo_revision: 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:56.996151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:56.996550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:20:57.009690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 09:20:57.010200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:20:57 INFO - MultiFileLogger online at 20170112 09:20:57 in /builds/slave/test 09:20:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:20:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:57 INFO - {'append_to_log': False, 09:20:57 INFO - 'base_work_dir': '/builds/slave/test', 09:20:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:20:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:57 INFO - 'branch': 'Mozilla-Aurora', 09:20:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:57 INFO - 'config_files': ('talos/linux_config.py',), 09:20:57 INFO - 'default_actions': ('clobber', 09:20:57 INFO - 'read-buildbot-config', 09:20:57 INFO - 'download-and-extract', 09:20:57 INFO - 'populate-webroot', 09:20:57 INFO - 'create-virtualenv', 09:20:57 INFO - 'install', 09:20:57 INFO - 'run-tests'), 09:20:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:57 INFO - 'download_minidump_stackwalk': True, 09:20:57 INFO - 'download_symbols': 'ondemand', 09:20:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:57 INFO - 'installer_path': 'installer.exe', 09:20:57 INFO - 'log_level': 'info', 09:20:57 INFO - 'log_name': 'talos', 09:20:57 INFO - 'log_to_console': True, 09:20:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:20:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:20:57 INFO - 'opt_config_files': (), 09:20:57 INFO - 'pip_index': False, 09:20:57 INFO - 'sps_profile': False, 09:20:57 INFO - 'sps_profile_interval': 0, 09:20:57 INFO - 'suite': 'dromaeojs', 09:20:57 INFO - 'system_bits': '32', 09:20:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:57 INFO - 'title': 'talos-linux64-ix-055', 09:20:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:57 INFO - 'use_talos_json': True, 09:20:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:57 INFO - 'work_dir': 'build'} 09:20:57 INFO - [mozharness: 2017-01-12 17:20:57.871965Z] Running clobber step. 09:20:57 INFO - Running pre-action listener: _resource_record_pre_action 09:20:57 INFO - Running main action method: clobber 09:20:57 INFO - rmtree: /builds/slave/test/build 09:20:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:58 INFO - Running post-action listener: _resource_record_post_action 09:20:58 INFO - [mozharness: 2017-01-12 17:20:58.327163Z] Finished clobber step (success) 09:20:58 INFO - [mozharness: 2017-01-12 17:20:58.327263Z] Running read-buildbot-config step. 09:20:58 INFO - Running pre-action listener: _resource_record_pre_action 09:20:58 INFO - Running main action method: read_buildbot_config 09:20:58 INFO - Using buildbot properties: 09:20:58 INFO - { 09:20:58 INFO - "project": "", 09:20:58 INFO - "product": "firefox", 09:20:58 INFO - "script_repo_revision": "production", 09:20:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:20:58 INFO - "repository": "", 09:20:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:20:58 INFO - "buildid": "20170112072417", 09:20:58 INFO - "pgo_build": "True", 09:20:58 INFO - "basedir": "/builds/slave/test", 09:20:58 INFO - "buildnumber": 734, 09:20:58 INFO - "slavename": "talos-linux64-ix-055", 09:20:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:20:58 INFO - "platform": "ubuntu64_hw", 09:20:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:20:58 INFO - "branch": "mozilla-aurora", 09:20:58 INFO - "repo_path": "releases/mozilla-aurora", 09:20:58 INFO - "revision": "6a7701e2bb8ea480c6001069f0f04c938a2d4e53", 09:20:58 INFO - "stage_platform": "linux64-pgo", 09:20:58 INFO - "builduid": "7e33201cb6a94468a1006151bb08bb16", 09:20:58 INFO - "slavebuilddir": "test" 09:20:58 INFO - } 09:20:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:20:58 INFO - Running post-action listener: _resource_record_post_action 09:20:58 INFO - [mozharness: 2017-01-12 17:20:58.329687Z] Finished read-buildbot-config step (success) 09:20:58 INFO - [mozharness: 2017-01-12 17:20:58.329777Z] Running download-and-extract step. 09:20:58 INFO - Running pre-action listener: _resource_record_pre_action 09:20:58 INFO - Running main action method: download_and_extract 09:20:58 INFO - mkdir: /builds/slave/test/build/tests 09:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:58 INFO - trying https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:20:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:20:58 INFO - Downloaded 1361 bytes. 09:20:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:20:58 INFO - Using the following test package requirements: 09:20:58 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:20:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:20:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:20:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'jsshell-linux-x86_64.zip'], 09:20:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:20:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:20:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:20:58 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:20:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:20:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:20:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:20:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:20:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:20:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:20:59 INFO - Http code: 200 09:20:59 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:20:59 INFO - x-amz-cf-id: rMeWNgwAMKqizB03NmT_400LopMLe8oPrk27AW1QShbrxeesoDclIQ== 09:20:59 INFO - x-amz-version-id: N1CCI9KGxJTg98XVRMc10wTG2dBrFq8W 09:20:59 INFO - Expected file size: 21949089 09:20:59 INFO - Obtained file size: 21949089 09:21:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:21:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:03 INFO - Fetch https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:21:04 INFO - Http code: 200 09:21:04 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:21:04 INFO - x-amz-cf-id: 17bJVfThMYc87bLvOzVo1mff7JFkFotRw6su3JHMrI04PXD9wKSJpA== 09:21:04 INFO - x-amz-version-id: N1CCI9KGxJTg98XVRMc10wTG2dBrFq8W 09:21:04 INFO - Expected file size: 21949089 09:21:04 INFO - Obtained file size: 21949089 09:21:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:21:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:09 INFO - Fetch https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:21:09 INFO - Http code: 200 09:21:09 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:21:09 INFO - x-amz-cf-id: oDLd4dVA9goybDfGPEvAhKh5z4TE_yOOL1cVbtDZaz3x8fXxbku7aQ== 09:21:09 INFO - x-amz-version-id: ljCgRvejC0BOPFK7RKn7oO9PaAIVM420 09:21:09 INFO - Expected file size: 14409038 09:21:09 INFO - Obtained file size: 14409038 09:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:10 INFO - trying https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:21:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:21:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:21:11 INFO - Downloaded 64132576 bytes. 09:21:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:21:11 INFO - mkdir: /builds/slave/test/properties 09:21:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:11 INFO - Contents: 09:21:11 INFO - build_url:https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:21:12 INFO - Running post-action listener: _resource_record_post_action 09:21:12 INFO - Running post-action listener: set_extra_try_arguments 09:21:12 INFO - [mozharness: 2017-01-12 17:21:12.145700Z] Finished download-and-extract step (success) 09:21:12 INFO - [mozharness: 2017-01-12 17:21:12.145928Z] Running populate-webroot step. 09:21:12 INFO - Running pre-action listener: _resource_record_pre_action 09:21:12 INFO - Running main action method: populate_webroot 09:21:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:12 INFO - '--tppagecycles', 09:21:12 INFO - '7'], 09:21:12 INFO - 'tests': ['tsvgm']}}, 09:21:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['damp', 'tps']}, 09:21:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'tests': ['damp', 'tps']}, 09:21:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['dromaeo_dom']}, 09:21:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['basic_compositor_video']}, 09:21:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['a11yr', 09:21:12 INFO - 'ts_paint', 09:21:12 INFO - 'tpaint', 09:21:12 INFO - 'sessionrestore', 09:21:12 INFO - 'sessionrestore_no_auto_restore', 09:21:12 INFO - 'tabpaint']}, 09:21:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['tsvgx', 09:21:12 INFO - 'tsvgr_opacity', 09:21:12 INFO - 'tart', 09:21:12 INFO - 'tscrollx', 09:21:12 INFO - 'cart']}, 09:21:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:12 INFO - 'tsvgr_opacity', 09:21:12 INFO - 'tart', 09:21:12 INFO - 'tscrollx', 09:21:12 INFO - 'cart']}, 09:21:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'talos_options': ['--disable-e10s'], 09:21:12 INFO - 'tests': ['tp5o']}, 09:21:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'tests': ['tp5o']}, 09:21:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'talos_options': ['--disable-e10s', 09:21:12 INFO - '--xperf_path', 09:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:12 INFO - 'tests': ['tp5n']}, 09:21:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:12 INFO - 'talos_options': ['--xperf_path', 09:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:12 INFO - 'tests': ['tp5n']}}, 09:21:12 INFO - 'talos.zip': {'path': '', 09:21:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:12 INFO - Running post-action listener: _resource_record_post_action 09:21:12 INFO - [mozharness: 2017-01-12 17:21:12.167308Z] Finished populate-webroot step (success) 09:21:12 INFO - [mozharness: 2017-01-12 17:21:12.167396Z] Running create-virtualenv step. 09:21:12 INFO - Running pre-action listener: _resource_record_pre_action 09:21:12 INFO - Running main action method: create_virtualenv 09:21:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:21:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:12 INFO - Using real prefix '/usr' 09:21:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:14 INFO - Installing pip.................done. 09:21:14 INFO - Return code: 0 09:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:14 INFO - Reading from file tmpfile_stdout 09:21:14 INFO - Output received: 09:21:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:21:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:14 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:21:14 INFO - Using env: {'DISPLAY': ':0', 09:21:14 INFO - 'HOME': '/home/cltbld', 09:21:14 INFO - 'LANG': 'en_US.UTF-8', 09:21:14 INFO - 'LANGUAGE': 'en_US:en', 09:21:14 INFO - 'LOGNAME': 'cltbld', 09:21:14 INFO - 'MAIL': '/var/mail/cltbld', 09:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:14 INFO - 'MOZ_NO_REMOTE': '1', 09:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:14 INFO - 'NO_EM_RESTART': '1', 09:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:14 INFO - 'PWD': '/builds/slave/test', 09:21:14 INFO - 'SHELL': '/bin/bash', 09:21:14 INFO - 'SHLVL': '1', 09:21:14 INFO - 'TERM': 'linux', 09:21:14 INFO - 'TMOUT': '86400', 09:21:14 INFO - 'USER': 'cltbld', 09:21:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:14 INFO - '_': '/tools/buildbot/bin/python'} 09:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:21:15 INFO - Cleaning up... 09:21:15 INFO - Return code: 0 09:21:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:15 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:21:15 INFO - Using env: {'DISPLAY': ':0', 09:21:15 INFO - 'HOME': '/home/cltbld', 09:21:15 INFO - 'LANG': 'en_US.UTF-8', 09:21:15 INFO - 'LANGUAGE': 'en_US:en', 09:21:15 INFO - 'LOGNAME': 'cltbld', 09:21:15 INFO - 'MAIL': '/var/mail/cltbld', 09:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:15 INFO - 'MOZ_NO_REMOTE': '1', 09:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:15 INFO - 'NO_EM_RESTART': '1', 09:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:15 INFO - 'PWD': '/builds/slave/test', 09:21:15 INFO - 'SHELL': '/bin/bash', 09:21:15 INFO - 'SHLVL': '1', 09:21:15 INFO - 'TERM': 'linux', 09:21:15 INFO - 'TMOUT': '86400', 09:21:15 INFO - 'USER': 'cltbld', 09:21:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:15 INFO - '_': '/tools/buildbot/bin/python'} 09:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:15 INFO - Downloading/unpacking psutil>=3.1.1 09:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:17 INFO - Installing collected packages: psutil 09:21:17 INFO - Running setup.py install for psutil 09:21:17 INFO - building 'psutil._psutil_linux' extension 09:21:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:21:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:21:17 INFO - building 'psutil._psutil_posix' extension 09:21:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:21:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:21:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:18 INFO - Successfully installed psutil 09:21:18 INFO - Cleaning up... 09:21:18 INFO - Return code: 0 09:21:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:18 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:21:18 INFO - Using env: {'DISPLAY': ':0', 09:21:18 INFO - 'HOME': '/home/cltbld', 09:21:18 INFO - 'LANG': 'en_US.UTF-8', 09:21:18 INFO - 'LANGUAGE': 'en_US:en', 09:21:18 INFO - 'LOGNAME': 'cltbld', 09:21:18 INFO - 'MAIL': '/var/mail/cltbld', 09:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:18 INFO - 'MOZ_NO_REMOTE': '1', 09:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:18 INFO - 'NO_EM_RESTART': '1', 09:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:18 INFO - 'PWD': '/builds/slave/test', 09:21:18 INFO - 'SHELL': '/bin/bash', 09:21:18 INFO - 'SHLVL': '1', 09:21:18 INFO - 'TERM': 'linux', 09:21:18 INFO - 'TMOUT': '86400', 09:21:18 INFO - 'USER': 'cltbld', 09:21:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:18 INFO - '_': '/tools/buildbot/bin/python'} 09:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:20 INFO - Installing collected packages: mozsystemmonitor 09:21:20 INFO - Running setup.py install for mozsystemmonitor 09:21:20 INFO - Successfully installed mozsystemmonitor 09:21:20 INFO - Cleaning up... 09:21:20 INFO - Return code: 0 09:21:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:20 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:20 INFO - Using env: {'DISPLAY': ':0', 09:21:20 INFO - 'HOME': '/home/cltbld', 09:21:20 INFO - 'LANG': 'en_US.UTF-8', 09:21:20 INFO - 'LANGUAGE': 'en_US:en', 09:21:20 INFO - 'LOGNAME': 'cltbld', 09:21:20 INFO - 'MAIL': '/var/mail/cltbld', 09:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:20 INFO - 'MOZ_NO_REMOTE': '1', 09:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:20 INFO - 'NO_EM_RESTART': '1', 09:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:20 INFO - 'PWD': '/builds/slave/test', 09:21:20 INFO - 'SHELL': '/bin/bash', 09:21:20 INFO - 'SHLVL': '1', 09:21:20 INFO - 'TERM': 'linux', 09:21:20 INFO - 'TMOUT': '86400', 09:21:20 INFO - 'USER': 'cltbld', 09:21:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:20 INFO - '_': '/tools/buildbot/bin/python'} 09:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:20 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:23 INFO - warning: no files found matching '*.txt' 09:21:23 INFO - no previously-included directories found matching 'build' 09:21:23 INFO - no previously-included directories found matching 'dist' 09:21:23 INFO - no previously-included directories found matching '.git*' 09:21:23 INFO - Installing collected packages: jsonschema, functools32 09:21:23 INFO - Running setup.py install for functools32 09:21:23 INFO - warning: no files found matching '*.txt' 09:21:23 INFO - no previously-included directories found matching 'build' 09:21:23 INFO - no previously-included directories found matching 'dist' 09:21:23 INFO - no previously-included directories found matching '.git*' 09:21:23 INFO - Successfully installed jsonschema functools32 09:21:23 INFO - Cleaning up... 09:21:23 INFO - Return code: 0 09:21:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:21:23 INFO - Using env: {'DISPLAY': ':0', 09:21:23 INFO - 'HOME': '/home/cltbld', 09:21:23 INFO - 'LANG': 'en_US.UTF-8', 09:21:23 INFO - 'LANGUAGE': 'en_US:en', 09:21:23 INFO - 'LOGNAME': 'cltbld', 09:21:23 INFO - 'MAIL': '/var/mail/cltbld', 09:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:23 INFO - 'MOZ_NO_REMOTE': '1', 09:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:23 INFO - 'NO_EM_RESTART': '1', 09:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:23 INFO - 'PWD': '/builds/slave/test', 09:21:23 INFO - 'SHELL': '/bin/bash', 09:21:23 INFO - 'SHLVL': '1', 09:21:23 INFO - 'TERM': 'linux', 09:21:23 INFO - 'TMOUT': '86400', 09:21:23 INFO - 'USER': 'cltbld', 09:21:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:23 INFO - '_': '/tools/buildbot/bin/python'} 09:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:23 INFO - Cleaning up... 09:21:23 INFO - Return code: 0 09:21:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:23 INFO - Using env: {'DISPLAY': ':0', 09:21:23 INFO - 'HOME': '/home/cltbld', 09:21:23 INFO - 'LANG': 'en_US.UTF-8', 09:21:23 INFO - 'LANGUAGE': 'en_US:en', 09:21:23 INFO - 'LOGNAME': 'cltbld', 09:21:23 INFO - 'MAIL': '/var/mail/cltbld', 09:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:23 INFO - 'MOZ_NO_REMOTE': '1', 09:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:23 INFO - 'NO_EM_RESTART': '1', 09:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:23 INFO - 'PWD': '/builds/slave/test', 09:21:23 INFO - 'SHELL': '/bin/bash', 09:21:23 INFO - 'SHLVL': '1', 09:21:23 INFO - 'TERM': 'linux', 09:21:23 INFO - 'TMOUT': '86400', 09:21:23 INFO - 'USER': 'cltbld', 09:21:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:23 INFO - '_': '/tools/buildbot/bin/python'} 09:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:26 INFO - Downloading docopt-0.6.1.tar.gz 09:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:26 INFO - Running setup.py install for blobuploader 09:21:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:26 INFO - Running setup.py install for requests 09:21:26 INFO - Running setup.py install for docopt 09:21:27 INFO - Successfully installed blobuploader requests docopt 09:21:27 INFO - Cleaning up... 09:21:27 INFO - Return code: 0 09:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:27 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:27 INFO - Using env: {'DISPLAY': ':0', 09:21:27 INFO - 'HOME': '/home/cltbld', 09:21:27 INFO - 'LANG': 'en_US.UTF-8', 09:21:27 INFO - 'LANGUAGE': 'en_US:en', 09:21:27 INFO - 'LOGNAME': 'cltbld', 09:21:27 INFO - 'MAIL': '/var/mail/cltbld', 09:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:27 INFO - 'MOZ_NO_REMOTE': '1', 09:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:27 INFO - 'NO_EM_RESTART': '1', 09:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:27 INFO - 'PWD': '/builds/slave/test', 09:21:27 INFO - 'SHELL': '/bin/bash', 09:21:27 INFO - 'SHLVL': '1', 09:21:27 INFO - 'TERM': 'linux', 09:21:27 INFO - 'TMOUT': '86400', 09:21:27 INFO - 'USER': 'cltbld', 09:21:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:27 INFO - '_': '/tools/buildbot/bin/python'} 09:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:27 INFO - Running setup.py (path:/tmp/pip-VtuyOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:27 INFO - Running setup.py (path:/tmp/pip-pkqWep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:27 INFO - Running setup.py (path:/tmp/pip-xy48Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:27 INFO - Running setup.py (path:/tmp/pip-KieAFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:27 INFO - Running setup.py (path:/tmp/pip-65TSQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:27 INFO - Running setup.py (path:/tmp/pip-r_7BXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:27 INFO - Running setup.py (path:/tmp/pip-veT2P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:27 INFO - Running setup.py (path:/tmp/pip-lYc4O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:27 INFO - Running setup.py (path:/tmp/pip-fy7gZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:28 INFO - Running setup.py (path:/tmp/pip-YoEAll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:28 INFO - Running setup.py (path:/tmp/pip-hCX9q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:28 INFO - Running setup.py (path:/tmp/pip-3AxjIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:28 INFO - Running setup.py (path:/tmp/pip-vvRcLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:28 INFO - Running setup.py (path:/tmp/pip-aGfqrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:28 INFO - Running setup.py (path:/tmp/pip-UiYQKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:28 INFO - Running setup.py (path:/tmp/pip-gcDDdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:28 INFO - Running setup.py (path:/tmp/pip-l37fVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:28 INFO - Running setup.py install for manifestparser 09:21:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:28 INFO - Running setup.py install for mozcrash 09:21:28 INFO - Running setup.py install for mozdebug 09:21:28 INFO - Running setup.py install for mozdevice 09:21:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozfile 09:21:29 INFO - Running setup.py install for mozhttpd 09:21:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozinfo 09:21:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozInstall 09:21:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozleak 09:21:29 INFO - Running setup.py install for mozlog 09:21:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for moznetwork 09:21:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozprocess 09:21:29 INFO - Running setup.py install for mozprofile 09:21:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:29 INFO - Running setup.py install for mozrunner 09:21:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:30 INFO - Running setup.py install for mozscreenshot 09:21:30 INFO - Running setup.py install for moztest 09:21:30 INFO - Running setup.py install for mozversion 09:21:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:30 INFO - Cleaning up... 09:21:30 INFO - Return code: 0 09:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:30 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:30 INFO - Using env: {'DISPLAY': ':0', 09:21:30 INFO - 'HOME': '/home/cltbld', 09:21:30 INFO - 'LANG': 'en_US.UTF-8', 09:21:30 INFO - 'LANGUAGE': 'en_US:en', 09:21:30 INFO - 'LOGNAME': 'cltbld', 09:21:30 INFO - 'MAIL': '/var/mail/cltbld', 09:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:30 INFO - 'MOZ_NO_REMOTE': '1', 09:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:30 INFO - 'NO_EM_RESTART': '1', 09:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:30 INFO - 'PWD': '/builds/slave/test', 09:21:30 INFO - 'SHELL': '/bin/bash', 09:21:30 INFO - 'SHLVL': '1', 09:21:30 INFO - 'TERM': 'linux', 09:21:30 INFO - 'TMOUT': '86400', 09:21:30 INFO - 'USER': 'cltbld', 09:21:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:30 INFO - '_': '/tools/buildbot/bin/python'} 09:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:30 INFO - Running setup.py (path:/tmp/pip-cfktpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:30 INFO - Running setup.py (path:/tmp/pip-g29o2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:30 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)) 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:30 INFO - Running setup.py (path:/tmp/pip-lmhzCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:30 INFO - Running setup.py (path:/tmp/pip-U043R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:30 INFO - Running setup.py (path:/tmp/pip-CEnMSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:30 INFO - Running setup.py (path:/tmp/pip-EeZucE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:31 INFO - Running setup.py (path:/tmp/pip-4z1rZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:31 INFO - Running setup.py (path:/tmp/pip-BZcKf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:31 INFO - Running setup.py (path:/tmp/pip-BwTBWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:31 INFO - Running setup.py (path:/tmp/pip-jQ7pCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:31 INFO - Running setup.py (path:/tmp/pip-dFjI7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:31 INFO - Running setup.py (path:/tmp/pip-gdtgsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:31 INFO - Running setup.py (path:/tmp/pip-mMJIGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:31 INFO - Running setup.py (path:/tmp/pip-fP9COr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:31 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)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:31 INFO - Running setup.py (path:/tmp/pip-O0I2HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:31 INFO - Running setup.py (path:/tmp/pip-YJboIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:31 INFO - Running setup.py (path:/tmp/pip-7WgMMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:21:31 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)) 09:21:31 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)) 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:33 INFO - Downloading blessings-1.6.tar.gz 09:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:33 INFO - Installing collected packages: blessings 09:21:33 INFO - Running setup.py install for blessings 09:21:34 INFO - Successfully installed blessings 09:21:34 INFO - Cleaning up... 09:21:34 INFO - Return code: 0 09:21:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:34 INFO - Reading from file tmpfile_stdout 09:21:34 INFO - Current package versions: 09:21:34 INFO - argparse == 1.2.1 09:21:34 INFO - blessings == 1.6 09:21:34 INFO - blobuploader == 1.2.4 09:21:34 INFO - docopt == 0.6.1 09:21:34 INFO - functools32 == 3.2.3-2 09:21:34 INFO - jsonschema == 2.5.1 09:21:34 INFO - manifestparser == 1.1 09:21:34 INFO - mozInstall == 1.12 09:21:34 INFO - mozcrash == 1.0 09:21:34 INFO - mozdebug == 0.1 09:21:34 INFO - mozdevice == 0.48 09:21:34 INFO - mozfile == 1.2 09:21:34 INFO - mozhttpd == 0.7 09:21:34 INFO - mozinfo == 0.9 09:21:34 INFO - mozleak == 0.1 09:21:34 INFO - mozlog == 3.4 09:21:34 INFO - moznetwork == 0.27 09:21:34 INFO - mozprocess == 0.23 09:21:34 INFO - mozprofile == 0.28 09:21:34 INFO - mozrunner == 6.13 09:21:34 INFO - mozscreenshot == 0.1 09:21:34 INFO - mozsystemmonitor == 0.3 09:21:34 INFO - moztest == 0.8 09:21:34 INFO - mozversion == 1.4 09:21:34 INFO - psutil == 3.1.1 09:21:34 INFO - requests == 1.2.3 09:21:34 INFO - wsgiref == 0.1.2 09:21:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 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 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:34 INFO - Using env: {'DISPLAY': ':0', 09:21:34 INFO - 'HOME': '/home/cltbld', 09:21:34 INFO - 'LANG': 'en_US.UTF-8', 09:21:34 INFO - 'LANGUAGE': 'en_US:en', 09:21:34 INFO - 'LOGNAME': 'cltbld', 09:21:34 INFO - 'MAIL': '/var/mail/cltbld', 09:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:34 INFO - 'MOZ_NO_REMOTE': '1', 09:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:34 INFO - 'NO_EM_RESTART': '1', 09:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:34 INFO - 'PWD': '/builds/slave/test', 09:21:34 INFO - 'SHELL': '/bin/bash', 09:21:34 INFO - 'SHLVL': '1', 09:21:34 INFO - 'TERM': 'linux', 09:21:34 INFO - 'TMOUT': '86400', 09:21:34 INFO - 'USER': 'cltbld', 09:21:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:34 INFO - '_': '/tools/buildbot/bin/python'} 09:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:34 INFO - Cleaning up... 09:21:34 INFO - Return code: 0 09:21:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67b931ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:34 INFO - Using env: {'DISPLAY': ':0', 09:21:34 INFO - 'HOME': '/home/cltbld', 09:21:34 INFO - 'LANG': 'en_US.UTF-8', 09:21:34 INFO - 'LANGUAGE': 'en_US:en', 09:21:34 INFO - 'LOGNAME': 'cltbld', 09:21:34 INFO - 'MAIL': '/var/mail/cltbld', 09:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:34 INFO - 'MOZ_NO_REMOTE': '1', 09:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:34 INFO - 'NO_EM_RESTART': '1', 09:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:34 INFO - 'PWD': '/builds/slave/test', 09:21:34 INFO - 'SHELL': '/bin/bash', 09:21:34 INFO - 'SHLVL': '1', 09:21:34 INFO - 'TERM': 'linux', 09:21:34 INFO - 'TMOUT': '86400', 09:21:34 INFO - 'USER': 'cltbld', 09:21:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:34 INFO - '_': '/tools/buildbot/bin/python'} 09:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:34 INFO - Cleaning up... 09:21:34 INFO - Return code: 0 09:21:34 INFO - Running post-action listener: _resource_record_post_action 09:21:34 INFO - Running post-action listener: _start_resource_monitoring 09:21:34 INFO - Starting resource monitoring. 09:21:34 INFO - [mozharness: 2017-01-12 17:21:34.853251Z] Finished create-virtualenv step (success) 09:21:34 INFO - [mozharness: 2017-01-12 17:21:34.853711Z] Running install step. 09:21:34 INFO - Running pre-action listener: _resource_record_pre_action 09:21:34 INFO - Running main action method: install 09:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:35 INFO - Reading from file tmpfile_stdout 09:21:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:35 INFO - Reading from file tmpfile_stdout 09:21:35 INFO - Output received: 09:21:35 INFO - Usage: mozinstall [options] installer 09:21:35 INFO - Options: 09:21:35 INFO - -h, --help show this help message and exit 09:21:35 INFO - -d DEST, --destination=DEST 09:21:35 INFO - Directory to install application into. [default: 09:21:35 INFO - "/builds/slave/test"] 09:21:35 INFO - --app=APP Application being installed. [default: firefox] 09:21:35 INFO - mkdir: /builds/slave/test/build/application 09:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:21:51 INFO - Reading from file tmpfile_stdout 09:21:51 INFO - Output received: 09:21:51 INFO - /builds/slave/test/build/application/firefox/firefox 09:21:51 INFO - Running post-action listener: _resource_record_post_action 09:21:51 INFO - [mozharness: 2017-01-12 17:21:51.101184Z] Finished install step (success) 09:21:51 INFO - [mozharness: 2017-01-12 17:21:51.101428Z] Running run-tests step. 09:21:51 INFO - Running pre-action listener: _resource_record_pre_action 09:21:51 INFO - Running main action method: run_tests 09:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:51 INFO - Python 2.7.3 09:21:51 INFO - Return code: 0 09:21:51 INFO - grabbing minidump binary from tooltool 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:51 INFO - 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 0x2569f60>, '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 0x256ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:21:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:21:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:21:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:51 INFO - Return code: 0 09:21:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:21:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:21:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:21:51 INFO - mozversion application_buildid: 20170112072417 09:21:51 INFO - mozversion application_changeset: 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 09:21:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:21:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:51 INFO - mozversion application_name: Firefox 09:21:51 INFO - mozversion application_remotingname: firefox-dev 09:21:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:21:51 INFO - mozversion application_vendor: Mozilla 09:21:51 INFO - mozversion application_version: 52.0a2 09:21:51 INFO - mozversion platform_buildid: 20170112072417 09:21:51 INFO - mozversion platform_changeset: 6a7701e2bb8ea480c6001069f0f04c938a2d4e53 09:21:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:21:51 INFO - mozversion platform_version: 52.0a2 09:21:51 INFO - using testdate: 1484241711 09:21:51 INFO - actual date: 1484241711 09:21:51 INFO - starting webserver on 'localhost:51415' 09:21:51 INFO - SUITE-START | Running 2 tests 09:21:51 INFO - TEST-START | dromaeo_css 09:21:51 INFO - operating with platform_type : linux_ 09:21:51 INFO - Initialising browser for dromaeo_css test... 09:21:51 INFO - TEST-INFO | started process 8843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFuUYx/profile http://localhost:51415/getInfo.html) 09:21:55 INFO - PROCESS | 8843 | __metrics Screen width/height:1600/1200 09:21:55 INFO - PROCESS | 8843 | colorDepth:24 09:21:55 INFO - PROCESS | 8843 | Browser inner width/height: 1024/697 09:21:55 INFO - PROCESS | 8843 | __metrics 09:21:55 INFO - PROCESS | 8843 | 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" 09:21:55 INFO - PROCESS | 8843 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:56 INFO - PROCESS | 8843 | console.error: PushService: 09:21:56 INFO - PROCESS | 8843 | stateChangeProcessEnqueue: Error transitioning state 09:21:56 INFO - PROCESS | 8843 | UnknownError 09:21:56 INFO - TEST-INFO | 8843: exit 0 09:21:56 INFO - Browser initialized. 09:21:56 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:56 INFO - TEST-INFO | started process 8936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFuUYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:08 INFO - PROCESS | 8936 | RSS: Main: 146751488 09:22:08 INFO - PROCESS | 8936 | 09:25:09 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51415/tests/dromaeo/cssquery-ext.html) 09:25:11 INFO - PROCESS | 8936 | RSS: Main: 289824768 09:25:11 INFO - PROCESS | 8936 | 09:28:13 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-ext.html (next: http://localhost:51415/tests/dromaeo/cssquery-jquery.html) 09:28:14 INFO - PROCESS | 8936 | RSS: Main: 223776768 09:28:14 INFO - PROCESS | 8936 | 09:31:16 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51415/tests/dromaeo/cssquery-mootools.html) 09:31:16 INFO - PROCESS | 8936 | RSS: Main: 220577792 09:31:16 INFO - PROCESS | 8936 | 09:34:18 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51415/tests/dromaeo/cssquery-prototype.html) 09:34:19 INFO - PROCESS | 8936 | RSS: Main: 172994560 09:34:19 INFO - PROCESS | 8936 | 09:37:21 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51415/tests/dromaeo/cssquery-yui.html) 09:37:22 INFO - PROCESS | 8936 | RSS: Main: 176525312 09:37:22 INFO - PROCESS | 8936 | 09:40:24 INFO - PROCESS | 8936 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-yui.html (next: http://localhost:51415/tests/dromaeo/cssquery-dojo.html) 09:40:25 INFO - PROCESS | 8936 | RSS: Main: 265211904 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | __start_tp_report 09:40:25 INFO - PROCESS | 8936 | _x_x_mozilla_page_load 09:40:25 INFO - PROCESS | 8936 | _x_x_mozilla_page_load_details 09:40:25 INFO - PROCESS | 8936 | |i|pagename|runs| 09:40:25 INFO - PROCESS | 8936 | |0;dojo.html;3230;3254.723348515376;3257.576515053044;3272.247383101888;3297.7032067113955;5633.4648208420185;5640.633358831673;5653.8586535336535;5680.346760122577;5685.3461851887;5665.716714164296;5720.456556627124;5735.598508104435;5736.741846616902;5782.392848750873;5091.618128640348;5100.209467532529;5121.590272778188;5152.742362881841;5175.870603234912;5002.24966255061;5006.4492905780335;5068.5438310552045;5216.9478305217035;5252.894942101156;5127.564157046656;5214.713190774506;5220.634555581111;5232.790688372461;5238.476152384769;5226.242194881759;5241.318628578299;5243.10867152585;5250.159974404115;5270.5520030797425;4985.252212168168;5008.974955125201;5019.67372120811;5128.564072053842;5128.923066153973;5538.529225015878;5543.944560554383;5555.638883472561;5640.435956404368;5723.055695810186;6056.364081771439;6093.268807743055;6096.268447786249;6112.113743507167;6112.358202388774;5959.10613407988;6025.15647809307;6160.815175544741;6163.383661633846;6167.784127555559;5639.069553523664;5685.431456854323;5703.486686198221;5710.7430165642645;5729.455701708331;6253.3121356651645;6260.906086408708;6262.5929314594405;6264.248290205204;6264.279607845065;5890.204822349014;5946.643201407929;6030.969845150747;6038.547108966845;6045.667488288186;6047.3045599755715;6128.4790792783115;6133;6134.631922084689;6135.447809697149;5985.491233245136;6041.72812223451;6059.454649081604;6104;6110.409184516063;6048.637081775019;6107.541934354941;6107.969460152671;6122.785702500391;6141.324454310023;4679.976600116977;4683.2038553446;4686.343911852344;4697.224957881911;4705.7411842349;4074.124063326399;4102.220578090153;4130.091379896418;4138.13099249161;4163.791810409528;5723.7996670116345;5734.741936612862;5734.799282025109;5739.053056245756;5765.279340082489;6080.9391906081255;6136.478399336106;6138.171346868205;6141.785037523665;6154.261488621394;5566.526845218121;5619.381867994517;5619.438056194348;5719.513841323451;5740.885182296331;5177.430482646906;5222.8955420892125;5226.163813789852;5244.895102097937;5254.369475662945;6203.2556093269095;6205.28639206488;6213.409726076015;6215.098810672427;6220.409061139275;5948.583599148018;6014.36849130835;6096.268447786294;6097.390260973867;6103.908441373472;6132.540059495466;6146.938530614815;6149.108379284889;6225.8132256032395;6227;5965.135055417027;5979.252593425822;5980.162777211281;5981.820545383645;5983.9401605983385;5930.05119180929;6048.7278072487725;6125.908111378244;6134.263888333428;6136.754529818757;5841.678707671119;5898.793542226002;5956.076808094752;5991.580589358878;6091.1472393864005;6042.395760423922;6044.667543284985;6046.2139921809885;6046.365131661112;6049.848753781191;6004.789832355847;6009.579329446897;6012.729427175875;6014.909776353271;6021.277446706248;5836.387179346108;5883.911741323798;5918;5931.970340148272;6003.8198854034445;5908.527317814651;5918.585699001029;5924.674142922181;5927.436893495111;5939.138824870456 09:40:25 INFO - PROCESS | 8936 | |1;ext.html;572.9828105156847;624.5316012990256;654.4633400611499;668.1047396488701;686.0361192524505;33487.66512334876;36635.26729465409;36636.26727465456;36667.26665466692;36691.26617467652;36210.456843147374;45088.77455612717;46067.53932460675;46148;49966.250506242344;8669.089745576703;8790.736277911641;8792.736217913442;8795.428297160664;8800.383973121883;8716.694915677952;8829.426087304304;8832.911670883273;8834.425762325429;8836.381453298272;8274.2139496748;8456.238938495535;10408.115310198604;10664.62673806417;10670.573177072907;10474.109700675452;10513.106385957202;10547.156227501782;10549.47252637365;10550;10541.15670746346;10591.788164236672;10605.416702081382;10610.787784244349;10613.363198208132;42460.363094553606;42638.786806066084;42654.36018459726;42834;42904.57095429037;3818.828152733106;3907.3162196615763;3993;4214.894627634303;4337.7397356158735;32497.51253731196;32741.18147046319;32819.67180328214;32962.83518582392;33032.33935321304;4493.505714371417;4506.233940230169;4562.6121779648765;4597.7011494252765;4615.984483413644;340763;342159;344298;344397.9999999975;345128;61116.38883611107;61635;61637.38362616406;61709.69145154335;61719;39087.80456097758;63667;63973;63986;64054.03918941219;17549.824501754818;18662.906685466485;18663.346782862536;18692.25230990745;18704;14352.210628415538;14460;14462;14464.638384040483;14466;18031.909840450713;18508.907455462904;19945.60108797816;20111.39665810028;20183.192672292942;7164.889442136478;7234.674439650228;7269.600171990592;7505.686504861627;7808.2609282177555;1011.3881101933224;1026.7946410717736;1112.1547623805966;1137.2039572299423;1191.803352446854;33475.66524334774;33720.32559348848;33868.83065584656;33985.49021764676;34276.31447371039;1169.216624861328;1182.7811854806716;1185.9229150105389;1231.4027696567157;1253.129075292663;14935.399225290515;17919.46241612754;18446.451509714127;19074.33239836599;19115.426537203904;573533;583263;583682;584860;586565;54738;56062.43937560654;56081.71959140178;60391.69804150951;61402.38597614056;1386.4869998100567;1442.7691569349063;1445.8120444342378;1447.2185020089034;1450.7461194290956;32661;34225.48661770125;34261.43039272015;34572.82713586416;34680.82659586787;52270;52829.471705282456;52872.73563632157;52911.73544132255;52939.47060529499;501116;503420;506018;527548;530165;45261;45773.31340029969;46052.7697361511;46290.53709462862;46536.53463465458;49204;49497;49546.50453495419;49758.50241497539;50886.74556627193;41681;43065.569344306154;43323;43375;43762.34356484591;42066.789666051474;42451.3632295522;43457.13085738204;43685.78157109194;43953.56046439495;42486.57513424826;43148.78425607852;43558.782206090036;44068.77965610151;44142.33786493269;35105.82447087748;38022.429663555624;38208.617913820504;38367.42448863213;39449.40825887556;28933.42133157367;29499.55750663699;29624;29640;29656.55515167231 09:40:25 INFO - PROCESS | 8936 | |2;jquery.html;390.4728616367905;410.20010978591756;417.25728203797235;418.516613311625;431.48868590719997;15778.447754328601;19658.508537286576;19726.704099438484;19749.506262343413;19759.308424205174;13071.477140914352;13906.096103753249;13917;15963.92018039911;20443.897780511114;5253.789848406059;5522.502974732273;5528.944710552903;5536.833894983157;5541.085720856054;5135.64050516464;5445.754941027663;5463.399026107145;5464.153056276264;5467.261919640857;5452.945470545284;5463.31708536433;5463.890722185554;5470.589705772063;5472.534834539069;5274.604404669646;5438.7280635968245;5460.672359658433;5467.343918729778;5467.589930755209;5158.303629010074;5326.414094449608;5328.387235467932;5329.840104796824;5336.813211537577;19962.30131945375;20326.186952521883;20328.593428131502;21980.450488737748;23491;2493.127405408111;2697.3796026913724;2752.9587056194173;2754.476649436621;2875.7411832934927;10902.781944361068;11221.326720396803;11224.943875280653;13214.603561893158;15598.610034749108;1978.8021197880241;1983.1571582077559;2014.0735261779598;2025.3113941259894;2091.7385326834146;71857;86492.56753716191;87200.12799871984;87592.56203719004;87727;11695.298282103102;11780.410979450993;11891.227070240408;12017.098717596215;12304.630861074182;17128;17162.656746864992;17163.570910727332;17167.399141030004;17167.828321716872;8536.957315213383;8631.913680863237;9022.323325750594;9022.548872556346;9069.274458043472;7917.089534703583;7929.48458350217;8119.878201826978;8132.186781321939;8141.185881411811;4903.068417000758;5046.369203849519;5153.948460515347;5241.554467870197;5319.015982043257;2063.5769667218183;2120.9469763255734;2175.8368122390884;2187.824974002076;2201.482651576878;918.7978644698155;941.3692825806726;952.8570714392896;967.3180407812616;1042.9791404171874;18960.81039189618;20382.337506559652;20768.48078798012;20778.168873245202;20789.376318710463;1041.5573381313063;1041.5677493840124;1057.9153667706564;1060.3849767135043;1062.697131317571;10744.570217191225;11248.550057997752;11484.368359740127;11541.653750387502;11617.593384231512;378173;382404;387045;486514;490217;69090.30909690939;101785;103270;105414.47292763487;109691;968.1625394034251;982.5185659027026;1016.425719468498;1052.9789404212027;1055.3245922609535;18138.81861181424;18213.81786182121;18386.632267354846;18507.35224267144;19005.049747512294;38272.61727382691;47206.527934720216;47224.7638761804;47262.76368618273;47526.52473475221;64465.67767161134;65229;65824;66983.66508167428;67107.66446167933;8610.741677749678;8747.518886461306;8840.867386989072;8934.28525717928;9131.086891310815;11856.407179641155;13000.414981325674;13280.867191328349;13481.32593370308;13498.392572334073;11954.10344224204;12110.515579376726;12185.390730463265;12300.876991229974;12517.374131293216;11190.048845848194;11511.654650360502;12025.939870300592;12047.759044818878;12085.456154473246;11582.42087895585;12159.81760273579;12160.331181785086;12193.390330483619;12255.632331030083;8578.91421085781;8862.955685221532;8915.55422228873;8916.465012099296;8999.775005624912;10380.532876020749;11881.5841445549;12070.336131512851;12181.573644922386;12314.876851231373 09:40:25 INFO - PROCESS | 8936 | |3;mootools.html;1419.0917812599944;1479.73364794337;1488.7915691803146;1675.1456757053907;1840.677881370759;7965.123836378001;8746.300295976322;9081.455112693227;9108.089191080888;9281.860772088425;9125.087491250872;9199.724008279762;9204.769880752985;9206.033366496506;9222.953885230581;2572.318335641057;2594.15689900783;2607.8565678887653;2610.8172427930053;2615.215435369391;2504.4365017871014;2565.307367010906;2570.691517017951;2574.806889483287;2576.780973617245;2495.089292408267;2512.874356282188;2513.4973005398992;2513.8114641401876;2522.382016405983;2404.663347131403;2438.9146379876797;2458.766417190373;2466.48203877186;2467.0501856785086;2472.4560596668885;2495.1142344467817;2502.962455563168;2509.2597683683357;2513.5852584323566;8932.910670893272;8985.415947963362;9189.908100918972;9212.723618291462;9232.8615070774;5646.632968857011;5798.507126894219;5812.099124635688;5815.21494598228;5816.243888294494;3572.3034008368377;3658.890233292979;3691;3721.7580857244193;3745.0450135215347;1161.2451906260912;1164.4003338280793;1192.0582739635677;1198.2690558759236;1230.5139469909425;12664.303463309514;12811.103222774409;12853.807192892114;12867.485300587965;12888.226706397647;4824.155772739757;4881.560659540658;4903.975480122648;4908.337374454474;5016.949830501721;10158.339707918962;10159.187265018782;10168.28821982469;10172.389656620626;10217.795644087077;5663.773449061991;5676.545876329884;5684.431556844283;5688.23208866806;5688.5733569981585;4493.236149854532;4645.767711614473;4783.162946484351;5221.347331583552;5287.894242115213;4131.892734705262;4187.309093999456;4229.365595160751;4274.059706864485;4304.203722311382;1280.155097635556;1318.762622727899;1327.0710502648185;1329.9069065165538;1338.0499845109887;925.1349987761464;978.2516374973151;1006.4213077480478;1007.1238022920106;1012.5342342522375;6030.849228769316;6300.432961033529;6356.336123213862;6610.3720146586;6648.03603477493;491.7688686317425;492.58130588999063;510.67572091722025;513.4813838023548;515.0523037610814;4453.532379100213;4499.122671079108;4526.072155208174;4543.840965566189;4565.292379681155;11027.724306892393;11369.488373023234;11464.541418343173;11530.962213400835;11545.076393888468;10526.578936842594;11483.311001339946;11489.827652585218;11504.482298296596;11515.272709093702;8350.206730360605;8736.213740763362;8748.212660860552;8748.912510874938;8762.299016078698;6414.61512309263;6435.292117867125;6477.255115661759;6566.606003639797;6697.464202863662;10433.165346772088;10504.159667226757;10504.947475262576;10553.261271710906;10581.36511809294;9321.953390233277;9657.082577155159;9934.354266972623;10038.949805250926;10363.11913487332;7380.225076366904;7404.888926666212;7441.776746697607;7452.254774522505;7453.850922981618;8682.131786821268;8744.562771861509;8764.561771911507;8766.474011559327;8766.736997890073;8023.318017968538;8058.274755272054;8076.030876294647;8154.2253485918745;8227.053888802624;7572.924270757222;7607.648373479016;7676.232376762502;7862.803429914298;8180.550069746221;7514.9624251878395;7521.887171692539;7539.886901696369;7581.469297149147;7614.695412183451;5453.809116680897;5521.503064724194;5653.717314134359;5661.773529058956;5836.708164591669;5468.617196796186;5573.470520300565;5653.632513886584;5791.594588378942;5822.592418530831 09:40:25 INFO - PROCESS | 8936 | |4;prototype.html;347.92693534357784;351.729168540224;354.46298857231284;357.9708338526735;362.7225172742852;5347.278117454142;5363.471410647966;5374.677519348832;5382.596305277105;5393;5257.13257312543;5278.709670968095;5293.947060529394;5298.284731561238;5311.176767601028;4050.2102090092444;4174.812133454002;4204.075103477246;4227.365895115727;4242.469691288589;4171.665067178504;4177.832886684529;4178.749275043492;4179.979100104495;4213.85251516197;4009.7794621295816;4176.853810116647;4183.6653067754505;4215.936760948588;4218.97890510547;4044.5146582410152;4100.118474527976;4142.5857414258635;4161.52142503613;4172.7287726298;3731.4962480065115;3733.925321493582;3743.4571987061995;3746.6253374662588;3756.323861704892;4915.5821755150855;5171.301874246966;5173.5602473789395;5184.507471790174;5191.195364718475;4486.775661216926;4791.089692958327;4832.9275060874115;4835.734034628094;4838.927416088762;5441.211024401479;5493.285872836505;5539.390667026624;5561.332640083176;5564.27664403629;4036.4752582164424;4146.896327591804;4147.29960716108;4162.647139679586;4181.790910454465;5709.115991722721;5714;5726.255586773735;5730.828075157752;5745.339285982123;4243.321068629066;4250.364773840177;4251.171021650748;4255;4264.294282287048;4178.707490475637;4331.566843315706;4331.870043898688;4335.241332766753;4336.609705126553;4812.759362031955;4825.3485779419325;4847.75761211938;4855.975720121377;4863.392075990501;5549.861253468695;5591.496765291144;5636.577256705764;5669.489745922887;5679.971600142056;1360.6122255157234;1446.4214314274163;1462.0861961274204;1467.948621798232;1475.6532214929482;973.7662960889477;988.3476905242505;1007.2445665750687;1008.626808081;1010.2927950434726;5036.471170527115;5140.485951404829;5141.76862041209;5151.201563757623;5173.430922598511;5461.453854614507;5461.481159289861;5468.371137319259;5477.616566840363;5484.698341591251;5029.622778291569;5128.692278463304;5140.537351638296;5170.431252562215;5180.766865491062;2856.728610782014;2904.796664233483;2909.956350654742;2910.039686903317;2911.97088029117;5587.603099225194;5609.439056094439;5612.400465867208;5616.326040875039;5629.241671580896;5494.2857428534835;5562.332520097533;5573.972130139324;5581.469760372758;5593.8321850344555;5549.223108764776;5586.910552442235;5587.597333146705;5592.384837667853;5601.443083641835;5362.410134885082;5481.506664400223;5504.4770746778995;5525.696086715269;5529.419410961791;5707.8858422832145;5720.742566584597;5722.17028530869;5723.456271654186;5731.770729170787;5854.707264636836;5867.735951882261;5878.529717622666;5880.911786323123;5885.61743486672;4010.177913527778;4151.792410379529;4182.330827067654;4197.034682023091;4200.138971510772;5623.8875222496135;5684.640874037228;5693.4875861172695;5705;5719.398568400855;5511.4213007633625;5599.412061733459;5608.467195616573;5609.971950140386;5619.241402410622;5468.207109969112;5501.944980550304;5565.5825813063375;5565.805196818092;5584.692841893735;5514.393416724077;5535.972320138373;5545.112781954868;5548.889022219614;5554.166874968787;5465.508104270635;5567.24842146305;5570.607348162959;5615.507593924762;5617.258649818569;5449.1826226066405;5450.672959622435;5476.972615137058;5478.424765399575;5495.752691128989 09:40:25 INFO - PROCESS | 8936 | |5;yui.html;799.3046049936556;801.414967074036;812.5733989655427;843.9324854011679;869.578254546545;15464.458743943964;15686.294116764744;15996.280167392466;16215.83784162158;16292.348306067757;14364.856351436483;14471.565853024425;14562;14779;14936.103833769981;710.3997122431563;732.3738203835698;845.5560830563942;858.1975852577859;860.0754189246554;826.4215049465369;847.9448835825682;850.2730165708323;851.7742798158492;852.3053711225363;889.4485419040204;891.496304587909;892.0054139634326;893.6693423433338;894.0210469535848;743.22333161846;888.0897080492482;888.2449917570046;889.777555611094;890.3589415620775;561.1386521689187;632.7848531499312;645.1451826330084;646.7574659502686;647.6696884588846;14373.928130359385;14412.135271883615;14424.495142669955;14456.783148252785;14508.564743057725;13989.440422383092;14101.506447274398;14139.787903181461;14372.568822935329;14502.41990320386;12675.176113552681;12712.745745085047;12774.936125319407;12777.552785652457;12975.1566148201;4314.417553630251;4349.543297953701;4375.5405682403525;4423.668224883147;4490.012197316585;58200.417995819924;59577.404225957616;60027.69986150085;65460;65769.01346479806;11668.94165529167;11677.240979336317;11986.460609272604;12027.819582706266;12063.457144428521;20749.377518674464;20868;20902.37292881216;20932.895335523226;21162.576748464944;8876.8668469973;8883.244924181388;8890.777730556658;8904.109589041043;8934.329925255632;4806.038792241496;4921.901561968741;4921.975390123098;4959.231319145538;5047.4952504749235;3824.0822202671156;3943.645071943539;3943.8225279862477;3976.224636195972;4001.679865610744;716.8673795347877;717.5300178383168;718.4432065149551;738.3686947659781;747.2975403121158;698.8672152291049;781.0939310399909;792.18405042806;825.9149357072206;827.0736774812249;9687.467189304656;9929.2056635469;9954.800903981879;9984.950075249722;10177.389356638625;689.021589343134;692.7159864455549;708.2421808664782;709.3403135084421;764.2663043478212;4439.741048228069;4562.270036794163;4655.4180727409075;4881.267809828554;4883.926741098815;82254.58872705718;90845.54577227072;91044;95064;95911;49824.50175498271;51558.74220628873;64007;66710.99933501001;79834.20165798384;72688;72825.53268075222;73000.63499682574;73768.63115684387;74503.62748186225;9296;9363.719088427359;9431.339806213498;9527.571259293487;9541.522923853641;36660.633393665725;37368;40252.59747402606;40992.1801563973;51228.97542049213;48535.75732121317;60140;60587.69706151441;62211;63259.36740632535;12367.381630918238;12385.318807465675;12445.75108497843;12497.187682800952;12575.182613130117;13797.793033104712;14111.858881411055;14191.64520886986;14204.147751134551;14730.926345368205;11237.887621123684;13398.86109680688;13584;13688.726225475633;13733.45066197341;12795.424205910942;13150.408231629408;13375.26436045988;13443.529476468277;14358.928205358907;13681;13825.30873456303;14013;14030.929845350707;14619.12285262845;10987.175961803057;11536.019438347834;11594;12011.897917864513;12119.272843629411;11583.247088939192;12095.092868034757;12104.213226140273;12210.26738395699;12301.831326024014 09:40:25 INFO - PROCESS | 8936 | __end_tp_report 09:40:25 INFO - PROCESS | 8936 | __start_cc_report 09:40:25 INFO - PROCESS | 8936 | _x_x_mozilla_cycle_collect,1386 09:40:25 INFO - PROCESS | 8936 | __end_cc_report 09:40:25 INFO - PROCESS | 8936 | __startTimestamp1484242825202__endTimestamp 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | ------- Summary: start ------- 09:40:25 INFO - PROCESS | 8936 | Number of tests: 6 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#0] dojo.html Cycles:165 Average:5645.98 Median:5918.59 stddev:648.23 (11.0%) stddev-sans-first:621.90 09:40:25 INFO - PROCESS | 8936 | Values: 3230.0 3254.7 3257.6 3272.2 3297.7 5633.5 5640.6 5653.9 5680.3 5685.3 5665.7 5720.5 5735.6 5736.7 5782.4 5091.6 5100.2 5121.6 5152.7 5175.9 5002.2 5006.4 5068.5 5216.9 5252.9 5127.6 5214.7 5220.6 5232.8 5238.5 5226.2 5241.3 5243.1 5250.2 5270.6 4985.3 5009.0 5019.7 5128.6 5128.9 5538.5 5543.9 5555.6 5640.4 5723.1 6056.4 6093.3 6096.3 6112.1 6112.4 5959.1 6025.2 6160.8 6163.4 6167.8 5639.1 5685.4 5703.5 5710.7 5729.5 6253.3 6260.9 6262.6 6264.2 6264.3 5890.2 5946.6 6031.0 6038.5 6045.7 6047.3 6128.5 6133.0 6134.6 6135.4 5985.5 6041.7 6059.5 6104.0 6110.4 6048.6 6107.5 6108.0 6122.8 6141.3 4680.0 4683.2 4686.3 4697.2 4705.7 4074.1 4102.2 4130.1 4138.1 4163.8 5723.8 5734.7 5734.8 5739.1 5765.3 6080.9 6136.5 6138.2 6141.8 6154.3 5566.5 5619.4 5619.4 5719.5 5740.9 5177.4 5222.9 5226.2 5244.9 5254.4 6203.3 6205.3 6213.4 6215.1 6220.4 5948.6 6014.4 6096.3 6097.4 6103.9 6132.5 6146.9 6149.1 6225.8 6227.0 5965.1 5979.3 5980.2 5981.8 5983.9 5930.1 6048.7 6125.9 6134.3 6136.8 5841.7 5898.8 5956.1 5991.6 6091.1 6042.4 6044.7 6046.2 6046.4 6049.8 6004.8 6009.6 6012.7 6014.9 6021.3 5836.4 5883.9 5918.0 5932.0 6003.8 5908.5 5918.6 5924.7 5927.4 5939.1 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#1] ext.html Cycles:180 Average:64616.91 Median:23333.13 stddev:130222.80 (558.1%) stddev-sans-first:130499.33 09:40:25 INFO - PROCESS | 8936 | Values: 573.0 624.5 654.5 668.1 686.0 33487.7 36635.3 36636.3 36667.3 36691.3 36210.5 45088.8 46067.5 46148.0 49966.3 8669.1 8790.7 8792.7 8795.4 8800.4 8716.7 8829.4 8832.9 8834.4 8836.4 8274.2 8456.2 10408.1 10664.6 10670.6 10474.1 10513.1 10547.2 10549.5 10550.0 10541.2 10591.8 10605.4 10610.8 10613.4 42460.4 42638.8 42654.4 42834.0 42904.6 3818.8 3907.3 3993.0 4214.9 4337.7 32497.5 32741.2 32819.7 32962.8 33032.3 4493.5 4506.2 4562.6 4597.7 4616.0 340763.0 342159.0 344298.0 344398.0 345128.0 61116.4 61635.0 61637.4 61709.7 61719.0 39087.8 63667.0 63973.0 63986.0 64054.0 17549.8 18662.9 18663.3 18692.3 18704.0 14352.2 14460.0 14462.0 14464.6 14466.0 18031.9 18508.9 19945.6 20111.4 20183.2 7164.9 7234.7 7269.6 7505.7 7808.3 1011.4 1026.8 1112.2 1137.2 1191.8 33475.7 33720.3 33868.8 33985.5 34276.3 1169.2 1182.8 1185.9 1231.4 1253.1 14935.4 17919.5 18446.5 19074.3 19115.4 573533.0 583263.0 583682.0 584860.0 586565.0 54738.0 56062.4 56081.7 60391.7 61402.4 1386.5 1442.8 1445.8 1447.2 1450.7 32661.0 34225.5 34261.4 34572.8 34680.8 52270.0 52829.5 52872.7 52911.7 52939.5 501116.0 503420.0 506018.0 527548.0 530165.0 45261.0 45773.3 46052.8 46290.5 46536.5 49204.0 49497.0 49546.5 49758.5 50886.7 41681.0 43065.6 43323.0 43375.0 43762.3 42066.8 42451.4 43457.1 43685.8 43953.6 42486.6 43148.8 43558.8 44068.8 44142.3 35105.8 38022.4 38208.6 38367.4 39449.4 28933.4 29499.6 29624.0 29640.0 29656.6 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#2] jquery.html Cycles:180 Average:27876.21 Median:12090.97 stddev:71369.38 (590.3%) stddev-sans-first:71539.75 09:40:25 INFO - PROCESS | 8936 | Values: 390.5 410.2 417.3 418.5 431.5 15778.4 19658.5 19726.7 19749.5 19759.3 13071.5 13906.1 13917.0 15963.9 20443.9 5253.8 5522.5 5528.9 5536.8 5541.1 5135.6 5445.8 5463.4 5464.2 5467.3 5452.9 5463.3 5463.9 5470.6 5472.5 5274.6 5438.7 5460.7 5467.3 5467.6 5158.3 5326.4 5328.4 5329.8 5336.8 19962.3 20326.2 20328.6 21980.5 23491.0 2493.1 2697.4 2753.0 2754.5 2875.7 10902.8 11221.3 11224.9 13214.6 15598.6 1978.8 1983.2 2014.1 2025.3 2091.7 71857.0 86492.6 87200.1 87592.6 87727.0 11695.3 11780.4 11891.2 12017.1 12304.6 17128.0 17162.7 17163.6 17167.4 17167.8 8537.0 8631.9 9022.3 9022.5 9069.3 7917.1 7929.5 8119.9 8132.2 8141.2 4903.1 5046.4 5153.9 5241.6 5319.0 2063.6 2120.9 2175.8 2187.8 2201.5 918.8 941.4 952.9 967.3 1043.0 18960.8 20382.3 20768.5 20778.2 20789.4 1041.6 1041.6 1057.9 1060.4 1062.7 10744.6 11248.6 11484.4 11541.7 11617.6 378173.0 382404.0 387045.0 486514.0 490217.0 69090.3 101785.0 103270.0 105414.5 109691.0 968.2 982.5 1016.4 1053.0 1055.3 18138.8 18213.8 18386.6 18507.4 19005.0 38272.6 47206.5 47224.8 47262.8 47526.5 64465.7 65229.0 65824.0 66983.7 67107.7 8610.7 8747.5 8840.9 8934.3 9131.1 11856.4 13000.4 13280.9 13481.3 13498.4 11954.1 12110.5 12185.4 12300.9 12517.4 11190.0 11511.7 12025.9 12047.8 12085.5 11582.4 12159.8 12160.3 12193.4 12255.6 8578.9 8863.0 8915.6 8916.5 8999.8 10380.5 11881.6 12070.3 12181.6 12314.9 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#3] mootools.html Cycles:180 Average:6042.96 Median:4906.16 stddev:3368.46 (68.7%) stddev-sans-first:3359.98 09:40:25 INFO - PROCESS | 8936 | Values: 1419.1 1479.7 1488.8 1675.1 1840.7 7965.1 8746.3 9081.5 9108.1 9281.9 9125.1 9199.7 9204.8 9206.0 9223.0 2572.3 2594.2 2607.9 2610.8 2615.2 2504.4 2565.3 2570.7 2574.8 2576.8 2495.1 2512.9 2513.5 2513.8 2522.4 2404.7 2438.9 2458.8 2466.5 2467.1 2472.5 2495.1 2503.0 2509.3 2513.6 8932.9 8985.4 9189.9 9212.7 9232.9 5646.6 5798.5 5812.1 5815.2 5816.2 3572.3 3658.9 3691.0 3721.8 3745.0 1161.2 1164.4 1192.1 1198.3 1230.5 12664.3 12811.1 12853.8 12867.5 12888.2 4824.2 4881.6 4904.0 4908.3 5016.9 10158.3 10159.2 10168.3 10172.4 10217.8 5663.8 5676.5 5684.4 5688.2 5688.6 4493.2 4645.8 4783.2 5221.3 5287.9 4131.9 4187.3 4229.4 4274.1 4304.2 1280.2 1318.8 1327.1 1329.9 1338.0 925.1 978.3 1006.4 1007.1 1012.5 6030.8 6300.4 6356.3 6610.4 6648.0 491.8 492.6 510.7 513.5 515.1 4453.5 4499.1 4526.1 4543.8 4565.3 11027.7 11369.5 11464.5 11531.0 11545.1 10526.6 11483.3 11489.8 11504.5 11515.3 8350.2 8736.2 8748.2 8748.9 8762.3 6414.6 6435.3 6477.3 6566.6 6697.5 10433.2 10504.2 10504.9 10553.3 10581.4 9322.0 9657.1 9934.4 10038.9 10363.1 7380.2 7404.9 7441.8 7452.3 7453.9 8682.1 8744.6 8764.6 8766.5 8766.7 8023.3 8058.3 8076.0 8154.2 8227.1 7572.9 7607.6 7676.2 7862.8 8180.6 7515.0 7521.9 7539.9 7581.5 7614.7 5453.8 5521.5 5653.7 5661.8 5836.7 5468.6 5573.5 5653.6 5791.6 5822.6 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#4] prototype.html Cycles:180 Average:4670.29 Median:5296.12 stddev:1336.95 (25.2%) stddev-sans-first:1300.74 09:40:25 INFO - PROCESS | 8936 | Values: 347.9 351.7 354.5 358.0 362.7 5347.3 5363.5 5374.7 5382.6 5393.0 5257.1 5278.7 5293.9 5298.3 5311.2 4050.2 4174.8 4204.1 4227.4 4242.5 4171.7 4177.8 4178.7 4180.0 4213.9 4009.8 4176.9 4183.7 4215.9 4219.0 4044.5 4100.1 4142.6 4161.5 4172.7 3731.5 3733.9 3743.5 3746.6 3756.3 4915.6 5171.3 5173.6 5184.5 5191.2 4486.8 4791.1 4832.9 4835.7 4838.9 5441.2 5493.3 5539.4 5561.3 5564.3 4036.5 4146.9 4147.3 4162.6 4181.8 5709.1 5714.0 5726.3 5730.8 5745.3 4243.3 4250.4 4251.2 4255.0 4264.3 4178.7 4331.6 4331.9 4335.2 4336.6 4812.8 4825.3 4847.8 4856.0 4863.4 5549.9 5591.5 5636.6 5669.5 5680.0 1360.6 1446.4 1462.1 1467.9 1475.7 973.8 988.3 1007.2 1008.6 1010.3 5036.5 5140.5 5141.8 5151.2 5173.4 5461.5 5461.5 5468.4 5477.6 5484.7 5029.6 5128.7 5140.5 5170.4 5180.8 2856.7 2904.8 2910.0 2910.0 2912.0 5587.6 5609.4 5612.4 5616.3 5629.2 5494.3 5562.3 5574.0 5581.5 5593.8 5549.2 5586.9 5587.6 5592.4 5601.4 5362.4 5481.5 5504.5 5525.7 5529.4 5707.9 5720.7 5722.2 5723.5 5731.8 5854.7 5867.7 5878.5 5880.9 5885.6 4010.2 4151.8 4182.3 4197.0 4200.1 5623.9 5684.6 5693.5 5705.0 5719.4 5511.4 5599.4 5608.5 5610.0 5619.2 5468.2 5501.9 5565.6 5565.8 5584.7 5514.4 5536.0 5545.1 5548.9 5554.2 5465.5 5567.2 5570.6 5615.5 5617.3 5449.2 5450.7 5477.0 5478.4 5495.8 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - PROCESS | 8936 | [#5] yui.html Cycles:180 Average:17718.84 Median:4882.60 stddev:22812.45 (467.2%) stddev-sans-first:22841.07 09:40:25 INFO - PROCESS | 8936 | Values: 799.3 801.4 812.6 843.9 869.6 15464.5 15686.3 15996.3 16215.8 16292.3 14364.9 14471.6 14562.0 14779.0 14936.1 710.4 732.4 845.6 858.2 860.1 826.4 847.9 850.3 851.8 852.3 889.4 891.5 892.0 893.7 894.0 743.2 888.1 888.2 889.8 890.4 561.1 632.8 645.1 646.8 647.7 14373.9 14412.1 14424.5 14456.8 14508.6 13989.4 14101.5 14139.8 14372.6 14502.4 12675.2 12712.7 12774.9 12777.6 12975.2 4314.4 4349.5 4375.5 4423.7 4490.0 58200.4 59577.4 60027.7 65460.0 65769.0 11668.9 11677.2 11986.5 12027.8 12063.5 20749.4 20868.0 20902.4 20932.9 21162.6 8876.9 8883.2 8890.8 8904.1 8934.3 4806.0 4921.9 4922.0 4959.2 5047.5 3824.1 3943.6 3943.8 3976.2 4001.7 716.9 717.5 718.4 738.4 747.3 698.9 781.1 792.2 825.9 827.1 9687.5 9929.2 9954.8 9985.0 10177.4 689.0 692.7 708.2 709.3 764.3 4439.7 4562.3 4655.4 4881.3 4883.9 82254.6 90845.5 91044.0 95064.0 95911.0 49824.5 51558.7 64007.0 66711.0 79834.2 72688.0 72825.5 73000.6 73768.6 74503.6 9296.0 9363.7 9431.3 9527.6 9541.5 36660.6 37368.0 40252.6 40992.2 51229.0 48535.8 60140.0 60587.7 62211.0 63259.4 12367.4 12385.3 12445.8 12497.2 12575.2 13797.8 14111.9 14191.6 14204.1 14730.9 11237.9 13398.9 13584.0 13688.7 13733.5 12795.4 13150.4 13375.3 13443.5 14358.9 13681.0 13825.3 14013.0 14030.9 14619.1 10987.2 11536.0 11594.0 12011.9 12119.3 11583.2 12095.1 12104.2 12210.3 12301.8 09:40:25 INFO - PROCESS | 8936 | -------- Summary: end -------- 09:40:25 INFO - PROCESS | 8936 | 09:40:25 INFO - TEST-INFO | 8936: exit 0 09:40:25 INFO - TEST-OK | dromaeo_css | took 1114582ms 09:40:25 INFO - TEST-START | kraken 09:40:25 INFO - operating with platform_type : linux_ 09:40:25 INFO - Initialising browser for kraken test... 09:40:25 INFO - TEST-INFO | started process 9249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4uYcp/profile http://localhost:51415/getInfo.html) 09:40:29 INFO - PROCESS | 9249 | __metrics Screen width/height:1600/1200 09:40:29 INFO - PROCESS | 9249 | colorDepth:24 09:40:29 INFO - PROCESS | 9249 | Browser inner width/height: 1024/697 09:40:29 INFO - PROCESS | 9249 | __metrics 09:40:30 INFO - PROCESS | 9249 | 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" 09:40:30 INFO - PROCESS | 9249 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:31 INFO - PROCESS | 9249 | console.error: PushService: 09:40:31 INFO - PROCESS | 9249 | stateChangeProcessEnqueue: Error transitioning state 09:40:31 INFO - PROCESS | 9249 | UnknownError 09:40:31 INFO - TEST-INFO | 9249: exit 0 09:40:31 INFO - Browser initialized. 09:40:31 INFO - Running cycle 1/1 for kraken test... 09:40:31 INFO - TEST-INFO | started process 9342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4uYcp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:43 INFO - PROCESS | 9342 | RSS: Main: 144400384 09:40:43 INFO - PROCESS | 9342 | 09:40:45 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:46 INFO - PROCESS | 9342 | RSS: Main: 185536512 09:40:46 INFO - PROCESS | 9342 | 09:40:49 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-dft) 09:40:49 INFO - PROCESS | 9342 | RSS: Main: 175411200 09:40:49 INFO - PROCESS | 9342 | 09:40:52 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-fft) 09:40:53 INFO - PROCESS | 9342 | RSS: Main: 266301440 09:40:53 INFO - PROCESS | 9342 | 09:40:55 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-oscillator) 09:40:56 INFO - PROCESS | 9342 | RSS: Main: 173129728 09:40:56 INFO - PROCESS | 9342 | 09:40:58 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:58 INFO - PROCESS | 9342 | RSS: Main: 175194112 09:40:58 INFO - PROCESS | 9342 | 09:41:01 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:02 INFO - PROCESS | 9342 | RSS: Main: 213577728 09:41:02 INFO - PROCESS | 9342 | 09:41:05 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:06 INFO - PROCESS | 9342 | RSS: Main: 212856832 09:41:06 INFO - PROCESS | 9342 | 09:41:08 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51415/tests/kraken/driver.html?testName=json-parse-financial) 09:41:09 INFO - PROCESS | 9342 | RSS: Main: 211243008 09:41:09 INFO - PROCESS | 9342 | 09:41:10 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:11 INFO - PROCESS | 9342 | RSS: Main: 173899776 09:41:11 INFO - PROCESS | 9342 | 09:41:13 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:13 INFO - PROCESS | 9342 | RSS: Main: 181178368 09:41:13 INFO - PROCESS | 9342 | 09:41:15 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:16 INFO - PROCESS | 9342 | RSS: Main: 189562880 09:41:16 INFO - PROCESS | 9342 | 09:41:18 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:19 INFO - PROCESS | 9342 | RSS: Main: 199282688 09:41:19 INFO - PROCESS | 9342 | 09:41:22 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:22 INFO - PROCESS | 9342 | RSS: Main: 194830336 09:41:22 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51415/tests/kraken/driver.html?testName=ai-astar) 09:41:24 INFO - PROCESS | 9342 | RSS: Main: 246718464 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | __start_tp_report 09:41:24 INFO - PROCESS | 9342 | _x_x_mozilla_page_load 09:41:24 INFO - PROCESS | 9342 | _x_x_mozilla_page_load_details 09:41:24 INFO - PROCESS | 9342 | |i|pagename|runs| 09:41:24 INFO - PROCESS | 9342 | |0;ai-astar;100;111;109;109;110;110;109;111;111;110 09:41:24 INFO - PROCESS | 9342 | |1;audio-beat-detection;142;119;119;161;124;126;118;121;152;124 09:41:24 INFO - PROCESS | 9342 | |2;audio-dft;161;162;160;160;159;159;160;161;160;159 09:41:24 INFO - PROCESS | 9342 | |3;audio-fft;75;74;76;106;75;75;75;75;111;77 09:41:24 INFO - PROCESS | 9342 | |4;audio-oscillator;82;82;109;81;81;82;99;81;81;118 09:41:24 INFO - PROCESS | 9342 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;117;117;117 09:41:24 INFO - PROCESS | 9342 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;149;146 09:41:24 INFO - PROCESS | 9342 | |7;imaging-desaturate;85;84;84;84;85;85;85;84;84;84 09:41:24 INFO - PROCESS | 9342 | |8;json-parse-financial;50;50;51;51;50;52;51;51;49;50 09:41:24 INFO - PROCESS | 9342 | |9;json-stringify-tinderbox;59;60;60;60;64;59;60;60;60;60 09:41:24 INFO - PROCESS | 9342 | |10;stanford-crypto-aes;74;74;75;73;74;74;74;75;74;82 09:41:24 INFO - PROCESS | 9342 | |11;stanford-crypto-ccm;122;129;120;125;120;127;118;126;176;126 09:41:24 INFO - PROCESS | 9342 | |12;stanford-crypto-pbkdf2;156;152;159;158;151;152;155;156;157;153 09:41:24 INFO - PROCESS | 9342 | |13;stanford-crypto-sha256-iterative;63;62;61;62;62;61;62;60;61;60 09:41:24 INFO - PROCESS | 9342 | __end_tp_report 09:41:24 INFO - PROCESS | 9342 | __start_cc_report 09:41:24 INFO - PROCESS | 9342 | _x_x_mozilla_cycle_collect,1608 09:41:24 INFO - PROCESS | 9342 | __end_cc_report 09:41:24 INFO - PROCESS | 9342 | __startTimestamp1484242884703__endTimestamp 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | ------- Summary: start ------- 09:41:24 INFO - PROCESS | 9342 | Number of tests: 14 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.27 (3.0%) stddev-sans-first:0.87 09:41:24 INFO - PROCESS | 9342 | Values: 100.0 111.0 109.0 109.0 110.0 110.0 109.0 111.0 111.0 110.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:125.00 stddev:15.42 (12.3%) stddev-sans-first:15.80 09:41:24 INFO - PROCESS | 9342 | Values: 142.0 119.0 119.0 161.0 124.0 126.0 118.0 121.0 152.0 124.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 09:41:24 INFO - PROCESS | 9342 | Values: 161.0 162.0 160.0 160.0 159.0 159.0 160.0 161.0 160.0 159.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.09 (18.8%) stddev-sans-first:14.72 09:41:24 INFO - PROCESS | 9342 | Values: 75.0 74.0 76.0 106.0 75.0 75.0 75.0 75.0 111.0 77.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.50 stddev:13.91 (17.1%) stddev-sans-first:14.48 09:41:24 INFO - PROCESS | 9342 | Values: 82.0 82.0 109.0 81.0 81.0 82.0 99.0 81.0 81.0 118.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:41:24 INFO - PROCESS | 9342 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:41:24 INFO - PROCESS | 9342 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 149.0 146.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:41:24 INFO - PROCESS | 9342 | Values: 85.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.85 (1.7%) stddev-sans-first:0.88 09:41:24 INFO - PROCESS | 9342 | Values: 50.0 50.0 51.0 51.0 50.0 52.0 51.0 51.0 49.0 50.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.40 (2.3%) stddev-sans-first:1.41 09:41:24 INFO - PROCESS | 9342 | Values: 59.0 60.0 60.0 60.0 64.0 59.0 60.0 60.0 60.0 60.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.56 (3.5%) stddev-sans-first:2.69 09:41:24 INFO - PROCESS | 9342 | Values: 74.0 74.0 75.0 73.0 74.0 74.0 74.0 75.0 74.0 82.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:126.00 stddev:16.93 (13.4%) stddev-sans-first:17.77 09:41:24 INFO - PROCESS | 9342 | Values: 122.0 129.0 120.0 125.0 120.0 127.0 118.0 126.0 176.0 126.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:156.00 stddev:2.77 (1.8%) stddev-sans-first:2.91 09:41:24 INFO - PROCESS | 9342 | Values: 156.0 152.0 159.0 158.0 151.0 152.0 155.0 156.0 157.0 153.0 09:41:24 INFO - PROCESS | 9342 | 09:41:24 INFO - PROCESS | 9342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:0.83 09:41:24 INFO - PROCESS | 9342 | Values: 63.0 62.0 61.0 62.0 62.0 61.0 62.0 60.0 61.0 60.0 09:41:24 INFO - PROCESS | 9342 | -------- Summary: end -------- 09:41:24 INFO - PROCESS | 9342 | 09:41:25 INFO - TEST-INFO | 9342: exit 0 09:41:25 INFO - TEST-OK | kraken | took 59836ms 09:41:25 INFO - SUITE-END | took 1174s 09:41:25 INFO - Completed test suite (00:19:34) 09:41:25 INFO - javascript benchmark 09:41:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.0, 3254.723348515376, 3257.576515053044, 3272.247383101888, 3297.7032067113955, 5633.4648208420185, 5640.633358831673, 5653.8586535336535, 5680.346760122577, 5685.3461851887, 5665.716714164296, 5720.456556627124, 5735.598508104435, 5736.741846616902, 5782.392848750873, 5091.618128640348, 5100.209467532529, 5121.590272778188, 5152.742362881841, 5175.870603234912, 5002.24966255061, 5006.4492905780335, 5068.5438310552045, 5216.9478305217035, 5252.894942101156, 5127.564157046656, 5214.713190774506, 5220.634555581111, 5232.790688372461, 5238.476152384769, 5226.242194881759, 5241.318628578299, 5243.10867152585, 5250.159974404115, 5270.5520030797425, 4985.252212168168, 5008.974955125201, 5019.67372120811, 5128.564072053842, 5128.923066153973, 5538.529225015878, 5543.944560554383, 5555.638883472561, 5640.435956404368, 5723.055695810186, 6056.364081771439, 6093.268807743055, 6096.268447786249, 6112.113743507167, 6112.358202388774, 5959.10613407988, 6025.15647809307, 6160.815175544741, 6163.383661633846, 6167.784127555559, 5639.069553523664, 5685.431456854323, 5703.486686198221, 5710.7430165642645, 5729.455701708331, 6253.3121356651645, 6260.906086408708, 6262.5929314594405, 6264.248290205204, 6264.279607845065, 5890.204822349014, 5946.643201407929, 6030.969845150747, 6038.547108966845, 6045.667488288186, 6047.3045599755715, 6128.4790792783115, 6133.0, 6134.631922084689, 6135.447809697149, 5985.491233245136, 6041.72812223451, 6059.454649081604, 6104.0, 6110.409184516063, 6048.637081775019, 6107.541934354941, 6107.969460152671, 6122.785702500391, 6141.324454310023, 4679.976600116977, 4683.2038553446, 4686.343911852344, 4697.224957881911, 4705.7411842349, 4074.124063326399, 4102.220578090153, 4130.091379896418, 4138.13099249161, 4163.791810409528, 5723.7996670116345, 5734.741936612862, 5734.799282025109, 5739.053056245756, 5765.279340082489, 6080.9391906081255, 6136.478399336106, 6138.171346868205, 6141.785037523665, 6154.261488621394, 5566.526845218121, 5619.381867994517, 5619.438056194348, 5719.513841323451, 5740.885182296331, 5177.430482646906, 5222.8955420892125, 5226.163813789852, 5244.895102097937, 5254.369475662945, 6203.2556093269095, 6205.28639206488, 6213.409726076015, 6215.098810672427, 6220.409061139275, 5948.583599148018, 6014.36849130835, 6096.268447786294, 6097.390260973867, 6103.908441373472, 6132.540059495466, 6146.938530614815, 6149.108379284889, 6225.8132256032395, 6227.0, 5965.135055417027, 5979.252593425822, 5980.162777211281, 5981.820545383645, 5983.9401605983385, 5930.05119180929, 6048.7278072487725, 6125.908111378244, 6134.263888333428, 6136.754529818757, 5841.678707671119, 5898.793542226002, 5956.076808094752, 5991.580589358878, 6091.1472393864005, 6042.395760423922, 6044.667543284985, 6046.2139921809885, 6046.365131661112, 6049.848753781191, 6004.789832355847, 6009.579329446897, 6012.729427175875, 6014.909776353271, 6021.277446706248, 5836.387179346108, 5883.911741323798, 5918.0, 5931.970340148272, 6003.8198854034445, 5908.527317814651, 5918.585699001029, 5924.674142922181, 5927.436893495111, 5939.138824870456], "value": 5601.488078430499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9828105156847, 624.5316012990256, 654.4633400611499, 668.1047396488701, 686.0361192524505, 33487.66512334876, 36635.26729465409, 36636.26727465456, 36667.26665466692, 36691.26617467652, 36210.456843147374, 45088.77455612717, 46067.53932460675, 46148.0, 49966.250506242344, 8669.089745576703, 8790.736277911641, 8792.736217913442, 8795.428297160664, 8800.383973121883, 8716.694915677952, 8829.426087304304, 8832.911670883273, 8834.425762325429, 8836.381453298272, 8274.2139496748, 8456.238938495535, 10408.115310198604, 10664.62673806417, 10670.573177072907, 10474.109700675452, 10513.106385957202, 10547.156227501782, 10549.47252637365, 10550.0, 10541.15670746346, 10591.788164236672, 10605.416702081382, 10610.787784244349, 10613.363198208132, 42460.363094553606, 42638.786806066084, 42654.36018459726, 42834.0, 42904.57095429037, 3818.828152733106, 3907.3162196615763, 3993.0, 4214.894627634303, 4337.7397356158735, 32497.51253731196, 32741.18147046319, 32819.67180328214, 32962.83518582392, 33032.33935321304, 4493.505714371417, 4506.233940230169, 4562.6121779648765, 4597.7011494252765, 4615.984483413644, 340763.0, 342159.0, 344298.0, 344397.9999999975, 345128.0, 61116.38883611107, 61635.0, 61637.38362616406, 61709.69145154335, 61719.0, 39087.80456097758, 63667.0, 63973.0, 63986.0, 64054.03918941219, 17549.824501754818, 18662.906685466485, 18663.346782862536, 18692.25230990745, 18704.0, 14352.210628415538, 14460.0, 14462.0, 14464.638384040483, 14466.0, 18031.909840450713, 18508.907455462904, 19945.60108797816, 20111.39665810028, 20183.192672292942, 7164.889442136478, 7234.674439650228, 7269.600171990592, 7505.686504861627, 7808.2609282177555, 1011.3881101933224, 1026.7946410717736, 1112.1547623805966, 1137.2039572299423, 1191.803352446854, 33475.66524334774, 33720.32559348848, 33868.83065584656, 33985.49021764676, 34276.31447371039, 1169.216624861328, 1182.7811854806716, 1185.9229150105389, 1231.4027696567157, 1253.129075292663, 14935.399225290515, 17919.46241612754, 18446.451509714127, 19074.33239836599, 19115.426537203904, 573533.0, 583263.0, 583682.0, 584860.0, 586565.0, 54738.0, 56062.43937560654, 56081.71959140178, 60391.69804150951, 61402.38597614056, 1386.4869998100567, 1442.7691569349063, 1445.8120444342378, 1447.2185020089034, 1450.7461194290956, 32661.0, 34225.48661770125, 34261.43039272015, 34572.82713586416, 34680.82659586787, 52270.0, 52829.471705282456, 52872.73563632157, 52911.73544132255, 52939.47060529499, 501116.0, 503420.0, 506018.0, 527548.0, 530165.0, 45261.0, 45773.31340029969, 46052.7697361511, 46290.53709462862, 46536.53463465458, 49204.0, 49497.0, 49546.50453495419, 49758.50241497539, 50886.74556627193, 41681.0, 43065.569344306154, 43323.0, 43375.0, 43762.34356484591, 42066.789666051474, 42451.3632295522, 43457.13085738204, 43685.78157109194, 43953.56046439495, 42486.57513424826, 43148.78425607852, 43558.782206090036, 44068.77965610151, 44142.33786493269, 35105.82447087748, 38022.429663555624, 38208.617913820504, 38367.42448863213, 39449.40825887556, 28933.42133157367, 29499.55750663699, 29624.0, 29640.0, 29656.55515167231], "value": 21397.674377759315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.4728616367905, 410.20010978591756, 417.25728203797235, 418.516613311625, 431.48868590719997, 15778.447754328601, 19658.508537286576, 19726.704099438484, 19749.506262343413, 19759.308424205174, 13071.477140914352, 13906.096103753249, 13917.0, 15963.92018039911, 20443.897780511114, 5253.789848406059, 5522.502974732273, 5528.944710552903, 5536.833894983157, 5541.085720856054, 5135.64050516464, 5445.754941027663, 5463.399026107145, 5464.153056276264, 5467.261919640857, 5452.945470545284, 5463.31708536433, 5463.890722185554, 5470.589705772063, 5472.534834539069, 5274.604404669646, 5438.7280635968245, 5460.672359658433, 5467.343918729778, 5467.589930755209, 5158.303629010074, 5326.414094449608, 5328.387235467932, 5329.840104796824, 5336.813211537577, 19962.30131945375, 20326.186952521883, 20328.593428131502, 21980.450488737748, 23491.0, 2493.127405408111, 2697.3796026913724, 2752.9587056194173, 2754.476649436621, 2875.7411832934927, 10902.781944361068, 11221.326720396803, 11224.943875280653, 13214.603561893158, 15598.610034749108, 1978.8021197880241, 1983.1571582077559, 2014.0735261779598, 2025.3113941259894, 2091.7385326834146, 71857.0, 86492.56753716191, 87200.12799871984, 87592.56203719004, 87727.0, 11695.298282103102, 11780.410979450993, 11891.227070240408, 12017.098717596215, 12304.630861074182, 17128.0, 17162.656746864992, 17163.570910727332, 17167.399141030004, 17167.828321716872, 8536.957315213383, 8631.913680863237, 9022.323325750594, 9022.548872556346, 9069.274458043472, 7917.089534703583, 7929.48458350217, 8119.878201826978, 8132.186781321939, 8141.185881411811, 4903.068417000758, 5046.369203849519, 5153.948460515347, 5241.554467870197, 5319.015982043257, 2063.5769667218183, 2120.9469763255734, 2175.8368122390884, 2187.824974002076, 2201.482651576878, 918.7978644698155, 941.3692825806726, 952.8570714392896, 967.3180407812616, 1042.9791404171874, 18960.81039189618, 20382.337506559652, 20768.48078798012, 20778.168873245202, 20789.376318710463, 1041.5573381313063, 1041.5677493840124, 1057.9153667706564, 1060.3849767135043, 1062.697131317571, 10744.570217191225, 11248.550057997752, 11484.368359740127, 11541.653750387502, 11617.593384231512, 378173.0, 382404.0, 387045.0, 486514.0, 490217.0, 69090.30909690939, 101785.0, 103270.0, 105414.47292763487, 109691.0, 968.1625394034251, 982.5185659027026, 1016.425719468498, 1052.9789404212027, 1055.3245922609535, 18138.81861181424, 18213.81786182121, 18386.632267354846, 18507.35224267144, 19005.049747512294, 38272.61727382691, 47206.527934720216, 47224.7638761804, 47262.76368618273, 47526.52473475221, 64465.67767161134, 65229.0, 65824.0, 66983.66508167428, 67107.66446167933, 8610.741677749678, 8747.518886461306, 8840.867386989072, 8934.28525717928, 9131.086891310815, 11856.407179641155, 13000.414981325674, 13280.867191328349, 13481.32593370308, 13498.392572334073, 11954.10344224204, 12110.515579376726, 12185.390730463265, 12300.876991229974, 12517.374131293216, 11190.048845848194, 11511.654650360502, 12025.939870300592, 12047.759044818878, 12085.456154473246, 11582.42087895585, 12159.81760273579, 12160.331181785086, 12193.390330483619, 12255.632331030083, 8578.91421085781, 8862.955685221532, 8915.55422228873, 8916.465012099296, 8999.775005624912, 10380.532876020749, 11881.5841445549, 12070.336131512851, 12181.573644922386, 12314.876851231373], "value": 9440.884849029322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.0917812599944, 1479.73364794337, 1488.7915691803146, 1675.1456757053907, 1840.677881370759, 7965.123836378001, 8746.300295976322, 9081.455112693227, 9108.089191080888, 9281.860772088425, 9125.087491250872, 9199.724008279762, 9204.769880752985, 9206.033366496506, 9222.953885230581, 2572.318335641057, 2594.15689900783, 2607.8565678887653, 2610.8172427930053, 2615.215435369391, 2504.4365017871014, 2565.307367010906, 2570.691517017951, 2574.806889483287, 2576.780973617245, 2495.089292408267, 2512.874356282188, 2513.4973005398992, 2513.8114641401876, 2522.382016405983, 2404.663347131403, 2438.9146379876797, 2458.766417190373, 2466.48203877186, 2467.0501856785086, 2472.4560596668885, 2495.1142344467817, 2502.962455563168, 2509.2597683683357, 2513.5852584323566, 8932.910670893272, 8985.415947963362, 9189.908100918972, 9212.723618291462, 9232.8615070774, 5646.632968857011, 5798.507126894219, 5812.099124635688, 5815.21494598228, 5816.243888294494, 3572.3034008368377, 3658.890233292979, 3691.0, 3721.7580857244193, 3745.0450135215347, 1161.2451906260912, 1164.4003338280793, 1192.0582739635677, 1198.2690558759236, 1230.5139469909425, 12664.303463309514, 12811.103222774409, 12853.807192892114, 12867.485300587965, 12888.226706397647, 4824.155772739757, 4881.560659540658, 4903.975480122648, 4908.337374454474, 5016.949830501721, 10158.339707918962, 10159.187265018782, 10168.28821982469, 10172.389656620626, 10217.795644087077, 5663.773449061991, 5676.545876329884, 5684.431556844283, 5688.23208866806, 5688.5733569981585, 4493.236149854532, 4645.767711614473, 4783.162946484351, 5221.347331583552, 5287.894242115213, 4131.892734705262, 4187.309093999456, 4229.365595160751, 4274.059706864485, 4304.203722311382, 1280.155097635556, 1318.762622727899, 1327.0710502648185, 1329.9069065165538, 1338.0499845109887, 925.1349987761464, 978.2516374973151, 1006.4213077480478, 1007.1238022920106, 1012.5342342522375, 6030.849228769316, 6300.432961033529, 6356.336123213862, 6610.3720146586, 6648.03603477493, 491.7688686317425, 492.58130588999063, 510.67572091722025, 513.4813838023548, 515.0523037610814, 4453.532379100213, 4499.122671079108, 4526.072155208174, 4543.840965566189, 4565.292379681155, 11027.724306892393, 11369.488373023234, 11464.541418343173, 11530.962213400835, 11545.076393888468, 10526.578936842594, 11483.311001339946, 11489.827652585218, 11504.482298296596, 11515.272709093702, 8350.206730360605, 8736.213740763362, 8748.212660860552, 8748.912510874938, 8762.299016078698, 6414.61512309263, 6435.292117867125, 6477.255115661759, 6566.606003639797, 6697.464202863662, 10433.165346772088, 10504.159667226757, 10504.947475262576, 10553.261271710906, 10581.36511809294, 9321.953390233277, 9657.082577155159, 9934.354266972623, 10038.949805250926, 10363.11913487332, 7380.225076366904, 7404.888926666212, 7441.776746697607, 7452.254774522505, 7453.850922981618, 8682.131786821268, 8744.562771861509, 8764.561771911507, 8766.474011559327, 8766.736997890073, 8023.318017968538, 8058.274755272054, 8076.030876294647, 8154.2253485918745, 8227.053888802624, 7572.924270757222, 7607.648373479016, 7676.232376762502, 7862.803429914298, 8180.550069746221, 7514.9624251878395, 7521.887171692539, 7539.886901696369, 7581.469297149147, 7614.695412183451, 5453.809116680897, 5521.503064724194, 5653.717314134359, 5661.773529058956, 5836.708164591669, 5468.617196796186, 5573.470520300565, 5653.632513886584, 5791.594588378942, 5822.592418530831], "value": 4794.153490161313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.92693534357784, 351.729168540224, 354.46298857231284, 357.9708338526735, 362.7225172742852, 5347.278117454142, 5363.471410647966, 5374.677519348832, 5382.596305277105, 5393.0, 5257.13257312543, 5278.709670968095, 5293.947060529394, 5298.284731561238, 5311.176767601028, 4050.2102090092444, 4174.812133454002, 4204.075103477246, 4227.365895115727, 4242.469691288589, 4171.665067178504, 4177.832886684529, 4178.749275043492, 4179.979100104495, 4213.85251516197, 4009.7794621295816, 4176.853810116647, 4183.6653067754505, 4215.936760948588, 4218.97890510547, 4044.5146582410152, 4100.118474527976, 4142.5857414258635, 4161.52142503613, 4172.7287726298, 3731.4962480065115, 3733.925321493582, 3743.4571987061995, 3746.6253374662588, 3756.323861704892, 4915.5821755150855, 5171.301874246966, 5173.5602473789395, 5184.507471790174, 5191.195364718475, 4486.775661216926, 4791.089692958327, 4832.9275060874115, 4835.734034628094, 4838.927416088762, 5441.211024401479, 5493.285872836505, 5539.390667026624, 5561.332640083176, 5564.27664403629, 4036.4752582164424, 4146.896327591804, 4147.29960716108, 4162.647139679586, 4181.790910454465, 5709.115991722721, 5714.0, 5726.255586773735, 5730.828075157752, 5745.339285982123, 4243.321068629066, 4250.364773840177, 4251.171021650748, 4255.0, 4264.294282287048, 4178.707490475637, 4331.566843315706, 4331.870043898688, 4335.241332766753, 4336.609705126553, 4812.759362031955, 4825.3485779419325, 4847.75761211938, 4855.975720121377, 4863.392075990501, 5549.861253468695, 5591.496765291144, 5636.577256705764, 5669.489745922887, 5679.971600142056, 1360.6122255157234, 1446.4214314274163, 1462.0861961274204, 1467.948621798232, 1475.6532214929482, 973.7662960889477, 988.3476905242505, 1007.2445665750687, 1008.626808081, 1010.2927950434726, 5036.471170527115, 5140.485951404829, 5141.76862041209, 5151.201563757623, 5173.430922598511, 5461.453854614507, 5461.481159289861, 5468.371137319259, 5477.616566840363, 5484.698341591251, 5029.622778291569, 5128.692278463304, 5140.537351638296, 5170.431252562215, 5180.766865491062, 2856.728610782014, 2904.796664233483, 2909.956350654742, 2910.039686903317, 2911.97088029117, 5587.603099225194, 5609.439056094439, 5612.400465867208, 5616.326040875039, 5629.241671580896, 5494.2857428534835, 5562.332520097533, 5573.972130139324, 5581.469760372758, 5593.8321850344555, 5549.223108764776, 5586.910552442235, 5587.597333146705, 5592.384837667853, 5601.443083641835, 5362.410134885082, 5481.506664400223, 5504.4770746778995, 5525.696086715269, 5529.419410961791, 5707.8858422832145, 5720.742566584597, 5722.17028530869, 5723.456271654186, 5731.770729170787, 5854.707264636836, 5867.735951882261, 5878.529717622666, 5880.911786323123, 5885.61743486672, 4010.177913527778, 4151.792410379529, 4182.330827067654, 4197.034682023091, 4200.138971510772, 5623.8875222496135, 5684.640874037228, 5693.4875861172695, 5705.0, 5719.398568400855, 5511.4213007633625, 5599.412061733459, 5608.467195616573, 5609.971950140386, 5619.241402410622, 5468.207109969112, 5501.944980550304, 5565.5825813063375, 5565.805196818092, 5584.692841893735, 5514.393416724077, 5535.972320138373, 5545.112781954868, 5548.889022219614, 5554.166874968787, 5465.508104270635, 5567.24842146305, 5570.607348162959, 5615.507593924762, 5617.258649818569, 5449.1826226066405, 5450.672959622435, 5476.972615137058, 5478.424765399575, 5495.752691128989], "value": 4252.586209430442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.3046049936556, 801.414967074036, 812.5733989655427, 843.9324854011679, 869.578254546545, 15464.458743943964, 15686.294116764744, 15996.280167392466, 16215.83784162158, 16292.348306067757, 14364.856351436483, 14471.565853024425, 14562.0, 14779.0, 14936.103833769981, 710.3997122431563, 732.3738203835698, 845.5560830563942, 858.1975852577859, 860.0754189246554, 826.4215049465369, 847.9448835825682, 850.2730165708323, 851.7742798158492, 852.3053711225363, 889.4485419040204, 891.496304587909, 892.0054139634326, 893.6693423433338, 894.0210469535848, 743.22333161846, 888.0897080492482, 888.2449917570046, 889.777555611094, 890.3589415620775, 561.1386521689187, 632.7848531499312, 645.1451826330084, 646.7574659502686, 647.6696884588846, 14373.928130359385, 14412.135271883615, 14424.495142669955, 14456.783148252785, 14508.564743057725, 13989.440422383092, 14101.506447274398, 14139.787903181461, 14372.568822935329, 14502.41990320386, 12675.176113552681, 12712.745745085047, 12774.936125319407, 12777.552785652457, 12975.1566148201, 4314.417553630251, 4349.543297953701, 4375.5405682403525, 4423.668224883147, 4490.012197316585, 58200.417995819924, 59577.404225957616, 60027.69986150085, 65460.0, 65769.01346479806, 11668.94165529167, 11677.240979336317, 11986.460609272604, 12027.819582706266, 12063.457144428521, 20749.377518674464, 20868.0, 20902.37292881216, 20932.895335523226, 21162.576748464944, 8876.8668469973, 8883.244924181388, 8890.777730556658, 8904.109589041043, 8934.329925255632, 4806.038792241496, 4921.901561968741, 4921.975390123098, 4959.231319145538, 5047.4952504749235, 3824.0822202671156, 3943.645071943539, 3943.8225279862477, 3976.224636195972, 4001.679865610744, 716.8673795347877, 717.5300178383168, 718.4432065149551, 738.3686947659781, 747.2975403121158, 698.8672152291049, 781.0939310399909, 792.18405042806, 825.9149357072206, 827.0736774812249, 9687.467189304656, 9929.2056635469, 9954.800903981879, 9984.950075249722, 10177.389356638625, 689.021589343134, 692.7159864455549, 708.2421808664782, 709.3403135084421, 764.2663043478212, 4439.741048228069, 4562.270036794163, 4655.4180727409075, 4881.267809828554, 4883.926741098815, 82254.58872705718, 90845.54577227072, 91044.0, 95064.0, 95911.0, 49824.50175498271, 51558.74220628873, 64007.0, 66710.99933501001, 79834.20165798384, 72688.0, 72825.53268075222, 73000.63499682574, 73768.63115684387, 74503.62748186225, 9296.0, 9363.719088427359, 9431.339806213498, 9527.571259293487, 9541.522923853641, 36660.633393665725, 37368.0, 40252.59747402606, 40992.1801563973, 51228.97542049213, 48535.75732121317, 60140.0, 60587.69706151441, 62211.0, 63259.36740632535, 12367.381630918238, 12385.318807465675, 12445.75108497843, 12497.187682800952, 12575.182613130117, 13797.793033104712, 14111.858881411055, 14191.64520886986, 14204.147751134551, 14730.926345368205, 11237.887621123684, 13398.86109680688, 13584.0, 13688.726225475633, 13733.45066197341, 12795.424205910942, 13150.408231629408, 13375.26436045988, 13443.529476468277, 14358.928205358907, 13681.0, 13825.30873456303, 14013.0, 14030.929845350707, 14619.12285262845, 10987.175961803057, 11536.019438347834, 11594.0, 12011.897917864513, 12119.272843629411, 11583.247088939192, 12095.092868034757, 12104.213226140273, 12210.26738395699, 12301.831326024014], "value": 7419.789348989521, "unit": "score"}], "name": "dromaeo_css", "value": 7451.564232294299, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 111.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 119.0, 161.0, 124.0, 126.0, 118.0, 121.0, 152.0, 124.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 159.0, 159.0, 160.0, 161.0, 160.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 106.0, 75.0, 75.0, 75.0, 75.0, 111.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 109.0, 81.0, 81.0, 82.0, 99.0, 81.0, 81.0, 118.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 149.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 51.0, 50.0, 52.0, 51.0, 51.0, 49.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 64.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 73.0, 74.0, 74.0, 74.0, 75.0, 74.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 129.0, 120.0, 125.0, 120.0, 127.0, 118.0, 126.0, 176.0, 126.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 159.0, 158.0, 151.0, 152.0, 155.0, 156.0, 157.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 60.0, 61.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1449.4000000000003, "alertThreshold": 2.0}]} 09:41:25 INFO - Return code: 0 09:41:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:26 INFO - # TBPL SUCCESS # 09:41:26 INFO - Running post-action listener: _resource_record_post_action 09:41:26 INFO - [mozharness: 2017-01-12 17:41:26.037360Z] Finished run-tests step (success) 09:41:26 INFO - Running post-run listener: _resource_record_post_run 09:41:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 356569088; Read time: 0; Write time: 175464 09:41:26 INFO - TinderboxPrint: CPU usage
13.0% 09:41:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:41:26 INFO - TinderboxPrint: I/O write bytes / time
356,569,088 / 175,464 09:41:26 INFO - TinderboxPrint: CPU idle
8,273.6 (87.0%) 09:41:26 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 09:41:26 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107466752; Read time: 0; Write time: 54044 09:41:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 248123392; Read time: 0; Write time: 121396 09:41:26 INFO - Running post-run listener: _upload_blobber_files 09:41:26 INFO - Blob upload gear active. 09:41:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:41:26 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:26 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:27 INFO - (blobuploader) - INFO - Done attempting. 09:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:28 INFO - (blobuploader) - INFO - Done attempting. 09:41:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:32 INFO - (blobuploader) - INFO - Done attempting. 09:41:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:32 INFO - Return code: 0 09:41:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d632e155c55d03d51de875016887124ef946ee3a0ae842dad681ad01c3f96f9e31e404d73635cb98b08e306dbd51f0c0c0259f3920af977a4ec67c200a13401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da4f099b1144fe7a1cf854bfa222c60b2eb27c9d1ba307313895a4a81fba07b09aee34b523421a8de0891b02bba33314e79328a59e3310e47a7c5e58440799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/968633537d3b123d26b360a9f96d7b41c62fa53550270950ef38f42c72b0702e47de4c0f71300f7b5234e1c277f9510517c39de1679f2259721eb798140a8868"} 09:41:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:32 INFO - Contents: 09:41:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d632e155c55d03d51de875016887124ef946ee3a0ae842dad681ad01c3f96f9e31e404d73635cb98b08e306dbd51f0c0c0259f3920af977a4ec67c200a13401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da4f099b1144fe7a1cf854bfa222c60b2eb27c9d1ba307313895a4a81fba07b09aee34b523421a8de0891b02bba33314e79328a59e3310e47a7c5e58440799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/968633537d3b123d26b360a9f96d7b41c62fa53550270950ef38f42c72b0702e47de4c0f71300f7b5234e1c277f9510517c39de1679f2259721eb798140a8868"} 09:41:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:32 INFO - Copying logs to upload dir... 09:41:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.882867 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 09:41:31.894826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:31.898756) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d632e155c55d03d51de875016887124ef946ee3a0ae842dad681ad01c3f96f9e31e404d73635cb98b08e306dbd51f0c0c0259f3920af977a4ec67c200a13401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da4f099b1144fe7a1cf854bfa222c60b2eb27c9d1ba307313895a4a81fba07b09aee34b523421a8de0891b02bba33314e79328a59e3310e47a7c5e58440799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/968633537d3b123d26b360a9f96d7b41c62fa53550270950ef38f42c72b0702e47de4c0f71300f7b5234e1c277f9510517c39de1679f2259721eb798140a8868"} build_url:https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011626 build_url: 'https://queue.taskcluster.net/v1/task/MCnjelPfQ2iAdK6_ayDeuw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d632e155c55d03d51de875016887124ef946ee3a0ae842dad681ad01c3f96f9e31e404d73635cb98b08e306dbd51f0c0c0259f3920af977a4ec67c200a13401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da4f099b1144fe7a1cf854bfa222c60b2eb27c9d1ba307313895a4a81fba07b09aee34b523421a8de0891b02bba33314e79328a59e3310e47a7c5e58440799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/968633537d3b123d26b360a9f96d7b41c62fa53550270950ef38f42c72b0702e47de4c0f71300f7b5234e1c277f9510517c39de1679f2259721eb798140a8868"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:31.927349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:31.927687) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484241654.445743-740050204 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:41:32.012026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:41:32.012358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:41:32.012666) ========= ========= Total master_lag: 0.95 =========