builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1484412968.98 results: success (0) buildid: 20170114070524 builduid: f590ab0d9afc438abf13527871c2109e revision: 13a9adf5f429bd1454608aa3d313bfd994c3ef81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:08.984299) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:08.984831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:08.985122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.003794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.004110) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-14 08:56:10-- 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% 50.5M=0s 2017-01-14 08:56:10 (50.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.156385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.156722) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014243 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.209762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.210083) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 13a9adf5f429bd1454608aa3d313bfd994c3ef81 --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 13a9adf5f429bd1454608aa3d313bfd994c3ef81 --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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-14 08:56:10,260 truncating revision to first 12 chars 2017-01-14 08:56:10,261 Setting DEBUG logging. 2017-01-14 08:56:10,261 attempt 1/10 2017-01-14 08:56:10,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/13a9adf5f429?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 08:56:10,564 unpacking tar archive at: mozilla-aurora-13a9adf5f429/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.827277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.827650) ========= script_repo_revision: 13a9adf5f429bd1454608aa3d313bfd994c3ef81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.828069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.828369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 08:56:09.837250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-14 08:56:09.837629) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:56:10 INFO - MultiFileLogger online at 20170114 08:56:10 in /builds/slave/test 08:56:10 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 08:56:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:10 INFO - {'append_to_log': False, 08:56:10 INFO - 'base_work_dir': '/builds/slave/test', 08:56:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:56:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:10 INFO - 'branch': 'Mozilla-Aurora', 08:56:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:10 INFO - 'config_files': ('talos/linux_config.py',), 08:56:10 INFO - 'default_actions': ('clobber', 08:56:10 INFO - 'read-buildbot-config', 08:56:10 INFO - 'download-and-extract', 08:56:10 INFO - 'populate-webroot', 08:56:10 INFO - 'create-virtualenv', 08:56:10 INFO - 'install', 08:56:10 INFO - 'run-tests'), 08:56:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:10 INFO - 'download_minidump_stackwalk': True, 08:56:10 INFO - 'download_symbols': 'ondemand', 08:56:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:10 INFO - 'installer_path': 'installer.exe', 08:56:10 INFO - 'log_level': 'info', 08:56:10 INFO - 'log_name': 'talos', 08:56:10 INFO - 'log_to_console': True, 08:56:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:56:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:56:10 INFO - 'opt_config_files': (), 08:56:10 INFO - 'pip_index': False, 08:56:10 INFO - 'sps_profile': False, 08:56:10 INFO - 'sps_profile_interval': 0, 08:56:10 INFO - 'suite': 'dromaeojs', 08:56:10 INFO - 'system_bits': '32', 08:56:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:10 INFO - 'title': 'talos-linux64-ix-005', 08:56:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:10 INFO - 'use_talos_json': True, 08:56:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:10 INFO - 'work_dir': 'build'} 08:56:10 INFO - [mozharness: 2017-01-14 16:56:10.985450Z] Running clobber step. 08:56:10 INFO - Running pre-action listener: _resource_record_pre_action 08:56:10 INFO - Running main action method: clobber 08:56:10 INFO - rmtree: /builds/slave/test/build 08:56:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:11 INFO - Running post-action listener: _resource_record_post_action 08:56:11 INFO - [mozharness: 2017-01-14 16:56:11.431185Z] Finished clobber step (success) 08:56:11 INFO - [mozharness: 2017-01-14 16:56:11.431284Z] Running read-buildbot-config step. 08:56:11 INFO - Running pre-action listener: _resource_record_pre_action 08:56:11 INFO - Running main action method: read_buildbot_config 08:56:11 INFO - Using buildbot properties: 08:56:11 INFO - { 08:56:11 INFO - "project": "", 08:56:11 INFO - "product": "firefox", 08:56:11 INFO - "script_repo_revision": "production", 08:56:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:56:11 INFO - "repository": "", 08:56:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:56:11 INFO - "buildid": "20170114070524", 08:56:11 INFO - "pgo_build": "True", 08:56:11 INFO - "basedir": "/builds/slave/test", 08:56:11 INFO - "buildnumber": 705, 08:56:11 INFO - "slavename": "talos-linux64-ix-005", 08:56:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:56:11 INFO - "platform": "ubuntu64_hw", 08:56:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:56:11 INFO - "branch": "mozilla-aurora", 08:56:11 INFO - "repo_path": "releases/mozilla-aurora", 08:56:11 INFO - "revision": "13a9adf5f429bd1454608aa3d313bfd994c3ef81", 08:56:11 INFO - "stage_platform": "linux64-pgo", 08:56:11 INFO - "builduid": "f590ab0d9afc438abf13527871c2109e", 08:56:11 INFO - "slavebuilddir": "test" 08:56:11 INFO - } 08:56:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:56:11 INFO - Running post-action listener: _resource_record_post_action 08:56:11 INFO - [mozharness: 2017-01-14 16:56:11.433739Z] Finished read-buildbot-config step (success) 08:56:11 INFO - [mozharness: 2017-01-14 16:56:11.433826Z] Running download-and-extract step. 08:56:11 INFO - Running pre-action listener: _resource_record_pre_action 08:56:11 INFO - Running main action method: download_and_extract 08:56:11 INFO - mkdir: /builds/slave/test/build/tests 08:56:11 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')]} 08:56:11 INFO - trying https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:56:11 INFO - Downloading https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/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 08:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/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 08:56:11 INFO - Downloaded 1361 bytes. 08:56:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:56:11 INFO - Using the following test package requirements: 08:56:11 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:56:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:56:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:56:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'jsshell-linux-x86_64.zip'], 08:56:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:56:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:56:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:56:11 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:56:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:56:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:56:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:56:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:56:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:56:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:56:11 INFO - Fetch https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:56:12 INFO - Http code: 200 08:56:12 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 08:56:12 INFO - x-amz-cf-id: aA0eLhXhnx9eHDuQDhud6Lv4BXdzrMZyH--wyKiXagxqSG6XJ-dciQ== 08:56:12 INFO - x-amz-version-id: xL7zK0EBe7rSVnYf4X1L7ByLwyEMliHB 08:56:12 INFO - Expected file size: 21948541 08:56:12 INFO - Obtained file size: 21948541 08:56:16 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 08:56:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:56:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:56:16 INFO - Fetch https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:56:17 INFO - Http code: 200 08:56:17 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:56:17 INFO - x-amz-cf-id: K8g-wvDKS14QbpfPwE4TWubUsty-a3mODp_uOeT85K7ZRs96RWcyiQ== 08:56:17 INFO - x-amz-version-id: xL7zK0EBe7rSVnYf4X1L7ByLwyEMliHB 08:56:17 INFO - Expected file size: 21948541 08:56:17 INFO - Obtained file size: 21948541 08:56:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:56:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:56:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:56:22 INFO - Http code: 200 08:56:22 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:56:22 INFO - x-amz-cf-id: lqEPrgXjnCN1euOn65tTK2Eg6FrevbuFnHElh2_wB5ySa-enhrZLNw== 08:56:22 INFO - x-amz-version-id: Cuhgx_GxBs_p.hIr_vNuAhMlisnptBpp 08:56:23 INFO - Expected file size: 14409038 08:56:23 INFO - Obtained file size: 14409038 08:56: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')]} 08:56:23 INFO - trying https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:56:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/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 08:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/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 08:56:26 INFO - Downloaded 64161760 bytes. 08:56:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:56:26 INFO - mkdir: /builds/slave/test/properties 08:56:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:26 INFO - Contents: 08:56:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:56:27 INFO - Running post-action listener: _resource_record_post_action 08:56:27 INFO - Running post-action listener: set_extra_try_arguments 08:56:27 INFO - [mozharness: 2017-01-14 16:56:27.038050Z] Finished download-and-extract step (success) 08:56:27 INFO - [mozharness: 2017-01-14 16:56:27.038277Z] Running populate-webroot step. 08:56:27 INFO - Running pre-action listener: _resource_record_pre_action 08:56:27 INFO - Running main action method: populate_webroot 08:56:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:27 INFO - '--tppagecycles', 08:56:27 INFO - '7'], 08:56:27 INFO - 'tests': ['tsvgm']}}, 08:56:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['damp', 'tps']}, 08:56:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'tests': ['damp', 'tps']}, 08:56:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['dromaeo_dom']}, 08:56:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['basic_compositor_video']}, 08:56:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['a11yr', 08:56:27 INFO - 'ts_paint', 08:56:27 INFO - 'tpaint', 08:56:27 INFO - 'sessionrestore', 08:56:27 INFO - 'sessionrestore_no_auto_restore', 08:56:27 INFO - 'tabpaint']}, 08:56:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['tsvgx', 08:56:27 INFO - 'tsvgr_opacity', 08:56:27 INFO - 'tart', 08:56:27 INFO - 'tscrollx', 08:56:27 INFO - 'cart']}, 08:56:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:27 INFO - 'tsvgr_opacity', 08:56:27 INFO - 'tart', 08:56:27 INFO - 'tscrollx', 08:56:27 INFO - 'cart']}, 08:56:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'talos_options': ['--disable-e10s'], 08:56:27 INFO - 'tests': ['tp5o']}, 08:56:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'tests': ['tp5o']}, 08:56:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'talos_options': ['--disable-e10s', 08:56:27 INFO - '--xperf_path', 08:56:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:27 INFO - 'tests': ['tp5n']}, 08:56:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:27 INFO - 'talos_options': ['--xperf_path', 08:56:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:27 INFO - 'tests': ['tp5n']}}, 08:56:27 INFO - 'talos.zip': {'path': '', 08:56:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:27 INFO - Running post-action listener: _resource_record_post_action 08:56:27 INFO - [mozharness: 2017-01-14 16:56:27.058354Z] Finished populate-webroot step (success) 08:56:27 INFO - [mozharness: 2017-01-14 16:56:27.058442Z] Running create-virtualenv step. 08:56:27 INFO - Running pre-action listener: _resource_record_pre_action 08:56:27 INFO - Running main action method: create_virtualenv 08:56:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:56:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:27 INFO - Using real prefix '/usr' 08:56:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:29 INFO - Installing pip.................done. 08:56:29 INFO - Return code: 0 08:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:29 INFO - Reading from file tmpfile_stdout 08:56:29 INFO - Output received: 08:56:29 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) 08:56:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:29 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')]} 08:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:29 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')]} 08:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:29 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 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:29 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 08:56:29 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 08:56:29 INFO - Using env: {'DISPLAY': ':0', 08:56:29 INFO - 'HOME': '/home/cltbld', 08:56:29 INFO - 'LANG': 'en_US.UTF-8', 08:56:29 INFO - 'LANGUAGE': 'en_US:en', 08:56:29 INFO - 'LOGNAME': 'cltbld', 08:56:29 INFO - 'MAIL': '/var/mail/cltbld', 08:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:29 INFO - 'MOZ_NO_REMOTE': '1', 08:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:29 INFO - 'NO_EM_RESTART': '1', 08:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:29 INFO - 'PWD': '/builds/slave/test', 08:56:29 INFO - 'SHELL': '/bin/bash', 08:56:29 INFO - 'SHLVL': '1', 08:56:29 INFO - 'TERM': 'linux', 08:56:29 INFO - 'TMOUT': '86400', 08:56:29 INFO - 'USER': 'cltbld', 08:56:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:29 INFO - '_': '/tools/buildbot/bin/python'} 08:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:56:30 INFO - Cleaning up... 08:56:30 INFO - Return code: 0 08:56:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:30 INFO - Using env: {'DISPLAY': ':0', 08:56:30 INFO - 'HOME': '/home/cltbld', 08:56:30 INFO - 'LANG': 'en_US.UTF-8', 08:56:30 INFO - 'LANGUAGE': 'en_US:en', 08:56:30 INFO - 'LOGNAME': 'cltbld', 08:56:30 INFO - 'MAIL': '/var/mail/cltbld', 08:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:30 INFO - 'MOZ_NO_REMOTE': '1', 08:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:30 INFO - 'NO_EM_RESTART': '1', 08:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:30 INFO - 'PWD': '/builds/slave/test', 08:56:30 INFO - 'SHELL': '/bin/bash', 08:56:30 INFO - 'SHLVL': '1', 08:56:30 INFO - 'TERM': 'linux', 08:56:30 INFO - 'TMOUT': '86400', 08:56:30 INFO - 'USER': 'cltbld', 08:56:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:30 INFO - '_': '/tools/buildbot/bin/python'} 08:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:30 INFO - Downloading/unpacking psutil>=3.1.1 08:56:30 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 08:56:30 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 08:56:30 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 08:56:30 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 08:56:30 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 08:56:30 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 08:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:32 INFO - Installing collected packages: psutil 08:56:32 INFO - Running setup.py install for psutil 08:56:32 INFO - building 'psutil._psutil_linux' extension 08:56:32 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 08:56:32 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 08:56:32 INFO - building 'psutil._psutil_posix' extension 08:56:32 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 08:56:32 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 08:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:32 INFO - Successfully installed psutil 08:56:32 INFO - Cleaning up... 08:56:32 INFO - Return code: 0 08:56:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:32 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')]} 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 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')]} 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 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 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:32 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 08:56:32 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 08:56:32 INFO - Using env: {'DISPLAY': ':0', 08:56:32 INFO - 'HOME': '/home/cltbld', 08:56:32 INFO - 'LANG': 'en_US.UTF-8', 08:56:32 INFO - 'LANGUAGE': 'en_US:en', 08:56:32 INFO - 'LOGNAME': 'cltbld', 08:56:32 INFO - 'MAIL': '/var/mail/cltbld', 08:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:32 INFO - 'MOZ_NO_REMOTE': '1', 08:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:32 INFO - 'NO_EM_RESTART': '1', 08:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:32 INFO - 'PWD': '/builds/slave/test', 08:56:32 INFO - 'SHELL': '/bin/bash', 08:56:32 INFO - 'SHLVL': '1', 08:56:32 INFO - 'TERM': 'linux', 08:56:32 INFO - 'TMOUT': '86400', 08:56:32 INFO - 'USER': 'cltbld', 08:56:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:32 INFO - '_': '/tools/buildbot/bin/python'} 08:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:35 INFO - Installing collected packages: mozsystemmonitor 08:56:35 INFO - Running setup.py install for mozsystemmonitor 08:56:35 INFO - Successfully installed mozsystemmonitor 08:56:35 INFO - Cleaning up... 08:56:35 INFO - Return code: 0 08:56:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:35 INFO - Using env: {'DISPLAY': ':0', 08:56:35 INFO - 'HOME': '/home/cltbld', 08:56:35 INFO - 'LANG': 'en_US.UTF-8', 08:56:35 INFO - 'LANGUAGE': 'en_US:en', 08:56:35 INFO - 'LOGNAME': 'cltbld', 08:56:35 INFO - 'MAIL': '/var/mail/cltbld', 08:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:35 INFO - 'MOZ_NO_REMOTE': '1', 08:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:35 INFO - 'NO_EM_RESTART': '1', 08:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:35 INFO - 'PWD': '/builds/slave/test', 08:56:35 INFO - 'SHELL': '/bin/bash', 08:56:35 INFO - 'SHLVL': '1', 08:56:35 INFO - 'TERM': 'linux', 08:56:35 INFO - 'TMOUT': '86400', 08:56:35 INFO - 'USER': 'cltbld', 08:56:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:35 INFO - '_': '/tools/buildbot/bin/python'} 08:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:37 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 08:56:37 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 08:56:37 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 08:56:37 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 08:56:37 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 08:56:37 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 08:56:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:37 INFO - warning: no files found matching '*.txt' 08:56:37 INFO - no previously-included directories found matching 'build' 08:56:37 INFO - no previously-included directories found matching 'dist' 08:56:37 INFO - no previously-included directories found matching '.git*' 08:56:37 INFO - Installing collected packages: jsonschema, functools32 08:56:37 INFO - Running setup.py install for functools32 08:56:37 INFO - warning: no files found matching '*.txt' 08:56:37 INFO - no previously-included directories found matching 'build' 08:56:37 INFO - no previously-included directories found matching 'dist' 08:56:37 INFO - no previously-included directories found matching '.git*' 08:56:37 INFO - Successfully installed jsonschema functools32 08:56:37 INFO - Cleaning up... 08:56:38 INFO - Return code: 0 08:56:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:56:38 INFO - Using env: {'DISPLAY': ':0', 08:56:38 INFO - 'HOME': '/home/cltbld', 08:56:38 INFO - 'LANG': 'en_US.UTF-8', 08:56:38 INFO - 'LANGUAGE': 'en_US:en', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MAIL': '/var/mail/cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SHLVL': '1', 08:56:38 INFO - 'TERM': 'linux', 08:56:38 INFO - 'TMOUT': '86400', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - '_': '/tools/buildbot/bin/python'} 08:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:38 INFO - Cleaning up... 08:56:38 INFO - Return code: 0 08:56:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:56:38 INFO - Using env: {'DISPLAY': ':0', 08:56:38 INFO - 'HOME': '/home/cltbld', 08:56:38 INFO - 'LANG': 'en_US.UTF-8', 08:56:38 INFO - 'LANGUAGE': 'en_US:en', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MAIL': '/var/mail/cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SHLVL': '1', 08:56:38 INFO - 'TERM': 'linux', 08:56:38 INFO - 'TMOUT': '86400', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - '_': '/tools/buildbot/bin/python'} 08:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:41 INFO - Downloading docopt-0.6.1.tar.gz 08:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:41 INFO - Running setup.py install for blobuploader 08:56:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:41 INFO - Running setup.py install for requests 08:56:41 INFO - Running setup.py install for docopt 08:56:41 INFO - Successfully installed blobuploader requests docopt 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:41 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 08:56:41 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 08:56:41 INFO - Using env: {'DISPLAY': ':0', 08:56:41 INFO - 'HOME': '/home/cltbld', 08:56:41 INFO - 'LANG': 'en_US.UTF-8', 08:56:41 INFO - 'LANGUAGE': 'en_US:en', 08:56:41 INFO - 'LOGNAME': 'cltbld', 08:56:41 INFO - 'MAIL': '/var/mail/cltbld', 08:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:41 INFO - 'MOZ_NO_REMOTE': '1', 08:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:41 INFO - 'NO_EM_RESTART': '1', 08:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:41 INFO - 'PWD': '/builds/slave/test', 08:56:41 INFO - 'SHELL': '/bin/bash', 08:56:41 INFO - 'SHLVL': '1', 08:56:41 INFO - 'TERM': 'linux', 08:56:41 INFO - 'TMOUT': '86400', 08:56:41 INFO - 'USER': 'cltbld', 08:56:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:41 INFO - '_': '/tools/buildbot/bin/python'} 08:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:42 INFO - Running setup.py (path:/tmp/pip-vBkiYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:42 INFO - Running setup.py (path:/tmp/pip-qBuYuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 INFO - Running setup.py (path:/tmp/pip-4SlolF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 INFO - Running setup.py (path:/tmp/pip-KKibc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:42 INFO - Running setup.py (path:/tmp/pip-yIOLxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Running setup.py (path:/tmp/pip-_EdaFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Running setup.py (path:/tmp/pip-QCGQ8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Running setup.py (path:/tmp/pip-b9VCKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Running setup.py (path:/tmp/pip-nluta4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:42 INFO - Running setup.py (path:/tmp/pip-DzE84t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:42 INFO - Running setup.py (path:/tmp/pip-God8EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:42 INFO - Running setup.py (path:/tmp/pip-iQtVXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 INFO - Running setup.py (path:/tmp/pip-Tlid4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 INFO - Running setup.py (path:/tmp/pip-tlPK3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 INFO - Running setup.py (path:/tmp/pip-0mwiyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Running setup.py (path:/tmp/pip-FDd8kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Running setup.py (path:/tmp/pip-WzjIFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:43 INFO - Running setup.py install for manifestparser 08:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Running setup.py install for mozcrash 08:56:43 INFO - Running setup.py install for mozdebug 08:56:43 INFO - Running setup.py install for mozdevice 08:56:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Running setup.py install for mozfile 08:56:43 INFO - Running setup.py install for mozhttpd 08:56:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Running setup.py install for mozinfo 08:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozInstall 08:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozleak 08:56:44 INFO - Running setup.py install for mozlog 08:56:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for moznetwork 08:56:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozprocess 08:56:44 INFO - Running setup.py install for mozprofile 08:56:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozrunner 08:56:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozscreenshot 08:56:44 INFO - Running setup.py install for moztest 08:56:45 INFO - Running setup.py install for mozversion 08:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:45 INFO - Cleaning up... 08:56:45 INFO - Return code: 0 08:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:45 INFO - Using env: {'DISPLAY': ':0', 08:56:45 INFO - 'HOME': '/home/cltbld', 08:56:45 INFO - 'LANG': 'en_US.UTF-8', 08:56:45 INFO - 'LANGUAGE': 'en_US:en', 08:56:45 INFO - 'LOGNAME': 'cltbld', 08:56:45 INFO - 'MAIL': '/var/mail/cltbld', 08:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:45 INFO - 'MOZ_NO_REMOTE': '1', 08:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:45 INFO - 'NO_EM_RESTART': '1', 08:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:45 INFO - 'PWD': '/builds/slave/test', 08:56:45 INFO - 'SHELL': '/bin/bash', 08:56:45 INFO - 'SHLVL': '1', 08:56:45 INFO - 'TERM': 'linux', 08:56:45 INFO - 'TMOUT': '86400', 08:56:45 INFO - 'USER': 'cltbld', 08:56:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:45 INFO - '_': '/tools/buildbot/bin/python'} 08:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:45 INFO - Running setup.py (path:/tmp/pip-t7JnRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:45 INFO - Running setup.py (path:/tmp/pip-t4y0ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:45 INFO - Running setup.py (path:/tmp/pip-6vkM66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:45 INFO - Running setup.py (path:/tmp/pip-xFbmME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:45 INFO - Running setup.py (path:/tmp/pip-sRvUPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:45 INFO - Running setup.py (path:/tmp/pip-Q1FRsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:45 INFO - Running setup.py (path:/tmp/pip-BylZky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:45 INFO - Running setup.py (path:/tmp/pip-m0Zr31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:45 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)) 08:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:45 INFO - Running setup.py (path:/tmp/pip-xsMg0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:46 INFO - Running setup.py (path:/tmp/pip-iDxj1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:46 INFO - Running setup.py (path:/tmp/pip-BhsAzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:46 INFO - Running setup.py (path:/tmp/pip-8mR7b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:46 INFO - Running setup.py (path:/tmp/pip-VSjj_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:46 INFO - Running setup.py (path:/tmp/pip-H90sXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:46 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)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:46 INFO - Running setup.py (path:/tmp/pip-tU2ywp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:46 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)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:46 INFO - Running setup.py (path:/tmp/pip-3XKCDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:46 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)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:46 INFO - Running setup.py (path:/tmp/pip-qONHLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:46 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)) 08:56:46 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)) 08:56:46 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)) 08:56:46 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)) 08:56:46 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)) 08:56:46 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)) 08:56:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:46 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 08:56:46 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 08:56:46 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 08:56:46 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 08:56:46 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 08:56:46 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 08:56:48 INFO - Downloading blessings-1.6.tar.gz 08:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:48 INFO - Installing collected packages: blessings 08:56:48 INFO - Running setup.py install for blessings 08:56:48 INFO - Successfully installed blessings 08:56:48 INFO - Cleaning up... 08:56:48 INFO - Return code: 0 08:56:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:49 INFO - Reading from file tmpfile_stdout 08:56:49 INFO - Current package versions: 08:56:49 INFO - argparse == 1.2.1 08:56:49 INFO - blessings == 1.6 08:56:49 INFO - blobuploader == 1.2.4 08:56:49 INFO - docopt == 0.6.1 08:56:49 INFO - functools32 == 3.2.3-2 08:56:49 INFO - jsonschema == 2.5.1 08:56:49 INFO - manifestparser == 1.1 08:56:49 INFO - mozInstall == 1.12 08:56:49 INFO - mozcrash == 1.0 08:56:49 INFO - mozdebug == 0.1 08:56:49 INFO - mozdevice == 0.48 08:56:49 INFO - mozfile == 1.2 08:56:49 INFO - mozhttpd == 0.7 08:56:49 INFO - mozinfo == 0.9 08:56:49 INFO - mozleak == 0.1 08:56:49 INFO - mozlog == 3.4 08:56:49 INFO - moznetwork == 0.27 08:56:49 INFO - mozprocess == 0.23 08:56:49 INFO - mozprofile == 0.28 08:56:49 INFO - mozrunner == 6.13 08:56:49 INFO - mozscreenshot == 0.1 08:56:49 INFO - mozsystemmonitor == 0.3 08:56:49 INFO - moztest == 0.8 08:56:49 INFO - mozversion == 1.4 08:56:49 INFO - psutil == 3.1.1 08:56:49 INFO - requests == 1.2.3 08:56:49 INFO - wsgiref == 0.1.2 08:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:49 INFO - Using env: {'DISPLAY': ':0', 08:56:49 INFO - 'HOME': '/home/cltbld', 08:56:49 INFO - 'LANG': 'en_US.UTF-8', 08:56:49 INFO - 'LANGUAGE': 'en_US:en', 08:56:49 INFO - 'LOGNAME': 'cltbld', 08:56:49 INFO - 'MAIL': '/var/mail/cltbld', 08:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:49 INFO - 'MOZ_NO_REMOTE': '1', 08:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:49 INFO - 'NO_EM_RESTART': '1', 08:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:49 INFO - 'PWD': '/builds/slave/test', 08:56:49 INFO - 'SHELL': '/bin/bash', 08:56:49 INFO - 'SHLVL': '1', 08:56:49 INFO - 'TERM': 'linux', 08:56:49 INFO - 'TMOUT': '86400', 08:56:49 INFO - 'USER': 'cltbld', 08:56:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:49 INFO - '_': '/tools/buildbot/bin/python'} 08:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:49 INFO - Cleaning up... 08:56:49 INFO - Return code: 0 08:56:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b21672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', '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 08:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:49 INFO - Using env: {'DISPLAY': ':0', 08:56:49 INFO - 'HOME': '/home/cltbld', 08:56:49 INFO - 'LANG': 'en_US.UTF-8', 08:56:49 INFO - 'LANGUAGE': 'en_US:en', 08:56:49 INFO - 'LOGNAME': 'cltbld', 08:56:49 INFO - 'MAIL': '/var/mail/cltbld', 08:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:49 INFO - 'MOZ_NO_REMOTE': '1', 08:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:49 INFO - 'NO_EM_RESTART': '1', 08:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:49 INFO - 'PWD': '/builds/slave/test', 08:56:49 INFO - 'SHELL': '/bin/bash', 08:56:49 INFO - 'SHLVL': '1', 08:56:49 INFO - 'TERM': 'linux', 08:56:49 INFO - 'TMOUT': '86400', 08:56:49 INFO - 'USER': 'cltbld', 08:56:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:49 INFO - '_': '/tools/buildbot/bin/python'} 08:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:49 INFO - Cleaning up... 08:56:49 INFO - Return code: 0 08:56:49 INFO - Running post-action listener: _resource_record_post_action 08:56:49 INFO - Running post-action listener: _start_resource_monitoring 08:56:49 INFO - Starting resource monitoring. 08:56:49 INFO - [mozharness: 2017-01-14 16:56:49.566449Z] Finished create-virtualenv step (success) 08:56:49 INFO - [mozharness: 2017-01-14 16:56:49.566943Z] Running install step. 08:56:49 INFO - Running pre-action listener: _resource_record_pre_action 08:56:49 INFO - Running main action method: install 08:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:49 INFO - Reading from file tmpfile_stdout 08:56:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:49 INFO - Reading from file tmpfile_stdout 08:56:49 INFO - Output received: 08:56:49 INFO - Usage: mozinstall [options] installer 08:56:49 INFO - Options: 08:56:49 INFO - -h, --help show this help message and exit 08:56:49 INFO - -d DEST, --destination=DEST 08:56:49 INFO - Directory to install application into. [default: 08:56:49 INFO - "/builds/slave/test"] 08:56:49 INFO - --app=APP Application being installed. [default: firefox] 08:56:49 INFO - mkdir: /builds/slave/test/build/application 08:56:49 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'] 08:56:49 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 08:57:05 INFO - Reading from file tmpfile_stdout 08:57:05 INFO - Output received: 08:57:05 INFO - /builds/slave/test/build/application/firefox/firefox 08:57:05 INFO - Running post-action listener: _resource_record_post_action 08:57:05 INFO - [mozharness: 2017-01-14 16:57:05.806409Z] Finished install step (success) 08:57:05 INFO - [mozharness: 2017-01-14 16:57:05.806652Z] Running run-tests step. 08:57:05 INFO - Running pre-action listener: _resource_record_pre_action 08:57:05 INFO - Running main action method: run_tests 08:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:05 INFO - Python 2.7.3 08:57:05 INFO - Return code: 0 08:57:05 INFO - grabbing minidump binary from tooltool 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:05 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 0x284ef60>, '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 0x284fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28501d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:05 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 08:57:05 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 08:57:05 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 08:57:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:05 INFO - Return code: 0 08:57:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:57:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:57:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:05 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/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:57:05 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/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 08:57:05 INFO - Using env: {'DISPLAY': ':0', 08:57:05 INFO - 'HOME': '/home/cltbld', 08:57:05 INFO - 'LANG': 'en_US.UTF-8', 08:57:05 INFO - 'LANGUAGE': 'en_US:en', 08:57:05 INFO - 'LOGNAME': 'cltbld', 08:57:05 INFO - 'MAIL': '/var/mail/cltbld', 08:57:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:05 INFO - 'MOZ_NO_REMOTE': '1', 08:57:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:05 INFO - 'NO_EM_RESTART': '1', 08:57:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:05 INFO - 'PWD': '/builds/slave/test', 08:57:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:05 INFO - 'SHELL': '/bin/bash', 08:57:05 INFO - 'SHLVL': '1', 08:57:05 INFO - 'TERM': 'linux', 08:57:05 INFO - 'TMOUT': '86400', 08:57:05 INFO - 'USER': 'cltbld', 08:57:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888', 08:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:05 INFO - '_': '/tools/buildbot/bin/python'} 08:57:05 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/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:57:06 INFO - mozversion application_buildid: 20170114070524 08:57:06 INFO - mozversion application_changeset: 13a9adf5f429bd1454608aa3d313bfd994c3ef81 08:57:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:57:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:06 INFO - mozversion application_name: Firefox 08:57:06 INFO - mozversion application_remotingname: firefox-dev 08:57:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:06 INFO - mozversion application_vendor: Mozilla 08:57:06 INFO - mozversion application_version: 52.0a2 08:57:06 INFO - mozversion platform_buildid: 20170114070524 08:57:06 INFO - mozversion platform_changeset: 13a9adf5f429bd1454608aa3d313bfd994c3ef81 08:57:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:06 INFO - mozversion platform_version: 52.0a2 08:57:06 INFO - using testdate: 1484413026 08:57:06 INFO - actual date: 1484413026 08:57:06 INFO - starting webserver on 'localhost:46533' 08:57:06 INFO - SUITE-START | Running 2 tests 08:57:06 INFO - TEST-START | dromaeo_css 08:57:06 INFO - operating with platform_type : linux_ 08:57:06 INFO - Initialising browser for dromaeo_css test... 08:57:06 INFO - TEST-INFO | started process 7547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptas89i/profile http://localhost:46533/getInfo.html) 08:57:10 INFO - PROCESS | 7547 | __metrics Screen width/height:1600/1200 08:57:10 INFO - PROCESS | 7547 | colorDepth:24 08:57:10 INFO - PROCESS | 7547 | Browser inner width/height: 1024/697 08:57:10 INFO - PROCESS | 7547 | __metrics 08:57:10 INFO - PROCESS | 7547 | 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" 08:57:10 INFO - PROCESS | 7547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:11 INFO - PROCESS | 7547 | console.error: PushService: 08:57:11 INFO - PROCESS | 7547 | stateChangeProcessEnqueue: Error transitioning state 08:57:11 INFO - PROCESS | 7547 | UnknownError 08:57:11 INFO - TEST-INFO | 7547: exit 0 08:57:11 INFO - Browser initialized. 08:57:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:11 INFO - TEST-INFO | started process 7639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptas89i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:23 INFO - PROCESS | 7639 | RSS: Main: 143826944 08:57:23 INFO - PROCESS | 7639 | 09:00:24 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46533/tests/dromaeo/cssquery-ext.html) 09:00:25 INFO - PROCESS | 7639 | RSS: Main: 262782976 09:00:25 INFO - PROCESS | 7639 | 09:03:28 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-ext.html (next: http://localhost:46533/tests/dromaeo/cssquery-jquery.html) 09:03:28 INFO - PROCESS | 7639 | RSS: Main: 231784448 09:03:28 INFO - PROCESS | 7639 | 09:06:30 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46533/tests/dromaeo/cssquery-mootools.html) 09:06:31 INFO - PROCESS | 7639 | RSS: Main: 196829184 09:06:31 INFO - PROCESS | 7639 | 09:09:33 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46533/tests/dromaeo/cssquery-prototype.html) 09:09:33 INFO - PROCESS | 7639 | RSS: Main: 174796800 09:09:33 INFO - PROCESS | 7639 | 09:12:36 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46533/tests/dromaeo/cssquery-yui.html) 09:12:37 INFO - PROCESS | 7639 | RSS: Main: 174542848 09:12:37 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | Cycle 1(1): loaded http://localhost:46533/tests/dromaeo/cssquery-yui.html (next: http://localhost:46533/tests/dromaeo/cssquery-dojo.html) 09:15:39 INFO - PROCESS | 7639 | RSS: Main: 265498624 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | __start_tp_report 09:15:39 INFO - PROCESS | 7639 | _x_x_mozilla_page_load 09:15:39 INFO - PROCESS | 7639 | _x_x_mozilla_page_load_details 09:15:39 INFO - PROCESS | 7639 | |i|pagename|runs| 09:15:39 INFO - PROCESS | 7639 | |0;dojo.html;3185.7132858042773;3217.967820321796;3228.354329134172;3252.056903497986;3266.7386609071277;5529.474699903508;5562;5570.387257401682;5578.219049333096;5597.83206503805;5546.112621980484;5588.497035266825;5591.720413979305;5604.075327570946;5628.409017053212;5055.418626857912;5080.669756465836;5105.234214867763;5136.948630513703;5151.922721159167;4957.256411538262;4962.702237865721;5008.2738002989545;5125.666831655949;5167.328247327842;5025.14572522672;5136;5142.51146141116;5143.974280128613;5145.253938178962;5146.408163061221;5147.7683504242395;5151.150060240056;5156.92264616031;5171.741412929338;4926.359573255454;4937.975310123426;4963.4292056413615;5031.723255220962;5035.169197082477;5423.755930983115;5456.672599644034;5460.96241714073;5465.398806131322;5479.561635069185;5914.497267732248;5945.4946329562035;5952.9107063394085;5954.5534084943365;5965.3736357682255;5803.187553742479;5835.5915085944;5853.47318741311;5937.406259374071;5980.102984552352;5518.613697041209;5541.944580554224;5557.360903496069;5562.888742225133;5587.888242235133;6031;6040.909386359208;6047;6049.243844519435;6050.788222412194;5626.859328516738;5671.574631902624;5742.971285143631;5800.1299805029585;5829.154772557956;5836.970815145897;5912.024515954819;5916.171735956969;5942.019566771521;5945.346011938684;5891.528677705774;5892.263467066617;5900.970495147497;5902.970485147633;5918.763249469973;5621.971890140523;5731.942680573141;5906.291245050621;5907.1434641976675;5942;4512.503624601291;4537.228671125917;4543.068670922453;4547.431571053618;4549.749763763025;4059.7564146151326;4079.571644977294;4080.0411903202726;4080.9183816324103;4101.651359634465;5614.29821272341;5626.662400255997;5626.774929002876;5632.662040277596;5658.886822263532;5905.616134951214;5932.466078052996;5941.584089113807;5954.583179177416;5958.463738263577;5457.945420545744;5499.1476321170285;5507.0637991541535;5575.0522411190195;5606.383297837235;5058.367704036996;5065.366829146356;5065.366829146356;5065.848024559269;5065.873353166126;5892.7642894283745;5894.410558944157;5895.115732640053;5912.201852749909;6015.218021657157;5861.296644402699;5861.9413805863105;5863.706814659165;5865.149553314831;5866.6186697864505;5762.625429347079;5954.136650185786;5955.136505206808;5965.73154208053;5967.6121052131475;5629.3244810621345;5710.65736055838;5746.051901436216;5757.337906140848;5879.617824841372;5963.373845746134;5964.612300200473;5968.910466343095;5971.7611295547695;5974.312954010345;5714.085746280742;5807.419258074327;5818.650880947157;5822.097574875901;5824.563157763269;5603.327600687943;5634.690092044977;5635.154726791015;5668.943310567007;5700.059490184239;5712.857178570569;5718.285214348207;5718.971405142947;5719.799807006735;5741.598088133791;5795.362510123968;5799.623024503394;5802.013657678121;5807.361190268983;5808.6224395414165;5501.477359650827;5561.499465048165;5619.943800561942;5651.406602306699;5674.290713660793 09:15:39 INFO - PROCESS | 7639 | |1;ext.html;576.2048373244921;616.1712496691949;631.9951277468824;646.476354153136;647.4076220258464;35145.2970940581;37541.061473463174;37599.81200093999;37623.435648465296;37648.247035059314;38194.236115277745;46553.53446465534;47415.28877066847;47423;50338.748306258414;8853.424527405714;8968.820623587524;8976.685815996441;8978.685745998891;8981.056989016157;8306.169383061706;8873.06832782555;8950.86573701395;8964.551772411385;8966.282697384193;8431.578421078952;10368.533415996299;10711.03600675939;10715.303505272172;10951.780964380707;10623.25637205396;10672.839907401396;10699.518521666543;10704.250702450832;10714.035736783728;10605.73485662857;10689.732756681067;10694.46527673621;10698.572057117706;10701.625443109453;44177.33733993993;44240;44574.77712611449;44640.55359446396;44687.32969005468;3683.28176005679;3784.6026167252317;3823.751456155341;3900.668443182333;3971.205758848213;33617.6638233617;33849.153771155674;33899;33920;33960.49059264113;4469.128519938613;4482.305242687388;4493.887652808673;4531.388262584542;4557.635389168859;340863;341543;341633;342879;343465;62962.68518657469;63549.364506354344;63552.999999999076;63568.68215658984;63582;40615.79692101521;41564;41669.58330416657;42552.510662126675;42570.36144457835;16881.746773798404;16996.915015424845;17018.14909254532;17022.319107235573;17034.14829258532;12842.871571284355;12929.54746583865;12938.09433339676;12944.352782361033;12946.546870859474;18726.344577939708;19142.234310627697;20248.595028099357;20560.485987850123;20809.127178554;7430.925690743132;7431.516951398142;7523.962380188064;7543.585102819397;7558.206388329256;982.3860087445347;1010.2372708604956;1068.4497483795851;1077.5258886090096;1081.2377274021796;32959.67040329614;33727.83136084353;33929.83035084809;34074.48888266678;34538;1085.2728671789919;1089.9618513351995;1171.7656468706293;1182.3260741377505;1210.878912108782;17659.823401766076;17669.91165044192;17747.73378399325;17768.423578581034;17882.463526094238;474286;476468;477388;478790;478959;62942.37057629365;63463.36536634667;63701.681491592244;63747.36252637507;63888.68055659692;1269.206745783885;1344.0188662276594;1366.2417358366201;1424.6794471244095;1435.9210243436712;33370.33259334751;33809.15477113092;36402.4539631911;36967.8151609251;38344;60857;61481;61549.99999999821;61567.38432615616;61694.38305616887;445978;450979;451221;452551;452934;44923.32615010843;46200;46309.76845115753;46536;46564.2061476299;50362.2445663308;50660.493395065576;51428.22857657063;51930.48069519408;52258.73870630623;43251.35122973221;44034.55965440433;44124.77937610292;44650.3302450457;44851.32723009092;43410.56589434065;44526.77736611296;44699.55300446954;45304.32043519416;45394;39559.208815822945;40236.798816005736;44640.33039504475;45384.319235212155;45557.08885822331;35865.46201806923;37831;38514.80742596269;38659.6134038656;38710.22579548337;29225.56161657534;29632.555511667775;29670;29748;29931.251718707208 09:15:39 INFO - PROCESS | 7639 | |2;jquery.html;384.429122752712;426.0837347165617;431.7452702905286;440.7994362565032;450.8827704796754;15964.760528592065;19035.333763318285;19879.40361789145;20151.09320080596;20340.389788306373;19739.703904441445;19935.401937941886;20042.79957200431;20365.59268814623;20430.38708838737;5577.749001294941;5778.451047150514;5785.450382213683;5786.450287222707;5788.768449262046;5433.565314774828;5680.11958146488;5716.8284951451315;5717.9714101429645;5721.113227449731;5683.374828768832;5687.345955215141;5690.174924635925;5694.003549378863;5694.800681976131;5420.268263784398;5605.1872478490595;5610.775568977236;5633.126865335879;5635.887282254373;4907.092187945242;5053.898922021575;5059.089363914494;5059.392872855244;5060.367454068241;23308.184213552446;23485.530289394286;23518.176863809684;23751.76248237513;23874.7612523876;2431.7203521595065;2661.2149415922154;2719.442514284567;2772.7365900239447;2848.30216596933;14428.567142985727;14494.275286235646;14576.416943322254;14762.778558321634;15203.087814731152;2018.0918586635926;2047.1095073643014;2069.2136987944637;2073.523089689365;2091.853570250083;85735;86642.56678716629;87005.12994870034;87832;88093;9856.950715246378;10683.198760093024;10785.83821242682;10797.676069717922;11156.442177891235;15382.846171538366;15415.383384664488;15462.304196311194;15476.690466190614;15490.9225453872;7803.336716379172;8173.591320433955;8190.672373105128;8291.170882911782;8345.582720863933;7653.196414376522;7658.578778167142;7703.075630924325;7855.293023627786;7954.84090318202;6775.085363475966;6781.728730850711;6864.627074585103;6981;7074.257202993715;1956.4130760771711;2016.3446879764135;2019.2629690163278;2047.488127968008;2060.47457898235;954.6849539651898;1074.1621535202555;1079.4171147580219;1123.9775204496027;1151.2919554474106;19987.004548408233;20682.68975965362;20854.270100546408;20927.476813079797;20995;943.4810854030256;1014.4623349624711;1056.8784589772274;1073.7906108308962;1082.5345101606226;10788.892111078945;10803.351798891934;10817;10828.187885908588;10857.131429485622;498275;500930;501581;503561;509406;94734.52632736792;95233;98719.50640246896;100630;101701;1032.7108409645311;1038.7143535527791;1051.1800795379615;1079.3901445683164;1082.3073233130804;17162.884412513147;17362.27710489223;17594.208260628046;17673.29306827764;17863.821361786217;42626;42659.14681706411;42692.359614605186;42761.78619107009;45919.77040114778;55941.44058559362;59499.70250148721;61231.693841530505;61275;61655.38344616497;7489.700411983677;7526.09686837583;7723;7770.961145194238;7903.486273392211;11755.88244117548;12573.1198816082;12927.870721292667;12981.870181298444;13289;10239.692809215736;10502.737431564272;10680.145588353069;10843.295185812896;11010.779784404427;10240.18078553699;10548.894511054792;10750.892491074988;10802.945985270024;11040.400783710786;10949.56201751921;10955.616553420592;11132.109431245643;11169.497372618414;11327.943360283145;7691.346235570039;7810.336121429515;7934.801629959297;7991.680332786856;8030.357571394157;8063.637136328996;11139.05318047975;11140.777184456427;11260;11579.768404632028 09:15:39 INFO - PROCESS | 7639 | |3;mootools.html;1329.6210579984706;1501.474483930624;1530.3496014193968;1677.5806048487877;1812;7876.606169691514;8420.200080992303;8649.524276164808;8905.777355566113;8982.05688402718;8898.288136949044;8997.730068097952;8998.820023599541;9011.234045106174;9017.819643607141;2471.3203868936007;2501.0996041425074;2503.5869081601604;2505.34860936157;2505.5991041433376;2416.3838221253554;2513.5978243481045;2524.2931979045807;2525.01524405482;2525.5959046552557;2453;2456.078970386105;2476.4923190745853;2481.1936120760734;2483.044028049196;2344.3787396339985;2378.583747844129;2393.485400638871;2409.734929157791;2410.795082417979;2405.013944282836;2411.7588241175918;2438.1222759806456;2456.828022038458;2457.6313552967017;8733.388662793606;8793.956030219872;8806.33952453562;8888.288936885034;8928.24109950655;5329.573634109262;5542;5543.944560554383;5547.611667183299;5553.944460555384;3638.472421498868;3747.2130852521004;3776.0553315042775;3830.7893065881367;3838.3858582626644;1223.577865636354;1249.5001999200301;1254.4793910527121;1299.123091912955;1312.1667740984544;12642.49430022798;12753.298568578724;12754.808677869747;12779.233246005177;12805.807912881408;4517.34498497716;4678.181318269358;4778.37881075458;4851;4891.633127515451;10075.647352342632;10113.797724045478;10119.291649584606;10122;10124.54439550222;5462.317210348707;5462.562994960394;5471.753771080311;5476.041692703761;5483.122700367922;4481.641468682497;4549.249373853278;5091.2363145527725;5134.178531434953;5151.793928242903;3998.5001874765653;4067.572904844949;4097.959020409818;4158.251514727318;4161.791910404468;1227.858796238426;1233.495135934159;1233.747081848219;1239.2130996816907;1250.9499620015279;936.1153709744362;979.9857147851939;1013.5692330759398;1018.9490525473844;1022.6114076650825;6078.635281883101;6132.325444201134;6330.39861213184;6331.271903731038;6586.1438013058;948.2035090523993;963.6530848894392;967.1634036558467;989.7228775942748;1013.3970287678819;4087.3664581989838;4251.128518653669;4268.317069268965;4279.550647182064;4356.215881141362;10319.896801032044;10691.946540267405;10713.142948564097;10729.195310351599;10737.78524429507;10641.5211315491;10648.14814814813;10655.200859935536;10658.307210031324;10694.411807350514;8115.431919765678;8468.110848360957;8490.702825401082;8517.57412129391;8651.870221946676;6050.546209034252;6227.96886015567;6242.563020588515;6339.873202536016;6541.934580654132;10243.795124097327;10433.217508686726;10439;10462.319949203582;10544.472776361305;10534.947325263325;10658;10681.412522311037;10745.785084298113;10782.568697252022;8147.551884646401;8189.918100818915;8231.835363292821;8250.958745206235;8285.088640249447;8758.824823503366;8767.868481972902;8844.380893337404;8852.734417967471;8858.335624828293;7657.617119144132;7821.6089195541135;7880.921190788019;7936.761897143095;7964.123946366011;7783.6108194588915;7821.765347039598;7872.606369681607;7927.048754149539;8195.71315003972;7057.470689698191;7185.173705023989;7252.746153884589;7268.67290971897;7380.261973802577;5184.922226166535;5194.168932970707;5213.687178769286;5251.422343542284;5275.788968441219;5286.074936885952;5301.469853014668;5389.676619402849;5455.181722741462;5482.862928426821 09:15:39 INFO - PROCESS | 7639 | |4;prototype.html;336.6549286980844;341.7385699939547;344.698388909704;348.445970906259;351.3447420560655;5445.863853403662;5486.396496385394;5513.8345849624475;5520.14437762147;5577.749001294941;5387.595930305223;5426.62013659044;5465.754041068151;5470.826920386176;5488.341399032111;4057.6550993165615;4114.300568903279;4118.794060296988;4170.666346692257;4215.49414070312;4204.3302502910565;4217.704760666755;4242.278812601865;4249.213895429355;4283.229018776619;4184.895377615569;4185.142045880587;4191.413202151702;4214.2414365414215;4232.809523571446;3923.1369098798364;4024.7585144891254;4118.588141185887;4177.7857735400285;4207.242696314662;3698.7410881238056;3702.778083232527;3710.5547334319785;3712.684421824148;3713.795741234231;5180.844574662766;5220.504052115043;5220.582353411718;5236.764345604457;5269.1832765921345;4517.351166824118;4751.786169622375;4752.500987396308;4770.7376094314795;4783.28250762385;5568.888622227573;5588.748506317225;5592.664440133605;5602.747876345574;5608.635438696471;4040;4041.4544036555276;4044.766346264388;4053.209624123297;4082.101937573729;5529.889402211974;5731.595759039021;5760.53915686744;5814.854628634275;5829.18391425205;4092.304308267542;4099.221147981874;4105;4117;4132.834686612502;4177.582241775798;4179.686523510688;4180.163967206571;4182.644475219579;4202.348635961431;4556.88607784808;4708.952910470852;4765.666403351802;4803.903921921542;4815.579404075806;5603.523700485504;5610.719464026783;5614.29821272341;5620.578456615688;5624.91562626561;1398.7622104242303;1407.7606806842862;1409.837868645119;1423.9715205695827;1424.7364237616075;917.9357444978788;926.305271046715;977.1986970684113;979.2264111352094;989.4014121456559;5140.742962851918;5358.223057656618;5480.369757477862;5485.17722341644;5504.862378440491;5733;5758.913616295759;5770.855728606818;5776.393478684678;5811.593188476766;5373.328333958255;5396.811111611153;5514.751836167382;5526.447355264441;5534.972325138348;2932.0470846974818;2932.765378769693;2938.9853050735037;2976.2113040044405;2982.3140677644265;5695.1741997410145;5718.628289161191;5718.7426565804635;5719.256496655491;5726.4273572642405;5420.674759514362;5678.375378708339;5695.231143795535;5696.914546281809;5699.487046165865;5627.227423361628;5662.235598194274;5664.943350566442;5697.914531282034;5768.125359258174;5482.28730265079;5579.911917176274;5641.266635337544;5700.429957004267;5797.826065218051;5758.6887539665695;5768.769489086125;5770.163326317745;5780.265920224;5798.246227990334;5947.524198064058;5980.641161530322;5987.64074155552;5994.6403215807195;6032.819015429544;4045.211183819127;4150.024744185053;4173.6661067115165;4186.3254698121;4193.97903010483;5815.2149459822385;5824.271966004249;5842.510159909366;5865.618734782225;5871.943050250996;5565.551157490691;5733.913991290217;5739.426057394227;5761.3209857416505;5784.595078344644;5644.52021578154;5655.4627310407095;5660.264165658438;5665.745041473226;5739.598228123991;5616.848546047969;5637.49262566371;5640.294963129609;5700.971495142498;5708.972384970745;5553.11194193976;5575.414581468887;5674.4892959633835;5698.743556539883;5725.484706376279;5517.875617887062;5523.944760552343;5541.889162216814;5586.273784408001;5593.860153496195 09:15:39 INFO - PROCESS | 7639 | |5;yui.html;803.3613277444427;810.8378324335133;814.7392834293029;825.521197705331;883.8630012348088;15028.699426011473;15245.390184392625;15452.69094618107;15603.921980390081;15744.448944286938;14542.636434089152;14745.041572297792;14760.188189649592;14905.32926018329;14928.850711492882;714.7141143542573;733.0214164090945;854.5300084953282;865.5023361567124;866.8266346730647;823.9217274358926;856.2293935458107;860.6256278518864;861.6467248428146;864.8356812205692;893.2764460786751;894.5974311559825;894.6510860764307;895.0288936503902;897.9640814367417;741.6291854072964;892.8437523433438;893.6246776353947;894.3024440936048;895.3508706188027;562.5134258866051;636.6053047110775;655.5181941273161;659.3735950846715;660.9985871404825;14219.573412797528;14237.359318830677;14253.572392828231;14258.714825703531;14263.429462821474;13181.472741090345;13272.601821945356;13545.051846370758;13658.658533536642;14017;12407.62777116679;12416.75166496674;12740.299283539402;12834.037447191498;12968.351582420935;4315.525292217853;4375.409319741858;4397.494288156871;4415.381846541487;4479.1489616972995;60611;60690.696546516985;62272.37727622756;65229.67385163091;65545.67227163834;10835.945820270848;10888.945555272332;11071.225014248925;11121.72195695098;11321.320720756781;20515.076821543065;20550;20556;20715;20765.688514672293;8146.83706325882;8419.621117049748;8457.112003239694;8474.74575762728;8577.399582029322;4666.69666471685;4716.716996980193;4738.597219236403;4754.21555443348;4883.02339532095;3302.570665813477;3409.4885767134633;3414.095264754842;3414.7194801949267;3417.470292104678;587.1779508687786;589.8849724303806;591.8459004940297;600.504583718434;609.9725512351955;655.5443966443277;658.1411258307954;662.1755913887241;669.5882032550044;702.9367356937901;8296.875546866802;8620.051794302623;8760.51817150063;9089.136532029446;9183.311251656152;670.8624731929942;682.774684354162;683.3337495941516;696.1437431958618;712.4834494991194;4396.712700837768;4409.977950110229;4419.381286619876;4469.7988590513505;4479.46246450428;54245.72877135589;67260.99108513376;87537.5623121893;88060.55969720239;91462.54268728614;76702.61648691833;78352.60823695845;78687.21312786799;79140.34251201911;81608.59195704102;68340.65829670819;68735.31264687289;68847.65576172087;70367;71700.28299716936;8222.712205073032;8555.331710316677;8560.785980350542;8578.785530361542;8847;47716.7614161927;47731.76134119307;48571.76981109586;51261.231081533064;53070;60449.69775151096;61044.69477652583;65772.34227657662;66550.66898661903;69223.65388173026;11079.113670906147;11169.218154729417;11484.770304594029;11543.307401555934;11651.41742912868;12500.812487812873;12683.87316126827;12818.807717884052;12839.101262911507;13069.085164038426;11691.590794322497;11962.760744784882;11978.940105299418;12267.754644906874;12503.249805011365;11295.37875416827;11576.88217938923;11757.76484470323;11781.646550603497;12308.876911230773;11566.132540059361;11850.525978960744;11991.940040299743;12247.632571022526;12466;10158.288919775545;10319.638812641522;10380.740481488023;10652.147828173573;10722.946385268337;9866.950665246628;10432.530536125741;10535.262531623019;10553.419561924167;10567.63013294531 09:15:39 INFO - PROCESS | 7639 | __end_tp_report 09:15:39 INFO - PROCESS | 7639 | __start_cc_report 09:15:39 INFO - PROCESS | 7639 | _x_x_mozilla_cycle_collect,1157 09:15:39 INFO - PROCESS | 7639 | __end_cc_report 09:15:39 INFO - PROCESS | 7639 | __startTimestamp1484414139973__endTimestamp 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | ------- Summary: start ------- 09:15:39 INFO - PROCESS | 7639 | Number of tests: 6 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#0] dojo.html Cycles:165 Average:5479.32 Median:5635.15 stddev:595.29 (10.6%) stddev-sans-first:569.27 09:15:39 INFO - PROCESS | 7639 | Values: 3185.7 3218.0 3228.4 3252.1 3266.7 5529.5 5562.0 5570.4 5578.2 5597.8 5546.1 5588.5 5591.7 5604.1 5628.4 5055.4 5080.7 5105.2 5136.9 5151.9 4957.3 4962.7 5008.3 5125.7 5167.3 5025.1 5136.0 5142.5 5144.0 5145.3 5146.4 5147.8 5151.2 5156.9 5171.7 4926.4 4938.0 4963.4 5031.7 5035.2 5423.8 5456.7 5461.0 5465.4 5479.6 5914.5 5945.5 5952.9 5954.6 5965.4 5803.2 5835.6 5853.5 5937.4 5980.1 5518.6 5541.9 5557.4 5562.9 5587.9 6031.0 6040.9 6047.0 6049.2 6050.8 5626.9 5671.6 5743.0 5800.1 5829.2 5837.0 5912.0 5916.2 5942.0 5945.3 5891.5 5892.3 5901.0 5903.0 5918.8 5622.0 5731.9 5906.3 5907.1 5942.0 4512.5 4537.2 4543.1 4547.4 4549.7 4059.8 4079.6 4080.0 4080.9 4101.7 5614.3 5626.7 5626.8 5632.7 5658.9 5905.6 5932.5 5941.6 5954.6 5958.5 5457.9 5499.1 5507.1 5575.1 5606.4 5058.4 5065.4 5065.4 5065.8 5065.9 5892.8 5894.4 5895.1 5912.2 6015.2 5861.3 5861.9 5863.7 5865.1 5866.6 5762.6 5954.1 5955.1 5965.7 5967.6 5629.3 5710.7 5746.1 5757.3 5879.6 5963.4 5964.6 5968.9 5971.8 5974.3 5714.1 5807.4 5818.7 5822.1 5824.6 5603.3 5634.7 5635.2 5668.9 5700.1 5712.9 5718.3 5719.0 5719.8 5741.6 5795.4 5799.6 5802.0 5807.4 5808.6 5501.5 5561.5 5619.9 5651.4 5674.3 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#1] ext.html Cycles:180 Average:60141.41 Median:40426.30 stddev:112731.99 (278.9%) stddev-sans-first:112959.52 09:15:39 INFO - PROCESS | 7639 | Values: 576.2 616.2 632.0 646.5 647.4 35145.3 37541.1 37599.8 37623.4 37648.2 38194.2 46553.5 47415.3 47423.0 50338.7 8853.4 8968.8 8976.7 8978.7 8981.1 8306.2 8873.1 8950.9 8964.6 8966.3 8431.6 10368.5 10711.0 10715.3 10951.8 10623.3 10672.8 10699.5 10704.3 10714.0 10605.7 10689.7 10694.5 10698.6 10701.6 44177.3 44240.0 44574.8 44640.6 44687.3 3683.3 3784.6 3823.8 3900.7 3971.2 33617.7 33849.2 33899.0 33920.0 33960.5 4469.1 4482.3 4493.9 4531.4 4557.6 340863.0 341543.0 341633.0 342879.0 343465.0 62962.7 63549.4 63553.0 63568.7 63582.0 40615.8 41564.0 41669.6 42552.5 42570.4 16881.7 16996.9 17018.1 17022.3 17034.1 12842.9 12929.5 12938.1 12944.4 12946.5 18726.3 19142.2 20248.6 20560.5 20809.1 7430.9 7431.5 7524.0 7543.6 7558.2 982.4 1010.2 1068.4 1077.5 1081.2 32959.7 33727.8 33929.8 34074.5 34538.0 1085.3 1090.0 1171.8 1182.3 1210.9 17659.8 17669.9 17747.7 17768.4 17882.5 474286.0 476468.0 477388.0 478790.0 478959.0 62942.4 63463.4 63701.7 63747.4 63888.7 1269.2 1344.0 1366.2 1424.7 1435.9 33370.3 33809.2 36402.5 36967.8 38344.0 60857.0 61481.0 61550.0 61567.4 61694.4 445978.0 450979.0 451221.0 452551.0 452934.0 44923.3 46200.0 46309.8 46536.0 46564.2 50362.2 50660.5 51428.2 51930.5 52258.7 43251.4 44034.6 44124.8 44650.3 44851.3 43410.6 44526.8 44699.6 45304.3 45394.0 39559.2 40236.8 44640.3 45384.3 45557.1 35865.5 37831.0 38514.8 38659.6 38710.2 29225.6 29632.6 29670.0 29748.0 29931.3 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#2] jquery.html Cycles:180 Average:29891.70 Median:23634.97 stddev:83089.17 (351.6%) stddev-sans-first:83292.72 09:15:39 INFO - PROCESS | 7639 | Values: 384.4 426.1 431.7 440.8 450.9 15964.8 19035.3 19879.4 20151.1 20340.4 19739.7 19935.4 20042.8 20365.6 20430.4 5577.7 5778.5 5785.5 5786.5 5788.8 5433.6 5680.1 5716.8 5718.0 5721.1 5683.4 5687.3 5690.2 5694.0 5694.8 5420.3 5605.2 5610.8 5633.1 5635.9 4907.1 5053.9 5059.1 5059.4 5060.4 23308.2 23485.5 23518.2 23751.8 23874.8 2431.7 2661.2 2719.4 2772.7 2848.3 14428.6 14494.3 14576.4 14762.8 15203.1 2018.1 2047.1 2069.2 2073.5 2091.9 85735.0 86642.6 87005.1 87832.0 88093.0 9857.0 10683.2 10785.8 10797.7 11156.4 15382.8 15415.4 15462.3 15476.7 15490.9 7803.3 8173.6 8190.7 8291.2 8345.6 7653.2 7658.6 7703.1 7855.3 7954.8 6775.1 6781.7 6864.6 6981.0 7074.3 1956.4 2016.3 2019.3 2047.5 2060.5 954.7 1074.2 1079.4 1124.0 1151.3 19987.0 20682.7 20854.3 20927.5 20995.0 943.5 1014.5 1056.9 1073.8 1082.5 10788.9 10803.4 10817.0 10828.2 10857.1 498275.0 500930.0 501581.0 503561.0 509406.0 94734.5 95233.0 98719.5 100630.0 101701.0 1032.7 1038.7 1051.2 1079.4 1082.3 17162.9 17362.3 17594.2 17673.3 17863.8 42626.0 42659.1 42692.4 42761.8 45919.8 55941.4 59499.7 61231.7 61275.0 61655.4 7489.7 7526.1 7723.0 7771.0 7903.5 11755.9 12573.1 12927.9 12981.9 13289.0 10239.7 10502.7 10680.1 10843.3 11010.8 10240.2 10548.9 10750.9 10802.9 11040.4 10949.6 10955.6 11132.1 11169.5 11327.9 7691.3 7810.3 7934.8 7991.7 8030.4 8063.6 11139.1 11140.8 11260.0 11579.8 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#3] mootools.html Cycles:180 Average:5954.33 Median:4533.30 stddev:3311.14 (73.0%) stddev-sans-first:3302.18 09:15:39 INFO - PROCESS | 7639 | Values: 1329.6 1501.5 1530.3 1677.6 1812.0 7876.6 8420.2 8649.5 8905.8 8982.1 8898.3 8997.7 8998.8 9011.2 9017.8 2471.3 2501.1 2503.6 2505.3 2505.6 2416.4 2513.6 2524.3 2525.0 2525.6 2453.0 2456.1 2476.5 2481.2 2483.0 2344.4 2378.6 2393.5 2409.7 2410.8 2405.0 2411.8 2438.1 2456.8 2457.6 8733.4 8794.0 8806.3 8888.3 8928.2 5329.6 5542.0 5543.9 5547.6 5553.9 3638.5 3747.2 3776.1 3830.8 3838.4 1223.6 1249.5 1254.5 1299.1 1312.2 12642.5 12753.3 12754.8 12779.2 12805.8 4517.3 4678.2 4778.4 4851.0 4891.6 10075.6 10113.8 10119.3 10122.0 10124.5 5462.3 5462.6 5471.8 5476.0 5483.1 4481.6 4549.2 5091.2 5134.2 5151.8 3998.5 4067.6 4098.0 4158.3 4161.8 1227.9 1233.5 1233.7 1239.2 1250.9 936.1 980.0 1013.6 1018.9 1022.6 6078.6 6132.3 6330.4 6331.3 6586.1 948.2 963.7 967.2 989.7 1013.4 4087.4 4251.1 4268.3 4279.6 4356.2 10319.9 10691.9 10713.1 10729.2 10737.8 10641.5 10648.1 10655.2 10658.3 10694.4 8115.4 8468.1 8490.7 8517.6 8651.9 6050.5 6228.0 6242.6 6339.9 6541.9 10243.8 10433.2 10439.0 10462.3 10544.5 10534.9 10658.0 10681.4 10745.8 10782.6 8147.6 8189.9 8231.8 8251.0 8285.1 8758.8 8767.9 8844.4 8852.7 8858.3 7657.6 7821.6 7880.9 7936.8 7964.1 7783.6 7821.8 7872.6 7927.0 8195.7 7057.5 7185.2 7252.7 7268.7 7380.3 5184.9 5194.2 5213.7 5251.4 5275.8 5286.1 5301.5 5389.7 5455.2 5482.9 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#4] prototype.html Cycles:180 Average:4729.86 Median:5509.35 stddev:1390.47 (25.2%) stddev-sans-first:1354.71 09:15:39 INFO - PROCESS | 7639 | Values: 336.7 341.7 344.7 348.4 351.3 5445.9 5486.4 5513.8 5520.1 5577.7 5387.6 5426.6 5465.8 5470.8 5488.3 4057.7 4114.3 4118.8 4170.7 4215.5 4204.3 4217.7 4242.3 4249.2 4283.2 4184.9 4185.1 4191.4 4214.2 4232.8 3923.1 4024.8 4118.6 4177.8 4207.2 3698.7 3702.8 3710.6 3712.7 3713.8 5180.8 5220.5 5220.6 5236.8 5269.2 4517.4 4751.8 4752.5 4770.7 4783.3 5568.9 5588.7 5592.7 5602.7 5608.6 4040.0 4041.5 4044.8 4053.2 4082.1 5529.9 5731.6 5760.5 5814.9 5829.2 4092.3 4099.2 4105.0 4117.0 4132.8 4177.6 4179.7 4180.2 4182.6 4202.3 4556.9 4709.0 4765.7 4803.9 4815.6 5603.5 5610.7 5614.3 5620.6 5624.9 1398.8 1407.8 1409.8 1424.0 1424.7 917.9 926.3 977.2 979.2 989.4 5140.7 5358.2 5480.4 5485.2 5504.9 5733.0 5758.9 5770.9 5776.4 5811.6 5373.3 5396.8 5514.8 5526.4 5535.0 2932.0 2932.8 2939.0 2976.2 2982.3 5695.2 5718.6 5718.7 5719.3 5726.4 5420.7 5678.4 5695.2 5696.9 5699.5 5627.2 5662.2 5664.9 5697.9 5768.1 5482.3 5579.9 5641.3 5700.4 5797.8 5758.7 5768.8 5770.2 5780.3 5798.2 5947.5 5980.6 5987.6 5994.6 6032.8 4045.2 4150.0 4173.7 4186.3 4194.0 5815.2 5824.3 5842.5 5865.6 5871.9 5565.6 5733.9 5739.4 5761.3 5784.6 5644.5 5655.5 5660.3 5665.7 5739.6 5616.8 5637.5 5640.3 5701.0 5709.0 5553.1 5575.4 5674.5 5698.7 5725.5 5517.9 5523.9 5541.9 5586.3 5593.9 09:15:39 INFO - PROCESS | 7639 | 09:15:39 INFO - PROCESS | 7639 | [#5] yui.html Cycles:180 Average:17669.38 Median:26727.40 stddev:23330.84 (87.3%) stddev-sans-first:23361.91 09:15:39 INFO - PROCESS | 7639 | Values: 803.4 810.8 814.7 825.5 883.9 15028.7 15245.4 15452.7 15603.9 15744.4 14542.6 14745.0 14760.2 14905.3 14928.9 714.7 733.0 854.5 865.5 866.8 823.9 856.2 860.6 861.6 864.8 893.3 894.6 894.7 895.0 898.0 741.6 892.8 893.6 894.3 895.4 562.5 636.6 655.5 659.4 661.0 14219.6 14237.4 14253.6 14258.7 14263.4 13181.5 13272.6 13545.1 13658.7 14017.0 12407.6 12416.8 12740.3 12834.0 12968.4 4315.5 4375.4 4397.5 4415.4 4479.1 60611.0 60690.7 62272.4 65229.7 65545.7 10835.9 10888.9 11071.2 11121.7 11321.3 20515.1 20550.0 20556.0 20715.0 20765.7 8146.8 8419.6 8457.1 8474.7 8577.4 4666.7 4716.7 4738.6 4754.2 4883.0 3302.6 3409.5 3414.1 3414.7 3417.5 587.2 589.9 591.8 600.5 610.0 655.5 658.1 662.2 669.6 702.9 8296.9 8620.1 8760.5 9089.1 9183.3 670.9 682.8 683.3 696.1 712.5 4396.7 4410.0 4419.4 4469.8 4479.5 54245.7 67261.0 87537.6 88060.6 91462.5 76702.6 78352.6 78687.2 79140.3 81608.6 68340.7 68735.3 68847.7 70367.0 71700.3 8222.7 8555.3 8560.8 8578.8 8847.0 47716.8 47731.8 48571.8 51261.2 53070.0 60449.7 61044.7 65772.3 66550.7 69223.7 11079.1 11169.2 11484.8 11543.3 11651.4 12500.8 12683.9 12818.8 12839.1 13069.1 11691.6 11962.8 11978.9 12267.8 12503.2 11295.4 11576.9 11757.8 11781.6 12308.9 11566.1 11850.5 11991.9 12247.6 12466.0 10158.3 10319.6 10380.7 10652.1 10722.9 9867.0 10432.5 10535.3 10553.4 10567.6 09:15:39 INFO - PROCESS | 7639 | -------- Summary: end -------- 09:15:39 INFO - PROCESS | 7639 | 09:15:40 INFO - TEST-INFO | 7639: exit 0 09:15:40 INFO - TEST-OK | dromaeo_css | took 1114638ms 09:15:40 INFO - TEST-START | kraken 09:15:40 INFO - operating with platform_type : linux_ 09:15:40 INFO - Initialising browser for kraken test... 09:15:40 INFO - TEST-INFO | started process 7954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp74XRGa/profile http://localhost:46533/getInfo.html) 09:15:44 INFO - PROCESS | 7954 | __metrics Screen width/height:1600/1200 09:15:44 INFO - PROCESS | 7954 | colorDepth:24 09:15:44 INFO - PROCESS | 7954 | Browser inner width/height: 1024/697 09:15:44 INFO - PROCESS | 7954 | __metrics 09:15:45 INFO - PROCESS | 7954 | 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:15:45 INFO - PROCESS | 7954 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:45 INFO - PROCESS | 7954 | console.error: PushService: 09:15:45 INFO - PROCESS | 7954 | stateChangeProcessEnqueue: Error transitioning state 09:15:45 INFO - PROCESS | 7954 | UnknownError 09:15:46 INFO - TEST-INFO | 7954: exit 0 09:15:46 INFO - Browser initialized. 09:15:46 INFO - Running cycle 1/1 for kraken test... 09:15:46 INFO - TEST-INFO | started process 8046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp74XRGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:57 INFO - PROCESS | 8046 | RSS: Main: 144228352 09:15:57 INFO - PROCESS | 8046 | 09:16:00 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46533/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:01 INFO - PROCESS | 8046 | RSS: Main: 185470976 09:16:01 INFO - PROCESS | 8046 | 09:16:03 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46533/tests/kraken/driver.html?testName=audio-dft) 09:16:04 INFO - PROCESS | 8046 | RSS: Main: 175214592 09:16:04 INFO - PROCESS | 8046 | 09:16:07 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46533/tests/kraken/driver.html?testName=audio-fft) 09:16:07 INFO - PROCESS | 8046 | RSS: Main: 266444800 09:16:07 INFO - PROCESS | 8046 | 09:16:09 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46533/tests/kraken/driver.html?testName=audio-oscillator) 09:16:10 INFO - PROCESS | 8046 | RSS: Main: 173359104 09:16:10 INFO - PROCESS | 8046 | 09:16:12 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:13 INFO - PROCESS | 8046 | RSS: Main: 175337472 09:16:13 INFO - PROCESS | 8046 | 09:16:16 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46533/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:16 INFO - PROCESS | 8046 | RSS: Main: 214282240 09:16:16 INFO - PROCESS | 8046 | 09:16:19 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46533/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:20 INFO - PROCESS | 8046 | RSS: Main: 213094400 09:16:20 INFO - PROCESS | 8046 | 09:16:23 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46533/tests/kraken/driver.html?testName=json-parse-financial) 09:16:23 INFO - PROCESS | 8046 | RSS: Main: 211750912 09:16:23 INFO - PROCESS | 8046 | 09:16:25 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:25 INFO - PROCESS | 8046 | RSS: Main: 173641728 09:16:25 INFO - PROCESS | 8046 | 09:16:27 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:28 INFO - PROCESS | 8046 | RSS: Main: 180576256 09:16:28 INFO - PROCESS | 8046 | 09:16:30 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:30 INFO - PROCESS | 8046 | RSS: Main: 190005248 09:16:30 INFO - PROCESS | 8046 | 09:16:33 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:33 INFO - PROCESS | 8046 | RSS: Main: 197906432 09:16:33 INFO - PROCESS | 8046 | 09:16:36 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:37 INFO - PROCESS | 8046 | RSS: Main: 194990080 09:16:37 INFO - PROCESS | 8046 | 09:16:38 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:46533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46533/tests/kraken/driver.html?testName=ai-astar) 09:16:39 INFO - PROCESS | 8046 | RSS: Main: 246177792 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | __start_tp_report 09:16:39 INFO - PROCESS | 8046 | _x_x_mozilla_page_load 09:16:39 INFO - PROCESS | 8046 | _x_x_mozilla_page_load_details 09:16:39 INFO - PROCESS | 8046 | |i|pagename|runs| 09:16:39 INFO - PROCESS | 8046 | |0;ai-astar;103;111;111;110;111;111;112;111;112;110 09:16:39 INFO - PROCESS | 8046 | |1;audio-beat-detection;146;119;120;159;120;120;116;115;145;117 09:16:39 INFO - PROCESS | 8046 | |2;audio-dft;161;160;160;159;161;160;161;160;159;159 09:16:39 INFO - PROCESS | 8046 | |3;audio-fft;74;75;74;101;74;74;76;75;96;75 09:16:39 INFO - PROCESS | 8046 | |4;audio-oscillator;81;82;111;82;81;82;101;81;82;117 09:16:39 INFO - PROCESS | 8046 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 09:16:39 INFO - PROCESS | 8046 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;147;146 09:16:39 INFO - PROCESS | 8046 | |7;imaging-desaturate;84;85;84;84;85;84;84;85;85;84 09:16:39 INFO - PROCESS | 8046 | |8;json-parse-financial;52;51;52;52;51;51;52;52;51;51 09:16:39 INFO - PROCESS | 8046 | |9;json-stringify-tinderbox;68;59;58;59;59;62;59;58;59;59 09:16:39 INFO - PROCESS | 8046 | |10;stanford-crypto-aes;75;74;74;78;75;84;75;75;74;75 09:16:39 INFO - PROCESS | 8046 | |11;stanford-crypto-ccm;124;131;128;120;123;121;123;120;163;126 09:16:39 INFO - PROCESS | 8046 | |12;stanford-crypto-pbkdf2;154;151;151;155;152;159;155;158;150;151 09:16:39 INFO - PROCESS | 8046 | |13;stanford-crypto-sha256-iterative;63;61;62;63;61;61;62;61;61;61 09:16:39 INFO - PROCESS | 8046 | __end_tp_report 09:16:39 INFO - PROCESS | 8046 | __start_cc_report 09:16:39 INFO - PROCESS | 8046 | _x_x_mozilla_cycle_collect,1631 09:16:39 INFO - PROCESS | 8046 | __end_cc_report 09:16:39 INFO - PROCESS | 8046 | __startTimestamp1484414199056__endTimestamp 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | ------- Summary: start ------- 09:16:39 INFO - PROCESS | 8046 | Number of tests: 14 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.62 (2.4%) stddev-sans-first:0.71 09:16:39 INFO - PROCESS | 8046 | Values: 103.0 111.0 111.0 110.0 111.0 111.0 112.0 111.0 112.0 110.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:120.00 stddev:15.92 (13.3%) stddev-sans-first:15.44 09:16:39 INFO - PROCESS | 8046 | Values: 146.0 119.0 120.0 159.0 120.0 120.0 116.0 115.0 145.0 117.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 09:16:39 INFO - PROCESS | 8046 | Values: 161.0 160.0 160.0 159.0 161.0 160.0 161.0 160.0 159.0 159.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#3] audio-fft Cycles:10 Average:79.40 Median:75.00 stddev:10.16 (13.5%) stddev-sans-first:10.58 09:16:39 INFO - PROCESS | 8046 | Values: 74.0 75.0 74.0 101.0 74.0 74.0 76.0 75.0 96.0 75.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:81.50 stddev:14.10 (17.3%) stddev-sans-first:14.58 09:16:39 INFO - PROCESS | 8046 | Values: 81.0 82.0 111.0 82.0 81.0 82.0 101.0 81.0 82.0 117.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:16:39 INFO - PROCESS | 8046 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:16:39 INFO - PROCESS | 8046 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:16:39 INFO - PROCESS | 8046 | Values: 84.0 85.0 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 09:16:39 INFO - PROCESS | 8046 | Values: 52.0 51.0 52.0 52.0 51.0 51.0 52.0 52.0 51.0 51.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.00 stddev:3.02 (5.1%) stddev-sans-first:1.17 09:16:39 INFO - PROCESS | 8046 | Values: 68.0 59.0 58.0 59.0 59.0 62.0 59.0 58.0 59.0 59.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:3.07 (4.1%) stddev-sans-first:3.24 09:16:39 INFO - PROCESS | 8046 | Values: 75.0 74.0 74.0 78.0 75.0 84.0 75.0 75.0 74.0 75.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.00 stddev:12.83 (10.3%) stddev-sans-first:13.53 09:16:39 INFO - PROCESS | 8046 | Values: 124.0 131.0 128.0 120.0 123.0 121.0 123.0 120.0 163.0 126.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.50 stddev:3.13 (2.0%) stddev-sans-first:3.32 09:16:39 INFO - PROCESS | 8046 | Values: 154.0 151.0 151.0 155.0 152.0 159.0 155.0 158.0 150.0 151.0 09:16:39 INFO - PROCESS | 8046 | 09:16:39 INFO - PROCESS | 8046 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 09:16:39 INFO - PROCESS | 8046 | Values: 63.0 61.0 62.0 63.0 61.0 61.0 62.0 61.0 61.0 61.0 09:16:39 INFO - PROCESS | 8046 | -------- Summary: end -------- 09:16:39 INFO - PROCESS | 8046 | 09:16:40 INFO - TEST-INFO | 8046: exit 0 09:16:40 INFO - TEST-OK | kraken | took 59341ms 09:16:40 INFO - SUITE-END | took 1173s 09:16:40 INFO - Completed test suite (00:19:34) 09:16:40 INFO - javascript benchmark 09:16:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.7132858042773, 3217.967820321796, 3228.354329134172, 3252.056903497986, 3266.7386609071277, 5529.474699903508, 5562.0, 5570.387257401682, 5578.219049333096, 5597.83206503805, 5546.112621980484, 5588.497035266825, 5591.720413979305, 5604.075327570946, 5628.409017053212, 5055.418626857912, 5080.669756465836, 5105.234214867763, 5136.948630513703, 5151.922721159167, 4957.256411538262, 4962.702237865721, 5008.2738002989545, 5125.666831655949, 5167.328247327842, 5025.14572522672, 5136.0, 5142.51146141116, 5143.974280128613, 5145.253938178962, 5146.408163061221, 5147.7683504242395, 5151.150060240056, 5156.92264616031, 5171.741412929338, 4926.359573255454, 4937.975310123426, 4963.4292056413615, 5031.723255220962, 5035.169197082477, 5423.755930983115, 5456.672599644034, 5460.96241714073, 5465.398806131322, 5479.561635069185, 5914.497267732248, 5945.4946329562035, 5952.9107063394085, 5954.5534084943365, 5965.3736357682255, 5803.187553742479, 5835.5915085944, 5853.47318741311, 5937.406259374071, 5980.102984552352, 5518.613697041209, 5541.944580554224, 5557.360903496069, 5562.888742225133, 5587.888242235133, 6031.0, 6040.909386359208, 6047.0, 6049.243844519435, 6050.788222412194, 5626.859328516738, 5671.574631902624, 5742.971285143631, 5800.1299805029585, 5829.154772557956, 5836.970815145897, 5912.024515954819, 5916.171735956969, 5942.019566771521, 5945.346011938684, 5891.528677705774, 5892.263467066617, 5900.970495147497, 5902.970485147633, 5918.763249469973, 5621.971890140523, 5731.942680573141, 5906.291245050621, 5907.1434641976675, 5942.0, 4512.503624601291, 4537.228671125917, 4543.068670922453, 4547.431571053618, 4549.749763763025, 4059.7564146151326, 4079.571644977294, 4080.0411903202726, 4080.9183816324103, 4101.651359634465, 5614.29821272341, 5626.662400255997, 5626.774929002876, 5632.662040277596, 5658.886822263532, 5905.616134951214, 5932.466078052996, 5941.584089113807, 5954.583179177416, 5958.463738263577, 5457.945420545744, 5499.1476321170285, 5507.0637991541535, 5575.0522411190195, 5606.383297837235, 5058.367704036996, 5065.366829146356, 5065.366829146356, 5065.848024559269, 5065.873353166126, 5892.7642894283745, 5894.410558944157, 5895.115732640053, 5912.201852749909, 6015.218021657157, 5861.296644402699, 5861.9413805863105, 5863.706814659165, 5865.149553314831, 5866.6186697864505, 5762.625429347079, 5954.136650185786, 5955.136505206808, 5965.73154208053, 5967.6121052131475, 5629.3244810621345, 5710.65736055838, 5746.051901436216, 5757.337906140848, 5879.617824841372, 5963.373845746134, 5964.612300200473, 5968.910466343095, 5971.7611295547695, 5974.312954010345, 5714.085746280742, 5807.419258074327, 5818.650880947157, 5822.097574875901, 5824.563157763269, 5603.327600687943, 5634.690092044977, 5635.154726791015, 5668.943310567007, 5700.059490184239, 5712.857178570569, 5718.285214348207, 5718.971405142947, 5719.799807006735, 5741.598088133791, 5795.362510123968, 5799.623024503394, 5802.013657678121, 5807.361190268983, 5808.6224395414165, 5501.477359650827, 5561.499465048165, 5619.943800561942, 5651.406602306699, 5674.290713660793], "value": 5440.661148831182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2048373244921, 616.1712496691949, 631.9951277468824, 646.476354153136, 647.4076220258464, 35145.2970940581, 37541.061473463174, 37599.81200093999, 37623.435648465296, 37648.247035059314, 38194.236115277745, 46553.53446465534, 47415.28877066847, 47423.0, 50338.748306258414, 8853.424527405714, 8968.820623587524, 8976.685815996441, 8978.685745998891, 8981.056989016157, 8306.169383061706, 8873.06832782555, 8950.86573701395, 8964.551772411385, 8966.282697384193, 8431.578421078952, 10368.533415996299, 10711.03600675939, 10715.303505272172, 10951.780964380707, 10623.25637205396, 10672.839907401396, 10699.518521666543, 10704.250702450832, 10714.035736783728, 10605.73485662857, 10689.732756681067, 10694.46527673621, 10698.572057117706, 10701.625443109453, 44177.33733993993, 44240.0, 44574.77712611449, 44640.55359446396, 44687.32969005468, 3683.28176005679, 3784.6026167252317, 3823.751456155341, 3900.668443182333, 3971.205758848213, 33617.6638233617, 33849.153771155674, 33899.0, 33920.0, 33960.49059264113, 4469.128519938613, 4482.305242687388, 4493.887652808673, 4531.388262584542, 4557.635389168859, 340863.0, 341543.0, 341633.0, 342879.0, 343465.0, 62962.68518657469, 63549.364506354344, 63552.999999999076, 63568.68215658984, 63582.0, 40615.79692101521, 41564.0, 41669.58330416657, 42552.510662126675, 42570.36144457835, 16881.746773798404, 16996.915015424845, 17018.14909254532, 17022.319107235573, 17034.14829258532, 12842.871571284355, 12929.54746583865, 12938.09433339676, 12944.352782361033, 12946.546870859474, 18726.344577939708, 19142.234310627697, 20248.595028099357, 20560.485987850123, 20809.127178554, 7430.925690743132, 7431.516951398142, 7523.962380188064, 7543.585102819397, 7558.206388329256, 982.3860087445347, 1010.2372708604956, 1068.4497483795851, 1077.5258886090096, 1081.2377274021796, 32959.67040329614, 33727.83136084353, 33929.83035084809, 34074.48888266678, 34538.0, 1085.2728671789919, 1089.9618513351995, 1171.7656468706293, 1182.3260741377505, 1210.878912108782, 17659.823401766076, 17669.91165044192, 17747.73378399325, 17768.423578581034, 17882.463526094238, 474286.0, 476468.0, 477388.0, 478790.0, 478959.0, 62942.37057629365, 63463.36536634667, 63701.681491592244, 63747.36252637507, 63888.68055659692, 1269.206745783885, 1344.0188662276594, 1366.2417358366201, 1424.6794471244095, 1435.9210243436712, 33370.33259334751, 33809.15477113092, 36402.4539631911, 36967.8151609251, 38344.0, 60857.0, 61481.0, 61549.99999999821, 61567.38432615616, 61694.38305616887, 445978.0, 450979.0, 451221.0, 452551.0, 452934.0, 44923.32615010843, 46200.0, 46309.76845115753, 46536.0, 46564.2061476299, 50362.2445663308, 50660.493395065576, 51428.22857657063, 51930.48069519408, 52258.73870630623, 43251.35122973221, 44034.55965440433, 44124.77937610292, 44650.3302450457, 44851.32723009092, 43410.56589434065, 44526.77736611296, 44699.55300446954, 45304.32043519416, 45394.0, 39559.208815822945, 40236.798816005736, 44640.33039504475, 45384.319235212155, 45557.08885822331, 35865.46201806923, 37831.0, 38514.80742596269, 38659.6134038656, 38710.22579548337, 29225.56161657534, 29632.555511667775, 29670.0, 29748.0, 29931.251718707208], "value": 21143.422610730013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.429122752712, 426.0837347165617, 431.7452702905286, 440.7994362565032, 450.8827704796754, 15964.760528592065, 19035.333763318285, 19879.40361789145, 20151.09320080596, 20340.389788306373, 19739.703904441445, 19935.401937941886, 20042.79957200431, 20365.59268814623, 20430.38708838737, 5577.749001294941, 5778.451047150514, 5785.450382213683, 5786.450287222707, 5788.768449262046, 5433.565314774828, 5680.11958146488, 5716.8284951451315, 5717.9714101429645, 5721.113227449731, 5683.374828768832, 5687.345955215141, 5690.174924635925, 5694.003549378863, 5694.800681976131, 5420.268263784398, 5605.1872478490595, 5610.775568977236, 5633.126865335879, 5635.887282254373, 4907.092187945242, 5053.898922021575, 5059.089363914494, 5059.392872855244, 5060.367454068241, 23308.184213552446, 23485.530289394286, 23518.176863809684, 23751.76248237513, 23874.7612523876, 2431.7203521595065, 2661.2149415922154, 2719.442514284567, 2772.7365900239447, 2848.30216596933, 14428.567142985727, 14494.275286235646, 14576.416943322254, 14762.778558321634, 15203.087814731152, 2018.0918586635926, 2047.1095073643014, 2069.2136987944637, 2073.523089689365, 2091.853570250083, 85735.0, 86642.56678716629, 87005.12994870034, 87832.0, 88093.0, 9856.950715246378, 10683.198760093024, 10785.83821242682, 10797.676069717922, 11156.442177891235, 15382.846171538366, 15415.383384664488, 15462.304196311194, 15476.690466190614, 15490.9225453872, 7803.336716379172, 8173.591320433955, 8190.672373105128, 8291.170882911782, 8345.582720863933, 7653.196414376522, 7658.578778167142, 7703.075630924325, 7855.293023627786, 7954.84090318202, 6775.085363475966, 6781.728730850711, 6864.627074585103, 6981.0, 7074.257202993715, 1956.4130760771711, 2016.3446879764135, 2019.2629690163278, 2047.488127968008, 2060.47457898235, 954.6849539651898, 1074.1621535202555, 1079.4171147580219, 1123.9775204496027, 1151.2919554474106, 19987.004548408233, 20682.68975965362, 20854.270100546408, 20927.476813079797, 20995.0, 943.4810854030256, 1014.4623349624711, 1056.8784589772274, 1073.7906108308962, 1082.5345101606226, 10788.892111078945, 10803.351798891934, 10817.0, 10828.187885908588, 10857.131429485622, 498275.0, 500930.0, 501581.0, 503561.0, 509406.0, 94734.52632736792, 95233.0, 98719.50640246896, 100630.0, 101701.0, 1032.7108409645311, 1038.7143535527791, 1051.1800795379615, 1079.3901445683164, 1082.3073233130804, 17162.884412513147, 17362.27710489223, 17594.208260628046, 17673.29306827764, 17863.821361786217, 42626.0, 42659.14681706411, 42692.359614605186, 42761.78619107009, 45919.77040114778, 55941.44058559362, 59499.70250148721, 61231.693841530505, 61275.0, 61655.38344616497, 7489.700411983677, 7526.09686837583, 7723.0, 7770.961145194238, 7903.486273392211, 11755.88244117548, 12573.1198816082, 12927.870721292667, 12981.870181298444, 13289.0, 10239.692809215736, 10502.737431564272, 10680.145588353069, 10843.295185812896, 11010.779784404427, 10240.18078553699, 10548.894511054792, 10750.892491074988, 10802.945985270024, 11040.400783710786, 10949.56201751921, 10955.616553420592, 11132.109431245643, 11169.497372618414, 11327.943360283145, 7691.346235570039, 7810.336121429515, 7934.801629959297, 7991.680332786856, 8030.357571394157, 8063.637136328996, 11139.05318047975, 11140.777184456427, 11260.0, 11579.768404632028], "value": 9442.585899256304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.6210579984706, 1501.474483930624, 1530.3496014193968, 1677.5806048487877, 1812.0, 7876.606169691514, 8420.200080992303, 8649.524276164808, 8905.777355566113, 8982.05688402718, 8898.288136949044, 8997.730068097952, 8998.820023599541, 9011.234045106174, 9017.819643607141, 2471.3203868936007, 2501.0996041425074, 2503.5869081601604, 2505.34860936157, 2505.5991041433376, 2416.3838221253554, 2513.5978243481045, 2524.2931979045807, 2525.01524405482, 2525.5959046552557, 2453.0, 2456.078970386105, 2476.4923190745853, 2481.1936120760734, 2483.044028049196, 2344.3787396339985, 2378.583747844129, 2393.485400638871, 2409.734929157791, 2410.795082417979, 2405.013944282836, 2411.7588241175918, 2438.1222759806456, 2456.828022038458, 2457.6313552967017, 8733.388662793606, 8793.956030219872, 8806.33952453562, 8888.288936885034, 8928.24109950655, 5329.573634109262, 5542.0, 5543.944560554383, 5547.611667183299, 5553.944460555384, 3638.472421498868, 3747.2130852521004, 3776.0553315042775, 3830.7893065881367, 3838.3858582626644, 1223.577865636354, 1249.5001999200301, 1254.4793910527121, 1299.123091912955, 1312.1667740984544, 12642.49430022798, 12753.298568578724, 12754.808677869747, 12779.233246005177, 12805.807912881408, 4517.34498497716, 4678.181318269358, 4778.37881075458, 4851.0, 4891.633127515451, 10075.647352342632, 10113.797724045478, 10119.291649584606, 10122.0, 10124.54439550222, 5462.317210348707, 5462.562994960394, 5471.753771080311, 5476.041692703761, 5483.122700367922, 4481.641468682497, 4549.249373853278, 5091.2363145527725, 5134.178531434953, 5151.793928242903, 3998.5001874765653, 4067.572904844949, 4097.959020409818, 4158.251514727318, 4161.791910404468, 1227.858796238426, 1233.495135934159, 1233.747081848219, 1239.2130996816907, 1250.9499620015279, 936.1153709744362, 979.9857147851939, 1013.5692330759398, 1018.9490525473844, 1022.6114076650825, 6078.635281883101, 6132.325444201134, 6330.39861213184, 6331.271903731038, 6586.1438013058, 948.2035090523993, 963.6530848894392, 967.1634036558467, 989.7228775942748, 1013.3970287678819, 4087.3664581989838, 4251.128518653669, 4268.317069268965, 4279.550647182064, 4356.215881141362, 10319.896801032044, 10691.946540267405, 10713.142948564097, 10729.195310351599, 10737.78524429507, 10641.5211315491, 10648.14814814813, 10655.200859935536, 10658.307210031324, 10694.411807350514, 8115.431919765678, 8468.110848360957, 8490.702825401082, 8517.57412129391, 8651.870221946676, 6050.546209034252, 6227.96886015567, 6242.563020588515, 6339.873202536016, 6541.934580654132, 10243.795124097327, 10433.217508686726, 10439.0, 10462.319949203582, 10544.472776361305, 10534.947325263325, 10658.0, 10681.412522311037, 10745.785084298113, 10782.568697252022, 8147.551884646401, 8189.918100818915, 8231.835363292821, 8250.958745206235, 8285.088640249447, 8758.824823503366, 8767.868481972902, 8844.380893337404, 8852.734417967471, 8858.335624828293, 7657.617119144132, 7821.6089195541135, 7880.921190788019, 7936.761897143095, 7964.123946366011, 7783.6108194588915, 7821.765347039598, 7872.606369681607, 7927.048754149539, 8195.71315003972, 7057.470689698191, 7185.173705023989, 7252.746153884589, 7268.67290971897, 7380.261973802577, 5184.922226166535, 5194.168932970707, 5213.687178769286, 5251.422343542284, 5275.788968441219, 5286.074936885952, 5301.469853014668, 5389.676619402849, 5455.181722741462, 5482.862928426821], "value": 4799.02200404026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6549286980844, 341.7385699939547, 344.698388909704, 348.445970906259, 351.3447420560655, 5445.863853403662, 5486.396496385394, 5513.8345849624475, 5520.14437762147, 5577.749001294941, 5387.595930305223, 5426.62013659044, 5465.754041068151, 5470.826920386176, 5488.341399032111, 4057.6550993165615, 4114.300568903279, 4118.794060296988, 4170.666346692257, 4215.49414070312, 4204.3302502910565, 4217.704760666755, 4242.278812601865, 4249.213895429355, 4283.229018776619, 4184.895377615569, 4185.142045880587, 4191.413202151702, 4214.2414365414215, 4232.809523571446, 3923.1369098798364, 4024.7585144891254, 4118.588141185887, 4177.7857735400285, 4207.242696314662, 3698.7410881238056, 3702.778083232527, 3710.5547334319785, 3712.684421824148, 3713.795741234231, 5180.844574662766, 5220.504052115043, 5220.582353411718, 5236.764345604457, 5269.1832765921345, 4517.351166824118, 4751.786169622375, 4752.500987396308, 4770.7376094314795, 4783.28250762385, 5568.888622227573, 5588.748506317225, 5592.664440133605, 5602.747876345574, 5608.635438696471, 4040.0, 4041.4544036555276, 4044.766346264388, 4053.209624123297, 4082.101937573729, 5529.889402211974, 5731.595759039021, 5760.53915686744, 5814.854628634275, 5829.18391425205, 4092.304308267542, 4099.221147981874, 4105.0, 4117.0, 4132.834686612502, 4177.582241775798, 4179.686523510688, 4180.163967206571, 4182.644475219579, 4202.348635961431, 4556.88607784808, 4708.952910470852, 4765.666403351802, 4803.903921921542, 4815.579404075806, 5603.523700485504, 5610.719464026783, 5614.29821272341, 5620.578456615688, 5624.91562626561, 1398.7622104242303, 1407.7606806842862, 1409.837868645119, 1423.9715205695827, 1424.7364237616075, 917.9357444978788, 926.305271046715, 977.1986970684113, 979.2264111352094, 989.4014121456559, 5140.742962851918, 5358.223057656618, 5480.369757477862, 5485.17722341644, 5504.862378440491, 5733.0, 5758.913616295759, 5770.855728606818, 5776.393478684678, 5811.593188476766, 5373.328333958255, 5396.811111611153, 5514.751836167382, 5526.447355264441, 5534.972325138348, 2932.0470846974818, 2932.765378769693, 2938.9853050735037, 2976.2113040044405, 2982.3140677644265, 5695.1741997410145, 5718.628289161191, 5718.7426565804635, 5719.256496655491, 5726.4273572642405, 5420.674759514362, 5678.375378708339, 5695.231143795535, 5696.914546281809, 5699.487046165865, 5627.227423361628, 5662.235598194274, 5664.943350566442, 5697.914531282034, 5768.125359258174, 5482.28730265079, 5579.911917176274, 5641.266635337544, 5700.429957004267, 5797.826065218051, 5758.6887539665695, 5768.769489086125, 5770.163326317745, 5780.265920224, 5798.246227990334, 5947.524198064058, 5980.641161530322, 5987.64074155552, 5994.6403215807195, 6032.819015429544, 4045.211183819127, 4150.024744185053, 4173.6661067115165, 4186.3254698121, 4193.97903010483, 5815.2149459822385, 5824.271966004249, 5842.510159909366, 5865.618734782225, 5871.943050250996, 5565.551157490691, 5733.913991290217, 5739.426057394227, 5761.3209857416505, 5784.595078344644, 5644.52021578154, 5655.4627310407095, 5660.264165658438, 5665.745041473226, 5739.598228123991, 5616.848546047969, 5637.49262566371, 5640.294963129609, 5700.971495142498, 5708.972384970745, 5553.11194193976, 5575.414581468887, 5674.4892959633835, 5698.743556539883, 5725.484706376279, 5517.875617887062, 5523.944760552343, 5541.889162216814, 5586.273784408001, 5593.860153496195], "value": 4287.539124558458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.3613277444427, 810.8378324335133, 814.7392834293029, 825.521197705331, 883.8630012348088, 15028.699426011473, 15245.390184392625, 15452.69094618107, 15603.921980390081, 15744.448944286938, 14542.636434089152, 14745.041572297792, 14760.188189649592, 14905.32926018329, 14928.850711492882, 714.7141143542573, 733.0214164090945, 854.5300084953282, 865.5023361567124, 866.8266346730647, 823.9217274358926, 856.2293935458107, 860.6256278518864, 861.6467248428146, 864.8356812205692, 893.2764460786751, 894.5974311559825, 894.6510860764307, 895.0288936503902, 897.9640814367417, 741.6291854072964, 892.8437523433438, 893.6246776353947, 894.3024440936048, 895.3508706188027, 562.5134258866051, 636.6053047110775, 655.5181941273161, 659.3735950846715, 660.9985871404825, 14219.573412797528, 14237.359318830677, 14253.572392828231, 14258.714825703531, 14263.429462821474, 13181.472741090345, 13272.601821945356, 13545.051846370758, 13658.658533536642, 14017.0, 12407.62777116679, 12416.75166496674, 12740.299283539402, 12834.037447191498, 12968.351582420935, 4315.525292217853, 4375.409319741858, 4397.494288156871, 4415.381846541487, 4479.1489616972995, 60611.0, 60690.696546516985, 62272.37727622756, 65229.67385163091, 65545.67227163834, 10835.945820270848, 10888.945555272332, 11071.225014248925, 11121.72195695098, 11321.320720756781, 20515.076821543065, 20550.0, 20556.0, 20715.0, 20765.688514672293, 8146.83706325882, 8419.621117049748, 8457.112003239694, 8474.74575762728, 8577.399582029322, 4666.69666471685, 4716.716996980193, 4738.597219236403, 4754.21555443348, 4883.02339532095, 3302.570665813477, 3409.4885767134633, 3414.095264754842, 3414.7194801949267, 3417.470292104678, 587.1779508687786, 589.8849724303806, 591.8459004940297, 600.504583718434, 609.9725512351955, 655.5443966443277, 658.1411258307954, 662.1755913887241, 669.5882032550044, 702.9367356937901, 8296.875546866802, 8620.051794302623, 8760.51817150063, 9089.136532029446, 9183.311251656152, 670.8624731929942, 682.774684354162, 683.3337495941516, 696.1437431958618, 712.4834494991194, 4396.712700837768, 4409.977950110229, 4419.381286619876, 4469.7988590513505, 4479.46246450428, 54245.72877135589, 67260.99108513376, 87537.5623121893, 88060.55969720239, 91462.54268728614, 76702.61648691833, 78352.60823695845, 78687.21312786799, 79140.34251201911, 81608.59195704102, 68340.65829670819, 68735.31264687289, 68847.65576172087, 70367.0, 71700.28299716936, 8222.712205073032, 8555.331710316677, 8560.785980350542, 8578.785530361542, 8847.0, 47716.7614161927, 47731.76134119307, 48571.76981109586, 51261.231081533064, 53070.0, 60449.69775151096, 61044.69477652583, 65772.34227657662, 66550.66898661903, 69223.65388173026, 11079.113670906147, 11169.218154729417, 11484.770304594029, 11543.307401555934, 11651.41742912868, 12500.812487812873, 12683.87316126827, 12818.807717884052, 12839.101262911507, 13069.085164038426, 11691.590794322497, 11962.760744784882, 11978.940105299418, 12267.754644906874, 12503.249805011365, 11295.37875416827, 11576.88217938923, 11757.76484470323, 11781.646550603497, 12308.876911230773, 11566.132540059361, 11850.525978960744, 11991.940040299743, 12247.632571022526, 12466.0, 10158.288919775545, 10319.638812641522, 10380.740481488023, 10652.147828173573, 10722.946385268337, 9866.950665246628, 10432.530536125741, 10535.262531623019, 10553.419561924167, 10567.63013294531], "value": 7105.512615473803, "unit": "score"}], "name": "dromaeo_css", "value": 7359.018388581355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 111.0, 111.0, 112.0, 111.0, 112.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 120.0, 159.0, 120.0, 120.0, 116.0, 115.0, 145.0, 117.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 161.0, 160.0, 159.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 101.0, 74.0, 74.0, 76.0, 75.0, 96.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 111.0, 82.0, 81.0, 82.0, 101.0, 81.0, 82.0, 117.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 59.0, 58.0, 59.0, 59.0, 62.0, 59.0, 58.0, 59.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 78.0, 75.0, 84.0, 75.0, 75.0, 74.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 128.0, 120.0, 123.0, 121.0, 123.0, 120.0, 163.0, 126.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 151.0, 155.0, 152.0, 159.0, 155.0, 158.0, 150.0, 151.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1445.4, "alertThreshold": 2.0}]} 09:16:40 INFO - Return code: 0 09:16:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:40 INFO - # TBPL SUCCESS # 09:16:40 INFO - Running post-action listener: _resource_record_post_action 09:16:40 INFO - [mozharness: 2017-01-14 17:16:40.389315Z] Finished run-tests step (success) 09:16:40 INFO - Running post-run listener: _resource_record_post_run 09:16:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 358965248; Read time: 212; Write time: 185008 09:16:40 INFO - TinderboxPrint: CPU usage
12.9% 09:16:40 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 212 09:16:40 INFO - TinderboxPrint: I/O write bytes / time
358,965,248 / 185,008 09:16:40 INFO - TinderboxPrint: CPU idle
8,267.3 (87.0%) 09:16:40 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 09:16:40 INFO - TinderboxPrint: Swap in / out
0 / 0 09:16:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108343296; Read time: 132; Write time: 63364 09:16:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 239218688; Read time: 76; Write time: 117776 09:16:41 INFO - Running post-run listener: _upload_blobber_files 09:16:41 INFO - Blob upload gear active. 09:16:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:41 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:16:41 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:16:41 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:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:44 INFO - (blobuploader) - INFO - Done attempting. 09:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:44 INFO - (blobuploader) - INFO - Done attempting. 09:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:47 INFO - (blobuploader) - INFO - Done attempting. 09:16:47 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:47 INFO - Return code: 0 09:16:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d9907a16c8568bf65c3fc3b2af316e3cc7fc2ffac8a75c81f3eba48c4a029ba09b8fd84b86726265c60e1dd625d84782efb3b72bc6e22dd48bc4ff3ea052a50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30d55163faf9629f1bbd6afb1db7576dc3afc546d2216cc54511e222e773b558f8ad012bb576058b25080efa54446d58abc63a8482830b8085b6caaf89a1c8cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5317638ca9c5c6b7aff0b96ffa71c689a836be94ae4c7e9deaddf95c40924b815deffc0b74dee2f95d6a2dc981ab91348a3b962aef22e9040a43fe2411e27691"} 09:16:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:47 INFO - Contents: 09:16:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d9907a16c8568bf65c3fc3b2af316e3cc7fc2ffac8a75c81f3eba48c4a029ba09b8fd84b86726265c60e1dd625d84782efb3b72bc6e22dd48bc4ff3ea052a50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30d55163faf9629f1bbd6afb1db7576dc3afc546d2216cc54511e222e773b558f8ad012bb576058b25080efa54446d58abc63a8482830b8085b6caaf89a1c8cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5317638ca9c5c6b7aff0b96ffa71c689a836be94ae4c7e9deaddf95c40924b815deffc0b74dee2f95d6a2dc981ab91348a3b962aef22e9040a43fe2411e27691"} 09:16:47 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:47 INFO - Copying logs to upload dir... 09:16:47 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.139479 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-14 09:16:46.990272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 09:16:46.993690) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 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/5d9907a16c8568bf65c3fc3b2af316e3cc7fc2ffac8a75c81f3eba48c4a029ba09b8fd84b86726265c60e1dd625d84782efb3b72bc6e22dd48bc4ff3ea052a50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30d55163faf9629f1bbd6afb1db7576dc3afc546d2216cc54511e222e773b558f8ad012bb576058b25080efa54446d58abc63a8482830b8085b6caaf89a1c8cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5317638ca9c5c6b7aff0b96ffa71c689a836be94ae4c7e9deaddf95c40924b815deffc0b74dee2f95d6a2dc981ab91348a3b962aef22e9040a43fe2411e27691"} build_url:https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/NfAk3cBlRtiurYfCbLSqJg/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/5d9907a16c8568bf65c3fc3b2af316e3cc7fc2ffac8a75c81f3eba48c4a029ba09b8fd84b86726265c60e1dd625d84782efb3b72bc6e22dd48bc4ff3ea052a50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30d55163faf9629f1bbd6afb1db7576dc3afc546d2216cc54511e222e773b558f8ad012bb576058b25080efa54446d58abc63a8482830b8085b6caaf89a1c8cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5317638ca9c5c6b7aff0b96ffa71c689a836be94ae4c7e9deaddf95c40924b815deffc0b74dee2f95d6a2dc981ab91348a3b962aef22e9040a43fe2411e27691"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 09:16:47.019591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 09:16:47.020137) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1484398399.140623-1581976888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 09:16:47.102058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 09:16:47.102400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 09:16:47.102723) ========= ========= Total master_lag: 0.17 =========