builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1484321398.95 results: success (0) buildid: 20170113004016 builduid: 1ddab738b6c94dabbf70c85d9d7abfce revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:58.952012) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:58.952600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:58.952898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:58.968020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:58.968491) ========= 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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-13 07:29:59-- 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% 46.0M=0s 2017-01-13 07:29:59 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.081350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.081694) ========= 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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016443 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.130798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.131131) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --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 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-13 07:29:59,993 truncating revision to first 12 chars 2017-01-13 07:29:59,993 Setting DEBUG logging. 2017-01-13 07:29:59,993 attempt 1/10 2017-01-13 07:29:59,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1e322cd9c741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 07:30:00,494 unpacking tar archive at: mozilla-aurora-1e322cd9c741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.808978 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.953864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.954192) ========= script_repo_revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.954617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.954891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 07:29:59.963997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-13 07:29:59.964302) ========= /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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:00 INFO - MultiFileLogger online at 20170113 07:30:00 in /builds/slave/test 07:30:00 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 07:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:00 INFO - {'append_to_log': False, 07:30:00 INFO - 'base_work_dir': '/builds/slave/test', 07:30:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:00 INFO - 'branch': 'Mozilla-Aurora', 07:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:00 INFO - 'config_files': ('talos/linux_config.py',), 07:30:00 INFO - 'default_actions': ('clobber', 07:30:00 INFO - 'read-buildbot-config', 07:30:00 INFO - 'download-and-extract', 07:30:00 INFO - 'populate-webroot', 07:30:00 INFO - 'create-virtualenv', 07:30:00 INFO - 'install', 07:30:00 INFO - 'run-tests'), 07:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:00 INFO - 'download_minidump_stackwalk': True, 07:30:00 INFO - 'download_symbols': 'ondemand', 07:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:00 INFO - 'installer_path': 'installer.exe', 07:30:00 INFO - 'log_level': 'info', 07:30:00 INFO - 'log_name': 'talos', 07:30:00 INFO - 'log_to_console': True, 07:30:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:00 INFO - 'opt_config_files': (), 07:30:00 INFO - 'pip_index': False, 07:30:00 INFO - 'sps_profile': False, 07:30:00 INFO - 'sps_profile_interval': 0, 07:30:00 INFO - 'suite': 'dromaeojs', 07:30:00 INFO - 'system_bits': '32', 07:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:00 INFO - 'title': 'talos-linux64-ix-007', 07:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:00 INFO - 'use_talos_json': True, 07:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:00 INFO - 'work_dir': 'build'} 07:30:00 INFO - [mozharness: 2017-01-13 15:30:00.931301Z] Running clobber step. 07:30:00 INFO - Running pre-action listener: _resource_record_pre_action 07:30:00 INFO - Running main action method: clobber 07:30:00 INFO - rmtree: /builds/slave/test/build 07:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2017-01-13 15:30:01.911310Z] Finished clobber step (success) 07:30:01 INFO - [mozharness: 2017-01-13 15:30:01.911408Z] Running read-buildbot-config step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: read_buildbot_config 07:30:01 INFO - Using buildbot properties: 07:30:01 INFO - { 07:30:01 INFO - "project": "", 07:30:01 INFO - "product": "firefox", 07:30:01 INFO - "script_repo_revision": "production", 07:30:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:30:01 INFO - "repository": "", 07:30:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:30:01 INFO - "buildid": "20170113004016", 07:30:01 INFO - "stage_platform": "linux64-pgo", 07:30:01 INFO - "basedir": "/builds/slave/test", 07:30:01 INFO - "nightly_build": "True", 07:30:01 INFO - "buildnumber": 699, 07:30:01 INFO - "slavename": "talos-linux64-ix-007", 07:30:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:30:01 INFO - "platform": "ubuntu64_hw", 07:30:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:30:01 INFO - "branch": "mozilla-aurora", 07:30:01 INFO - "repo_path": "releases/mozilla-aurora", 07:30:01 INFO - "revision": "1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6", 07:30:01 INFO - "pgo_build": "True", 07:30:01 INFO - "builduid": "1ddab738b6c94dabbf70c85d9d7abfce", 07:30:01 INFO - "slavebuilddir": "test" 07:30:01 INFO - } 07:30:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2017-01-13 15:30:01.913910Z] Finished read-buildbot-config step (success) 07:30:01 INFO - [mozharness: 2017-01-13 15:30:01.913998Z] Running download-and-extract step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: download_and_extract 07:30:01 INFO - mkdir: /builds/slave/test/build/tests 07:30:01 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')]} 07:30:01 INFO - trying https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:30:01 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/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 07:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/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 07:30:02 INFO - Downloaded 1361 bytes. 07:30:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:30:02 INFO - Using the following test package requirements: 07:30:02 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:30:02 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:02 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:30:02 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'jsshell-linux-x86_64.zip'], 07:30:02 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:02 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:30:02 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:30:02 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:30:02 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:02 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:30:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:30:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:30:03 INFO - Http code: 200 07:30:03 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 07:30:03 INFO - x-amz-cf-id: zB2bBOtiCVpKCj3ONond5hBce7IbCPIEhYQvC_P3c6r4D5j3jrCzaQ== 07:30:03 INFO - x-amz-version-id: eImvHVRBSpUE6YaOYl5O2e4HmPtSg3uy 07:30:03 INFO - Expected file size: 21949005 07:30:03 INFO - Obtained file size: 21949005 07:30:07 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 07:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:30:07 INFO - Http code: 200 07:30:07 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 07:30:07 INFO - x-amz-cf-id: DMkAMHIfb2e6WagWdH5IlkJaFOgd54-hm2D5JyMUURD9ONb2--sCWw== 07:30:07 INFO - x-amz-version-id: eImvHVRBSpUE6YaOYl5O2e4HmPtSg3uy 07:30:08 INFO - Expected file size: 21949005 07:30:08 INFO - Obtained file size: 21949005 07:30:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:30:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:30:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:30:13 INFO - Http code: 200 07:30:13 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 07:30:13 INFO - x-amz-cf-id: VUTRfPt6jFI4h49DWe5cR8FF3I0NP7cJQz1dJfyoY9biceAYUBCe6A== 07:30:13 INFO - x-amz-version-id: ahwDDYvkWrOzwvL_DdItxd0VSqW8._.u 07:30:13 INFO - Expected file size: 14409038 07:30:13 INFO - Obtained file size: 14409038 07:30:13 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')]} 07:30:13 INFO - trying https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/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 07:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/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 07:30:15 INFO - Downloaded 64120252 bytes. 07:30:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:30:15 INFO - mkdir: /builds/slave/test/properties 07:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:15 INFO - Contents: 07:30:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:30:16 INFO - Running post-action listener: _resource_record_post_action 07:30:16 INFO - Running post-action listener: set_extra_try_arguments 07:30:16 INFO - [mozharness: 2017-01-13 15:30:16.668486Z] Finished download-and-extract step (success) 07:30:16 INFO - [mozharness: 2017-01-13 15:30:16.668713Z] Running populate-webroot step. 07:30:16 INFO - Running pre-action listener: _resource_record_pre_action 07:30:16 INFO - Running main action method: populate_webroot 07:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:16 INFO - '--tppagecycles', 07:30:16 INFO - '7'], 07:30:16 INFO - 'tests': ['tsvgm']}}, 07:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['damp', 'tps']}, 07:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['damp', 'tps']}, 07:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['dromaeo_dom']}, 07:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['basic_compositor_video']}, 07:30:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tsvgx', 07:30:16 INFO - 'tsvgr_opacity', 07:30:16 INFO - 'tart', 07:30:16 INFO - 'tscrollx', 07:30:16 INFO - 'cart']}, 07:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:16 INFO - 'tsvgr_opacity', 07:30:16 INFO - 'tart', 07:30:16 INFO - 'tscrollx', 07:30:16 INFO - 'cart']}, 07:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tp5o']}, 07:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['tp5o']}, 07:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s', 07:30:16 INFO - '--xperf_path', 07:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:16 INFO - 'tests': ['tp5n']}, 07:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--xperf_path', 07:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:16 INFO - 'tests': ['tp5n']}}, 07:30:16 INFO - 'talos.zip': {'path': '', 07:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:16 INFO - Running post-action listener: _resource_record_post_action 07:30:16 INFO - [mozharness: 2017-01-13 15:30:16.684077Z] Finished populate-webroot step (success) 07:30:16 INFO - [mozharness: 2017-01-13 15:30:16.684165Z] Running create-virtualenv step. 07:30:16 INFO - Running pre-action listener: _resource_record_pre_action 07:30:16 INFO - Running main action method: create_virtualenv 07:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:16 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 07:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:16 INFO - Using real prefix '/usr' 07:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:19 INFO - Installing pip.................done. 07:30:19 INFO - Return code: 0 07:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:19 INFO - Reading from file tmpfile_stdout 07:30:19 INFO - Output received: 07:30:19 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) 07:30:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:19 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')]} 07:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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')]} 07:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:19 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 07:30:19 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 07:30:19 INFO - Using env: {'DISPLAY': ':0', 07:30:19 INFO - 'HOME': '/home/cltbld', 07:30:19 INFO - 'LANG': 'en_US.UTF-8', 07:30:19 INFO - 'LANGUAGE': 'en_US:en', 07:30:19 INFO - 'LOGNAME': 'cltbld', 07:30:19 INFO - 'MAIL': '/var/mail/cltbld', 07:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:19 INFO - 'MOZ_NO_REMOTE': '1', 07:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:19 INFO - 'NO_EM_RESTART': '1', 07:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:19 INFO - 'PWD': '/builds/slave/test', 07:30:19 INFO - 'SHELL': '/bin/bash', 07:30:19 INFO - 'SHLVL': '1', 07:30:19 INFO - 'TERM': 'linux', 07:30:19 INFO - 'TMOUT': '86400', 07:30:19 INFO - 'USER': 'cltbld', 07:30:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:19 INFO - '_': '/tools/buildbot/bin/python'} 07:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:19 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 07:30:19 INFO - Cleaning up... 07:30:19 INFO - Return code: 0 07:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:19 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')]} 07:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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')]} 07:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:19 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 07:30:19 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 07:30:19 INFO - Using env: {'DISPLAY': ':0', 07:30:19 INFO - 'HOME': '/home/cltbld', 07:30:19 INFO - 'LANG': 'en_US.UTF-8', 07:30:19 INFO - 'LANGUAGE': 'en_US:en', 07:30:19 INFO - 'LOGNAME': 'cltbld', 07:30:19 INFO - 'MAIL': '/var/mail/cltbld', 07:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:19 INFO - 'MOZ_NO_REMOTE': '1', 07:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:19 INFO - 'NO_EM_RESTART': '1', 07:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:19 INFO - 'PWD': '/builds/slave/test', 07:30:19 INFO - 'SHELL': '/bin/bash', 07:30:19 INFO - 'SHLVL': '1', 07:30:19 INFO - 'TERM': 'linux', 07:30:19 INFO - 'TMOUT': '86400', 07:30:19 INFO - 'USER': 'cltbld', 07:30:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:19 INFO - '_': '/tools/buildbot/bin/python'} 07:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:19 INFO - Downloading/unpacking psutil>=3.1.1 07:30:19 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 07:30:19 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 07:30:19 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 07:30:19 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 07:30:19 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 07:30:19 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 07:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:21 INFO - Installing collected packages: psutil 07:30:21 INFO - Running setup.py install for psutil 07:30:22 INFO - building 'psutil._psutil_linux' extension 07:30:22 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 07:30:22 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 07:30:22 INFO - building 'psutil._psutil_posix' extension 07:30:22 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 07:30:22 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 07:30:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:22 INFO - Successfully installed psutil 07:30:22 INFO - Cleaning up... 07:30:22 INFO - Return code: 0 07:30:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30:22 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')]} 07:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:22 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')]} 07:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:22 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:22 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 07:30:22 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 07:30:22 INFO - Using env: {'DISPLAY': ':0', 07:30:22 INFO - 'HOME': '/home/cltbld', 07:30:22 INFO - 'LANG': 'en_US.UTF-8', 07:30:22 INFO - 'LANGUAGE': 'en_US:en', 07:30:22 INFO - 'LOGNAME': 'cltbld', 07:30:22 INFO - 'MAIL': '/var/mail/cltbld', 07:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:22 INFO - 'MOZ_NO_REMOTE': '1', 07:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:22 INFO - 'NO_EM_RESTART': '1', 07:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:22 INFO - 'PWD': '/builds/slave/test', 07:30:22 INFO - 'SHELL': '/bin/bash', 07:30:22 INFO - 'SHLVL': '1', 07:30:22 INFO - 'TERM': 'linux', 07:30:22 INFO - 'TMOUT': '86400', 07:30:22 INFO - 'USER': 'cltbld', 07:30:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:22 INFO - '_': '/tools/buildbot/bin/python'} 07:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:24 INFO - Installing collected packages: mozsystemmonitor 07:30:24 INFO - Running setup.py install for mozsystemmonitor 07:30:24 INFO - Successfully installed mozsystemmonitor 07:30:24 INFO - Cleaning up... 07:30:24 INFO - Return code: 0 07:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30:24 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')]} 07:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:24 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')]} 07:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:24 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:24 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 07:30:24 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 07:30:24 INFO - Using env: {'DISPLAY': ':0', 07:30:24 INFO - 'HOME': '/home/cltbld', 07:30:24 INFO - 'LANG': 'en_US.UTF-8', 07:30:24 INFO - 'LANGUAGE': 'en_US:en', 07:30:24 INFO - 'LOGNAME': 'cltbld', 07:30:24 INFO - 'MAIL': '/var/mail/cltbld', 07:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:24 INFO - 'MOZ_NO_REMOTE': '1', 07:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:24 INFO - 'NO_EM_RESTART': '1', 07:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:24 INFO - 'PWD': '/builds/slave/test', 07:30:24 INFO - 'SHELL': '/bin/bash', 07:30:24 INFO - 'SHLVL': '1', 07:30:24 INFO - 'TERM': 'linux', 07:30:24 INFO - 'TMOUT': '86400', 07:30:24 INFO - 'USER': 'cltbld', 07:30:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:24 INFO - '_': '/tools/buildbot/bin/python'} 07:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:27 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 07:30:27 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 07:30:27 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 07:30:27 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 07:30:27 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 07:30:27 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 07:30:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:27 INFO - warning: no files found matching '*.txt' 07:30:27 INFO - no previously-included directories found matching 'build' 07:30:27 INFO - no previously-included directories found matching 'dist' 07:30:27 INFO - no previously-included directories found matching '.git*' 07:30:27 INFO - Installing collected packages: jsonschema, functools32 07:30:27 INFO - Running setup.py install for functools32 07:30:27 INFO - warning: no files found matching '*.txt' 07:30:27 INFO - no previously-included directories found matching 'build' 07:30:27 INFO - no previously-included directories found matching 'dist' 07:30:27 INFO - no previously-included directories found matching '.git*' 07:30:27 INFO - Successfully installed jsonschema functools32 07:30:27 INFO - Cleaning up... 07:30:27 INFO - Return code: 0 07:30:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:27 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:27 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 07:30:27 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 07:30:27 INFO - Using env: {'DISPLAY': ':0', 07:30:27 INFO - 'HOME': '/home/cltbld', 07:30:27 INFO - 'LANG': 'en_US.UTF-8', 07:30:27 INFO - 'LANGUAGE': 'en_US:en', 07:30:27 INFO - 'LOGNAME': 'cltbld', 07:30:27 INFO - 'MAIL': '/var/mail/cltbld', 07:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:27 INFO - 'MOZ_NO_REMOTE': '1', 07:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:27 INFO - 'NO_EM_RESTART': '1', 07:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:27 INFO - 'PWD': '/builds/slave/test', 07:30:27 INFO - 'SHELL': '/bin/bash', 07:30:27 INFO - 'SHLVL': '1', 07:30:27 INFO - 'TERM': 'linux', 07:30:27 INFO - 'TMOUT': '86400', 07:30:27 INFO - 'USER': 'cltbld', 07:30:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:27 INFO - '_': '/tools/buildbot/bin/python'} 07:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:30:27 INFO - Cleaning up... 07:30:27 INFO - Return code: 0 07:30:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:27 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:27 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 07:30:27 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 07:30:27 INFO - Using env: {'DISPLAY': ':0', 07:30:27 INFO - 'HOME': '/home/cltbld', 07:30:27 INFO - 'LANG': 'en_US.UTF-8', 07:30:27 INFO - 'LANGUAGE': 'en_US:en', 07:30:27 INFO - 'LOGNAME': 'cltbld', 07:30:27 INFO - 'MAIL': '/var/mail/cltbld', 07:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:27 INFO - 'MOZ_NO_REMOTE': '1', 07:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:27 INFO - 'NO_EM_RESTART': '1', 07:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:27 INFO - 'PWD': '/builds/slave/test', 07:30:27 INFO - 'SHELL': '/bin/bash', 07:30:27 INFO - 'SHLVL': '1', 07:30:27 INFO - 'TERM': 'linux', 07:30:27 INFO - 'TMOUT': '86400', 07:30:27 INFO - 'USER': 'cltbld', 07:30:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:27 INFO - '_': '/tools/buildbot/bin/python'} 07:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:28 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 07:30:28 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 07:30:28 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 07:30:28 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 07:30:28 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 07:30:28 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 07:30:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:30 INFO - Downloading docopt-0.6.1.tar.gz 07:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:30 INFO - Running setup.py install for blobuploader 07:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:30 INFO - Running setup.py install for requests 07:30:31 INFO - Running setup.py install for docopt 07:30:31 INFO - Successfully installed blobuploader requests docopt 07:30:31 INFO - Cleaning up... 07:30:31 INFO - Return code: 0 07:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:31 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')]} 07:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:31 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')]} 07:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:31 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:31 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 07:30:31 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 07:30:31 INFO - Using env: {'DISPLAY': ':0', 07:30:31 INFO - 'HOME': '/home/cltbld', 07:30:31 INFO - 'LANG': 'en_US.UTF-8', 07:30:31 INFO - 'LANGUAGE': 'en_US:en', 07:30:31 INFO - 'LOGNAME': 'cltbld', 07:30:31 INFO - 'MAIL': '/var/mail/cltbld', 07:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:31 INFO - 'MOZ_NO_REMOTE': '1', 07:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:31 INFO - 'NO_EM_RESTART': '1', 07:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:31 INFO - 'PWD': '/builds/slave/test', 07:30:31 INFO - 'SHELL': '/bin/bash', 07:30:31 INFO - 'SHLVL': '1', 07:30:31 INFO - 'TERM': 'linux', 07:30:31 INFO - 'TMOUT': '86400', 07:30:31 INFO - 'USER': 'cltbld', 07:30:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:31 INFO - '_': '/tools/buildbot/bin/python'} 07:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:31 INFO - Running setup.py (path:/tmp/pip-HCfixf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:31 INFO - Running setup.py (path:/tmp/pip-ud5djP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:31 INFO - Running setup.py (path:/tmp/pip-LKx6u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:31 INFO - Running setup.py (path:/tmp/pip-vyXaDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:32 INFO - Running setup.py (path:/tmp/pip-ucNXj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:32 INFO - Running setup.py (path:/tmp/pip-dICLQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:32 INFO - Running setup.py (path:/tmp/pip-_c68KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:32 INFO - Running setup.py (path:/tmp/pip-8JyL7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:32 INFO - Running setup.py (path:/tmp/pip-7LvA2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:32 INFO - Running setup.py (path:/tmp/pip-9R5Cp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:32 INFO - Running setup.py (path:/tmp/pip-y0L1bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:32 INFO - Running setup.py (path:/tmp/pip-xk62kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:32 INFO - Running setup.py (path:/tmp/pip-uXosnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:32 INFO - Running setup.py (path:/tmp/pip-OBBLM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:32 INFO - Running setup.py (path:/tmp/pip-SeGHFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:32 INFO - Running setup.py (path:/tmp/pip-MtYN8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:32 INFO - Running setup.py (path:/tmp/pip-XNqOgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:32 INFO - Running setup.py install for manifestparser 07:30:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozcrash 07:30:33 INFO - Running setup.py install for mozdebug 07:30:33 INFO - Running setup.py install for mozdevice 07:30:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozfile 07:30:33 INFO - Running setup.py install for mozhttpd 07:30:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozinfo 07:30:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozInstall 07:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozleak 07:30:33 INFO - Running setup.py install for mozlog 07:30:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for moznetwork 07:30:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Running setup.py install for mozprocess 07:30:34 INFO - Running setup.py install for mozprofile 07:30:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Running setup.py install for mozrunner 07:30:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Running setup.py install for mozscreenshot 07:30:34 INFO - Running setup.py install for moztest 07:30:34 INFO - Running setup.py install for mozversion 07:30:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:34 INFO - Cleaning up... 07:30:34 INFO - Return code: 0 07:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:34 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:34 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 07:30:34 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 07:30:34 INFO - Using env: {'DISPLAY': ':0', 07:30:34 INFO - 'HOME': '/home/cltbld', 07:30:34 INFO - 'LANG': 'en_US.UTF-8', 07:30:34 INFO - 'LANGUAGE': 'en_US:en', 07:30:34 INFO - 'LOGNAME': 'cltbld', 07:30:34 INFO - 'MAIL': '/var/mail/cltbld', 07:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:34 INFO - 'MOZ_NO_REMOTE': '1', 07:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:34 INFO - 'NO_EM_RESTART': '1', 07:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:34 INFO - 'PWD': '/builds/slave/test', 07:30:34 INFO - 'SHELL': '/bin/bash', 07:30:34 INFO - 'SHLVL': '1', 07:30:34 INFO - 'TERM': 'linux', 07:30:34 INFO - 'TMOUT': '86400', 07:30:34 INFO - 'USER': 'cltbld', 07:30:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:34 INFO - '_': '/tools/buildbot/bin/python'} 07:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:34 INFO - Running setup.py (path:/tmp/pip-wA5BE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:35 INFO - Running setup.py (path:/tmp/pip-M7zi8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:35 INFO - Running setup.py (path:/tmp/pip-VY7oLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:35 INFO - Running setup.py (path:/tmp/pip-hkj_gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:35 INFO - Running setup.py (path:/tmp/pip-ULkqvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:35 INFO - Running setup.py (path:/tmp/pip-lg80Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:35 INFO - Running setup.py (path:/tmp/pip-WGlQC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:35 INFO - Running setup.py (path:/tmp/pip-pJgN_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:35 INFO - Running setup.py (path:/tmp/pip-8aoS7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:35 INFO - Running setup.py (path:/tmp/pip-AdLDcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:35 INFO - Running setup.py (path:/tmp/pip-mJhKAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:35 INFO - Running setup.py (path:/tmp/pip-Kr4EQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:35 INFO - Running setup.py (path:/tmp/pip-LUsC6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:35 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)) 07:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:35 INFO - Running setup.py (path:/tmp/pip-6RSjUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:36 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)) 07:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:36 INFO - Running setup.py (path:/tmp/pip-ieGGHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:36 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)) 07:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:36 INFO - Running setup.py (path:/tmp/pip-XHi1gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:36 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)) 07:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:36 INFO - Running setup.py (path:/tmp/pip-bSVx2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:36 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)) 07:30:36 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)) 07:30:36 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)) 07:30:36 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)) 07:30:36 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)) 07:30:36 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)) 07:30:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:38 INFO - Downloading blessings-1.6.tar.gz 07:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:38 INFO - Installing collected packages: blessings 07:30:38 INFO - Running setup.py install for blessings 07:30:38 INFO - Successfully installed blessings 07:30:38 INFO - Cleaning up... 07:30:38 INFO - Return code: 0 07:30:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:38 INFO - Reading from file tmpfile_stdout 07:30:38 INFO - Current package versions: 07:30:38 INFO - argparse == 1.2.1 07:30:38 INFO - blessings == 1.6 07:30:38 INFO - blobuploader == 1.2.4 07:30:38 INFO - docopt == 0.6.1 07:30:38 INFO - functools32 == 3.2.3-2 07:30:38 INFO - jsonschema == 2.5.1 07:30:38 INFO - manifestparser == 1.1 07:30:38 INFO - mozInstall == 1.12 07:30:38 INFO - mozcrash == 1.0 07:30:38 INFO - mozdebug == 0.1 07:30:38 INFO - mozdevice == 0.48 07:30:38 INFO - mozfile == 1.2 07:30:38 INFO - mozhttpd == 0.7 07:30:38 INFO - mozinfo == 0.9 07:30:38 INFO - mozleak == 0.1 07:30:38 INFO - mozlog == 3.4 07:30:38 INFO - moznetwork == 0.27 07:30:38 INFO - mozprocess == 0.23 07:30:38 INFO - mozprofile == 0.28 07:30:38 INFO - mozrunner == 6.13 07:30:38 INFO - mozscreenshot == 0.1 07:30:38 INFO - mozsystemmonitor == 0.3 07:30:38 INFO - moztest == 0.8 07:30:38 INFO - mozversion == 1.4 07:30:38 INFO - psutil == 3.1.1 07:30:38 INFO - requests == 1.2.3 07:30:38 INFO - wsgiref == 0.1.2 07:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:38 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 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30:38 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 07:30:38 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 07:30:38 INFO - Using env: {'DISPLAY': ':0', 07:30:38 INFO - 'HOME': '/home/cltbld', 07:30:38 INFO - 'LANG': 'en_US.UTF-8', 07:30:38 INFO - 'LANGUAGE': 'en_US:en', 07:30:38 INFO - 'LOGNAME': 'cltbld', 07:30:38 INFO - 'MAIL': '/var/mail/cltbld', 07:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:38 INFO - 'MOZ_NO_REMOTE': '1', 07:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:38 INFO - 'NO_EM_RESTART': '1', 07:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:38 INFO - 'PWD': '/builds/slave/test', 07:30:38 INFO - 'SHELL': '/bin/bash', 07:30:38 INFO - 'SHLVL': '1', 07:30:38 INFO - 'TERM': 'linux', 07:30:38 INFO - 'TMOUT': '86400', 07:30:38 INFO - 'USER': 'cltbld', 07:30:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:38 INFO - '_': '/tools/buildbot/bin/python'} 07:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 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)) 07:30:38 INFO - Cleaning up... 07:30:38 INFO - Return code: 0 07:30:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f071c78df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, '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': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', '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 07:30: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', 'jsonschema'] in /builds/slave/test/build 07:30: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 jsonschema 07:30:38 INFO - Using env: {'DISPLAY': ':0', 07:30:38 INFO - 'HOME': '/home/cltbld', 07:30:38 INFO - 'LANG': 'en_US.UTF-8', 07:30:38 INFO - 'LANGUAGE': 'en_US:en', 07:30:38 INFO - 'LOGNAME': 'cltbld', 07:30:38 INFO - 'MAIL': '/var/mail/cltbld', 07:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:38 INFO - 'MOZ_NO_REMOTE': '1', 07:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:38 INFO - 'NO_EM_RESTART': '1', 07:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:38 INFO - 'PWD': '/builds/slave/test', 07:30:38 INFO - 'SHELL': '/bin/bash', 07:30:38 INFO - 'SHLVL': '1', 07:30:38 INFO - 'TERM': 'linux', 07:30:38 INFO - 'TMOUT': '86400', 07:30:38 INFO - 'USER': 'cltbld', 07:30:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:38 INFO - '_': '/tools/buildbot/bin/python'} 07:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:39 INFO - Cleaning up... 07:30:39 INFO - Return code: 0 07:30:39 INFO - Running post-action listener: _resource_record_post_action 07:30:39 INFO - Running post-action listener: _start_resource_monitoring 07:30:39 INFO - Starting resource monitoring. 07:30:39 INFO - [mozharness: 2017-01-13 15:30:39.177426Z] Finished create-virtualenv step (success) 07:30:39 INFO - [mozharness: 2017-01-13 15:30:39.177937Z] Running install step. 07:30:39 INFO - Running pre-action listener: _resource_record_pre_action 07:30:39 INFO - Running main action method: install 07:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:39 INFO - Reading from file tmpfile_stdout 07:30:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:39 INFO - Reading from file tmpfile_stdout 07:30:39 INFO - Output received: 07:30:39 INFO - Usage: mozinstall [options] installer 07:30:39 INFO - Options: 07:30:39 INFO - -h, --help show this help message and exit 07:30:39 INFO - -d DEST, --destination=DEST 07:30:39 INFO - Directory to install application into. [default: 07:30:39 INFO - "/builds/slave/test"] 07:30:39 INFO - --app=APP Application being installed. [default: firefox] 07:30:39 INFO - mkdir: /builds/slave/test/build/application 07:30:39 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'] 07:30:39 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 07:30:55 INFO - Reading from file tmpfile_stdout 07:30:55 INFO - Output received: 07:30:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:55 INFO - Running post-action listener: _resource_record_post_action 07:30:55 INFO - [mozharness: 2017-01-13 15:30:55.418958Z] Finished install step (success) 07:30:55 INFO - [mozharness: 2017-01-13 15:30:55.419202Z] Running run-tests step. 07:30:55 INFO - Running pre-action listener: _resource_record_pre_action 07:30:55 INFO - Running main action method: run_tests 07:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:55 INFO - Python 2.7.3 07:30:55 INFO - Return code: 0 07:30:55 INFO - grabbing minidump binary from tooltool 07:30:55 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')]} 07:30:55 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 0x207cf60>, '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 0x207dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:55 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 07:30:55 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 07:30:55 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 07:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:55 INFO - Return code: 0 07:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:55 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/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:30:55 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/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 07:30:55 INFO - Using env: {'DISPLAY': ':0', 07:30:55 INFO - 'HOME': '/home/cltbld', 07:30:55 INFO - 'LANG': 'en_US.UTF-8', 07:30:55 INFO - 'LANGUAGE': 'en_US:en', 07:30:55 INFO - 'LOGNAME': 'cltbld', 07:30:55 INFO - 'MAIL': '/var/mail/cltbld', 07:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:55 INFO - 'MOZ_NO_REMOTE': '1', 07:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:55 INFO - 'NO_EM_RESTART': '1', 07:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:55 INFO - 'PWD': '/builds/slave/test', 07:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:55 INFO - 'SHELL': '/bin/bash', 07:30:55 INFO - 'SHLVL': '1', 07:30:55 INFO - 'TERM': 'linux', 07:30:55 INFO - 'TMOUT': '86400', 07:30:55 INFO - 'USER': 'cltbld', 07:30:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173', 07:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:55 INFO - '_': '/tools/buildbot/bin/python'} 07:30:55 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/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:30:55 INFO - mozversion application_buildid: 20170113004016 07:30:55 INFO - mozversion application_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 07:30:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:55 INFO - mozversion application_name: Firefox 07:30:55 INFO - mozversion application_remotingname: firefox-dev 07:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:30:55 INFO - mozversion application_vendor: Mozilla 07:30:55 INFO - mozversion application_version: 52.0a2 07:30:55 INFO - mozversion platform_buildid: 20170113004016 07:30:55 INFO - mozversion platform_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 07:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:30:55 INFO - mozversion platform_version: 52.0a2 07:30:55 INFO - using testdate: 1484321455 07:30:55 INFO - actual date: 1484321455 07:30:55 INFO - starting webserver on 'localhost:57314' 07:30:55 INFO - SUITE-START | Running 2 tests 07:30:55 INFO - TEST-START | dromaeo_css 07:30:55 INFO - operating with platform_type : linux_ 07:30:55 INFO - Initialising browser for dromaeo_css test... 07:30:55 INFO - TEST-INFO | started process 1462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnKQ1o/profile http://localhost:57314/getInfo.html) 07:30:59 INFO - PROCESS | 1462 | __metrics Screen width/height:1600/1200 07:30:59 INFO - PROCESS | 1462 | colorDepth:24 07:30:59 INFO - PROCESS | 1462 | Browser inner width/height: 1024/697 07:30:59 INFO - PROCESS | 1462 | __metrics 07:30:59 INFO - PROCESS | 1462 | 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" 07:30:59 INFO - PROCESS | 1462 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:00 INFO - PROCESS | 1462 | console.error: PushService: 07:31:00 INFO - PROCESS | 1462 | stateChangeProcessEnqueue: Error transitioning state 07:31:00 INFO - PROCESS | 1462 | UnknownError 07:31:00 INFO - TEST-INFO | 1462: exit 0 07:31:00 INFO - Browser initialized. 07:31:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:00 INFO - TEST-INFO | started process 1557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnKQ1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:12 INFO - PROCESS | 1557 | RSS: Main: 143589376 07:31:12 INFO - PROCESS | 1557 | 07:34:14 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57314/tests/dromaeo/cssquery-ext.html) 07:34:15 INFO - PROCESS | 1557 | RSS: Main: 230735872 07:34:15 INFO - PROCESS | 1557 | 07:37:17 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-ext.html (next: http://localhost:57314/tests/dromaeo/cssquery-jquery.html) 07:37:17 INFO - PROCESS | 1557 | RSS: Main: 244142080 07:37:17 INFO - PROCESS | 1557 | 07:40:19 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57314/tests/dromaeo/cssquery-mootools.html) 07:40:20 INFO - PROCESS | 1557 | RSS: Main: 216616960 07:40:20 INFO - PROCESS | 1557 | 07:43:22 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57314/tests/dromaeo/cssquery-prototype.html) 07:43:23 INFO - PROCESS | 1557 | RSS: Main: 225140736 07:43:23 INFO - PROCESS | 1557 | 07:46:25 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57314/tests/dromaeo/cssquery-yui.html) 07:46:26 INFO - PROCESS | 1557 | RSS: Main: 174313472 07:46:26 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | Cycle 1(1): loaded http://localhost:57314/tests/dromaeo/cssquery-yui.html (next: http://localhost:57314/tests/dromaeo/cssquery-dojo.html) 07:49:29 INFO - PROCESS | 1557 | RSS: Main: 247934976 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | __start_tp_report 07:49:29 INFO - PROCESS | 1557 | _x_x_mozilla_page_load 07:49:29 INFO - PROCESS | 1557 | _x_x_mozilla_page_load_details 07:49:29 INFO - PROCESS | 1557 | |i|pagename|runs| 07:49:29 INFO - PROCESS | 1557 | |0;dojo.html;3257.4136655402026;3290.901272961809;3292.835358232089;3312.3540909522653;3314.8674053037867;5482.396936337;5557.7776888924445;5563.221149039137;5592.328920529532;5603.41164177761;5549.278593782813;5592.273004509408;5599.972000140004;5613;5629.549636029118;5046.167382381903;5053.51991560803;5093.032323858455;5097.209932460456;5166.43169251382;4950.579200767921;5096.898062038757;5149.3305870237;5149.40781810091;5156.123459011977;4944.381952255968;5006.148954677696;5016.774245158958;5051.797928082872;5065.721385323805;5038.269450929613;5065.772040258197;5071.873203169914;5137.948620513785;5156.74216289184;4963.255511673242;5032.270320803463;5094.668846525001;5102.36220472441;5109;5366.91949620756;5413.593980451482;5415.404305526389;5438.374586922515;5464.153056276284;5842.152887831283;5845.269341332333;5854.297484301911;5938.7624495020145;5942.37605051472;5974.940250597482;5975.492083172936;5985.6408615483215;5996.370381109964;6002;5432.945670543283;5482.890342193174;5516.889662206733;5542.889142217133;5645.661260324311;6109.7861574844665;6131.417515336036;6138.263408391022;6139.10982907476;6143.815685529441;5877.177195192677;5893.174955506232;5894.528437725057;5895.263092113486;5895.29256489224;5766.94233057664;5814.186013958049;5875.236219291465;5909.6158749681135;5913.674747888821;5983.371745966698;5988.161657367972;5990.7903223386975;6012.30858451275;6014.338422773491;5944.435278648608;5993.0710739835395;5998.730057147439;6000.969995149996;6003.399660034049;4563.954360456353;4564.543545645409;4603.378543896598;4629.86110416688;4705.294205869079;4112.527059388149;4129.566395528426;4144.668426525871;4155.958440415558;4170.687198460128;5746.109353050284;5765.682887441147;5778.537716982715;5779.450952159538;5779.826605201766;5747.5114615257335;5776.797812076641;5887.234659494238;6004.099385092271;6009.639421634716;5701.914471282934;5763.625364351304;5785.421457854265;5802.564807639444;5805.071188609802;5166.9224961625605;5168.8966220675375;5173.689578625294;5193.974030129901;5197.428282888879;6114.023656277781;6205.255369355616;6241.344658810759;6247.937520624736;6253.468455181361;5911.113332999912;5921.319048309328;5967.224260846062;5970.940290597212;6040.728167232397;6351.110844481684;6353.7140828661895;6365;6368.554201205871;6380.680965951777;5876.882462350643;5879.794207202727;5887.4406931341455;5896.380880007538;5951.523878089656;5808.912866306924;5868.61853979507;5870.735816888336;5915.822525324247;5969.850753731192;5808.73860676279;5858.7070646468355;5873.060310350324;5873.618214816023;5895.970520147372;5774.133879918046;5789.9710501447225;5793.102069179284;5809.76760929575;5809.912851307149;5578.107502799533;5637.915431268452;5705.942940570541;5720.08478643415;5766.279215098113;5706.343770466449;5771.595988280948;5778.046622307273;5789.1895134680335;5799.333076696065;5386.973065134649;5442.319710036246;5444.237806707143;5447.700376479332;5454.372747133972 07:49:29 INFO - PROCESS | 1557 | |1;ext.html;568.4599630351167;599.0235915457805;602.3915844996552;607.5291648972043;616.6269407008759;34390.48414273788;35141.82429087854;36971.260574788554;37042.62957370425;37156.628433715654;36561.63438365616;47063.29405058927;47738.52261477384;47811.28283075748;51173;8707.695230666912;8808.64765409383;8828.955855220747;8834.072422395653;8845.159709827556;8717.694880679177;8809.295256379506;8833.20501154896;8839.646414143459;8841.867371989425;8880.689175878846;8898.510581917992;8928.508932008737;8935.508547029911;8943.284537237005;8782.38523303369;8848.734537963806;8855.158759917798;8858.689945851864;8861;8728.127187281221;8802.823943521094;8807.031226565072;8808.955955220246;8809.779755506099;44415;44496.3325550117;44728.3290750639;44876.10247795058;44913.101737965386;3526.876559320437;3712.3132220539287;3723.6648701616987;3850.826712797903;4036.3138266494766;32455.83772081148;32650.673493265;32767.344653106804;33338.499922501185;34931.126721831904;4387.868363949086;4457.576530229623;4474.2841145416905;4479.664025198123;4541.795619197144;341746;343269;344098;345095;345577.2721136403;38019;39461.210775784326;59902.70048649729;60401.39598604046;60423.697881510314;41360.1727965439;41788.791056045135;41838;41843.372349414785;41905.580944190166;15132.924335378473;15195.620109497351;15268.618284542976;15287.388504459697;15305.08169509833;12594.685132871567;12680.746385072247;12684.175528590613;12703.745925081632;12714.237145771283;9578.281628877861;9593.376430531993;9610.567524461416;9678.854817177747;9679.128878400978;3661.5423072115987;3667.7799332040163;3722.40441529354;3738.85044598213;3757.755745876509;1021.3514418344256;1112.410422476089;1137.7781332640056;1147.3230793831513;1149.626371429272;31297.530537041963;32442.351152976807;32888.835555822065;33509;33933;1128.667043222235;1138.59579849154;1175.4769127738246;1190.2798806721983;1255.6986323282347;17465.388711395295;17828.286868525374;17889.7316540252;17907.820921790877;17920;515413;522854;536529;539139;540441;63764.68117659382;64178;64528.67735661292;64609.35390646127;64646.67676661681;1179.6755892129734;1281.6475469245845;1409.8308203015704;1436.920969346675;1458.139697578434;29897.850510747307;34248.48627270543;34778.13054673653;35044.64955350516;35135;52974;53452.73273633607;53551.46448535465;53574.73212633912;53724;329845;330658;330901;331178;333369;27031.59452608173;27985.44029119447;30556.388872222877;30651.08046758601;30684.232894177825;47932.760336198095;47972.7601361991;48932.266016009075;48948.75525622349;50277;41257.55598554156;42799;42971.57028429676;43010.56989430066;43420.782896085315;42172;42648;42653;42837;42948;42645;42716.78641606772;43307.56692433036;43451;43468;35256.64743352534;36960.630393696796;37346;37702.24595508129;38102.42846357251;28457.715422845507;28851.278718032216;28969.275768105123;29157.562636560044;29268.56097158502 07:49:29 INFO - PROCESS | 1557 | |2;jquery.html;399.17769395046207;402.93955906613996;405.7768227474892;407.7614595461655;424.4482173174874;14338.713225735504;18381.632367352646;19363.806361936375;20233.494162645922;20237.392878213657;15643.608909777233;17024.574385640364;18831.340903068394;19254.90372548139;19850.503737406536;5750.252467179272;5994.580379373446;6009.1286763419275;6021.668808215568;6027.126066720323;5706.686132262724;5845.0647896336595;5876.11858221266;5945.346011938705;5948.732307046172;5883.0881213411985;5883.264591926009;5886.676232807194;5887.205227294303;5892.322382925954;5780.104083867007;5868.677222752747;5872.677002764846;5965.791197308116;6008.459238668541;5396.082665946798;5399.082156033483;5400.594955378323;5403.945960540423;5404.810831620914;23613.881930590407;23987.640185397235;24089.63865542018;24123.155689550782;24131.879340603362;2388.80889528839;2424.842385244971;2554.246497283287;2608.074133682553;2679.236417620988;10516.894831051668;10813.62152324665;14469.565913022627;15169.165695886722;15196.240187990667;1998.1907327532372;2053.979460205394;2075.937721868346;2102.5899949509853;2131.893405329727;77161.61419192924;85492;85521;87167;88266.55866720689;11689.590864319707;11704.47329870158;11856.88143118575;11941.044716422666;12366;16454.177291135395;16462.341506339853;16480.83519164793;16495.422660207074;16496.505104846874;7575.659095340723;7931.167227441036;7948.761537153895;8096.230858068474;8397.328213742885;7926.524408535506;8025.3980951428875;8068.314193293519;8228.25945664893;8307.6676932922;4995.975020124876;4999.550040496373;5035.093683137071;5135.281060651511;5150.587952963829;1821.7782612995643;1884.3593178319163;2103.1377135374423;2132.7334083239593;2133.1254185783755;927.5594092805998;959.0074273127419;1027.5324727249083;1060.226034994443;1105.3079676771993;19930.00349982495;20014.599708005757;20214;20320.28878989228;20342.79657203409;1004.7488127968008;1014.6144465103214;1038.7922415516928;1078.1159449251538;1081.297156848055;10467.947660261802;11337.659870203906;11524.308541487537;11548.884511154949;11605.129615278887;517151;544105;547719;549080;561184;98277.50861245648;99291;99317;102440.48779756053;103224;498.2103366164597;504;512.6129772022099;521.5332277611592;523.455606169587;11498.367589782642;11578.42107894585;11871.881281187078;12031.4585843639;12462.813057804322;40724.389134163604;41396.586034139276;41968.274522499676;42690.57309426866;42799.7860010698;58326;58958.41041589529;59920.70039649774;60330;60927;9043.819123617359;9230.261579073524;9244;9299.581518831805;9307.301952353466;10120.291579589653;13127.868721313047;13278.800817987545;13578.38897249646;14093.788593171315;11802.822957655813;11941.044716422839;11983.460744266704;12077.818832717341;12252.448639811408;11663;11750.823737644114;11823.645290641294;12142.817857731965;12238.75522489563;11856.051515878882;12140.33228172459;12247.142700010914;12335.198212116542;12634.368281585701;9190.31072669539;9192.58633361487;9234.815303694022;9260.861087083564;9379.74714861817;10564.524596393027;11051.557937682403;12108.939455302667;12190.085743569445;12284.754304913673 07:49:29 INFO - PROCESS | 1557 | |3;mootools.html;1516.4389176004877;1530.9026633512087;1689.11321556183;1761.973570396445;1794.4796009157337;8649.697260595873;9184.265258779298;9193.494357810318;9194.908050919481;9195.172434480895;7955.641996110175;8186.836263274746;8357.91642083579;8547.401681882271;8975.730728078168;2452.7301996780384;2483.8509689418693;2488.9377765555914;2489.4149874779414;2490.4272017436;2482.3173627252468;2563.820532562712;2564.3204550794053;2567.0373609896287;2567.204166708317;2468.2471846086937;2473.146764366291;2485.428351479161;2485.7389974052735;2487.9004839806385;2408.89159987801;2417.0331867253153;2418.1053010386095;2424.3696638873844;2429.3683642253054;2366.7278262999803;2396.1852969990114;2406.2420337593603;2415.867127307997;2417.5890098683267;8603.5698215089;8940.32947528938;9021.503817290046;9053.50205738684;9061.365704400694;5404.51359377654;5557.833265002057;5558.166275058733;5568.749406276727;5569.693666848321;3356.9496457553155;3394.8302584870903;3484.564429446319;3532.364174448598;3547.6984456321243;1102.922795404322;1128.9604863829727;1131.9886801131966;1167.5073717612872;1174.3130268792765;11719.414029298501;11763.176577639568;11781.58764443249;11786.941065294704;11803.114766392555;4764.666473346832;4859.586935110485;4886.291487734258;4958.256261560795;5089.872753181126;10313.381197128196;10361.533730982124;10365.948170259251;10372.222083343779;10375.740606484898;5439.5104440600535;5463.098588732894;5471.562275017989;5477.397486276506;5479.068558345091;4311.655067594585;4357.324614684729;5028.044671512474;5072.213806859942;5158.38099428071;4176.665866730655;4230.64039556635;4277.401163837066;4334.50153232376;4340.782960852008;1345.381124682657;1365.9112157709717;1376.3324787478066;1378.5312993582231;1379.544750232441;796.2913007423398;827.6482494939627;880.9383343166045;962.7689354554857;984.9064338887795;5879.235699359056;5976.073708575178;6015.398460154037;6076.301225359052;6100.571337566917;926.4441335198827;940.2618944128826;953.1659797677032;970.1414248390084;1002.1431675917132;3932.3465125194775;4028.879133625996;4032.516098068251;4076.286649836267;4224.4930608327195;10815.080718138888;11065.114790816715;11113.22207445471;11123.944380278046;11173.441327933571;11091.778164436666;11120.721981950515;11130.387828669502;11133.276337038067;11151.275167114274;8124.268815806724;8430.199131082538;8596.355273354524;8603.268722158688;8606.741797746077;5632.662040277596;5681.801136960186;5877.471027607536;5932.822015339547;5954.7915822947725;9991.950040249752;10059.547320370455;10079.34484258521;10145.797084058426;10200.591976320864;10515.053645171665;10539.367637941748;10636.042756151983;10639.574417023232;10650.041496265374;7516.661750221362;7680.231976802275;7752.0697516298405;7754.457187996786;7755.302022817974;8566.400351975302;8772.473651580925;8795.384323097578;8823.69117080899;8852.911470885467;6893.414059804973;7562.432817538816;7797.41519386037;7874.251946065115;7907.130215676386;7546.1321947976685;7665.846683066419;7717.498362606637;7802.336801371947;7880.05439347282;7130.35826775572;7164.2119366868565;7239.746608868664;7244.565326080452;7245.311695388929;5199.194124910645;5230.398504172069;5285.68285902847;5326.25432439451;5367.785288588413;5276.551493122974;5392.218128371443;5430.076886929152;5450.8909821802545;5506.531944784738 07:49:29 INFO - PROCESS | 1557 | |4;prototype.html;335.42307231561705;342.68986567156725;347.5967877262376;348.2495222794878;348.39901170480925;5345.171498417747;5365.597580181492;5380.112281473557;5402.540784033352;5411.4295709538;5004.499550044994;5143.3570803649545;5149.253358263049;5244.68531888087;5338.332708411449;4184.811683474236;4188.806190235783;4191.308434108369;4205.074883525627;4216.47294088239;4197.866576024471;4201.936970945439;4219.282721937263;4227.682923780713;4255.936160957588;3902.3707951604997;3941.7437866538585;4147.730397524167;4163.562825903282;4180;4135.234981528397;4147.6267135957605;4154.91690166198;4162.562930892258;4168.583141685837;3707.4068149096015;3711.3876210425246;3714.5542534895717;3722.3485889969147;3722.4788529605876;5005.373253692528;5151.072806894757;5160.432352441228;5199.870003249911;5232.555232805216;4767.355262434455;4767.404074490689;4770.189067858472;4779.761011949388;4783.804048987753;5497.367802702661;5517.44825517445;5518.440605809231;5525.972370138124;5534.723263836832;3921.705872059607;4075.816588253536;4081.2857749893947;4085.59144085592;4092.3043082676018;5739.885202295973;5741.741621626995;5747.195392645033;5749.367569567345;5755.913661295084;4182.53992060873;4182.874513764592;4199.9370009449885;4200.180964711913;4225.19721252961;4000.4999375078114;4169.749815011109;4266.360045993126;4272.743635381825;4283.850065247701;4773.928391074137;4773.928391074137;4777.593904518086;4798.640101992364;4800.7599620019555;5591.27313449249;5610.410906854803;5612;5616.354119276254;5641.717914104278;1307.1699470836088;1378.200643626694;1401.7897315402772;1411.865872742088;1426.4594238222694;888.644542183119;923.6720964057797;952.3666761603595;960.1550635440767;964.4213471916794;5291.137469647179;5291.735413229323;5317;5360.60624237701;5366.443731317874;5536.923653629889;5553.527950124285;5555.416706238702;5557.276934302163;5559.666420014732;5216.38215777102;5236.162214045735;5268.394134674561;5291.841244762663;5315.415304316522;2901.8984335548153;2904.5788360687584;2905.186547766629;2912.6504819421807;2923.517619592786;5616.5787565932715;5698.46695049064;5785.508231800344;5797;5798.768049278066;5554.694491802989;5557.165555766508;5558.609248358498;5571.130867603188;5587.686893580006;5755.395683453261;5761.827145185567;5791.507721843691;5808.983427900016;5814.691694368733;5507.284053073075;5513.421090785409;5529.225908372911;5667.659940403589;5719.656820590778;5692;5713.143028545752;5721.628094173865;5733.913991290217;5737.627054241461;5850.795222167204;6103.725332359965;6106.45041946227;6116.785912493041;6131.601445906002;4122.175564886975;4138.544760076329;4159.251334759772;4159.854405095807;4188.162367526568;5758.510526605118;5797.275340582427;5809.883802323845;5810.4189581041555;5827.475527202572;5503.587230957614;5665.272092011811;5693.580228402995;5706.372299047019;5712.228849105318;5597.916031259453;5617.269754931833;5621.7189140542;5653.180288858175;5672.787612830916;5343.251944727664;5499.917501237404;5535.584831137761;5578.721063946705;5609.663420194638;5516.613837031369;5632.9436705632415;5645.209670646195;5661.867626474804;5662.7734890603915;5331.200319951883;5345.118055520796;5347.9304139171545;5351.59863010268;5362.302900622894 07:49:29 INFO - PROCESS | 1557 | |5;yui.html;721.7834649605118;773.8336257704592;804.203838200182;832.0389949608202;836.5068352989914;14694.853051469481;15138.848611513882;15455.381784728597;15606.219689015546;15636.061836289831;13714.7656710896;14305.070170438914;14644.926775366135;14672.19302938338;14675.92662036691;715.4062128433388;715.6707914359388;728.5264578024301;835.6991483066122;839.7102999465205;821.0844907927677;839.0979696825906;845.0619812008665;845.5941148248813;846.6697987784769;882.0914458108127;884.1777147253052;884.6770928611043;885.2917665867312;885.8981217160012;746.9290417410338;754.3098065270271;858.0904241504026;877.350760437275;881.2025117268882;647.7538535356581;651.7849109793804;652.3704625036862;652.4258652385918;652.4356431686557;14663.853361466356;14730.263486825615;14761.114333140045;14778.334974926154;14781.704365912728;13887.652808679763;14061.78907316391;14112.294385280695;14313.499027533986;14326.57020289393;12924;12984.28586427746;12993.825474017809;13328;13432.126911750705;3822.6750726188307;4434.866953991385;4435.489918659363;4437.600615944548;4560.612347950429;60816;66050.04632083749;67588.3241167587;67794.66102669504;68018.31981680219;11153.498092585853;11318.207725459139;11368.943155284336;11460.19778615489;11485.023772979222;19883.801161988195;19899.502512437015;19944.50138746543;20031.799682003286;20140.798592014184;8066.354691624656;8219;8408.426329295235;8453.915460845436;8464.153584641486;4683.672142949961;4801.903961920742;4828.758562071883;4923.212286034217;4923.433805112386;3567.28654269142;3662.9450558241647;3665.395209790355;3672.3940549809518;3676.246369494301;597.4443767296369;603.3303033632665;608.8873558391712;609.430182779103;618.9907151392732;618.703022549179;650.3464018661309;676.47573130824;697.1668855717369;713.4684659928387;9088.909110908939;9156.313276504288;9378.90621093794;9699.224062075016;9837.606495740234;653.5359894474976;664.35225654986;675.6148995072859;678.7861823525574;690.8065741592362;4600.5629465200755;4617.307403889444;4636.907261854744;4663.626909847204;4767.809287628525;92789.53605231931;93225;94462;94951;97727.51136244416;81563.59218203872;83522.58238708768;84411;84481;86164;76090;76698.99999999888;77599;77735.61132194303;79911.60044199742;9028.864567031369;9185.127412895765;9249.630014799333;9276.953615231881;9319.813603728024;50338.74153146054;50517.49482505275;51244.231336529236;52179.47820521746;52392;71009.64495177491;72699;72761;73283;75223.62388188024;10924.890751092706;11349.943250284026;11501.934751320907;11722.531098755955;12008.099392545419;12270.693232669255;12431.875681243433;13004.349782510648;13321.733565328444;13831;10785.784284314113;11957.820632690342;12664.556740514037;12784.232946023269;13261.403236854172;12082.637520874388;12448.875511244772;12484.93757531243;12546.372681366078;12756.362181891054;13072.934635327143;13134.737305254033;13316.067875249028;13415.798763018367;13764.793528096887;10166.542505587415;10179.440130792878;10433.107994083652;10582.312149710244;10781.299215550964;9944.850827237742;10024.789588373047;10116.848247276444;10394.16846652251;11037.83443248368 07:49:29 INFO - PROCESS | 1557 | __end_tp_report 07:49:29 INFO - PROCESS | 1557 | __start_cc_report 07:49:29 INFO - PROCESS | 1557 | _x_x_mozilla_cycle_collect,923 07:49:29 INFO - PROCESS | 1557 | __end_cc_report 07:49:29 INFO - PROCESS | 1557 | __startTimestamp1484322569286__endTimestamp 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | ------- Summary: start ------- 07:49:29 INFO - PROCESS | 1557 | Number of tests: 6 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#0] dojo.html Cycles:165 Average:5537.09 Median:5771.60 stddev:617.41 (10.7%) stddev-sans-first:592.84 07:49:29 INFO - PROCESS | 1557 | Values: 3257.4 3290.9 3292.8 3312.4 3314.9 5482.4 5557.8 5563.2 5592.3 5603.4 5549.3 5592.3 5600.0 5613.0 5629.5 5046.2 5053.5 5093.0 5097.2 5166.4 4950.6 5096.9 5149.3 5149.4 5156.1 4944.4 5006.1 5016.8 5051.8 5065.7 5038.3 5065.8 5071.9 5137.9 5156.7 4963.3 5032.3 5094.7 5102.4 5109.0 5366.9 5413.6 5415.4 5438.4 5464.2 5842.2 5845.3 5854.3 5938.8 5942.4 5974.9 5975.5 5985.6 5996.4 6002.0 5432.9 5482.9 5516.9 5542.9 5645.7 6109.8 6131.4 6138.3 6139.1 6143.8 5877.2 5893.2 5894.5 5895.3 5895.3 5766.9 5814.2 5875.2 5909.6 5913.7 5983.4 5988.2 5990.8 6012.3 6014.3 5944.4 5993.1 5998.7 6001.0 6003.4 4564.0 4564.5 4603.4 4629.9 4705.3 4112.5 4129.6 4144.7 4156.0 4170.7 5746.1 5765.7 5778.5 5779.5 5779.8 5747.5 5776.8 5887.2 6004.1 6009.6 5701.9 5763.6 5785.4 5802.6 5805.1 5166.9 5168.9 5173.7 5194.0 5197.4 6114.0 6205.3 6241.3 6247.9 6253.5 5911.1 5921.3 5967.2 5970.9 6040.7 6351.1 6353.7 6365.0 6368.6 6380.7 5876.9 5879.8 5887.4 5896.4 5951.5 5808.9 5868.6 5870.7 5915.8 5969.9 5808.7 5858.7 5873.1 5873.6 5896.0 5774.1 5790.0 5793.1 5809.8 5809.9 5578.1 5637.9 5705.9 5720.1 5766.3 5706.3 5771.6 5778.0 5789.2 5799.3 5387.0 5442.3 5444.2 5447.7 5454.4 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#1] ext.html Cycles:180 Average:56453.89 Median:41813.40 stddev:109302.08 (261.4%) stddev-sans-first:109528.16 07:49:29 INFO - PROCESS | 1557 | Values: 568.5 599.0 602.4 607.5 616.6 34390.5 35141.8 36971.3 37042.6 37156.6 36561.6 47063.3 47738.5 47811.3 51173.0 8707.7 8808.6 8829.0 8834.1 8845.2 8717.7 8809.3 8833.2 8839.6 8841.9 8880.7 8898.5 8928.5 8935.5 8943.3 8782.4 8848.7 8855.2 8858.7 8861.0 8728.1 8802.8 8807.0 8809.0 8809.8 44415.0 44496.3 44728.3 44876.1 44913.1 3526.9 3712.3 3723.7 3850.8 4036.3 32455.8 32650.7 32767.3 33338.5 34931.1 4387.9 4457.6 4474.3 4479.7 4541.8 341746.0 343269.0 344098.0 345095.0 345577.3 38019.0 39461.2 59902.7 60401.4 60423.7 41360.2 41788.8 41838.0 41843.4 41905.6 15132.9 15195.6 15268.6 15287.4 15305.1 12594.7 12680.7 12684.2 12703.7 12714.2 9578.3 9593.4 9610.6 9678.9 9679.1 3661.5 3667.8 3722.4 3738.9 3757.8 1021.4 1112.4 1137.8 1147.3 1149.6 31297.5 32442.4 32888.8 33509.0 33933.0 1128.7 1138.6 1175.5 1190.3 1255.7 17465.4 17828.3 17889.7 17907.8 17920.0 515413.0 522854.0 536529.0 539139.0 540441.0 63764.7 64178.0 64528.7 64609.4 64646.7 1179.7 1281.6 1409.8 1436.9 1458.1 29897.9 34248.5 34778.1 35044.6 35135.0 52974.0 53452.7 53551.5 53574.7 53724.0 329845.0 330658.0 330901.0 331178.0 333369.0 27031.6 27985.4 30556.4 30651.1 30684.2 47932.8 47972.8 48932.3 48948.8 50277.0 41257.6 42799.0 42971.6 43010.6 43420.8 42172.0 42648.0 42653.0 42837.0 42948.0 42645.0 42716.8 43307.6 43451.0 43468.0 35256.6 36960.6 37346.0 37702.2 38102.4 28457.7 28851.3 28969.3 29157.6 29268.6 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#2] jquery.html Cycles:180 Average:30977.49 Median:13278.36 stddev:89665.83 (675.3%) stddev-sans-first:89887.97 07:49:29 INFO - PROCESS | 1557 | Values: 399.2 402.9 405.8 407.8 424.4 14338.7 18381.6 19363.8 20233.5 20237.4 15643.6 17024.6 18831.3 19254.9 19850.5 5750.3 5994.6 6009.1 6021.7 6027.1 5706.7 5845.1 5876.1 5945.3 5948.7 5883.1 5883.3 5886.7 5887.2 5892.3 5780.1 5868.7 5872.7 5965.8 6008.5 5396.1 5399.1 5400.6 5403.9 5404.8 23613.9 23987.6 24089.6 24123.2 24131.9 2388.8 2424.8 2554.2 2608.1 2679.2 10516.9 10813.6 14469.6 15169.2 15196.2 1998.2 2054.0 2075.9 2102.6 2131.9 77161.6 85492.0 85521.0 87167.0 88266.6 11689.6 11704.5 11856.9 11941.0 12366.0 16454.2 16462.3 16480.8 16495.4 16496.5 7575.7 7931.2 7948.8 8096.2 8397.3 7926.5 8025.4 8068.3 8228.3 8307.7 4996.0 4999.6 5035.1 5135.3 5150.6 1821.8 1884.4 2103.1 2132.7 2133.1 927.6 959.0 1027.5 1060.2 1105.3 19930.0 20014.6 20214.0 20320.3 20342.8 1004.7 1014.6 1038.8 1078.1 1081.3 10467.9 11337.7 11524.3 11548.9 11605.1 517151.0 544105.0 547719.0 549080.0 561184.0 98277.5 99291.0 99317.0 102440.5 103224.0 498.2 504.0 512.6 521.5 523.5 11498.4 11578.4 11871.9 12031.5 12462.8 40724.4 41396.6 41968.3 42690.6 42799.8 58326.0 58958.4 59920.7 60330.0 60927.0 9043.8 9230.3 9244.0 9299.6 9307.3 10120.3 13127.9 13278.8 13578.4 14093.8 11802.8 11941.0 11983.5 12077.8 12252.4 11663.0 11750.8 11823.6 12142.8 12238.8 11856.1 12140.3 12247.1 12335.2 12634.4 9190.3 9192.6 9234.8 9260.9 9379.7 10564.5 11051.6 12108.9 12190.1 12284.8 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#3] mootools.html Cycles:180 Average:5895.67 Median:4993.15 stddev:3279.19 (65.7%) stddev-sans-first:3271.87 07:49:29 INFO - PROCESS | 1557 | Values: 1516.4 1530.9 1689.1 1762.0 1794.5 8649.7 9184.3 9193.5 9194.9 9195.2 7955.6 8186.8 8357.9 8547.4 8975.7 2452.7 2483.9 2488.9 2489.4 2490.4 2482.3 2563.8 2564.3 2567.0 2567.2 2468.2 2473.1 2485.4 2485.7 2487.9 2408.9 2417.0 2418.1 2424.4 2429.4 2366.7 2396.2 2406.2 2415.9 2417.6 8603.6 8940.3 9021.5 9053.5 9061.4 5404.5 5557.8 5558.2 5568.7 5569.7 3356.9 3394.8 3484.6 3532.4 3547.7 1102.9 1129.0 1132.0 1167.5 1174.3 11719.4 11763.2 11781.6 11786.9 11803.1 4764.7 4859.6 4886.3 4958.3 5089.9 10313.4 10361.5 10365.9 10372.2 10375.7 5439.5 5463.1 5471.6 5477.4 5479.1 4311.7 4357.3 5028.0 5072.2 5158.4 4176.7 4230.6 4277.4 4334.5 4340.8 1345.4 1365.9 1376.3 1378.5 1379.5 796.3 827.6 880.9 962.8 984.9 5879.2 5976.1 6015.4 6076.3 6100.6 926.4 940.3 953.2 970.1 1002.1 3932.3 4028.9 4032.5 4076.3 4224.5 10815.1 11065.1 11113.2 11123.9 11173.4 11091.8 11120.7 11130.4 11133.3 11151.3 8124.3 8430.2 8596.4 8603.3 8606.7 5632.7 5681.8 5877.5 5932.8 5954.8 9992.0 10059.5 10079.3 10145.8 10200.6 10515.1 10539.4 10636.0 10639.6 10650.0 7516.7 7680.2 7752.1 7754.5 7755.3 8566.4 8772.5 8795.4 8823.7 8852.9 6893.4 7562.4 7797.4 7874.3 7907.1 7546.1 7665.8 7717.5 7802.3 7880.1 7130.4 7164.2 7239.7 7244.6 7245.3 5199.2 5230.4 5285.7 5326.3 5367.8 5276.6 5392.2 5430.1 5450.9 5506.5 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#4] prototype.html Cycles:180 Average:4690.48 Median:5345.14 stddev:1371.67 (25.7%) stddev-sans-first:1336.00 07:49:29 INFO - PROCESS | 1557 | Values: 335.4 342.7 347.6 348.2 348.4 5345.2 5365.6 5380.1 5402.5 5411.4 5004.5 5143.4 5149.3 5244.7 5338.3 4184.8 4188.8 4191.3 4205.1 4216.5 4197.9 4201.9 4219.3 4227.7 4255.9 3902.4 3941.7 4147.7 4163.6 4180.0 4135.2 4147.6 4154.9 4162.6 4168.6 3707.4 3711.4 3714.6 3722.3 3722.5 5005.4 5151.1 5160.4 5199.9 5232.6 4767.4 4767.4 4770.2 4779.8 4783.8 5497.4 5517.4 5518.4 5526.0 5534.7 3921.7 4075.8 4081.3 4085.6 4092.3 5739.9 5741.7 5747.2 5749.4 5755.9 4182.5 4182.9 4199.9 4200.2 4225.2 4000.5 4169.7 4266.4 4272.7 4283.9 4773.9 4773.9 4777.6 4798.6 4800.8 5591.3 5610.4 5612.0 5616.4 5641.7 1307.2 1378.2 1401.8 1411.9 1426.5 888.6 923.7 952.4 960.2 964.4 5291.1 5291.7 5317.0 5360.6 5366.4 5536.9 5553.5 5555.4 5557.3 5559.7 5216.4 5236.2 5268.4 5291.8 5315.4 2901.9 2904.6 2905.2 2912.7 2923.5 5616.6 5698.5 5785.5 5797.0 5798.8 5554.7 5557.2 5558.6 5571.1 5587.7 5755.4 5761.8 5791.5 5809.0 5814.7 5507.3 5513.4 5529.2 5667.7 5719.7 5692.0 5713.1 5721.6 5733.9 5737.6 5850.8 6103.7 6106.5 6116.8 6131.6 4122.2 4138.5 4159.3 4159.9 4188.2 5758.5 5797.3 5809.9 5810.4 5827.5 5503.6 5665.3 5693.6 5706.4 5712.2 5597.9 5617.3 5621.7 5653.2 5672.8 5343.3 5499.9 5535.6 5578.7 5609.7 5516.6 5632.9 5645.2 5661.9 5662.8 5331.2 5345.1 5347.9 5351.6 5362.3 07:49:29 INFO - PROCESS | 1557 | 07:49:29 INFO - PROCESS | 1557 | [#5] yui.html Cycles:180 Average:19004.64 Median:50880.86 stddev:26035.38 (51.2%) stddev-sans-first:26072.22 07:49:29 INFO - PROCESS | 1557 | Values: 721.8 773.8 804.2 832.0 836.5 14694.9 15138.8 15455.4 15606.2 15636.1 13714.8 14305.1 14644.9 14672.2 14675.9 715.4 715.7 728.5 835.7 839.7 821.1 839.1 845.1 845.6 846.7 882.1 884.2 884.7 885.3 885.9 746.9 754.3 858.1 877.4 881.2 647.8 651.8 652.4 652.4 652.4 14663.9 14730.3 14761.1 14778.3 14781.7 13887.7 14061.8 14112.3 14313.5 14326.6 12924.0 12984.3 12993.8 13328.0 13432.1 3822.7 4434.9 4435.5 4437.6 4560.6 60816.0 66050.0 67588.3 67794.7 68018.3 11153.5 11318.2 11368.9 11460.2 11485.0 19883.8 19899.5 19944.5 20031.8 20140.8 8066.4 8219.0 8408.4 8453.9 8464.2 4683.7 4801.9 4828.8 4923.2 4923.4 3567.3 3662.9 3665.4 3672.4 3676.2 597.4 603.3 608.9 609.4 619.0 618.7 650.3 676.5 697.2 713.5 9088.9 9156.3 9378.9 9699.2 9837.6 653.5 664.4 675.6 678.8 690.8 4600.6 4617.3 4636.9 4663.6 4767.8 92789.5 93225.0 94462.0 94951.0 97727.5 81563.6 83522.6 84411.0 84481.0 86164.0 76090.0 76699.0 77599.0 77735.6 79911.6 9028.9 9185.1 9249.6 9277.0 9319.8 50338.7 50517.5 51244.2 52179.5 52392.0 71009.6 72699.0 72761.0 73283.0 75223.6 10924.9 11349.9 11501.9 11722.5 12008.1 12270.7 12431.9 13004.3 13321.7 13831.0 10785.8 11957.8 12664.6 12784.2 13261.4 12082.6 12448.9 12484.9 12546.4 12756.4 13072.9 13134.7 13316.1 13415.8 13764.8 10166.5 10179.4 10433.1 10582.3 10781.3 9944.9 10024.8 10116.8 10394.2 11037.8 07:49:29 INFO - PROCESS | 1557 | -------- Summary: end -------- 07:49:29 INFO - PROCESS | 1557 | 07:49:30 INFO - TEST-INFO | 1557: exit 0 07:49:30 INFO - TEST-OK | dromaeo_css | took 1114354ms 07:49:30 INFO - TEST-START | kraken 07:49:30 INFO - operating with platform_type : linux_ 07:49:30 INFO - Initialising browser for kraken test... 07:49:30 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKsTnh/profile http://localhost:57314/getInfo.html) 07:49:33 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 07:49:33 INFO - PROCESS | 1909 | colorDepth:24 07:49:33 INFO - PROCESS | 1909 | Browser inner width/height: 1024/697 07:49:33 INFO - PROCESS | 1909 | __metrics 07:49:33 INFO - PROCESS | 1909 | 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" 07:49:33 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:34 INFO - PROCESS | 1909 | console.error: PushService: 07:49:34 INFO - PROCESS | 1909 | stateChangeProcessEnqueue: Error transitioning state 07:49:34 INFO - PROCESS | 1909 | UnknownError 07:49:34 INFO - TEST-INFO | 1909: exit 0 07:49:34 INFO - Browser initialized. 07:49:34 INFO - Running cycle 1/1 for kraken test... 07:49:34 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKsTnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:46 INFO - PROCESS | 1999 | RSS: Main: 144011264 07:49:46 INFO - PROCESS | 1999 | 07:49:49 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57314/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:49 INFO - PROCESS | 1999 | RSS: Main: 185659392 07:49:49 INFO - PROCESS | 1999 | 07:49:52 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57314/tests/kraken/driver.html?testName=audio-dft) 07:49:53 INFO - PROCESS | 1999 | RSS: Main: 174690304 07:49:53 INFO - PROCESS | 1999 | 07:49:55 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57314/tests/kraken/driver.html?testName=audio-fft) 07:49:56 INFO - PROCESS | 1999 | RSS: Main: 266403840 07:49:56 INFO - PROCESS | 1999 | 07:49:58 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57314/tests/kraken/driver.html?testName=audio-oscillator) 07:49:59 INFO - PROCESS | 1999 | RSS: Main: 173527040 07:49:59 INFO - PROCESS | 1999 | 07:50:01 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:01 INFO - PROCESS | 1999 | RSS: Main: 175579136 07:50:01 INFO - PROCESS | 1999 | 07:50:04 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57314/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:05 INFO - PROCESS | 1999 | RSS: Main: 213319680 07:50:05 INFO - PROCESS | 1999 | 07:50:08 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57314/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:09 INFO - PROCESS | 1999 | RSS: Main: 212680704 07:50:09 INFO - PROCESS | 1999 | 07:50:11 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57314/tests/kraken/driver.html?testName=json-parse-financial) 07:50:12 INFO - PROCESS | 1999 | RSS: Main: 211570688 07:50:12 INFO - PROCESS | 1999 | 07:50:14 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:14 INFO - PROCESS | 1999 | RSS: Main: 172990464 07:50:14 INFO - PROCESS | 1999 | 07:50:16 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:16 INFO - PROCESS | 1999 | RSS: Main: 180547584 07:50:16 INFO - PROCESS | 1999 | 07:50:18 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:19 INFO - PROCESS | 1999 | RSS: Main: 189808640 07:50:19 INFO - PROCESS | 1999 | 07:50:22 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:22 INFO - PROCESS | 1999 | RSS: Main: 199270400 07:50:22 INFO - PROCESS | 1999 | 07:50:25 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:25 INFO - PROCESS | 1999 | RSS: Main: 194985984 07:50:25 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:57314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57314/tests/kraken/driver.html?testName=ai-astar) 07:50:27 INFO - PROCESS | 1999 | RSS: Main: 246456320 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | __start_tp_report 07:50:27 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 07:50:27 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 07:50:27 INFO - PROCESS | 1999 | |i|pagename|runs| 07:50:27 INFO - PROCESS | 1999 | |0;ai-astar;102;110;111;111;113;111;114;112;113;113 07:50:27 INFO - PROCESS | 1999 | |1;audio-beat-detection;148;117;117;153;118;118;119;118;152;121 07:50:27 INFO - PROCESS | 1999 | |2;audio-dft;161;160;161;161;161;163;161;161;159;162 07:50:27 INFO - PROCESS | 1999 | |3;audio-fft;74;75;76;104;75;77;75;76;104;75 07:50:27 INFO - PROCESS | 1999 | |4;audio-oscillator;81;82;110;81;81;82;96;81;80;116 07:50:27 INFO - PROCESS | 1999 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 07:50:27 INFO - PROCESS | 1999 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;144 07:50:27 INFO - PROCESS | 1999 | |7;imaging-desaturate;84;84;85;85;84;84;84;84;84;84 07:50:27 INFO - PROCESS | 1999 | |8;json-parse-financial;49;50;50;49;49;50;50;50;49;50 07:50:27 INFO - PROCESS | 1999 | |9;json-stringify-tinderbox;58;57;57;58;60;59;58;58;58;59 07:50:27 INFO - PROCESS | 1999 | |10;stanford-crypto-aes;75;74;75;75;75;74;75;82;74;74 07:50:27 INFO - PROCESS | 1999 | |11;stanford-crypto-ccm;125;125;126;120;130;119;129;119;165;121 07:50:27 INFO - PROCESS | 1999 | |12;stanford-crypto-pbkdf2;154;157;152;156;156;153;152;151;157;156 07:50:27 INFO - PROCESS | 1999 | |13;stanford-crypto-sha256-iterative;62;65;64;62;63;62;63;62;61;61 07:50:27 INFO - PROCESS | 1999 | __end_tp_report 07:50:27 INFO - PROCESS | 1999 | __start_cc_report 07:50:27 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,1591 07:50:27 INFO - PROCESS | 1999 | __end_cc_report 07:50:27 INFO - PROCESS | 1999 | __startTimestamp1484322627844__endTimestamp 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | ------- Summary: start ------- 07:50:27 INFO - PROCESS | 1999 | Number of tests: 14 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.40 (3.0%) stddev-sans-first:1.32 07:50:27 INFO - PROCESS | 1999 | Values: 102.0 110.0 111.0 111.0 113.0 111.0 114.0 112.0 113.0 113.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:120.00 stddev:15.89 (13.2%) stddev-sans-first:15.14 07:50:27 INFO - PROCESS | 1999 | Values: 148.0 117.0 117.0 153.0 118.0 118.0 119.0 118.0 152.0 121.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 07:50:27 INFO - PROCESS | 1999 | Values: 161.0 160.0 161.0 161.0 161.0 163.0 161.0 161.0 159.0 162.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.10 (16.1%) stddev-sans-first:12.55 07:50:27 INFO - PROCESS | 1999 | Values: 74.0 75.0 76.0 104.0 75.0 77.0 75.0 76.0 104.0 75.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:13.56 (16.7%) stddev-sans-first:14.07 07:50:27 INFO - PROCESS | 1999 | Values: 81.0 82.0 110.0 81.0 81.0 82.0 96.0 81.0 80.0 116.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:50:27 INFO - PROCESS | 1999 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:50:27 INFO - PROCESS | 1999 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 144.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 07:50:27 INFO - PROCESS | 1999 | Values: 84.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 07:50:27 INFO - PROCESS | 1999 | Values: 49.0 50.0 50.0 49.0 49.0 50.0 50.0 50.0 49.0 50.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 07:50:27 INFO - PROCESS | 1999 | Values: 58.0 57.0 57.0 58.0 60.0 59.0 58.0 58.0 58.0 59.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:2.41 (3.2%) stddev-sans-first:2.55 07:50:27 INFO - PROCESS | 1999 | Values: 75.0 74.0 75.0 75.0 75.0 74.0 75.0 82.0 74.0 74.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.50 stddev:13.63 (10.9%) stddev-sans-first:14.41 07:50:27 INFO - PROCESS | 1999 | Values: 125.0 125.0 126.0 120.0 130.0 119.0 129.0 119.0 165.0 121.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:156.00 stddev:2.27 (1.5%) stddev-sans-first:2.40 07:50:27 INFO - PROCESS | 1999 | Values: 154.0 157.0 152.0 156.0 156.0 153.0 152.0 151.0 157.0 156.0 07:50:27 INFO - PROCESS | 1999 | 07:50:27 INFO - PROCESS | 1999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.27 (2.0%) stddev-sans-first:1.33 07:50:27 INFO - PROCESS | 1999 | Values: 62.0 65.0 64.0 62.0 63.0 62.0 63.0 62.0 61.0 61.0 07:50:27 INFO - PROCESS | 1999 | -------- Summary: end -------- 07:50:27 INFO - PROCESS | 1999 | 07:50:28 INFO - TEST-INFO | 1999: exit 0 07:50:28 INFO - TEST-OK | kraken | took 58820ms 07:50:28 INFO - SUITE-END | took 1173s 07:50:29 INFO - Completed test suite (00:19:33) 07:50:29 INFO - javascript benchmark 07:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.4136655402026, 3290.901272961809, 3292.835358232089, 3312.3540909522653, 3314.8674053037867, 5482.396936337, 5557.7776888924445, 5563.221149039137, 5592.328920529532, 5603.41164177761, 5549.278593782813, 5592.273004509408, 5599.972000140004, 5613.0, 5629.549636029118, 5046.167382381903, 5053.51991560803, 5093.032323858455, 5097.209932460456, 5166.43169251382, 4950.579200767921, 5096.898062038757, 5149.3305870237, 5149.40781810091, 5156.123459011977, 4944.381952255968, 5006.148954677696, 5016.774245158958, 5051.797928082872, 5065.721385323805, 5038.269450929613, 5065.772040258197, 5071.873203169914, 5137.948620513785, 5156.74216289184, 4963.255511673242, 5032.270320803463, 5094.668846525001, 5102.36220472441, 5109.0, 5366.91949620756, 5413.593980451482, 5415.404305526389, 5438.374586922515, 5464.153056276284, 5842.152887831283, 5845.269341332333, 5854.297484301911, 5938.7624495020145, 5942.37605051472, 5974.940250597482, 5975.492083172936, 5985.6408615483215, 5996.370381109964, 6002.0, 5432.945670543283, 5482.890342193174, 5516.889662206733, 5542.889142217133, 5645.661260324311, 6109.7861574844665, 6131.417515336036, 6138.263408391022, 6139.10982907476, 6143.815685529441, 5877.177195192677, 5893.174955506232, 5894.528437725057, 5895.263092113486, 5895.29256489224, 5766.94233057664, 5814.186013958049, 5875.236219291465, 5909.6158749681135, 5913.674747888821, 5983.371745966698, 5988.161657367972, 5990.7903223386975, 6012.30858451275, 6014.338422773491, 5944.435278648608, 5993.0710739835395, 5998.730057147439, 6000.969995149996, 6003.399660034049, 4563.954360456353, 4564.543545645409, 4603.378543896598, 4629.86110416688, 4705.294205869079, 4112.527059388149, 4129.566395528426, 4144.668426525871, 4155.958440415558, 4170.687198460128, 5746.109353050284, 5765.682887441147, 5778.537716982715, 5779.450952159538, 5779.826605201766, 5747.5114615257335, 5776.797812076641, 5887.234659494238, 6004.099385092271, 6009.639421634716, 5701.914471282934, 5763.625364351304, 5785.421457854265, 5802.564807639444, 5805.071188609802, 5166.9224961625605, 5168.8966220675375, 5173.689578625294, 5193.974030129901, 5197.428282888879, 6114.023656277781, 6205.255369355616, 6241.344658810759, 6247.937520624736, 6253.468455181361, 5911.113332999912, 5921.319048309328, 5967.224260846062, 5970.940290597212, 6040.728167232397, 6351.110844481684, 6353.7140828661895, 6365.0, 6368.554201205871, 6380.680965951777, 5876.882462350643, 5879.794207202727, 5887.4406931341455, 5896.380880007538, 5951.523878089656, 5808.912866306924, 5868.61853979507, 5870.735816888336, 5915.822525324247, 5969.850753731192, 5808.73860676279, 5858.7070646468355, 5873.060310350324, 5873.618214816023, 5895.970520147372, 5774.133879918046, 5789.9710501447225, 5793.102069179284, 5809.76760929575, 5809.912851307149, 5578.107502799533, 5637.915431268452, 5705.942940570541, 5720.08478643415, 5766.279215098113, 5706.343770466449, 5771.595988280948, 5778.046622307273, 5789.1895134680335, 5799.333076696065, 5386.973065134649, 5442.319710036246, 5444.237806707143, 5447.700376479332, 5454.372747133972], "value": 5496.745654888579, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4599630351167, 599.0235915457805, 602.3915844996552, 607.5291648972043, 616.6269407008759, 34390.48414273788, 35141.82429087854, 36971.260574788554, 37042.62957370425, 37156.628433715654, 36561.63438365616, 47063.29405058927, 47738.52261477384, 47811.28283075748, 51173.0, 8707.695230666912, 8808.64765409383, 8828.955855220747, 8834.072422395653, 8845.159709827556, 8717.694880679177, 8809.295256379506, 8833.20501154896, 8839.646414143459, 8841.867371989425, 8880.689175878846, 8898.510581917992, 8928.508932008737, 8935.508547029911, 8943.284537237005, 8782.38523303369, 8848.734537963806, 8855.158759917798, 8858.689945851864, 8861.0, 8728.127187281221, 8802.823943521094, 8807.031226565072, 8808.955955220246, 8809.779755506099, 44415.0, 44496.3325550117, 44728.3290750639, 44876.10247795058, 44913.101737965386, 3526.876559320437, 3712.3132220539287, 3723.6648701616987, 3850.826712797903, 4036.3138266494766, 32455.83772081148, 32650.673493265, 32767.344653106804, 33338.499922501185, 34931.126721831904, 4387.868363949086, 4457.576530229623, 4474.2841145416905, 4479.664025198123, 4541.795619197144, 341746.0, 343269.0, 344098.0, 345095.0, 345577.2721136403, 38019.0, 39461.210775784326, 59902.70048649729, 60401.39598604046, 60423.697881510314, 41360.1727965439, 41788.791056045135, 41838.0, 41843.372349414785, 41905.580944190166, 15132.924335378473, 15195.620109497351, 15268.618284542976, 15287.388504459697, 15305.08169509833, 12594.685132871567, 12680.746385072247, 12684.175528590613, 12703.745925081632, 12714.237145771283, 9578.281628877861, 9593.376430531993, 9610.567524461416, 9678.854817177747, 9679.128878400978, 3661.5423072115987, 3667.7799332040163, 3722.40441529354, 3738.85044598213, 3757.755745876509, 1021.3514418344256, 1112.410422476089, 1137.7781332640056, 1147.3230793831513, 1149.626371429272, 31297.530537041963, 32442.351152976807, 32888.835555822065, 33509.0, 33933.0, 1128.667043222235, 1138.59579849154, 1175.4769127738246, 1190.2798806721983, 1255.6986323282347, 17465.388711395295, 17828.286868525374, 17889.7316540252, 17907.820921790877, 17920.0, 515413.0, 522854.0, 536529.0, 539139.0, 540441.0, 63764.68117659382, 64178.0, 64528.67735661292, 64609.35390646127, 64646.67676661681, 1179.6755892129734, 1281.6475469245845, 1409.8308203015704, 1436.920969346675, 1458.139697578434, 29897.850510747307, 34248.48627270543, 34778.13054673653, 35044.64955350516, 35135.0, 52974.0, 53452.73273633607, 53551.46448535465, 53574.73212633912, 53724.0, 329845.0, 330658.0, 330901.0, 331178.0, 333369.0, 27031.59452608173, 27985.44029119447, 30556.388872222877, 30651.08046758601, 30684.232894177825, 47932.760336198095, 47972.7601361991, 48932.266016009075, 48948.75525622349, 50277.0, 41257.55598554156, 42799.0, 42971.57028429676, 43010.56989430066, 43420.782896085315, 42172.0, 42648.0, 42653.0, 42837.0, 42948.0, 42645.0, 42716.78641606772, 43307.56692433036, 43451.0, 43468.0, 35256.64743352534, 36960.630393696796, 37346.0, 37702.24595508129, 38102.42846357251, 28457.715422845507, 28851.278718032216, 28969.275768105123, 29157.562636560044, 29268.56097158502], "value": 19258.826329374653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.17769395046207, 402.93955906613996, 405.7768227474892, 407.7614595461655, 424.4482173174874, 14338.713225735504, 18381.632367352646, 19363.806361936375, 20233.494162645922, 20237.392878213657, 15643.608909777233, 17024.574385640364, 18831.340903068394, 19254.90372548139, 19850.503737406536, 5750.252467179272, 5994.580379373446, 6009.1286763419275, 6021.668808215568, 6027.126066720323, 5706.686132262724, 5845.0647896336595, 5876.11858221266, 5945.346011938705, 5948.732307046172, 5883.0881213411985, 5883.264591926009, 5886.676232807194, 5887.205227294303, 5892.322382925954, 5780.104083867007, 5868.677222752747, 5872.677002764846, 5965.791197308116, 6008.459238668541, 5396.082665946798, 5399.082156033483, 5400.594955378323, 5403.945960540423, 5404.810831620914, 23613.881930590407, 23987.640185397235, 24089.63865542018, 24123.155689550782, 24131.879340603362, 2388.80889528839, 2424.842385244971, 2554.246497283287, 2608.074133682553, 2679.236417620988, 10516.894831051668, 10813.62152324665, 14469.565913022627, 15169.165695886722, 15196.240187990667, 1998.1907327532372, 2053.979460205394, 2075.937721868346, 2102.5899949509853, 2131.893405329727, 77161.61419192924, 85492.0, 85521.0, 87167.0, 88266.55866720689, 11689.590864319707, 11704.47329870158, 11856.88143118575, 11941.044716422666, 12366.0, 16454.177291135395, 16462.341506339853, 16480.83519164793, 16495.422660207074, 16496.505104846874, 7575.659095340723, 7931.167227441036, 7948.761537153895, 8096.230858068474, 8397.328213742885, 7926.524408535506, 8025.3980951428875, 8068.314193293519, 8228.25945664893, 8307.6676932922, 4995.975020124876, 4999.550040496373, 5035.093683137071, 5135.281060651511, 5150.587952963829, 1821.7782612995643, 1884.3593178319163, 2103.1377135374423, 2132.7334083239593, 2133.1254185783755, 927.5594092805998, 959.0074273127419, 1027.5324727249083, 1060.226034994443, 1105.3079676771993, 19930.00349982495, 20014.599708005757, 20214.0, 20320.28878989228, 20342.79657203409, 1004.7488127968008, 1014.6144465103214, 1038.7922415516928, 1078.1159449251538, 1081.297156848055, 10467.947660261802, 11337.659870203906, 11524.308541487537, 11548.884511154949, 11605.129615278887, 517151.0, 544105.0, 547719.0, 549080.0, 561184.0, 98277.50861245648, 99291.0, 99317.0, 102440.48779756053, 103224.0, 498.2103366164597, 504.0, 512.6129772022099, 521.5332277611592, 523.455606169587, 11498.367589782642, 11578.42107894585, 11871.881281187078, 12031.4585843639, 12462.813057804322, 40724.389134163604, 41396.586034139276, 41968.274522499676, 42690.57309426866, 42799.7860010698, 58326.0, 58958.41041589529, 59920.70039649774, 60330.0, 60927.0, 9043.819123617359, 9230.261579073524, 9244.0, 9299.581518831805, 9307.301952353466, 10120.291579589653, 13127.868721313047, 13278.800817987545, 13578.38897249646, 14093.788593171315, 11802.822957655813, 11941.044716422839, 11983.460744266704, 12077.818832717341, 12252.448639811408, 11663.0, 11750.823737644114, 11823.645290641294, 12142.817857731965, 12238.75522489563, 11856.051515878882, 12140.33228172459, 12247.142700010914, 12335.198212116542, 12634.368281585701, 9190.31072669539, 9192.58633361487, 9234.815303694022, 9260.861087083564, 9379.74714861817, 10564.524596393027, 11051.557937682403, 12108.939455302667, 12190.085743569445, 12284.754304913673], "value": 9303.476730929076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.4389176004877, 1530.9026633512087, 1689.11321556183, 1761.973570396445, 1794.4796009157337, 8649.697260595873, 9184.265258779298, 9193.494357810318, 9194.908050919481, 9195.172434480895, 7955.641996110175, 8186.836263274746, 8357.91642083579, 8547.401681882271, 8975.730728078168, 2452.7301996780384, 2483.8509689418693, 2488.9377765555914, 2489.4149874779414, 2490.4272017436, 2482.3173627252468, 2563.820532562712, 2564.3204550794053, 2567.0373609896287, 2567.204166708317, 2468.2471846086937, 2473.146764366291, 2485.428351479161, 2485.7389974052735, 2487.9004839806385, 2408.89159987801, 2417.0331867253153, 2418.1053010386095, 2424.3696638873844, 2429.3683642253054, 2366.7278262999803, 2396.1852969990114, 2406.2420337593603, 2415.867127307997, 2417.5890098683267, 8603.5698215089, 8940.32947528938, 9021.503817290046, 9053.50205738684, 9061.365704400694, 5404.51359377654, 5557.833265002057, 5558.166275058733, 5568.749406276727, 5569.693666848321, 3356.9496457553155, 3394.8302584870903, 3484.564429446319, 3532.364174448598, 3547.6984456321243, 1102.922795404322, 1128.9604863829727, 1131.9886801131966, 1167.5073717612872, 1174.3130268792765, 11719.414029298501, 11763.176577639568, 11781.58764443249, 11786.941065294704, 11803.114766392555, 4764.666473346832, 4859.586935110485, 4886.291487734258, 4958.256261560795, 5089.872753181126, 10313.381197128196, 10361.533730982124, 10365.948170259251, 10372.222083343779, 10375.740606484898, 5439.5104440600535, 5463.098588732894, 5471.562275017989, 5477.397486276506, 5479.068558345091, 4311.655067594585, 4357.324614684729, 5028.044671512474, 5072.213806859942, 5158.38099428071, 4176.665866730655, 4230.64039556635, 4277.401163837066, 4334.50153232376, 4340.782960852008, 1345.381124682657, 1365.9112157709717, 1376.3324787478066, 1378.5312993582231, 1379.544750232441, 796.2913007423398, 827.6482494939627, 880.9383343166045, 962.7689354554857, 984.9064338887795, 5879.235699359056, 5976.073708575178, 6015.398460154037, 6076.301225359052, 6100.571337566917, 926.4441335198827, 940.2618944128826, 953.1659797677032, 970.1414248390084, 1002.1431675917132, 3932.3465125194775, 4028.879133625996, 4032.516098068251, 4076.286649836267, 4224.4930608327195, 10815.080718138888, 11065.114790816715, 11113.22207445471, 11123.944380278046, 11173.441327933571, 11091.778164436666, 11120.721981950515, 11130.387828669502, 11133.276337038067, 11151.275167114274, 8124.268815806724, 8430.199131082538, 8596.355273354524, 8603.268722158688, 8606.741797746077, 5632.662040277596, 5681.801136960186, 5877.471027607536, 5932.822015339547, 5954.7915822947725, 9991.950040249752, 10059.547320370455, 10079.34484258521, 10145.797084058426, 10200.591976320864, 10515.053645171665, 10539.367637941748, 10636.042756151983, 10639.574417023232, 10650.041496265374, 7516.661750221362, 7680.231976802275, 7752.0697516298405, 7754.457187996786, 7755.302022817974, 8566.400351975302, 8772.473651580925, 8795.384323097578, 8823.69117080899, 8852.911470885467, 6893.414059804973, 7562.432817538816, 7797.41519386037, 7874.251946065115, 7907.130215676386, 7546.1321947976685, 7665.846683066419, 7717.498362606637, 7802.336801371947, 7880.05439347282, 7130.35826775572, 7164.2119366868565, 7239.746608868664, 7244.565326080452, 7245.311695388929, 5199.194124910645, 5230.398504172069, 5285.68285902847, 5326.25432439451, 5367.785288588413, 5276.551493122974, 5392.218128371443, 5430.076886929152, 5450.8909821802545, 5506.531944784738], "value": 4749.000955874183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.42307231561705, 342.68986567156725, 347.5967877262376, 348.2495222794878, 348.39901170480925, 5345.171498417747, 5365.597580181492, 5380.112281473557, 5402.540784033352, 5411.4295709538, 5004.499550044994, 5143.3570803649545, 5149.253358263049, 5244.68531888087, 5338.332708411449, 4184.811683474236, 4188.806190235783, 4191.308434108369, 4205.074883525627, 4216.47294088239, 4197.866576024471, 4201.936970945439, 4219.282721937263, 4227.682923780713, 4255.936160957588, 3902.3707951604997, 3941.7437866538585, 4147.730397524167, 4163.562825903282, 4180.0, 4135.234981528397, 4147.6267135957605, 4154.91690166198, 4162.562930892258, 4168.583141685837, 3707.4068149096015, 3711.3876210425246, 3714.5542534895717, 3722.3485889969147, 3722.4788529605876, 5005.373253692528, 5151.072806894757, 5160.432352441228, 5199.870003249911, 5232.555232805216, 4767.355262434455, 4767.404074490689, 4770.189067858472, 4779.761011949388, 4783.804048987753, 5497.367802702661, 5517.44825517445, 5518.440605809231, 5525.972370138124, 5534.723263836832, 3921.705872059607, 4075.816588253536, 4081.2857749893947, 4085.59144085592, 4092.3043082676018, 5739.885202295973, 5741.741621626995, 5747.195392645033, 5749.367569567345, 5755.913661295084, 4182.53992060873, 4182.874513764592, 4199.9370009449885, 4200.180964711913, 4225.19721252961, 4000.4999375078114, 4169.749815011109, 4266.360045993126, 4272.743635381825, 4283.850065247701, 4773.928391074137, 4773.928391074137, 4777.593904518086, 4798.640101992364, 4800.7599620019555, 5591.27313449249, 5610.410906854803, 5612.0, 5616.354119276254, 5641.717914104278, 1307.1699470836088, 1378.200643626694, 1401.7897315402772, 1411.865872742088, 1426.4594238222694, 888.644542183119, 923.6720964057797, 952.3666761603595, 960.1550635440767, 964.4213471916794, 5291.137469647179, 5291.735413229323, 5317.0, 5360.60624237701, 5366.443731317874, 5536.923653629889, 5553.527950124285, 5555.416706238702, 5557.276934302163, 5559.666420014732, 5216.38215777102, 5236.162214045735, 5268.394134674561, 5291.841244762663, 5315.415304316522, 2901.8984335548153, 2904.5788360687584, 2905.186547766629, 2912.6504819421807, 2923.517619592786, 5616.5787565932715, 5698.46695049064, 5785.508231800344, 5797.0, 5798.768049278066, 5554.694491802989, 5557.165555766508, 5558.609248358498, 5571.130867603188, 5587.686893580006, 5755.395683453261, 5761.827145185567, 5791.507721843691, 5808.983427900016, 5814.691694368733, 5507.284053073075, 5513.421090785409, 5529.225908372911, 5667.659940403589, 5719.656820590778, 5692.0, 5713.143028545752, 5721.628094173865, 5733.913991290217, 5737.627054241461, 5850.795222167204, 6103.725332359965, 6106.45041946227, 6116.785912493041, 6131.601445906002, 4122.175564886975, 4138.544760076329, 4159.251334759772, 4159.854405095807, 4188.162367526568, 5758.510526605118, 5797.275340582427, 5809.883802323845, 5810.4189581041555, 5827.475527202572, 5503.587230957614, 5665.272092011811, 5693.580228402995, 5706.372299047019, 5712.228849105318, 5597.916031259453, 5617.269754931833, 5621.7189140542, 5653.180288858175, 5672.787612830916, 5343.251944727664, 5499.917501237404, 5535.584831137761, 5578.721063946705, 5609.663420194638, 5516.613837031369, 5632.9436705632415, 5645.209670646195, 5661.867626474804, 5662.7734890603915, 5331.200319951883, 5345.118055520796, 5347.9304139171545, 5351.59863010268, 5362.302900622894], "value": 4252.922723662197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7834649605118, 773.8336257704592, 804.203838200182, 832.0389949608202, 836.5068352989914, 14694.853051469481, 15138.848611513882, 15455.381784728597, 15606.219689015546, 15636.061836289831, 13714.7656710896, 14305.070170438914, 14644.926775366135, 14672.19302938338, 14675.92662036691, 715.4062128433388, 715.6707914359388, 728.5264578024301, 835.6991483066122, 839.7102999465205, 821.0844907927677, 839.0979696825906, 845.0619812008665, 845.5941148248813, 846.6697987784769, 882.0914458108127, 884.1777147253052, 884.6770928611043, 885.2917665867312, 885.8981217160012, 746.9290417410338, 754.3098065270271, 858.0904241504026, 877.350760437275, 881.2025117268882, 647.7538535356581, 651.7849109793804, 652.3704625036862, 652.4258652385918, 652.4356431686557, 14663.853361466356, 14730.263486825615, 14761.114333140045, 14778.334974926154, 14781.704365912728, 13887.652808679763, 14061.78907316391, 14112.294385280695, 14313.499027533986, 14326.57020289393, 12924.0, 12984.28586427746, 12993.825474017809, 13328.0, 13432.126911750705, 3822.6750726188307, 4434.866953991385, 4435.489918659363, 4437.600615944548, 4560.612347950429, 60816.0, 66050.04632083749, 67588.3241167587, 67794.66102669504, 68018.31981680219, 11153.498092585853, 11318.207725459139, 11368.943155284336, 11460.19778615489, 11485.023772979222, 19883.801161988195, 19899.502512437015, 19944.50138746543, 20031.799682003286, 20140.798592014184, 8066.354691624656, 8219.0, 8408.426329295235, 8453.915460845436, 8464.153584641486, 4683.672142949961, 4801.903961920742, 4828.758562071883, 4923.212286034217, 4923.433805112386, 3567.28654269142, 3662.9450558241647, 3665.395209790355, 3672.3940549809518, 3676.246369494301, 597.4443767296369, 603.3303033632665, 608.8873558391712, 609.430182779103, 618.9907151392732, 618.703022549179, 650.3464018661309, 676.47573130824, 697.1668855717369, 713.4684659928387, 9088.909110908939, 9156.313276504288, 9378.90621093794, 9699.224062075016, 9837.606495740234, 653.5359894474976, 664.35225654986, 675.6148995072859, 678.7861823525574, 690.8065741592362, 4600.5629465200755, 4617.307403889444, 4636.907261854744, 4663.626909847204, 4767.809287628525, 92789.53605231931, 93225.0, 94462.0, 94951.0, 97727.51136244416, 81563.59218203872, 83522.58238708768, 84411.0, 84481.0, 86164.0, 76090.0, 76698.99999999888, 77599.0, 77735.61132194303, 79911.60044199742, 9028.864567031369, 9185.127412895765, 9249.630014799333, 9276.953615231881, 9319.813603728024, 50338.74153146054, 50517.49482505275, 51244.231336529236, 52179.47820521746, 52392.0, 71009.64495177491, 72699.0, 72761.0, 73283.0, 75223.62388188024, 10924.890751092706, 11349.943250284026, 11501.934751320907, 11722.531098755955, 12008.099392545419, 12270.693232669255, 12431.875681243433, 13004.349782510648, 13321.733565328444, 13831.0, 10785.784284314113, 11957.820632690342, 12664.556740514037, 12784.232946023269, 13261.403236854172, 12082.637520874388, 12448.875511244772, 12484.93757531243, 12546.372681366078, 12756.362181891054, 13072.934635327143, 13134.737305254033, 13316.067875249028, 13415.798763018367, 13764.793528096887, 10166.542505587415, 10179.440130792878, 10433.107994083652, 10582.312149710244, 10781.299215550964, 9944.850827237742, 10024.789588373047, 10116.848247276444, 10394.16846652251, 11037.83443248368], "value": 7297.387703061929, "unit": "score"}], "name": "dromaeo_css", "value": 7249.587500964128, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 111.0, 113.0, 111.0, 114.0, 112.0, 113.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 117.0, 153.0, 118.0, 118.0, 119.0, 118.0, 152.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 159.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 104.0, 75.0, 77.0, 75.0, 76.0, 104.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 110.0, 81.0, 81.0, 82.0, 96.0, 81.0, 80.0, 116.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.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, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 144.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 49.0, 49.0, 50.0, 50.0, 50.0, 49.0, 50.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 60.0, 59.0, 58.0, 58.0, 58.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 75.0, 74.0, 75.0, 82.0, 74.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 126.0, 120.0, 130.0, 119.0, 129.0, 119.0, 165.0, 121.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 152.0, 156.0, 156.0, 153.0, 152.0, 151.0, 157.0, 156.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1445.0000000000002, "alertThreshold": 2.0}]} 07:50:29 INFO - Return code: 0 07:50:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:29 INFO - # TBPL SUCCESS # 07:50:29 INFO - Running post-action listener: _resource_record_post_action 07:50:29 INFO - [mozharness: 2017-01-13 15:50:29.159168Z] Finished run-tests step (success) 07:50:29 INFO - Running post-run listener: _resource_record_post_run 07:50:29 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2392064; Write bytes: 364208128; Read time: 368; Write time: 227496 07:50:29 INFO - TinderboxPrint: CPU usage
13.0% 07:50:29 INFO - TinderboxPrint: I/O read bytes / time
2,392,064 / 368 07:50:29 INFO - TinderboxPrint: I/O write bytes / time
364,208,128 / 227,496 07:50:29 INFO - TinderboxPrint: CPU idle
8,259.2 (87.0%) 07:50:29 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 07:50:29 INFO - TinderboxPrint: Swap in / out
0 / 0 07:50:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108367872; Read time: 0; Write time: 89328 07:50:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 2392064; Write bytes: 238612480; Read time: 368; Write time: 132288 07:50:29 INFO - Running post-run listener: _upload_blobber_files 07:50:29 INFO - Blob upload gear active. 07:50:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:29 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 07:50:29 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'] 07:50:29 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 07:50:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:50:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:31 INFO - (blobuploader) - INFO - Done attempting. 07:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:34 INFO - (blobuploader) - INFO - Done attempting. 07:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:35 INFO - (blobuploader) - INFO - Done attempting. 07:50:35 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:35 INFO - Return code: 0 07:50:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e29037c0ca3c9a480a73079ea4e039c8713801b7d2edd13647fe85597a0fc0d0acb7d76cf717561c0ff06375e43df2017c65e1e16765f9d3c9b3231b71d5ed53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/229305d58c187fe1b505b5469a0333689993d1a74f7112a9712824552c986306fa6cde9143512daa334fa021c9ff9b67f346a225a0cde049daf9e70c333dc5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/570e69ec6016ccbc51961d1c1dcbb7787c50e2e0a4aa7e655e5ce40fb90626215e6f7e5c9dcc36c461a6b9edb60f502c22c26ad1e742b0325567dc69e4cb5596"} 07:50:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:35 INFO - Contents: 07:50:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e29037c0ca3c9a480a73079ea4e039c8713801b7d2edd13647fe85597a0fc0d0acb7d76cf717561c0ff06375e43df2017c65e1e16765f9d3c9b3231b71d5ed53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/229305d58c187fe1b505b5469a0333689993d1a74f7112a9712824552c986306fa6cde9143512daa334fa021c9ff9b67f346a225a0cde049daf9e70c333dc5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/570e69ec6016ccbc51961d1c1dcbb7787c50e2e0a4aa7e655e5ce40fb90626215e6f7e5c9dcc36c461a6b9edb60f502c22c26ad1e742b0325567dc69e4cb5596"} 07:50:35 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:35 INFO - Copying logs to upload dir... 07:50:35 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.748624 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-13 07:50:34.721479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 07:50:34.724551) ========= 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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 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/e29037c0ca3c9a480a73079ea4e039c8713801b7d2edd13647fe85597a0fc0d0acb7d76cf717561c0ff06375e43df2017c65e1e16765f9d3c9b3231b71d5ed53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/229305d58c187fe1b505b5469a0333689993d1a74f7112a9712824552c986306fa6cde9143512daa334fa021c9ff9b67f346a225a0cde049daf9e70c333dc5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/570e69ec6016ccbc51961d1c1dcbb7787c50e2e0a4aa7e655e5ce40fb90626215e6f7e5c9dcc36c461a6b9edb60f502c22c26ad1e742b0325567dc69e4cb5596"} build_url:https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/ZCdyf-B7SO6tSPR6wf-2ng/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/e29037c0ca3c9a480a73079ea4e039c8713801b7d2edd13647fe85597a0fc0d0acb7d76cf717561c0ff06375e43df2017c65e1e16765f9d3c9b3231b71d5ed53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/229305d58c187fe1b505b5469a0333689993d1a74f7112a9712824552c986306fa6cde9143512daa334fa021c9ff9b67f346a225a0cde049daf9e70c333dc5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/570e69ec6016ccbc51961d1c1dcbb7787c50e2e0a4aa7e655e5ce40fb90626215e6f7e5c9dcc36c461a6b9edb60f502c22c26ad1e742b0325567dc69e4cb5596"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 07:50:34.749687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:50:34.750073) ========= 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=923d835db2ba3686ebe126b700000192-1484306456.417119-1551787173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 07:50:34.832284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 07:50:34.832626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 07:50:34.832958) ========= ========= Total master_lag: 0.16 =========