builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1487870963.14 results: success (0) buildid: 20170223074023 builduid: 741746d4ae8e408ba57bd224145cbab5 revision: 6bff957177d230950b59c95bc8d126809c71ce39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.141612) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.142057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.142406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.166888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.167182) ========= 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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-23 09:29:23-- 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% 228M=0s 2017-02-23 09:29:23 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.323307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.324017) ========= 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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.377871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:23.378648) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6bff957177d230950b59c95bc8d126809c71ce39 --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-beta --rev 6bff957177d230950b59c95bc8d126809c71ce39 --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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-23 09:29:23,490 truncating revision to first 12 chars 2017-02-23 09:29:23,490 Setting DEBUG logging. 2017-02-23 09:29:23,490 attempt 1/10 2017-02-23 09:29:23,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6bff957177d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 09:29:23,788 unpacking tar archive at: mozilla-beta-6bff957177d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:24.009212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:24.012578) ========= script_repo_revision: 6bff957177d230950b59c95bc8d126809c71ce39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:24.012999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:24.013298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 09:29:24.023288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-02-23 09:29:24.023657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:24 INFO - MultiFileLogger online at 20170223 09:29:24 in /builds/slave/test 09:29:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:29:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:24 INFO - {'append_to_log': False, 09:29:24 INFO - 'base_work_dir': '/builds/slave/test', 09:29:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:29:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:24 INFO - 'branch': 'Mozilla-Beta', 09:29:24 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:24 INFO - 'config_files': ('talos/linux_config.py',), 09:29:24 INFO - 'default_actions': ('clobber', 09:29:24 INFO - 'read-buildbot-config', 09:29:24 INFO - 'download-and-extract', 09:29:24 INFO - 'populate-webroot', 09:29:24 INFO - 'create-virtualenv', 09:29:24 INFO - 'install', 09:29:24 INFO - 'run-tests'), 09:29:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:24 INFO - 'download_minidump_stackwalk': True, 09:29:24 INFO - 'download_symbols': 'ondemand', 09:29:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:24 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:24 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:24 INFO - 'installer_path': 'installer.exe', 09:29:24 INFO - 'log_level': 'info', 09:29:24 INFO - 'log_name': 'talos', 09:29:24 INFO - 'log_to_console': True, 09:29:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:24 INFO - 'opt_config_files': (), 09:29:24 INFO - 'pip_index': False, 09:29:24 INFO - 'sps_profile': False, 09:29:24 INFO - 'sps_profile_interval': 0, 09:29:24 INFO - 'suite': 'dromaeojs-e10s', 09:29:24 INFO - 'system_bits': '32', 09:29:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:24 INFO - 'title': 'talos-linux64-ix-058', 09:29:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:24 INFO - 'use_talos_json': True, 09:29:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:24 INFO - 'work_dir': 'build'} 09:29:24 INFO - [mozharness: 2017-02-23 17:29:24.237276Z] Running clobber step. 09:29:24 INFO - Running pre-action listener: _resource_record_pre_action 09:29:24 INFO - Running main action method: clobber 09:29:24 INFO - rmtree: /builds/slave/test/build 09:29:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:24 INFO - Running post-action listener: _resource_record_post_action 09:29:24 INFO - [mozharness: 2017-02-23 17:29:24.694806Z] Finished clobber step (success) 09:29:24 INFO - [mozharness: 2017-02-23 17:29:24.694904Z] Running read-buildbot-config step. 09:29:24 INFO - Running pre-action listener: _resource_record_pre_action 09:29:24 INFO - Running main action method: read_buildbot_config 09:29:24 INFO - Using buildbot properties: 09:29:24 INFO - { 09:29:24 INFO - "project": "", 09:29:24 INFO - "product": "firefox", 09:29:24 INFO - "script_repo_revision": "production", 09:29:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:29:24 INFO - "repository": "", 09:29:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:29:24 INFO - "buildid": "20170223074023", 09:29:24 INFO - "pgo_build": "True", 09:29:24 INFO - "basedir": "/builds/slave/test", 09:29:24 INFO - "buildnumber": 81, 09:29:24 INFO - "slavename": "talos-linux64-ix-058", 09:29:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:29:24 INFO - "platform": "ubuntu64_hw", 09:29:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:29:24 INFO - "branch": "mozilla-beta", 09:29:24 INFO - "repo_path": "releases/mozilla-beta", 09:29:24 INFO - "revision": "6bff957177d230950b59c95bc8d126809c71ce39", 09:29:24 INFO - "stage_platform": "linux64-pgo", 09:29:24 INFO - "builduid": "741746d4ae8e408ba57bd224145cbab5", 09:29:24 INFO - "slavebuilddir": "test" 09:29:24 INFO - } 09:29:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:29:24 INFO - Running post-action listener: _resource_record_post_action 09:29:24 INFO - [mozharness: 2017-02-23 17:29:24.697318Z] Finished read-buildbot-config step (success) 09:29:24 INFO - [mozharness: 2017-02-23 17:29:24.697405Z] Running download-and-extract step. 09:29:24 INFO - Running pre-action listener: _resource_record_pre_action 09:29:24 INFO - Running main action method: download_and_extract 09:29:24 INFO - mkdir: /builds/slave/test/build/tests 09:29: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')]} 09:29:24 INFO - trying https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:29:25 INFO - Downloaded 1327 bytes. 09:29:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:29:25 INFO - Using the following test package requirements: 09:29:25 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:29:25 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:29:25 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:29:25 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'jsshell-linux-x86_64.zip'], 09:29:25 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:29:25 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:29:25 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:29:25 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:29:25 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:29:25 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:29:25 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:29:25 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:29:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:29:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:29:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:29:26 INFO - Http code: 200 09:29:26 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 09:29:26 INFO - x-amz-cf-id: eWxs8bYrZ2tWMyX9Be38Ot_ryVX7uH-z1__O4PzoNcSwErjzxEJjHQ== 09:29:26 INFO - x-amz-version-id: Qfgu6kFA6CYjHjFuqabWQjmi_it2V3Fc 09:29:27 INFO - Expected file size: 21964272 09:29:27 INFO - Obtained file size: 21964272 09:29:31 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:29:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:29:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:29:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:29:31 INFO - Http code: 200 09:29:31 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:29:31 INFO - x-amz-cf-id: 3Q0AAgL-S7UG_4iYBLtYS4mfqkj1reLMf4l3bnu2RC-4n8JT6l1OOg== 09:29:31 INFO - x-amz-version-id: Qfgu6kFA6CYjHjFuqabWQjmi_it2V3Fc 09:29:31 INFO - Expected file size: 21964272 09:29:31 INFO - Obtained file size: 21964272 09:29:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:29:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:29:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:29:37 INFO - Http code: 200 09:29:37 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:29:37 INFO - x-amz-cf-id: -6IFBQ09mpIksDUhW_VAfqOp2djseALLBrJN7dbw_OWJ7bVBaEpnbw== 09:29:37 INFO - x-amz-version-id: KdQlqLvlZDnqot3VCPxWompWnb6akkr9 09:29:37 INFO - Expected file size: 14403005 09:29:37 INFO - Obtained file size: 14403005 09:29: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')]} 09:29:38 INFO - trying https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:29:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:29:40 INFO - Downloaded 57748888 bytes. 09:29:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:29:40 INFO - mkdir: /builds/slave/test/properties 09:29:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:40 INFO - Contents: 09:29:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:29:41 INFO - Running post-action listener: _resource_record_post_action 09:29:41 INFO - Running post-action listener: set_extra_try_arguments 09:29:41 INFO - [mozharness: 2017-02-23 17:29:41.543965Z] Finished download-and-extract step (success) 09:29:41 INFO - [mozharness: 2017-02-23 17:29:41.544191Z] Running populate-webroot step. 09:29:41 INFO - Running pre-action listener: _resource_record_pre_action 09:29:41 INFO - Running main action method: populate_webroot 09:29:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:41 INFO - '--tppagecycles', 09:29:41 INFO - '7'], 09:29:41 INFO - 'tests': ['tsvgm']}}, 09:29:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['damp', 'tps']}, 09:29:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'tests': ['damp', 'tps']}, 09:29:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['dromaeo_dom']}, 09:29:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['basic_compositor_video']}, 09:29:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['a11yr', 09:29:41 INFO - 'ts_paint', 09:29:41 INFO - 'tpaint', 09:29:41 INFO - 'sessionrestore', 09:29:41 INFO - 'sessionrestore_no_auto_restore', 09:29:41 INFO - 'tabpaint']}, 09:29:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['tsvgx', 09:29:41 INFO - 'tsvgr_opacity', 09:29:41 INFO - 'tart', 09:29:41 INFO - 'tscrollx', 09:29:41 INFO - 'cart']}, 09:29:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:41 INFO - 'tsvgr_opacity', 09:29:41 INFO - 'tart', 09:29:41 INFO - 'tscrollx', 09:29:41 INFO - 'cart']}, 09:29:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'talos_options': ['--disable-e10s'], 09:29:41 INFO - 'tests': ['tp5o']}, 09:29:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'tests': ['tp5o']}, 09:29:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'talos_options': ['--disable-e10s', 09:29:41 INFO - '--xperf_path', 09:29:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:41 INFO - 'tests': ['tp5n']}, 09:29:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:41 INFO - 'talos_options': ['--xperf_path', 09:29:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:41 INFO - 'tests': ['tp5n']}}, 09:29:41 INFO - 'talos.zip': {'path': '', 09:29:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:41 INFO - Running post-action listener: _resource_record_post_action 09:29:41 INFO - [mozharness: 2017-02-23 17:29:41.560546Z] Finished populate-webroot step (success) 09:29:41 INFO - [mozharness: 2017-02-23 17:29:41.560633Z] Running create-virtualenv step. 09:29:41 INFO - Running pre-action listener: _resource_record_pre_action 09:29:41 INFO - Running main action method: create_virtualenv 09:29:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:29:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:41 INFO - Using real prefix '/usr' 09:29:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:44 INFO - Installing pip.................done. 09:29:44 INFO - Return code: 0 09:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:29:44 INFO - Reading from file tmpfile_stdout 09:29:44 INFO - Output received: 09:29:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:29:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:44 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:44 INFO - Using env: {'DISPLAY': ':0', 09:29:44 INFO - 'HOME': '/home/cltbld', 09:29:44 INFO - 'LANG': 'en_US.UTF-8', 09:29:44 INFO - 'LANGUAGE': 'en_US:en', 09:29:44 INFO - 'LOGNAME': 'cltbld', 09:29:44 INFO - 'MAIL': '/var/mail/cltbld', 09:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:44 INFO - 'MOZ_NO_REMOTE': '1', 09:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:44 INFO - 'NO_EM_RESTART': '1', 09:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:44 INFO - 'PWD': '/builds/slave/test', 09:29:44 INFO - 'SHELL': '/bin/bash', 09:29:44 INFO - 'SHLVL': '1', 09:29:44 INFO - 'TERM': 'linux', 09:29:44 INFO - 'TMOUT': '86400', 09:29:44 INFO - 'USER': 'cltbld', 09:29:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:44 INFO - '_': '/tools/buildbot/bin/python'} 09:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:29:44 INFO - Cleaning up... 09:29:44 INFO - Return code: 0 09:29:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:44 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:29:44 INFO - Using env: {'DISPLAY': ':0', 09:29:44 INFO - 'HOME': '/home/cltbld', 09:29:44 INFO - 'LANG': 'en_US.UTF-8', 09:29:44 INFO - 'LANGUAGE': 'en_US:en', 09:29:44 INFO - 'LOGNAME': 'cltbld', 09:29:44 INFO - 'MAIL': '/var/mail/cltbld', 09:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:44 INFO - 'MOZ_NO_REMOTE': '1', 09:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:44 INFO - 'NO_EM_RESTART': '1', 09:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:44 INFO - 'PWD': '/builds/slave/test', 09:29:44 INFO - 'SHELL': '/bin/bash', 09:29:44 INFO - 'SHLVL': '1', 09:29:44 INFO - 'TERM': 'linux', 09:29:44 INFO - 'TMOUT': '86400', 09:29:44 INFO - 'USER': 'cltbld', 09:29:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:44 INFO - '_': '/tools/buildbot/bin/python'} 09:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:44 INFO - Downloading/unpacking psutil>=3.1.1 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:46 INFO - Installing collected packages: psutil 09:29:46 INFO - Running setup.py install for psutil 09:29:47 INFO - building 'psutil._psutil_linux' extension 09:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:29:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:29:47 INFO - building 'psutil._psutil_posix' extension 09:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:29:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:47 INFO - Successfully installed psutil 09:29:47 INFO - Cleaning up... 09:29:47 INFO - Return code: 0 09:29:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:47 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:29:47 INFO - Using env: {'DISPLAY': ':0', 09:29:47 INFO - 'HOME': '/home/cltbld', 09:29:47 INFO - 'LANG': 'en_US.UTF-8', 09:29:47 INFO - 'LANGUAGE': 'en_US:en', 09:29:47 INFO - 'LOGNAME': 'cltbld', 09:29:47 INFO - 'MAIL': '/var/mail/cltbld', 09:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:47 INFO - 'MOZ_NO_REMOTE': '1', 09:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:47 INFO - 'NO_EM_RESTART': '1', 09:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:47 INFO - 'PWD': '/builds/slave/test', 09:29:47 INFO - 'SHELL': '/bin/bash', 09:29:47 INFO - 'SHLVL': '1', 09:29:47 INFO - 'TERM': 'linux', 09:29:47 INFO - 'TMOUT': '86400', 09:29:47 INFO - 'USER': 'cltbld', 09:29:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:47 INFO - '_': '/tools/buildbot/bin/python'} 09:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:29:50 INFO - Installing collected packages: mozsystemmonitor 09:29:50 INFO - Running setup.py install for mozsystemmonitor 09:29:50 INFO - Successfully installed mozsystemmonitor 09:29:50 INFO - Cleaning up... 09:29:50 INFO - Return code: 0 09:29:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:51 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:29:51 INFO - Using env: {'DISPLAY': ':0', 09:29:51 INFO - 'HOME': '/home/cltbld', 09:29:51 INFO - 'LANG': 'en_US.UTF-8', 09:29:51 INFO - 'LANGUAGE': 'en_US:en', 09:29:51 INFO - 'LOGNAME': 'cltbld', 09:29:51 INFO - 'MAIL': '/var/mail/cltbld', 09:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:51 INFO - 'MOZ_NO_REMOTE': '1', 09:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:51 INFO - 'NO_EM_RESTART': '1', 09:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:51 INFO - 'PWD': '/builds/slave/test', 09:29:51 INFO - 'SHELL': '/bin/bash', 09:29:51 INFO - 'SHLVL': '1', 09:29:51 INFO - 'TERM': 'linux', 09:29:51 INFO - 'TMOUT': '86400', 09:29:51 INFO - 'USER': 'cltbld', 09:29:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:51 INFO - '_': '/tools/buildbot/bin/python'} 09:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:55 INFO - warning: no files found matching '*.txt' 09:29:55 INFO - no previously-included directories found matching 'build' 09:29:55 INFO - no previously-included directories found matching 'dist' 09:29:55 INFO - no previously-included directories found matching '.git*' 09:29:55 INFO - Installing collected packages: jsonschema, functools32 09:29:55 INFO - Running setup.py install for functools32 09:29:55 INFO - warning: no files found matching '*.txt' 09:29:55 INFO - no previously-included directories found matching 'build' 09:29:55 INFO - no previously-included directories found matching 'dist' 09:29:55 INFO - no previously-included directories found matching '.git*' 09:29:55 INFO - Successfully installed jsonschema functools32 09:29:55 INFO - Cleaning up... 09:29:55 INFO - Return code: 0 09:29:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:55 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:29:55 INFO - Using env: {'DISPLAY': ':0', 09:29:55 INFO - 'HOME': '/home/cltbld', 09:29:55 INFO - 'LANG': 'en_US.UTF-8', 09:29:55 INFO - 'LANGUAGE': 'en_US:en', 09:29:55 INFO - 'LOGNAME': 'cltbld', 09:29:55 INFO - 'MAIL': '/var/mail/cltbld', 09:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:55 INFO - 'MOZ_NO_REMOTE': '1', 09:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:55 INFO - 'NO_EM_RESTART': '1', 09:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:55 INFO - 'PWD': '/builds/slave/test', 09:29:55 INFO - 'SHELL': '/bin/bash', 09:29:55 INFO - 'SHLVL': '1', 09:29:55 INFO - 'TERM': 'linux', 09:29:55 INFO - 'TMOUT': '86400', 09:29:55 INFO - 'USER': 'cltbld', 09:29:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:55 INFO - '_': '/tools/buildbot/bin/python'} 09:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:29:56 INFO - Cleaning up... 09:29:56 INFO - Return code: 0 09:29:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:56 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:29:56 INFO - Using env: {'DISPLAY': ':0', 09:29:56 INFO - 'HOME': '/home/cltbld', 09:29:56 INFO - 'LANG': 'en_US.UTF-8', 09:29:56 INFO - 'LANGUAGE': 'en_US:en', 09:29:56 INFO - 'LOGNAME': 'cltbld', 09:29:56 INFO - 'MAIL': '/var/mail/cltbld', 09:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:56 INFO - 'MOZ_NO_REMOTE': '1', 09:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:56 INFO - 'NO_EM_RESTART': '1', 09:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:56 INFO - 'PWD': '/builds/slave/test', 09:29:56 INFO - 'SHELL': '/bin/bash', 09:29:56 INFO - 'SHLVL': '1', 09:29:56 INFO - 'TERM': 'linux', 09:29:56 INFO - 'TMOUT': '86400', 09:29:56 INFO - 'USER': 'cltbld', 09:29:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:56 INFO - '_': '/tools/buildbot/bin/python'} 09:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:00 INFO - Downloading docopt-0.6.1.tar.gz 09:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:00 INFO - Running setup.py install for blobuploader 09:30:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:00 INFO - Running setup.py install for requests 09:30:00 INFO - Running setup.py install for docopt 09:30:00 INFO - Successfully installed blobuploader requests docopt 09:30:00 INFO - Cleaning up... 09:30:00 INFO - Return code: 0 09:30:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:00 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:00 INFO - Using env: {'DISPLAY': ':0', 09:30:00 INFO - 'HOME': '/home/cltbld', 09:30:00 INFO - 'LANG': 'en_US.UTF-8', 09:30:00 INFO - 'LANGUAGE': 'en_US:en', 09:30:00 INFO - 'LOGNAME': 'cltbld', 09:30:00 INFO - 'MAIL': '/var/mail/cltbld', 09:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:00 INFO - 'MOZ_NO_REMOTE': '1', 09:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:00 INFO - 'NO_EM_RESTART': '1', 09:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:00 INFO - 'PWD': '/builds/slave/test', 09:30:00 INFO - 'SHELL': '/bin/bash', 09:30:00 INFO - 'SHLVL': '1', 09:30:00 INFO - 'TERM': 'linux', 09:30:00 INFO - 'TMOUT': '86400', 09:30:00 INFO - 'USER': 'cltbld', 09:30:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:00 INFO - '_': '/tools/buildbot/bin/python'} 09:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:01 INFO - Running setup.py (path:/tmp/pip-afwoae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:01 INFO - Running setup.py (path:/tmp/pip-Z9a9dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:01 INFO - Running setup.py (path:/tmp/pip-vKAOgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:01 INFO - Running setup.py (path:/tmp/pip-EYk4ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:01 INFO - Running setup.py (path:/tmp/pip-UXMPoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:01 INFO - Running setup.py (path:/tmp/pip-_fIxSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:01 INFO - Running setup.py (path:/tmp/pip-FbVq0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:01 INFO - Running setup.py (path:/tmp/pip-V680zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:01 INFO - Running setup.py (path:/tmp/pip-usXWWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:01 INFO - Running setup.py (path:/tmp/pip-h51Jq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:01 INFO - Running setup.py (path:/tmp/pip-8DBrEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:01 INFO - Running setup.py (path:/tmp/pip-7rB5gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:01 INFO - Running setup.py (path:/tmp/pip-_jpH5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:02 INFO - Running setup.py (path:/tmp/pip-vMVzbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:02 INFO - Running setup.py (path:/tmp/pip-Y3FtJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:02 INFO - Running setup.py (path:/tmp/pip-3gCpst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:02 INFO - Running setup.py (path:/tmp/pip-jpzAiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:02 INFO - Running setup.py install for manifestparser 09:30:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:02 INFO - Running setup.py install for mozcrash 09:30:02 INFO - Running setup.py install for mozdebug 09:30:02 INFO - Running setup.py install for mozdevice 09:30:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:02 INFO - Running setup.py install for mozfile 09:30:02 INFO - Running setup.py install for mozhttpd 09:30:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:02 INFO - Running setup.py install for mozinfo 09:30:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for mozInstall 09:30:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for mozleak 09:30:03 INFO - Running setup.py install for mozlog 09:30:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for moznetwork 09:30:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for mozprocess 09:30:03 INFO - Running setup.py install for mozprofile 09:30:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for mozrunner 09:30:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:03 INFO - Running setup.py install for mozscreenshot 09:30:03 INFO - Running setup.py install for moztest 09:30:04 INFO - Running setup.py install for mozversion 09:30:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:04 INFO - Cleaning up... 09:30:04 INFO - Return code: 0 09:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:04 INFO - Using env: {'DISPLAY': ':0', 09:30:04 INFO - 'HOME': '/home/cltbld', 09:30:04 INFO - 'LANG': 'en_US.UTF-8', 09:30:04 INFO - 'LANGUAGE': 'en_US:en', 09:30:04 INFO - 'LOGNAME': 'cltbld', 09:30:04 INFO - 'MAIL': '/var/mail/cltbld', 09:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:04 INFO - 'MOZ_NO_REMOTE': '1', 09:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:04 INFO - 'NO_EM_RESTART': '1', 09:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:04 INFO - 'PWD': '/builds/slave/test', 09:30:04 INFO - 'SHELL': '/bin/bash', 09:30:04 INFO - 'SHLVL': '1', 09:30:04 INFO - 'TERM': 'linux', 09:30:04 INFO - 'TMOUT': '86400', 09:30:04 INFO - 'USER': 'cltbld', 09:30:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:04 INFO - '_': '/tools/buildbot/bin/python'} 09:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:04 INFO - Running setup.py (path:/tmp/pip-_NLyAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:04 INFO - Running setup.py (path:/tmp/pip-aY5wp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:04 INFO - Running setup.py (path:/tmp/pip-TyFLxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:04 INFO - Running setup.py (path:/tmp/pip-iBMGKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:04 INFO - Running setup.py (path:/tmp/pip-D6iSxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:04 INFO - Running setup.py (path:/tmp/pip-BVE1tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:04 INFO - Running setup.py (path:/tmp/pip-kSRfzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:04 INFO - Running setup.py (path:/tmp/pip-mDk63s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:05 INFO - Running setup.py (path:/tmp/pip-mBFbts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:05 INFO - Running setup.py (path:/tmp/pip-wpm2y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:05 INFO - Running setup.py (path:/tmp/pip-l6U8Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:05 INFO - Running setup.py (path:/tmp/pip-LvfJyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:05 INFO - Running setup.py (path:/tmp/pip-1hPuGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:05 INFO - Running setup.py (path:/tmp/pip-l276Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:05 INFO - Running setup.py (path:/tmp/pip-OweYFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:05 INFO - Running setup.py (path:/tmp/pip-3WPOz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:05 INFO - Running setup.py (path:/tmp/pip-hjKio_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:07 INFO - Downloading blessings-1.6.tar.gz 09:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:07 INFO - Installing collected packages: blessings 09:30:07 INFO - Running setup.py install for blessings 09:30:07 INFO - Successfully installed blessings 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:08 INFO - Reading from file tmpfile_stdout 09:30:08 INFO - Current package versions: 09:30:08 INFO - argparse == 1.2.1 09:30:08 INFO - blessings == 1.6 09:30:08 INFO - blobuploader == 1.2.4 09:30:08 INFO - docopt == 0.6.1 09:30:08 INFO - functools32 == 3.2.3-2 09:30:08 INFO - jsonschema == 2.5.1 09:30:08 INFO - manifestparser == 1.1 09:30:08 INFO - mozInstall == 1.12 09:30:08 INFO - mozcrash == 1.0 09:30:08 INFO - mozdebug == 0.1 09:30:08 INFO - mozdevice == 0.48 09:30:08 INFO - mozfile == 1.2 09:30:08 INFO - mozhttpd == 0.7 09:30:08 INFO - mozinfo == 0.9 09:30:08 INFO - mozleak == 0.1 09:30:08 INFO - mozlog == 3.4 09:30:08 INFO - moznetwork == 0.27 09:30:08 INFO - mozprocess == 0.23 09:30:08 INFO - mozprofile == 0.28 09:30:08 INFO - mozrunner == 6.13 09:30:08 INFO - mozscreenshot == 0.1 09:30:08 INFO - mozsystemmonitor == 0.3 09:30:08 INFO - moztest == 0.8 09:30:08 INFO - mozversion == 1.4 09:30:08 INFO - psutil == 3.1.1 09:30:08 INFO - requests == 1.2.3 09:30:08 INFO - wsgiref == 0.1.2 09:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:08 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:08 INFO - Using env: {'DISPLAY': ':0', 09:30:08 INFO - 'HOME': '/home/cltbld', 09:30:08 INFO - 'LANG': 'en_US.UTF-8', 09:30:08 INFO - 'LANGUAGE': 'en_US:en', 09:30:08 INFO - 'LOGNAME': 'cltbld', 09:30:08 INFO - 'MAIL': '/var/mail/cltbld', 09:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:08 INFO - 'MOZ_NO_REMOTE': '1', 09:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:08 INFO - 'NO_EM_RESTART': '1', 09:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:08 INFO - 'PWD': '/builds/slave/test', 09:30:08 INFO - 'SHELL': '/bin/bash', 09:30:08 INFO - 'SHLVL': '1', 09:30:08 INFO - 'TERM': 'linux', 09:30:08 INFO - 'TMOUT': '86400', 09:30:08 INFO - 'USER': 'cltbld', 09:30:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:08 INFO - '_': '/tools/buildbot/bin/python'} 09:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:30:08 INFO - Cleaning up... 09:30:08 INFO - Return code: 0 09:30:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:08 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 0x7fdd5a07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:30:08 INFO - Using env: {'DISPLAY': ':0', 09:30:08 INFO - 'HOME': '/home/cltbld', 09:30:08 INFO - 'LANG': 'en_US.UTF-8', 09:30:08 INFO - 'LANGUAGE': 'en_US:en', 09:30:08 INFO - 'LOGNAME': 'cltbld', 09:30:08 INFO - 'MAIL': '/var/mail/cltbld', 09:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:08 INFO - 'MOZ_NO_REMOTE': '1', 09:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:08 INFO - 'NO_EM_RESTART': '1', 09:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:08 INFO - 'PWD': '/builds/slave/test', 09:30:08 INFO - 'SHELL': '/bin/bash', 09:30:08 INFO - 'SHLVL': '1', 09:30:08 INFO - 'TERM': 'linux', 09:30:08 INFO - 'TMOUT': '86400', 09:30:08 INFO - 'USER': 'cltbld', 09:30:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:08 INFO - '_': '/tools/buildbot/bin/python'} 09:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:08 INFO - Cleaning up... 09:30:08 INFO - Return code: 0 09:30:08 INFO - Running post-action listener: _resource_record_post_action 09:30:08 INFO - Running post-action listener: _start_resource_monitoring 09:30:08 INFO - Starting resource monitoring. 09:30:08 INFO - [mozharness: 2017-02-23 17:30:08.671109Z] Finished create-virtualenv step (success) 09:30:08 INFO - [mozharness: 2017-02-23 17:30:08.671683Z] Running install step. 09:30:08 INFO - Running pre-action listener: _resource_record_pre_action 09:30:08 INFO - Running main action method: install 09:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:08 INFO - Reading from file tmpfile_stdout 09:30:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:08 INFO - Reading from file tmpfile_stdout 09:30:08 INFO - Output received: 09:30:08 INFO - Usage: mozinstall [options] installer 09:30:08 INFO - Options: 09:30:08 INFO - -h, --help show this help message and exit 09:30:08 INFO - -d DEST, --destination=DEST 09:30:08 INFO - Directory to install application into. [default: 09:30:08 INFO - "/builds/slave/test"] 09:30:08 INFO - --app=APP Application being installed. [default: firefox] 09:30:08 INFO - mkdir: /builds/slave/test/build/application 09:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:30:22 INFO - Reading from file tmpfile_stdout 09:30:22 INFO - Output received: 09:30:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:22 INFO - Running post-action listener: _resource_record_post_action 09:30:22 INFO - [mozharness: 2017-02-23 17:30:22.607117Z] Finished install step (success) 09:30:22 INFO - [mozharness: 2017-02-23 17:30:22.607358Z] Running run-tests step. 09:30:22 INFO - Running pre-action listener: _resource_record_pre_action 09:30:22 INFO - Running main action method: run_tests 09:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:22 INFO - Python 2.7.3 09:30:22 INFO - Return code: 0 09:30:22 INFO - grabbing minidump binary from tooltool 09: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')]} 09:30:22 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 0x11e8f60>, '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 0x11e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ea1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:30:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:30:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:30:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:22 INFO - Return code: 0 09:30:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:30:22 INFO - Using env: {'DISPLAY': ':0', 09:30:22 INFO - 'HOME': '/home/cltbld', 09:30:22 INFO - 'LANG': 'en_US.UTF-8', 09:30:22 INFO - 'LANGUAGE': 'en_US:en', 09:30:22 INFO - 'LOGNAME': 'cltbld', 09:30:22 INFO - 'MAIL': '/var/mail/cltbld', 09:30:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:22 INFO - 'MOZ_NO_REMOTE': '1', 09:30:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:22 INFO - 'NO_EM_RESTART': '1', 09:30:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:22 INFO - 'PWD': '/builds/slave/test', 09:30:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:22 INFO - 'SHELL': '/bin/bash', 09:30:22 INFO - 'SHLVL': '1', 09:30:22 INFO - 'TERM': 'linux', 09:30:22 INFO - 'TMOUT': '86400', 09:30:22 INFO - 'USER': 'cltbld', 09:30:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671', 09:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:22 INFO - '_': '/tools/buildbot/bin/python'} 09:30:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:30:22 INFO - mozversion application_buildid: 20170223074023 09:30:22 INFO - mozversion application_changeset: 6bff957177d230950b59c95bc8d126809c71ce39 09:30:22 INFO - mozversion application_display_name: Firefox 09:30:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:22 INFO - mozversion application_name: Firefox 09:30:22 INFO - mozversion application_remotingname: firefox 09:30:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:30:22 INFO - mozversion application_vendor: Mozilla 09:30:22 INFO - mozversion application_version: 52.0 09:30:22 INFO - mozversion platform_buildid: 20170223074023 09:30:22 INFO - mozversion platform_changeset: 6bff957177d230950b59c95bc8d126809c71ce39 09:30:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:30:22 INFO - mozversion platform_version: 52.0 09:30:22 INFO - using testdate: 1487871022 09:30:22 INFO - actual date: 1487871022 09:30:22 INFO - starting webserver on 'localhost:54835' 09:30:22 INFO - SUITE-START | Running 2 tests 09:30:22 INFO - TEST-START | dromaeo_css 09:30:22 INFO - operating with platform_type : linux_ 09:30:22 INFO - Initialising browser for dromaeo_css test... 09:30:22 INFO - TEST-INFO | started process 25593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDb35IG/profile http://localhost:54835/getInfo.html) 09:30:27 INFO - PROCESS | 25593 | __metrics Screen width/height:1600/1200 09:30:27 INFO - PROCESS | 25593 | colorDepth:24 09:30:27 INFO - PROCESS | 25593 | Browser inner width/height: 1024/697 09:30:27 INFO - PROCESS | 25593 | __metrics 09:30:27 ERROR - PROCESS | 25593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:30:28 INFO - TEST-INFO | 25593: exit 0 09:30:28 INFO - Browser initialized. 09:30:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:28 INFO - TEST-INFO | started process 25724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDb35IG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:40 INFO - PROCESS | 25724 | RSS: Main: 146808832 09:30:40 INFO - PROCESS | 25724 | 09:33:40 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54835/tests/dromaeo/cssquery-ext.html) 09:33:41 INFO - PROCESS | 25724 | RSS: Main: 153432064 09:33:41 INFO - PROCESS | 25724 | 09:36:43 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-ext.html (next: http://localhost:54835/tests/dromaeo/cssquery-jquery.html) 09:36:44 INFO - PROCESS | 25724 | RSS: Main: 152342528 09:36:44 INFO - PROCESS | 25724 | 09:39:45 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54835/tests/dromaeo/cssquery-mootools.html) 09:39:46 INFO - PROCESS | 25724 | RSS: Main: 152035328 09:39:46 INFO - PROCESS | 25724 | 09:42:48 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54835/tests/dromaeo/cssquery-prototype.html) 09:42:48 INFO - PROCESS | 25724 | RSS: Main: 153366528 09:42:48 INFO - PROCESS | 25724 | 09:45:51 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54835/tests/dromaeo/cssquery-yui.html) 09:45:51 INFO - PROCESS | 25724 | RSS: Main: 154812416 09:45:51 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | Cycle 1(1): loaded http://localhost:54835/tests/dromaeo/cssquery-yui.html (next: http://localhost:54835/tests/dromaeo/cssquery-dojo.html) 09:48:54 INFO - PROCESS | 25724 | RSS: Main: 155426816 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | __start_tp_report 09:48:54 INFO - PROCESS | 25724 | _x_x_mozilla_page_load 09:48:54 INFO - PROCESS | 25724 | _x_x_mozilla_page_load_details 09:48:54 INFO - PROCESS | 25724 | |i|pagename|runs| 09:48:54 INFO - PROCESS | 25724 | |0;dojo.html;3224.016674914151;3258.7555933305007;3272.8690852365908;3280.311134661721;3284.8850290239816;5669.1212862006405;5718.885622287552;5741.827745167647;5752.568557358204;5766.481016708501;5700.230468886699;5743.827685169441;5763.567732420075;5789.160571717099;5809.564282678795;5164.122099243128;5207.6875387476875;5226.42509323976;5250.816221432251;5267.130923397634;5277.683338999653;5278.181881808307;5286.392064912546;5287.444818294081;5309.787608495655;5127.7948882044675;5137.049645815536;5252.947470525303;5256.474352564732;5259.579233661298;5214.661047031931;5253.684778913258;5278.947210527884;5310.389305229909;5329.760160792774;5135.229715542699;5215.139501982168;5222.112240919053;5224.242484839715;5257.7108259045735;5547.417521160261;5693.971530142364;5714.485696287354;5792.102224155263;5797.594168408213;5975.940240597582;6017.789377371771;6021.548383871183;6084.209052823149;6126.7549298028025;6048;6140.539459540552;6143.539234557381;6147.538934579924;6187.102870083812;5741.253637027202;5741.425857414267;5750.0512415450985;5755.769769209227;5758.337791153987;6108.175396321529;6112.449879510866;6126.609281623701;6224.564280500412;6224.968875155686;5973.104034394875;5994.100884867217;5994.430529099728;6002;6011.909821352683;5989.610675306091;6028.608140470856;6033.245844269466;6063.54523410746;6082.60463069899;6015.097735339734;6123.465646421213;6126.639818174547;6128.387161283836;6135.538906164978;6116.541259405562;6128.417800308964;6128.908066379008;6129.725578588854;6134.04922237054;4601.102784956901;4627.814887404534;4740.19416699155;4741.431028276629;4743.169945259566;4124.9587504125175;4134.235166494208;4164.250434921743;4188.685848561309;4224.78876056196;5894.67579283135;5904.616199947076;5912.260967379078;5918.556108291896;5933.199018132583;6020.969895150583;6139.600925939889;6199.721012554446;6201.255849298113;6212.534059945522;5782.858737578628;5796.275465566804;5806.419358064244;5878.353381128072;5913.852153696192;5235.607329450307;5238.030964271622;5250.921236181461;5307.752678120639;5315.920261196085;6136.274005701014;6274.905876411857;6276.184096067482;6279.058141278753;6295.622262664255;5991.281046274475;6025.758969641165;6030.4572588467245;6034.577579569388;6116.969415152896;6239.563230573816;6345.619262844244;6346.90479642815;6361.332060133619;6382.393672601095;5957.76168953237;6004.669743164168;6032.75868965254;6037;6048.97167481538;5979.970100149471;5980.970095149671;5982.162497250301;5997.310309314485;6027.156198132353;5962.314333851663;5970.611910225822;5971.492423143907;5976.850578735566;6000.729967151401;5904.852378690567;5922.7927022554;5935.080062590306;5937.5249980000635;5950.31571369298;5707.343655479673;5800;5804.796832110856;5821.126830975388;5897.174395584708;6009.87980240384;6010.368911264254;6023.337432882292;6031.7587296507645;6039.577229594062;5866.735996880066;5877.970610146922;5885.47030767233;5890.087036509348;5898.764049437975 09:48:54 INFO - PROCESS | 25724 | |1;ext.html;583.635227982511;604.9455549000589;617.336363409335;629.5781826176461;665.5906617430281;43440.56559434405;44420.55579444204;44434.111317773626;47262.29106563405;47353.763231183795;44302.11395772082;44790.55209447905;44816.3277550837;44820.3276950846;44867.55132448675;8975.596098175598;9061.13919177677;9103.863442048374;9126.543672816333;9142.268618510536;8983.416077954944;9038.728838134833;9049.95475022624;9072.31957603179;9072.8639070414;9034.68378606749;9081.95459022704;9102.590383432762;9105.317101217403;9141.862872056925;9053.592588333508;9062.546872656407;9076.273898088202;9085.591148398338;9123.999999999967;8975.730728078168;9016;9017.36878418511;9031.32265080115;9044.77388065297;43676.781616091714;43729.344059839124;44005.33991990123;44031.339529907076;44211.11577768459;3557.573091229069;3568.80371579563;3703.4815125882396;4171.958280417218;4308.310670292738;32459;32794.83602581972;33408.49887251693;33419.33161336784;33449;4494.146112238697;4507.5717806808625;4597.3793537872625;4680.531946805327;4720.622350211975;323943;324029.37985310156;324423;324535;326246;62319.37680623226;62641.68679156575;62827.37172628307;63058;63070.684646576476;63960.040599391046;64279.67860160763;64427.35572644307;64522.35477645163;64680.67659661765;18221.997790121404;18385.90807045956;18401.81598184001;18478.630427391377;18495.630087398178;14136.575902722729;14214;14249.358778854976;14268.858491320669;14273.64315892111;17818.198181081883;18416.17127229278;18429.447116586525;18518.81481185198;18610.255589776258;6538.8365290868105;6819.931800681929;6836.829079272959;6865.347791959756;6984.79045628632;957.3250858144991;1033.5504055735778;1033.844923261517;1041.3439533094254;1161.9186656934103;32575.348493030007;32782.836085819894;33149.3370132596;33157.17107072342;33227;1082.1180737698908;1154.486253617149;1159.9130065244972;1190.880233184915;1254.4229654358915;16915.407960721317;17277.56806079833;17355.39256126055;17427.302907883543;17443.389481368093;511683;514732;515001;517450;519668;60028;60105;60144.699276503336;60166.69916650389;60298.698506508066;1371.492547757336;1377.0704774277324;1388.7361401333715;1414.9009569330253;1420.3821337718125;30778;32412;32838.179045524055;32938.17654558559;32977.505337420436;53587;54102;54239;54281.45718542922;54617.726911365186;330958;332690;333245;334851;335324;44038;44217.33673994828;44747;44843.10313793771;45308;48616.270755937985;48660.5133948656;48916.510834891196;49513.25730113979;49775.50224497853;42304.78847605742;42415;42852.35721464118;43660.56339436692;43785;40985.18029639331;41130;42304.78847605865;42719;43161.78419107884;37134;37178.8141059293;40300.79097627076;40541.797291013354;41994;34786.65213347834;37847.62152378441;38125;38659.806700966314;38996;28579.142625721262;28649.856750716946;28671.42657146887;28673;28859.42281154323 09:48:54 INFO - PROCESS | 25724 | |2;jquery.html;405.0946135387409;413.4274030467805;416.69997601726755;426.3923908430486;437.1322923995868;18548.536286592844;19188.23247070119;19611.5097122572;19681.606367872653;20071.498212544677;17953.73069403957;18116.547086322847;19649.607007859835;19768;19819;5640.238567793357;5859.970700146493;5919.822405327825;5982;5989.3112292086535;5752.453516915907;5872.61827981182;5970.432808883149;5976.8505787355225;5980.132880732292;5860.677662728548;5918.201042859202;5937.495312898387;5937.910931336033;5942.108683697458;5526.972365138189;5744.3394009689;5924.97037514814;5929.258842644669;5946.108083787423;5694.572907031948;5696.6866822324755;5700.914486282709;5702.3157221133315;5711.05767548354;13449.663758406117;13593.796093058612;13745.106568073043;13811;13857;2461.4092617771607;2461.729209786922;2573.9099131530493;2801.2016575275948;2888.6822449530537;10031.74920626983;10280.383177009404;10453.372797632166;11329.603463878808;15029.924850375788;1902.838258748008;1923.6345094432013;1941.369055057112;1962.6859702447682;1989.8209161175564;80796;82536;83280;83966.16033839644;85459.5727021361;10878.292910960763;10883.129349652167;11178.329300242012;11242.831357529643;11263.26788758728;15481.458148964732;15495.845041549666;15508.302126404338;15512.069275843485;15521;8241.381896357798;8251.216134467217;8265.46274492156;8464.788380290542;8490.23587877094;7941.117021538739;7971.362291016705;8206.343492520584;8358.540280284642;8676.392652514389;4654.534546545318;4659.767011649472;4683.391159149289;4701.083288758659;4725.8345957892;1931.2082046360924;1934.5937353155996;1945.601151763885;1958.1482055305987;1996.5807180492259;973.0804389851522;981.8772653418323;1051.4742628685658;1061.5170097605571;1098.4946924414699;19236.422907312804;19512;19549.902250488656;19825.206991720457;20015.799842001685;992.6624947517879;1012.5342342522375;1013.8175128476945;1038.4548112241134;1054.520193312041;10625.5218515167;10858.771424599268;11018.944905275423;11026;11094;457966;467623;478586;481450;483151;84508;86248.56875715707;87510;87779.56110219535;89289;1008.6016023670609;1024.3546565663585;1036.404067661098;1038.9220808439245;1051.2851261142343;16645.25096370642;17024.552913002535;17058.976461412356;17674.823251767317;17726.468205953843;41327;41448.792756036026;41484.792576036925;42431.36352954646;42611.3608295882;56123.71938140283;57082;57205.42794572001;57789.42210578008;58410;8296;8371.079181289932;8750.781230469289;8752.78118047054;8819.073997230198;11984;13442.529511467052;13443.663908401977;13470.595882123553;13531.729365412833;10937.617183398543;11039.779204416027;11367.54529818798;11454.656360309204;11589.420528973686;10968.780624387307;11426.885731142915;11762.470688819194;11812.706045658342;11945.820812687643;11395.715107122056;11779.411029448665;12211.389430528616;12267.141300108906;12283.324417157142;8522.531260780717;8547.8717819234;8610.182032706884;8679.479231246145;8699.652013919373;10117.392956422638;11060.612878549213;11200;11292.378919159524;11325.263857849213 09:48:54 INFO - PROCESS | 25724 | |3;mootools.html;1490.2325302469226;1517.0139409383899;1674.3553731813256;1740.4256595323545;1776.999999999999;8545.359098067647;8938.597763100659;9034.141756533127;9096.499692516918;9201.631934722604;9194.080591940803;9282.582283797228;9358.906410935888;9372.297077719182;9374.203192728626;2325.5581439526477;2374.0741110966737;2374.643803429482;2380.440596459839;2380.773826486481;2383.1063351243283;2415.8912848921755;2449.938751531217;2450.620153876152;2463.9014439422403;2367.266147494274;2369.857808531485;2395.6286775549816;2396.4847557775074;2396.5686176488225;2282.7146606674164;2291.5875142474347;2318.119114736406;2330.475642980333;2331.9533609327887;2323.779240972122;2326.4998025424447;2334.9649755253686;2342.273895092527;2351.5061837014246;9106.635734570675;9165.679201227926;9166.175044245983;9177.311701622339;9182.127697868691;5083.085044691954;5199.818006369759;5201.817936372247;5202.167653175474;5212.947870521322;3277.3117645294515;3322.4684050552037;3408.9659103408894;3409.1647546351055;3412.5051867479324;1064.7604289034982;1102.162356608975;1112.9220954533187;1126.189143816451;1127.994360028203;12493.063020273425;12529.060320476001;12581.559645412366;12616.936915315364;12634;4358.21552120615;4481.551844815557;4581.450225972904;4607.617714685581;4608.792604332813;9928.106470417553;9931.155851752537;9951.457524083778;9969.35199212049;9969.351992120633;5377.247185394048;5408.161734931092;5430.51125398716;5434.619576629677;5434.70109143993;4825.95174048262;4941.160002799533;4984.900301994012;5012.774425150877;5051.873703157377;3859.459675645412;3929.292727309112;3956.5449973252867;4015.0765323975647;4028.879133625996;1186.128195776104;1186.4364426897155;1190.3215167354524;1198.0595232742255;1202.7113492761673;895.7671005538476;928.5078908178676;929.4469790474657;941.4539567051094;946.6875930942772;5629;5656.3879294400895;5685.090385538294;5912.408759124053;6013.067974463965;912.6258234123977;937.4422218779815;943.2454036770556;949.5964215208509;964.5852283518154;3728.8881333560034;3987.1626958339075;4047.0894048839364;4052.2705912935953;4072.898177545585;10914.345139291509;11233.66299011031;11247.100231981422;11276.210665253353;11312.773744525064;11070.723231919266;11189.776204475866;11236.94381528087;11272.380019099028;11272.718182045515;8213.34293256538;8347.624356903954;8554.957225213833;8561.743147705578;8682.6526938923;5669.291338582677;6036.124761909587;6096.1465394845645;6211.068339749074;6295.779647712308;10248;10357.274990750575;10452.634157804441;10498.790024199627;10519.316244444086;10528.315659482108;10677.57289708403;10693.411862347646;10693.732656683645;10718.946405267923;7887.84224315522;7991;8038;8074.677012919652;8086.595670216583;8586.699465518677;8685.435446695945;8704.651813927372;8758.781030474034;8886.777830554287;7008.299170082951;7164.820879478055;7423.406127509678;7469.253074692488;7565.243475652391;7626.466147369631;7658.195889431752;7672.769816905502;7682.961585192038;7775.455718099905;6955.791326260221;7047.753328633473;7050.189228238818;7058.470614703815;7062.223155452999;4981.726005069756;5114.2840002400435;5197.350331208599;5248.317718696545;5381.650192737459;5057.443681195139;5297.496737809902;5318.547923426552;5319.281896943863;5473.06957817164 09:48:54 INFO - PROCESS | 25724 | |4;prototype.html;326.13736666517065;327.7902142628718;334.9581302337208;339.03037313284017;340.6117026589688;5415.83752487426;5559.9444005559935;5613.691246981414;5671.716414179285;5710.828675139747;5364.222187782769;5458.972705136479;5509.972450137744;5512;5535.484967045924;4297.376880352347;4297.462817147856;4307.698461107724;4316.6115049645605;4322.8703138905885;4181.895452613694;4272.572742725733;4301.698881078326;4314.913701725979;4315.978420107911;4226.661867050629;4246.596573325529;4263;4273.606780203097;4283.614474697277;4268.103698223377;4269.338252570857;4279.957200427987;4284.742915425085;4294.656427485794;3675.3751862183494;3758.1168425420005;3761.341765191108;3764.9623503764888;3767.9058023549355;5370.382406023318;5375.086235340002;5408.648437851527;5410.3507579090365;5426.457354264581;4894.608431325485;4895.192293271606;4900.799304170466;4906.730129842857;4929.457759646436;5558.416366281523;5748;5751.539876809845;5757.251557297524;5760.567957403212;4139.441175441337;4140.668746500272;4145.813438395279;4160;4160.479940007499;6037.215162028952;6042.365551617061;6048.667323297261;6052.788152414644;6096.664683442409;4073.1446396256524;4170.666346692318;4209;4229.619334259932;4241.660667146621;4234.449521562177;4246.129543443587;4251.957480425156;4253.59590838876;4265.658747300208;4860;4865.683730557503;4881.780319885614;4882.389701287339;4904.411470623477;5644.447776861396;5821.2141360916585;5835.328937172195;5858.970705146447;5859.414058594107;1409.6969151632447;1438.5324769449971;1452.644102194969;1458.6280498473034;1459.2557795524358;959.2613687460616;985.7486340983004;991.1278075293695;995.1342332170913;995.542050656706;5491.835244942658;5516.282883225235;5525.364583072998;5543.889122217533;5546.670398432668;5805.941940580625;5842.883142337129;5852.970735146297;5854.356020837705;5864.214498113447;5334.546563542065;5344.652597581223;5469.15228139639;5513.3108361454815;5549.889002219933;3052.3895220955897;3082.041240409232;3090;3100.255938574771;3100.930179088211;5868.647881127146;5951.389339172408;6011.428914253139;6029.457348838626;6052.243469566304;5787.681677507778;5818.563607729353;5824.825255242349;5845.649261044351;5875.265591801025;5971.58198926071;5988.730507127189;6000.8799824004145;6008.587981824267;6011.5190784737115;5496.367917689517;5737.713114344183;5770.769169233184;5791.305043394819;5802.245708057925;5669.688167150846;5680.886382272414;5683.920055189501;5689.374168841341;5756.913646295226;5806.4193580641595;5958.791442299499;6004;6019.428154325332;6022.849428764316;4110.753354798721;4130.938035929524;4221.261279276176;4232.195882782262;4237.449131612871;6000.549958753024;6001.159837622649;6013.278406591237;6031.728572214173;6036.185115009417;5722.599418040697;5892.263467066617;5893;5897.764089436375;5905.940940590539;5803.622764520293;5803.767849285981;5806.831919591651;5833.912491312719;5869.94130058711;5726.770929162787;5754.19441278213;5791.652500849962;5799.4780469757925;5804.361520232686;5759.683217422914;5829.018133834516;5845.298564172326;5859.794907178229;5898.616589921641;5722.62802917809;5737.368889422244;5743.971280143573;5759.856003599776;5787.7395517200985 09:48:54 INFO - PROCESS | 25724 | |5;yui.html;757.208716890849;766.9003029606147;780.8204113053997;799.4403917257919;834.6452757578028;14348.210848403347;15452.922735386308;15574.84425155748;15576.532704018884;15606.687866242668;12956.352182390867;12983.870161298384;13031.60905172844;13097.345132743372;13100.868991310108;832.8167803083312;845.8350621628784;851.5784686580121;851.8211175653121;851.833892390984;837.8366218587378;839.8530257204995;840.5461051032465;841.4530555139147;842.7471758472434;871.7602659268689;874.7900503879055;877.2017464107663;877.2850127146387;877.3025444771422;865.4980111535294;869.6912596028413;869.7390782765145;871.3813192633238;872.1975782280253;642.9742810287582;644.5874640230256;645.4771634975684;645.8320836582523;646.1309538670481;13135.540256091086;13223.801642975362;13248.403821827944;13257.46970121194;13289.867101329057;11915.761684766343;12279.324637144953;12463.439145238486;12521.060920431004;12738.235705857585;10418.68743937683;10749.892501074968;10867.130629549618;11261.436928153642;11532.711682207928;4351.369051487548;4360.6293465055505;4369.257226271541;4410.073884484262;4419.580139886705;43642.34536481955;45266.09467810625;55858;57705.42294577084;61771;11072.446377681244;11133;11202.271852329572;11353;11707.356095414834;19924.60150796976;20137.19451221964;20138.295159669342;20155;20217.898910505646;8315.667373305;8539;8578.914210857936;8799.692010779592;8885.333599979898;4591.678582499193;4689.531046895283;4747.311639812208;4749.738764367993;4940.950590494121;3292.6048874134776;3368.9663103369144;3371.5279860819505;3374.1733275347206;3384.1032126486502;587.2219309415042;592.380961894821;592.8754961458142;594.3402822866615;598.8023952095798;597.5309382135003;625.6058683029662;726.9273072692794;737.2185483387626;768.0971732237659;8394.580270986426;8575.061709925923;9089.77275568116;9148.359614826899;9683.080107389787;639.4372951802384;651.7653644687908;655.7639249870043;663.1644128398253;674.1573033707865;4215.114825886537;4419.248727716296;4486.484054333728;4510.594046535827;4527.954720452819;48019.75990120027;50833.49166508362;54703.17945230825;55332.44667553273;55615;50930;56601;72305.2769472309;75306;76674.23325766671;55917.720411397684;56813.43186568164;57687.13469297964;65969.34030659728;66063.66968165128;9741.853872192065;10173.338732982333;10329.690109296733;10346.275760696679;10378;33512.1621959453;38643.99999999887;42842.78578607087;44237.336439952785;47832;54341;59786.70106649613;60899;60975;61186.38813611807;12073.154879158375;12315.076369272161;12365.319907405179;12695.619131426072;12767.106302559103;13956.79064814049;14098.295085245902;14193.787093193403;14205.28973551339;15133.092014479167;12650.240985540897;12727.554535591209;13080.803787942998;13141.802872956721;13463.798043029166;12622.810657840324;12639;12780.297083660487;12983.610491685264;13250.734985300433;12104.818427723416;12179.695507612381;12706.110572260222;13037.348132593143;13213.405396757362;10407.219458540489;10746.946265268623;11112;11146.55413783472;11427.200095993201;11122.44387780624;11150.386728729998;11179.60871369498;11334.659960201207;11443.427828608703 09:48:54 INFO - PROCESS | 25724 | __end_tp_report 09:48:54 INFO - PROCESS | 25724 | __start_cc_report 09:48:54 INFO - PROCESS | 25724 | _x_x_mozilla_cycle_collect,330 09:48:54 INFO - PROCESS | 25724 | __end_cc_report 09:48:54 INFO - PROCESS | 25724 | __startTimestamp1487872134478__endTimestamp 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | ------- Summary: start ------- 09:48:54 INFO - PROCESS | 25724 | Number of tests: 6 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#0] dojo.html Cycles:165 Average:5676.16 Median:5912.26 stddev:634.82 (10.7%) stddev-sans-first:606.93 09:48:54 INFO - PROCESS | 25724 | Values: 3224.0 3258.8 3272.9 3280.3 3284.9 5669.1 5718.9 5741.8 5752.6 5766.5 5700.2 5743.8 5763.6 5789.2 5809.6 5164.1 5207.7 5226.4 5250.8 5267.1 5277.7 5278.2 5286.4 5287.4 5309.8 5127.8 5137.0 5252.9 5256.5 5259.6 5214.7 5253.7 5278.9 5310.4 5329.8 5135.2 5215.1 5222.1 5224.2 5257.7 5547.4 5694.0 5714.5 5792.1 5797.6 5975.9 6017.8 6021.5 6084.2 6126.8 6048.0 6140.5 6143.5 6147.5 6187.1 5741.3 5741.4 5750.1 5755.8 5758.3 6108.2 6112.4 6126.6 6224.6 6225.0 5973.1 5994.1 5994.4 6002.0 6011.9 5989.6 6028.6 6033.2 6063.5 6082.6 6015.1 6123.5 6126.6 6128.4 6135.5 6116.5 6128.4 6128.9 6129.7 6134.0 4601.1 4627.8 4740.2 4741.4 4743.2 4125.0 4134.2 4164.3 4188.7 4224.8 5894.7 5904.6 5912.3 5918.6 5933.2 6021.0 6139.6 6199.7 6201.3 6212.5 5782.9 5796.3 5806.4 5878.4 5913.9 5235.6 5238.0 5250.9 5307.8 5315.9 6136.3 6274.9 6276.2 6279.1 6295.6 5991.3 6025.8 6030.5 6034.6 6117.0 6239.6 6345.6 6346.9 6361.3 6382.4 5957.8 6004.7 6032.8 6037.0 6049.0 5980.0 5981.0 5982.2 5997.3 6027.2 5962.3 5970.6 5971.5 5976.9 6000.7 5904.9 5922.8 5935.1 5937.5 5950.3 5707.3 5800.0 5804.8 5821.1 5897.2 6009.9 6010.4 6023.3 6031.8 6039.6 5866.7 5878.0 5885.5 5890.1 5898.8 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#1] ext.html Cycles:180 Average:57372.41 Median:43757.17 stddev:105885.91 (242.0%) stddev-sans-first:106097.10 09:48:54 INFO - PROCESS | 25724 | Values: 583.6 604.9 617.3 629.6 665.6 43440.6 44420.6 44434.1 47262.3 47353.8 44302.1 44790.6 44816.3 44820.3 44867.6 8975.6 9061.1 9103.9 9126.5 9142.3 8983.4 9038.7 9050.0 9072.3 9072.9 9034.7 9082.0 9102.6 9105.3 9141.9 9053.6 9062.5 9076.3 9085.6 9124.0 8975.7 9016.0 9017.4 9031.3 9044.8 43676.8 43729.3 44005.3 44031.3 44211.1 3557.6 3568.8 3703.5 4172.0 4308.3 32459.0 32794.8 33408.5 33419.3 33449.0 4494.1 4507.6 4597.4 4680.5 4720.6 323943.0 324029.4 324423.0 324535.0 326246.0 62319.4 62641.7 62827.4 63058.0 63070.7 63960.0 64279.7 64427.4 64522.4 64680.7 18222.0 18385.9 18401.8 18478.6 18495.6 14136.6 14214.0 14249.4 14268.9 14273.6 17818.2 18416.2 18429.4 18518.8 18610.3 6538.8 6819.9 6836.8 6865.3 6984.8 957.3 1033.6 1033.8 1041.3 1161.9 32575.3 32782.8 33149.3 33157.2 33227.0 1082.1 1154.5 1159.9 1190.9 1254.4 16915.4 17277.6 17355.4 17427.3 17443.4 511683.0 514732.0 515001.0 517450.0 519668.0 60028.0 60105.0 60144.7 60166.7 60298.7 1371.5 1377.1 1388.7 1414.9 1420.4 30778.0 32412.0 32838.2 32938.2 32977.5 53587.0 54102.0 54239.0 54281.5 54617.7 330958.0 332690.0 333245.0 334851.0 335324.0 44038.0 44217.3 44747.0 44843.1 45308.0 48616.3 48660.5 48916.5 49513.3 49775.5 42304.8 42415.0 42852.4 43660.6 43785.0 40985.2 41130.0 42304.8 42719.0 43161.8 37134.0 37178.8 40300.8 40541.8 41994.0 34786.7 37847.6 38125.0 38659.8 38996.0 28579.1 28649.9 28671.4 28673.0 28859.4 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#2] jquery.html Cycles:180 Average:28276.05 Median:20043.65 stddev:78164.19 (390.0%) stddev-sans-first:78355.44 09:48:54 INFO - PROCESS | 25724 | Values: 405.1 413.4 416.7 426.4 437.1 18548.5 19188.2 19611.5 19681.6 20071.5 17953.7 18116.5 19649.6 19768.0 19819.0 5640.2 5860.0 5919.8 5982.0 5989.3 5752.5 5872.6 5970.4 5976.9 5980.1 5860.7 5918.2 5937.5 5937.9 5942.1 5527.0 5744.3 5925.0 5929.3 5946.1 5694.6 5696.7 5700.9 5702.3 5711.1 13449.7 13593.8 13745.1 13811.0 13857.0 2461.4 2461.7 2573.9 2801.2 2888.7 10031.7 10280.4 10453.4 11329.6 15029.9 1902.8 1923.6 1941.4 1962.7 1989.8 80796.0 82536.0 83280.0 83966.2 85459.6 10878.3 10883.1 11178.3 11242.8 11263.3 15481.5 15495.8 15508.3 15512.1 15521.0 8241.4 8251.2 8265.5 8464.8 8490.2 7941.1 7971.4 8206.3 8358.5 8676.4 4654.5 4659.8 4683.4 4701.1 4725.8 1931.2 1934.6 1945.6 1958.1 1996.6 973.1 981.9 1051.5 1061.5 1098.5 19236.4 19512.0 19549.9 19825.2 20015.8 992.7 1012.5 1013.8 1038.5 1054.5 10625.5 10858.8 11018.9 11026.0 11094.0 457966.0 467623.0 478586.0 481450.0 483151.0 84508.0 86248.6 87510.0 87779.6 89289.0 1008.6 1024.4 1036.4 1038.9 1051.3 16645.3 17024.6 17059.0 17674.8 17726.5 41327.0 41448.8 41484.8 42431.4 42611.4 56123.7 57082.0 57205.4 57789.4 58410.0 8296.0 8371.1 8750.8 8752.8 8819.1 11984.0 13442.5 13443.7 13470.6 13531.7 10937.6 11039.8 11367.5 11454.7 11589.4 10968.8 11426.9 11762.5 11812.7 11945.8 11395.7 11779.4 12211.4 12267.1 12283.3 8522.5 8547.9 8610.2 8679.5 8699.7 10117.4 11060.6 11200.0 11292.4 11325.3 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#3] mootools.html Cycles:180 Average:5890.24 Median:5054.66 stddev:3388.94 (67.0%) stddev-sans-first:3382.31 09:48:54 INFO - PROCESS | 25724 | Values: 1490.2 1517.0 1674.4 1740.4 1777.0 8545.4 8938.6 9034.1 9096.5 9201.6 9194.1 9282.6 9358.9 9372.3 9374.2 2325.6 2374.1 2374.6 2380.4 2380.8 2383.1 2415.9 2449.9 2450.6 2463.9 2367.3 2369.9 2395.6 2396.5 2396.6 2282.7 2291.6 2318.1 2330.5 2332.0 2323.8 2326.5 2335.0 2342.3 2351.5 9106.6 9165.7 9166.2 9177.3 9182.1 5083.1 5199.8 5201.8 5202.2 5212.9 3277.3 3322.5 3409.0 3409.2 3412.5 1064.8 1102.2 1112.9 1126.2 1128.0 12493.1 12529.1 12581.6 12616.9 12634.0 4358.2 4481.6 4581.5 4607.6 4608.8 9928.1 9931.2 9951.5 9969.4 9969.4 5377.2 5408.2 5430.5 5434.6 5434.7 4826.0 4941.2 4984.9 5012.8 5051.9 3859.5 3929.3 3956.5 4015.1 4028.9 1186.1 1186.4 1190.3 1198.1 1202.7 895.8 928.5 929.4 941.5 946.7 5629.0 5656.4 5685.1 5912.4 6013.1 912.6 937.4 943.2 949.6 964.6 3728.9 3987.2 4047.1 4052.3 4072.9 10914.3 11233.7 11247.1 11276.2 11312.8 11070.7 11189.8 11236.9 11272.4 11272.7 8213.3 8347.6 8555.0 8561.7 8682.7 5669.3 6036.1 6096.1 6211.1 6295.8 10248.0 10357.3 10452.6 10498.8 10519.3 10528.3 10677.6 10693.4 10693.7 10718.9 7887.8 7991.0 8038.0 8074.7 8086.6 8586.7 8685.4 8704.7 8758.8 8886.8 7008.3 7164.8 7423.4 7469.3 7565.2 7626.5 7658.2 7672.8 7683.0 7775.5 6955.8 7047.8 7050.2 7058.5 7062.2 4981.7 5114.3 5197.4 5248.3 5381.7 5057.4 5297.5 5318.5 5319.3 5473.1 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#4] prototype.html Cycles:180 Average:4843.92 Median:5548.28 stddev:1425.86 (25.7%) stddev-sans-first:1388.95 09:48:54 INFO - PROCESS | 25724 | Values: 326.1 327.8 335.0 339.0 340.6 5415.8 5559.9 5613.7 5671.7 5710.8 5364.2 5459.0 5510.0 5512.0 5535.5 4297.4 4297.5 4307.7 4316.6 4322.9 4181.9 4272.6 4301.7 4314.9 4316.0 4226.7 4246.6 4263.0 4273.6 4283.6 4268.1 4269.3 4280.0 4284.7 4294.7 3675.4 3758.1 3761.3 3765.0 3767.9 5370.4 5375.1 5408.6 5410.4 5426.5 4894.6 4895.2 4900.8 4906.7 4929.5 5558.4 5748.0 5751.5 5757.3 5760.6 4139.4 4140.7 4145.8 4160.0 4160.5 6037.2 6042.4 6048.7 6052.8 6096.7 4073.1 4170.7 4209.0 4229.6 4241.7 4234.4 4246.1 4252.0 4253.6 4265.7 4860.0 4865.7 4881.8 4882.4 4904.4 5644.4 5821.2 5835.3 5859.0 5859.4 1409.7 1438.5 1452.6 1458.6 1459.3 959.3 985.7 991.1 995.1 995.5 5491.8 5516.3 5525.4 5543.9 5546.7 5805.9 5842.9 5853.0 5854.4 5864.2 5334.5 5344.7 5469.2 5513.3 5549.9 3052.4 3082.0 3090.0 3100.3 3100.9 5868.6 5951.4 6011.4 6029.5 6052.2 5787.7 5818.6 5824.8 5845.6 5875.3 5971.6 5988.7 6000.9 6008.6 6011.5 5496.4 5737.7 5770.8 5791.3 5802.2 5669.7 5680.9 5683.9 5689.4 5756.9 5806.4 5958.8 6004.0 6019.4 6022.8 4110.8 4130.9 4221.3 4232.2 4237.4 6000.5 6001.2 6013.3 6031.7 6036.2 5722.6 5892.3 5893.0 5897.8 5905.9 5803.6 5803.8 5806.8 5833.9 5869.9 5726.8 5754.2 5791.7 5799.5 5804.4 5759.7 5829.0 5845.3 5859.8 5898.6 5722.6 5737.4 5744.0 5759.9 5787.7 09:48:54 INFO - PROCESS | 25724 | 09:48:54 INFO - PROCESS | 25724 | [#5] yui.html Cycles:180 Average:15799.96 Median:24361.91 stddev:19028.60 (78.1%) stddev-sans-first:19048.45 09:48:54 INFO - PROCESS | 25724 | Values: 757.2 766.9 780.8 799.4 834.6 14348.2 15452.9 15574.8 15576.5 15606.7 12956.4 12983.9 13031.6 13097.3 13100.9 832.8 845.8 851.6 851.8 851.8 837.8 839.9 840.5 841.5 842.7 871.8 874.8 877.2 877.3 877.3 865.5 869.7 869.7 871.4 872.2 643.0 644.6 645.5 645.8 646.1 13135.5 13223.8 13248.4 13257.5 13289.9 11915.8 12279.3 12463.4 12521.1 12738.2 10418.7 10749.9 10867.1 11261.4 11532.7 4351.4 4360.6 4369.3 4410.1 4419.6 43642.3 45266.1 55858.0 57705.4 61771.0 11072.4 11133.0 11202.3 11353.0 11707.4 19924.6 20137.2 20138.3 20155.0 20217.9 8315.7 8539.0 8578.9 8799.7 8885.3 4591.7 4689.5 4747.3 4749.7 4941.0 3292.6 3369.0 3371.5 3374.2 3384.1 587.2 592.4 592.9 594.3 598.8 597.5 625.6 726.9 737.2 768.1 8394.6 8575.1 9089.8 9148.4 9683.1 639.4 651.8 655.8 663.2 674.2 4215.1 4419.2 4486.5 4510.6 4528.0 48019.8 50833.5 54703.2 55332.4 55615.0 50930.0 56601.0 72305.3 75306.0 76674.2 55917.7 56813.4 57687.1 65969.3 66063.7 9741.9 10173.3 10329.7 10346.3 10378.0 33512.2 38644.0 42842.8 44237.3 47832.0 54341.0 59786.7 60899.0 60975.0 61186.4 12073.2 12315.1 12365.3 12695.6 12767.1 13956.8 14098.3 14193.8 14205.3 15133.1 12650.2 12727.6 13080.8 13141.8 13463.8 12622.8 12639.0 12780.3 12983.6 13250.7 12104.8 12179.7 12706.1 13037.3 13213.4 10407.2 10746.9 11112.0 11146.6 11427.2 11122.4 11150.4 11179.6 11334.7 11443.4 09:48:54 INFO - PROCESS | 25724 | -------- Summary: end -------- 09:48:54 INFO - PROCESS | 25724 | 09:48:55 INFO - TEST-INFO | 25724: exit 0 09:48:55 INFO - TEST-OK | dromaeo_css | took 1112299ms 09:48:55 INFO - TEST-START | kraken 09:48:55 INFO - operating with platform_type : linux_ 09:48:55 INFO - Initialising browser for kraken test... 09:48:55 INFO - TEST-INFO | started process 26087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfgwD96/profile http://localhost:54835/getInfo.html) 09:48:59 INFO - PROCESS | 26087 | __metrics Screen width/height:1600/1200 09:48:59 INFO - PROCESS | 26087 | colorDepth:24 09:48:59 INFO - PROCESS | 26087 | Browser inner width/height: 1024/697 09:48:59 INFO - PROCESS | 26087 | __metrics 09:48:59 ERROR - PROCESS | 26087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:49:00 INFO - TEST-INFO | 26087: exit 0 09:49:00 INFO - Browser initialized. 09:49:00 INFO - Running cycle 1/1 for kraken test... 09:49:00 INFO - TEST-INFO | started process 26215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfgwD96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:12 INFO - PROCESS | 26215 | RSS: Main: 147046400 09:49:12 INFO - PROCESS | 26215 | 09:49:15 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54835/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:15 INFO - PROCESS | 26215 | RSS: Main: 154112000 09:49:15 INFO - PROCESS | 26215 | 09:49:18 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54835/tests/kraken/driver.html?testName=audio-dft) 09:49:19 INFO - PROCESS | 26215 | RSS: Main: 153280512 09:49:19 INFO - PROCESS | 26215 | 09:49:21 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54835/tests/kraken/driver.html?testName=audio-fft) 09:49:22 INFO - PROCESS | 26215 | RSS: Main: 153227264 09:49:22 INFO - PROCESS | 26215 | 09:49:24 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54835/tests/kraken/driver.html?testName=audio-oscillator) 09:49:25 INFO - PROCESS | 26215 | RSS: Main: 153354240 09:49:25 INFO - PROCESS | 26215 | 09:49:27 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:27 INFO - PROCESS | 26215 | RSS: Main: 153137152 09:49:27 INFO - PROCESS | 26215 | 09:49:30 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54835/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:31 INFO - PROCESS | 26215 | RSS: Main: 155123712 09:49:31 INFO - PROCESS | 26215 | 09:49:34 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54835/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:35 INFO - PROCESS | 26215 | RSS: Main: 155611136 09:49:35 INFO - PROCESS | 26215 | 09:49:38 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54835/tests/kraken/driver.html?testName=json-parse-financial) 09:49:38 INFO - PROCESS | 26215 | RSS: Main: 155779072 09:49:38 INFO - PROCESS | 26215 | 09:49:40 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:41 INFO - PROCESS | 26215 | RSS: Main: 155119616 09:49:41 INFO - PROCESS | 26215 | 09:49:42 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:43 INFO - PROCESS | 26215 | RSS: Main: 155222016 09:49:43 INFO - PROCESS | 26215 | 09:49:45 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:46 INFO - PROCESS | 26215 | RSS: Main: 155492352 09:49:46 INFO - PROCESS | 26215 | 09:49:48 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:49 INFO - PROCESS | 26215 | RSS: Main: 155369472 09:49:49 INFO - PROCESS | 26215 | 09:49:52 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:52 INFO - PROCESS | 26215 | RSS: Main: 155774976 09:49:52 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:54835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54835/tests/kraken/driver.html?testName=ai-astar) 09:49:54 INFO - PROCESS | 26215 | RSS: Main: 157437952 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | __start_tp_report 09:49:54 INFO - PROCESS | 26215 | _x_x_mozilla_page_load 09:49:54 INFO - PROCESS | 26215 | _x_x_mozilla_page_load_details 09:49:54 INFO - PROCESS | 26215 | |i|pagename|runs| 09:49:54 INFO - PROCESS | 26215 | |0;ai-astar;102;114;112;111;113;113;112;111;114;113 09:49:54 INFO - PROCESS | 26215 | |1;audio-beat-detection;143;121;119;157;119;120;120;125;147;118 09:49:54 INFO - PROCESS | 26215 | |2;audio-dft;162;162;164;163;162;163;164;161;164;162 09:49:54 INFO - PROCESS | 26215 | |3;audio-fft;76;75;75;113;75;75;76;75;114;75 09:49:54 INFO - PROCESS | 26215 | |4;audio-oscillator;83;82;108;82;81;81;96;81;82;104 09:49:54 INFO - PROCESS | 26215 | |5;imaging-gaussian-blur;118;117;117;118;119;117;117;118;118;117 09:49:54 INFO - PROCESS | 26215 | |6;imaging-darkroom;147;147;148;146;147;148;148;147;147;147 09:49:54 INFO - PROCESS | 26215 | |7;imaging-desaturate;85;85;85;84;86;85;85;84;85;86 09:49:54 INFO - PROCESS | 26215 | |8;json-parse-financial;54;56;53;53;55;55;54;55;54;58 09:49:54 INFO - PROCESS | 26215 | |9;json-stringify-tinderbox;60;61;61;62;60;60;60;60;62;61 09:49:54 INFO - PROCESS | 26215 | |10;stanford-crypto-aes;77;83;82;78;75;75;75;75;73;76 09:49:54 INFO - PROCESS | 26215 | |11;stanford-crypto-ccm;123;128;133;123;124;133;119;127;171;134 09:49:54 INFO - PROCESS | 26215 | |12;stanford-crypto-pbkdf2;158;157;160;160;155;158;156;159;157;156 09:49:54 INFO - PROCESS | 26215 | |13;stanford-crypto-sha256-iterative;65;64;65;63;64;64;66;63;63;64 09:49:54 INFO - PROCESS | 26215 | __end_tp_report 09:49:54 INFO - PROCESS | 26215 | __start_cc_report 09:49:54 INFO - PROCESS | 26215 | _x_x_mozilla_cycle_collect,808 09:49:54 INFO - PROCESS | 26215 | __end_cc_report 09:49:54 INFO - PROCESS | 26215 | __startTimestamp1487872194578__endTimestamp 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | ------- Summary: start ------- 09:49:54 INFO - PROCESS | 26215 | Number of tests: 14 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:1.13 09:49:54 INFO - PROCESS | 26215 | Values: 102.0 114.0 112.0 111.0 113.0 113.0 112.0 111.0 114.0 113.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:123.00 stddev:14.40 (11.7%) stddev-sans-first:14.34 09:49:54 INFO - PROCESS | 26215 | Values: 143.0 121.0 119.0 157.0 119.0 120.0 120.0 125.0 147.0 118.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 09:49:54 INFO - PROCESS | 26215 | Values: 162.0 162.0 164.0 163.0 162.0 163.0 164.0 161.0 164.0 162.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:16.13 (21.5%) stddev-sans-first:16.92 09:49:54 INFO - PROCESS | 26215 | Values: 76.0 75.0 75.0 113.0 75.0 75.0 76.0 75.0 114.0 75.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:10.54 (12.9%) stddev-sans-first:11.02 09:49:54 INFO - PROCESS | 26215 | Values: 83.0 82.0 108.0 82.0 81.0 81.0 96.0 81.0 82.0 104.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:49:54 INFO - PROCESS | 26215 | Values: 118.0 117.0 117.0 118.0 119.0 117.0 117.0 118.0 118.0 117.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:49:54 INFO - PROCESS | 26215 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 09:49:54 INFO - PROCESS | 26215 | Values: 85.0 85.0 85.0 84.0 86.0 85.0 85.0 84.0 85.0 86.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.56 09:49:54 INFO - PROCESS | 26215 | Values: 54.0 56.0 53.0 53.0 55.0 55.0 54.0 55.0 54.0 58.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:49:54 INFO - PROCESS | 26215 | Values: 60.0 61.0 61.0 62.0 60.0 60.0 60.0 60.0 62.0 61.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:3.25 (4.2%) stddev-sans-first:3.44 09:49:54 INFO - PROCESS | 26215 | Values: 77.0 83.0 82.0 78.0 75.0 75.0 75.0 75.0 73.0 76.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:130.50 stddev:14.76 (11.3%) stddev-sans-first:15.33 09:49:54 INFO - PROCESS | 26215 | Values: 123.0 128.0 133.0 123.0 124.0 133.0 119.0 127.0 171.0 134.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:1.71 (1.1%) stddev-sans-first:1.81 09:49:54 INFO - PROCESS | 26215 | Values: 158.0 157.0 160.0 160.0 155.0 158.0 156.0 159.0 157.0 156.0 09:49:54 INFO - PROCESS | 26215 | 09:49:54 INFO - PROCESS | 26215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 09:49:54 INFO - PROCESS | 26215 | Values: 65.0 64.0 65.0 63.0 64.0 64.0 66.0 63.0 63.0 64.0 09:49:54 INFO - PROCESS | 26215 | -------- Summary: end -------- 09:49:54 INFO - PROCESS | 26215 | 09:49:55 INFO - TEST-INFO | 26215: exit 0 09:49:55 INFO - TEST-OK | kraken | took 60428ms 09:49:55 INFO - SUITE-END | took 1172s 09:49:55 INFO - Completed test suite (00:19:32) 09:49:55 INFO - javascript benchmark 09:49:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7316.500367482912, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.016674914151, 3258.7555933305007, 3272.8690852365908, 3280.311134661721, 3284.8850290239816, 5669.1212862006405, 5718.885622287552, 5741.827745167647, 5752.568557358204, 5766.481016708501, 5700.230468886699, 5743.827685169441, 5763.567732420075, 5789.160571717099, 5809.564282678795, 5164.122099243128, 5207.6875387476875, 5226.42509323976, 5250.816221432251, 5267.130923397634, 5277.683338999653, 5278.181881808307, 5286.392064912546, 5287.444818294081, 5309.787608495655, 5127.7948882044675, 5137.049645815536, 5252.947470525303, 5256.474352564732, 5259.579233661298, 5214.661047031931, 5253.684778913258, 5278.947210527884, 5310.389305229909, 5329.760160792774, 5135.229715542699, 5215.139501982168, 5222.112240919053, 5224.242484839715, 5257.7108259045735, 5547.417521160261, 5693.971530142364, 5714.485696287354, 5792.102224155263, 5797.594168408213, 5975.940240597582, 6017.789377371771, 6021.548383871183, 6084.209052823149, 6126.7549298028025, 6048.0, 6140.539459540552, 6143.539234557381, 6147.538934579924, 6187.102870083812, 5741.253637027202, 5741.425857414267, 5750.0512415450985, 5755.769769209227, 5758.337791153987, 6108.175396321529, 6112.449879510866, 6126.609281623701, 6224.564280500412, 6224.968875155686, 5973.104034394875, 5994.100884867217, 5994.430529099728, 6002.0, 6011.909821352683, 5989.610675306091, 6028.608140470856, 6033.245844269466, 6063.54523410746, 6082.60463069899, 6015.097735339734, 6123.465646421213, 6126.639818174547, 6128.387161283836, 6135.538906164978, 6116.541259405562, 6128.417800308964, 6128.908066379008, 6129.725578588854, 6134.04922237054, 4601.102784956901, 4627.814887404534, 4740.19416699155, 4741.431028276629, 4743.169945259566, 4124.9587504125175, 4134.235166494208, 4164.250434921743, 4188.685848561309, 4224.78876056196, 5894.67579283135, 5904.616199947076, 5912.260967379078, 5918.556108291896, 5933.199018132583, 6020.969895150583, 6139.600925939889, 6199.721012554446, 6201.255849298113, 6212.534059945522, 5782.858737578628, 5796.275465566804, 5806.419358064244, 5878.353381128072, 5913.852153696192, 5235.607329450307, 5238.030964271622, 5250.921236181461, 5307.752678120639, 5315.920261196085, 6136.274005701014, 6274.905876411857, 6276.184096067482, 6279.058141278753, 6295.622262664255, 5991.281046274475, 6025.758969641165, 6030.4572588467245, 6034.577579569388, 6116.969415152896, 6239.563230573816, 6345.619262844244, 6346.90479642815, 6361.332060133619, 6382.393672601095, 5957.76168953237, 6004.669743164168, 6032.75868965254, 6037.0, 6048.97167481538, 5979.970100149471, 5980.970095149671, 5982.162497250301, 5997.310309314485, 6027.156198132353, 5962.314333851663, 5970.611910225822, 5971.492423143907, 5976.850578735566, 6000.729967151401, 5904.852378690567, 5922.7927022554, 5935.080062590306, 5937.5249980000635, 5950.31571369298, 5707.343655479673, 5800.0, 5804.796832110856, 5821.126830975388, 5897.174395584708, 6009.87980240384, 6010.368911264254, 6023.337432882292, 6031.7587296507645, 6039.577229594062, 5866.735996880066, 5877.970610146922, 5885.47030767233, 5890.087036509348, 5898.764049437975], "value": 5633.193869125872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.635227982511, 604.9455549000589, 617.336363409335, 629.5781826176461, 665.5906617430281, 43440.56559434405, 44420.55579444204, 44434.111317773626, 47262.29106563405, 47353.763231183795, 44302.11395772082, 44790.55209447905, 44816.3277550837, 44820.3276950846, 44867.55132448675, 8975.596098175598, 9061.13919177677, 9103.863442048374, 9126.543672816333, 9142.268618510536, 8983.416077954944, 9038.728838134833, 9049.95475022624, 9072.31957603179, 9072.8639070414, 9034.68378606749, 9081.95459022704, 9102.590383432762, 9105.317101217403, 9141.862872056925, 9053.592588333508, 9062.546872656407, 9076.273898088202, 9085.591148398338, 9123.999999999967, 8975.730728078168, 9016.0, 9017.36878418511, 9031.32265080115, 9044.77388065297, 43676.781616091714, 43729.344059839124, 44005.33991990123, 44031.339529907076, 44211.11577768459, 3557.573091229069, 3568.80371579563, 3703.4815125882396, 4171.958280417218, 4308.310670292738, 32459.0, 32794.83602581972, 33408.49887251693, 33419.33161336784, 33449.0, 4494.146112238697, 4507.5717806808625, 4597.3793537872625, 4680.531946805327, 4720.622350211975, 323943.0, 324029.37985310156, 324423.0, 324535.0, 326246.0, 62319.37680623226, 62641.68679156575, 62827.37172628307, 63058.0, 63070.684646576476, 63960.040599391046, 64279.67860160763, 64427.35572644307, 64522.35477645163, 64680.67659661765, 18221.997790121404, 18385.90807045956, 18401.81598184001, 18478.630427391377, 18495.630087398178, 14136.575902722729, 14214.0, 14249.358778854976, 14268.858491320669, 14273.64315892111, 17818.198181081883, 18416.17127229278, 18429.447116586525, 18518.81481185198, 18610.255589776258, 6538.8365290868105, 6819.931800681929, 6836.829079272959, 6865.347791959756, 6984.79045628632, 957.3250858144991, 1033.5504055735778, 1033.844923261517, 1041.3439533094254, 1161.9186656934103, 32575.348493030007, 32782.836085819894, 33149.3370132596, 33157.17107072342, 33227.0, 1082.1180737698908, 1154.486253617149, 1159.9130065244972, 1190.880233184915, 1254.4229654358915, 16915.407960721317, 17277.56806079833, 17355.39256126055, 17427.302907883543, 17443.389481368093, 511683.0, 514732.0, 515001.0, 517450.0, 519668.0, 60028.0, 60105.0, 60144.699276503336, 60166.69916650389, 60298.698506508066, 1371.492547757336, 1377.0704774277324, 1388.7361401333715, 1414.9009569330253, 1420.3821337718125, 30778.0, 32412.0, 32838.179045524055, 32938.17654558559, 32977.505337420436, 53587.0, 54102.0, 54239.0, 54281.45718542922, 54617.726911365186, 330958.0, 332690.0, 333245.0, 334851.0, 335324.0, 44038.0, 44217.33673994828, 44747.0, 44843.10313793771, 45308.0, 48616.270755937985, 48660.5133948656, 48916.510834891196, 49513.25730113979, 49775.50224497853, 42304.78847605742, 42415.0, 42852.35721464118, 43660.56339436692, 43785.0, 40985.18029639331, 41130.0, 42304.78847605865, 42719.0, 43161.78419107884, 37134.0, 37178.8141059293, 40300.79097627076, 40541.797291013354, 41994.0, 34786.65213347834, 37847.62152378441, 38125.0, 38659.806700966314, 38996.0, 28579.142625721262, 28649.856750716946, 28671.42657146887, 28673.0, 28859.42281154323], "value": 20742.32907129658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.0946135387409, 413.4274030467805, 416.69997601726755, 426.3923908430486, 437.1322923995868, 18548.536286592844, 19188.23247070119, 19611.5097122572, 19681.606367872653, 20071.498212544677, 17953.73069403957, 18116.547086322847, 19649.607007859835, 19768.0, 19819.0, 5640.238567793357, 5859.970700146493, 5919.822405327825, 5982.0, 5989.3112292086535, 5752.453516915907, 5872.61827981182, 5970.432808883149, 5976.8505787355225, 5980.132880732292, 5860.677662728548, 5918.201042859202, 5937.495312898387, 5937.910931336033, 5942.108683697458, 5526.972365138189, 5744.3394009689, 5924.97037514814, 5929.258842644669, 5946.108083787423, 5694.572907031948, 5696.6866822324755, 5700.914486282709, 5702.3157221133315, 5711.05767548354, 13449.663758406117, 13593.796093058612, 13745.106568073043, 13811.0, 13857.0, 2461.4092617771607, 2461.729209786922, 2573.9099131530493, 2801.2016575275948, 2888.6822449530537, 10031.74920626983, 10280.383177009404, 10453.372797632166, 11329.603463878808, 15029.924850375788, 1902.838258748008, 1923.6345094432013, 1941.369055057112, 1962.6859702447682, 1989.8209161175564, 80796.0, 82536.0, 83280.0, 83966.16033839644, 85459.5727021361, 10878.292910960763, 10883.129349652167, 11178.329300242012, 11242.831357529643, 11263.26788758728, 15481.458148964732, 15495.845041549666, 15508.302126404338, 15512.069275843485, 15521.0, 8241.381896357798, 8251.216134467217, 8265.46274492156, 8464.788380290542, 8490.23587877094, 7941.117021538739, 7971.362291016705, 8206.343492520584, 8358.540280284642, 8676.392652514389, 4654.534546545318, 4659.767011649472, 4683.391159149289, 4701.083288758659, 4725.8345957892, 1931.2082046360924, 1934.5937353155996, 1945.601151763885, 1958.1482055305987, 1996.5807180492259, 973.0804389851522, 981.8772653418323, 1051.4742628685658, 1061.5170097605571, 1098.4946924414699, 19236.422907312804, 19512.0, 19549.902250488656, 19825.206991720457, 20015.799842001685, 992.6624947517879, 1012.5342342522375, 1013.8175128476945, 1038.4548112241134, 1054.520193312041, 10625.5218515167, 10858.771424599268, 11018.944905275423, 11026.0, 11094.0, 457966.0, 467623.0, 478586.0, 481450.0, 483151.0, 84508.0, 86248.56875715707, 87510.0, 87779.56110219535, 89289.0, 1008.6016023670609, 1024.3546565663585, 1036.404067661098, 1038.9220808439245, 1051.2851261142343, 16645.25096370642, 17024.552913002535, 17058.976461412356, 17674.823251767317, 17726.468205953843, 41327.0, 41448.792756036026, 41484.792576036925, 42431.36352954646, 42611.3608295882, 56123.71938140283, 57082.0, 57205.42794572001, 57789.42210578008, 58410.0, 8296.0, 8371.079181289932, 8750.781230469289, 8752.78118047054, 8819.073997230198, 11984.0, 13442.529511467052, 13443.663908401977, 13470.595882123553, 13531.729365412833, 10937.617183398543, 11039.779204416027, 11367.54529818798, 11454.656360309204, 11589.420528973686, 10968.780624387307, 11426.885731142915, 11762.470688819194, 11812.706045658342, 11945.820812687643, 11395.715107122056, 11779.411029448665, 12211.389430528616, 12267.141300108906, 12283.324417157142, 8522.531260780717, 8547.8717819234, 8610.182032706884, 8679.479231246145, 8699.652013919373, 10117.392956422638, 11060.612878549213, 11200.0, 11292.378919159524, 11325.263857849213], "value": 9208.67939518694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.2325302469226, 1517.0139409383899, 1674.3553731813256, 1740.4256595323545, 1776.999999999999, 8545.359098067647, 8938.597763100659, 9034.141756533127, 9096.499692516918, 9201.631934722604, 9194.080591940803, 9282.582283797228, 9358.906410935888, 9372.297077719182, 9374.203192728626, 2325.5581439526477, 2374.0741110966737, 2374.643803429482, 2380.440596459839, 2380.773826486481, 2383.1063351243283, 2415.8912848921755, 2449.938751531217, 2450.620153876152, 2463.9014439422403, 2367.266147494274, 2369.857808531485, 2395.6286775549816, 2396.4847557775074, 2396.5686176488225, 2282.7146606674164, 2291.5875142474347, 2318.119114736406, 2330.475642980333, 2331.9533609327887, 2323.779240972122, 2326.4998025424447, 2334.9649755253686, 2342.273895092527, 2351.5061837014246, 9106.635734570675, 9165.679201227926, 9166.175044245983, 9177.311701622339, 9182.127697868691, 5083.085044691954, 5199.818006369759, 5201.817936372247, 5202.167653175474, 5212.947870521322, 3277.3117645294515, 3322.4684050552037, 3408.9659103408894, 3409.1647546351055, 3412.5051867479324, 1064.7604289034982, 1102.162356608975, 1112.9220954533187, 1126.189143816451, 1127.994360028203, 12493.063020273425, 12529.060320476001, 12581.559645412366, 12616.936915315364, 12634.0, 4358.21552120615, 4481.551844815557, 4581.450225972904, 4607.617714685581, 4608.792604332813, 9928.106470417553, 9931.155851752537, 9951.457524083778, 9969.35199212049, 9969.351992120633, 5377.247185394048, 5408.161734931092, 5430.51125398716, 5434.619576629677, 5434.70109143993, 4825.95174048262, 4941.160002799533, 4984.900301994012, 5012.774425150877, 5051.873703157377, 3859.459675645412, 3929.292727309112, 3956.5449973252867, 4015.0765323975647, 4028.879133625996, 1186.128195776104, 1186.4364426897155, 1190.3215167354524, 1198.0595232742255, 1202.7113492761673, 895.7671005538476, 928.5078908178676, 929.4469790474657, 941.4539567051094, 946.6875930942772, 5629.0, 5656.3879294400895, 5685.090385538294, 5912.408759124053, 6013.067974463965, 912.6258234123977, 937.4422218779815, 943.2454036770556, 949.5964215208509, 964.5852283518154, 3728.8881333560034, 3987.1626958339075, 4047.0894048839364, 4052.2705912935953, 4072.898177545585, 10914.345139291509, 11233.66299011031, 11247.100231981422, 11276.210665253353, 11312.773744525064, 11070.723231919266, 11189.776204475866, 11236.94381528087, 11272.380019099028, 11272.718182045515, 8213.34293256538, 8347.624356903954, 8554.957225213833, 8561.743147705578, 8682.6526938923, 5669.291338582677, 6036.124761909587, 6096.1465394845645, 6211.068339749074, 6295.779647712308, 10248.0, 10357.274990750575, 10452.634157804441, 10498.790024199627, 10519.316244444086, 10528.315659482108, 10677.57289708403, 10693.411862347646, 10693.732656683645, 10718.946405267923, 7887.84224315522, 7991.0, 8038.0, 8074.677012919652, 8086.595670216583, 8586.699465518677, 8685.435446695945, 8704.651813927372, 8758.781030474034, 8886.777830554287, 7008.299170082951, 7164.820879478055, 7423.406127509678, 7469.253074692488, 7565.243475652391, 7626.466147369631, 7658.195889431752, 7672.769816905502, 7682.961585192038, 7775.455718099905, 6955.791326260221, 7047.753328633473, 7050.189228238818, 7058.470614703815, 7062.223155452999, 4981.726005069756, 5114.2840002400435, 5197.350331208599, 5248.317718696545, 5381.650192737459, 5057.443681195139, 5297.496737809902, 5318.547923426552, 5319.281896943863, 5473.06957817164], "value": 4686.445381038927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.13736666517065, 327.7902142628718, 334.9581302337208, 339.03037313284017, 340.6117026589688, 5415.83752487426, 5559.9444005559935, 5613.691246981414, 5671.716414179285, 5710.828675139747, 5364.222187782769, 5458.972705136479, 5509.972450137744, 5512.0, 5535.484967045924, 4297.376880352347, 4297.462817147856, 4307.698461107724, 4316.6115049645605, 4322.8703138905885, 4181.895452613694, 4272.572742725733, 4301.698881078326, 4314.913701725979, 4315.978420107911, 4226.661867050629, 4246.596573325529, 4263.0, 4273.606780203097, 4283.614474697277, 4268.103698223377, 4269.338252570857, 4279.957200427987, 4284.742915425085, 4294.656427485794, 3675.3751862183494, 3758.1168425420005, 3761.341765191108, 3764.9623503764888, 3767.9058023549355, 5370.382406023318, 5375.086235340002, 5408.648437851527, 5410.3507579090365, 5426.457354264581, 4894.608431325485, 4895.192293271606, 4900.799304170466, 4906.730129842857, 4929.457759646436, 5558.416366281523, 5748.0, 5751.539876809845, 5757.251557297524, 5760.567957403212, 4139.441175441337, 4140.668746500272, 4145.813438395279, 4160.0, 4160.479940007499, 6037.215162028952, 6042.365551617061, 6048.667323297261, 6052.788152414644, 6096.664683442409, 4073.1446396256524, 4170.666346692318, 4209.0, 4229.619334259932, 4241.660667146621, 4234.449521562177, 4246.129543443587, 4251.957480425156, 4253.59590838876, 4265.658747300208, 4860.0, 4865.683730557503, 4881.780319885614, 4882.389701287339, 4904.411470623477, 5644.447776861396, 5821.2141360916585, 5835.328937172195, 5858.970705146447, 5859.414058594107, 1409.6969151632447, 1438.5324769449971, 1452.644102194969, 1458.6280498473034, 1459.2557795524358, 959.2613687460616, 985.7486340983004, 991.1278075293695, 995.1342332170913, 995.542050656706, 5491.835244942658, 5516.282883225235, 5525.364583072998, 5543.889122217533, 5546.670398432668, 5805.941940580625, 5842.883142337129, 5852.970735146297, 5854.356020837705, 5864.214498113447, 5334.546563542065, 5344.652597581223, 5469.15228139639, 5513.3108361454815, 5549.889002219933, 3052.3895220955897, 3082.041240409232, 3090.0, 3100.255938574771, 3100.930179088211, 5868.647881127146, 5951.389339172408, 6011.428914253139, 6029.457348838626, 6052.243469566304, 5787.681677507778, 5818.563607729353, 5824.825255242349, 5845.649261044351, 5875.265591801025, 5971.58198926071, 5988.730507127189, 6000.8799824004145, 6008.587981824267, 6011.5190784737115, 5496.367917689517, 5737.713114344183, 5770.769169233184, 5791.305043394819, 5802.245708057925, 5669.688167150846, 5680.886382272414, 5683.920055189501, 5689.374168841341, 5756.913646295226, 5806.4193580641595, 5958.791442299499, 6004.0, 6019.428154325332, 6022.849428764316, 4110.753354798721, 4130.938035929524, 4221.261279276176, 4232.195882782262, 4237.449131612871, 6000.549958753024, 6001.159837622649, 6013.278406591237, 6031.728572214173, 6036.185115009417, 5722.599418040697, 5892.263467066617, 5893.0, 5897.764089436375, 5905.940940590539, 5803.622764520293, 5803.767849285981, 5806.831919591651, 5833.912491312719, 5869.94130058711, 5726.770929162787, 5754.19441278213, 5791.652500849962, 5799.4780469757925, 5804.361520232686, 5759.683217422914, 5829.018133834516, 5845.298564172326, 5859.794907178229, 5898.616589921641, 5722.62802917809, 5737.368889422244, 5743.971280143573, 5759.856003599776, 5787.7395517200985], "value": 4384.9779533064775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.208716890849, 766.9003029606147, 780.8204113053997, 799.4403917257919, 834.6452757578028, 14348.210848403347, 15452.922735386308, 15574.84425155748, 15576.532704018884, 15606.687866242668, 12956.352182390867, 12983.870161298384, 13031.60905172844, 13097.345132743372, 13100.868991310108, 832.8167803083312, 845.8350621628784, 851.5784686580121, 851.8211175653121, 851.833892390984, 837.8366218587378, 839.8530257204995, 840.5461051032465, 841.4530555139147, 842.7471758472434, 871.7602659268689, 874.7900503879055, 877.2017464107663, 877.2850127146387, 877.3025444771422, 865.4980111535294, 869.6912596028413, 869.7390782765145, 871.3813192633238, 872.1975782280253, 642.9742810287582, 644.5874640230256, 645.4771634975684, 645.8320836582523, 646.1309538670481, 13135.540256091086, 13223.801642975362, 13248.403821827944, 13257.46970121194, 13289.867101329057, 11915.761684766343, 12279.324637144953, 12463.439145238486, 12521.060920431004, 12738.235705857585, 10418.68743937683, 10749.892501074968, 10867.130629549618, 11261.436928153642, 11532.711682207928, 4351.369051487548, 4360.6293465055505, 4369.257226271541, 4410.073884484262, 4419.580139886705, 43642.34536481955, 45266.09467810625, 55858.0, 57705.42294577084, 61771.0, 11072.446377681244, 11133.0, 11202.271852329572, 11353.0, 11707.356095414834, 19924.60150796976, 20137.19451221964, 20138.295159669342, 20155.0, 20217.898910505646, 8315.667373305, 8539.0, 8578.914210857936, 8799.692010779592, 8885.333599979898, 4591.678582499193, 4689.531046895283, 4747.311639812208, 4749.738764367993, 4940.950590494121, 3292.6048874134776, 3368.9663103369144, 3371.5279860819505, 3374.1733275347206, 3384.1032126486502, 587.2219309415042, 592.380961894821, 592.8754961458142, 594.3402822866615, 598.8023952095798, 597.5309382135003, 625.6058683029662, 726.9273072692794, 737.2185483387626, 768.0971732237659, 8394.580270986426, 8575.061709925923, 9089.77275568116, 9148.359614826899, 9683.080107389787, 639.4372951802384, 651.7653644687908, 655.7639249870043, 663.1644128398253, 674.1573033707865, 4215.114825886537, 4419.248727716296, 4486.484054333728, 4510.594046535827, 4527.954720452819, 48019.75990120027, 50833.49166508362, 54703.17945230825, 55332.44667553273, 55615.0, 50930.0, 56601.0, 72305.2769472309, 75306.0, 76674.23325766671, 55917.720411397684, 56813.43186568164, 57687.13469297964, 65969.34030659728, 66063.66968165128, 9741.853872192065, 10173.338732982333, 10329.690109296733, 10346.275760696679, 10378.0, 33512.1621959453, 38643.99999999887, 42842.78578607087, 44237.336439952785, 47832.0, 54341.0, 59786.70106649613, 60899.0, 60975.0, 61186.38813611807, 12073.154879158375, 12315.076369272161, 12365.319907405179, 12695.619131426072, 12767.106302559103, 13956.79064814049, 14098.295085245902, 14193.787093193403, 14205.28973551339, 15133.092014479167, 12650.240985540897, 12727.554535591209, 13080.803787942998, 13141.802872956721, 13463.798043029166, 12622.810657840324, 12639.0, 12780.297083660487, 12983.610491685264, 13250.734985300433, 12104.818427723416, 12179.695507612381, 12706.110572260222, 13037.348132593143, 13213.405396757362, 10407.219458540489, 10746.946265268623, 11112.0, 11146.55413783472, 11427.200095993201, 11122.44387780624, 11150.386728729998, 11179.60871369498, 11334.659960201207, 11443.427828608703], "value": 6936.757206778354, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 111.0, 113.0, 113.0, 112.0, 111.0, 114.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 119.0, 157.0, 119.0, 120.0, 120.0, 125.0, 147.0, 118.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 162.0, 163.0, 164.0, 161.0, 164.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 113.0, 75.0, 75.0, 76.0, 75.0, 114.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 82.0, 81.0, 81.0, 96.0, 81.0, 82.0, 104.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 86.0, 85.0, 85.0, 84.0, 85.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 53.0, 55.0, 55.0, 54.0, 55.0, 54.0, 58.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 60.0, 60.0, 60.0, 60.0, 62.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 82.0, 78.0, 75.0, 75.0, 75.0, 75.0, 73.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 133.0, 123.0, 124.0, 133.0, 119.0, 127.0, 171.0, 134.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 160.0, 160.0, 155.0, 158.0, 156.0, 159.0, 157.0, 156.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 63.0, 64.0, 64.0, 66.0, 63.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 09:49:55 INFO - Return code: 0 09:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:49:55 ERROR - # TBPL SUCCESS # 09:49:55 INFO - Running post-action listener: _resource_record_post_action 09:49:55 INFO - [mozharness: 2017-02-23 17:49:55.908710Z] Finished run-tests step (success) 09:49:55 INFO - Running post-run listener: _resource_record_post_run 09:49:55 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 307200; Write bytes: 293867520; Read time: 32; Write time: 145744 09:49:55 INFO - TinderboxPrint: CPU usage
13.2% 09:49:55 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 32 09:49:55 INFO - TinderboxPrint: I/O write bytes / time
293,867,520 / 145,744 09:49:55 INFO - TinderboxPrint: CPU idle
8,216.9 (86.7%) 09:49:55 INFO - TinderboxPrint: CPU user
1,202.7 (12.7%) 09:49:55 INFO - TinderboxPrint: Swap in / out
0 / 0 09:49:55 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 73437184; Read time: 0; Write time: 47360 09:49:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 307200; Write bytes: 220430336; Read time: 32; Write time: 98384 09:49:56 INFO - Running post-run listener: _upload_blobber_files 09:49:56 INFO - Blob upload gear active. 09:49:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:49:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:49:56 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:49:56 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:49:56 INFO - (blobuploader) - INFO - Open directory for files ... 09:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:00 INFO - (blobuploader) - INFO - Done attempting. 09:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:01 INFO - (blobuploader) - INFO - Done attempting. 09:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:03 INFO - (blobuploader) - INFO - Done attempting. 09:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:03 INFO - Return code: 0 09:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8159f3c3572c3ebc13bac3ed3e3f8714930d87b184680da78ccb71e1fcc9feed5bfa33c334abd75d0abe6e43e2251efc7037d4763154b069e547828206a41e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/401073772422f1af502a66ead428654b4f2175142121ab3d00ec50573276a65fe0e8b7a0e3cf92e5a66f52a498792b05356d851b024a4b4272b7a0a854d05ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a49281a0f2d52d330458df13d3f196fc5bd708e91a8702a3b8e52d1fad009881b65f03c16b181a1870b445cac6c442980a9471c533b7a186284ef407be86d7c"} 09:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:03 INFO - Contents: 09:50:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8159f3c3572c3ebc13bac3ed3e3f8714930d87b184680da78ccb71e1fcc9feed5bfa33c334abd75d0abe6e43e2251efc7037d4763154b069e547828206a41e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/401073772422f1af502a66ead428654b4f2175142121ab3d00ec50573276a65fe0e8b7a0e3cf92e5a66f52a498792b05356d851b024a4b4272b7a0a854d05ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a49281a0f2d52d330458df13d3f196fc5bd708e91a8702a3b8e52d1fad009881b65f03c16b181a1870b445cac6c442980a9471c533b7a186284ef407be86d7c"} 09:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:03 INFO - Copying logs to upload dir... 09:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.104566 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-02-23 09:50:03.141133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 09:50:03.145771) ========= 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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8159f3c3572c3ebc13bac3ed3e3f8714930d87b184680da78ccb71e1fcc9feed5bfa33c334abd75d0abe6e43e2251efc7037d4763154b069e547828206a41e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/401073772422f1af502a66ead428654b4f2175142121ab3d00ec50573276a65fe0e8b7a0e3cf92e5a66f52a498792b05356d851b024a4b4272b7a0a854d05ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a49281a0f2d52d330458df13d3f196fc5bd708e91a8702a3b8e52d1fad009881b65f03c16b181a1870b445cac6c442980a9471c533b7a186284ef407be86d7c"} build_url:https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011546 build_url: 'https://queue.taskcluster.net/v1/task/Aogn3v11TKCkXwN8saHd2A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8159f3c3572c3ebc13bac3ed3e3f8714930d87b184680da78ccb71e1fcc9feed5bfa33c334abd75d0abe6e43e2251efc7037d4763154b069e547828206a41e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/401073772422f1af502a66ead428654b4f2175142121ab3d00ec50573276a65fe0e8b7a0e3cf92e5a66f52a498792b05356d851b024a4b4272b7a0a854d05ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a49281a0f2d52d330458df13d3f196fc5bd708e91a8702a3b8e52d1fad009881b65f03c16b181a1870b445cac6c442980a9471c533b7a186284ef407be86d7c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 09:50:03.170946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:50:03.171270) ========= 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=0e2a256762fed810e2f0f810000001b3-1487868635.838572-136021671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:50:03.255217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 09:50:03.255571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 09:50:03.255893) ========= ========= Total master_lag: 0.17 =========