builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1486575722.85 results: success (0) buildid: 20170208075457 builduid: 89aa009685ec48e69f75505c5e62dc2f revision: 8b510eefa687ab18725e2c7abce570488d1e1825 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.852312) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.852774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.853066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.869467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.869816) ========= 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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-08 09:42:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.8M=0s 2017-02-08 09:42:03 (98.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.968833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:02.969155) ========= 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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.018550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.018907) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b510eefa687ab18725e2c7abce570488d1e1825 --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 8b510eefa687ab18725e2c7abce570488d1e1825 --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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-08 09:42:03,621 truncating revision to first 12 chars 2017-02-08 09:42:03,622 Setting DEBUG logging. 2017-02-08 09:42:03,622 attempt 1/10 2017-02-08 09:42:03,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b510eefa687?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 09:42:03,923 unpacking tar archive at: mozilla-beta-8b510eefa687/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.695936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.696270) ========= script_repo_revision: 8b510eefa687ab18725e2c7abce570488d1e1825 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.696662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.696930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 09:42:03.704747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-08 09:42:03.705012) ========= /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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:04 INFO - MultiFileLogger online at 20170208 09:42:04 in /builds/slave/test 09:42:04 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:42:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:04 INFO - {'append_to_log': False, 09:42:04 INFO - 'base_work_dir': '/builds/slave/test', 09:42:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:42:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:04 INFO - 'branch': 'Mozilla-Beta', 09:42:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:04 INFO - 'config_files': ('talos/linux_config.py',), 09:42:04 INFO - 'default_actions': ('clobber', 09:42:04 INFO - 'read-buildbot-config', 09:42:04 INFO - 'download-and-extract', 09:42:04 INFO - 'populate-webroot', 09:42:04 INFO - 'create-virtualenv', 09:42:04 INFO - 'install', 09:42:04 INFO - 'run-tests'), 09:42:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:04 INFO - 'download_minidump_stackwalk': True, 09:42:04 INFO - 'download_symbols': 'ondemand', 09:42:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:04 INFO - 'installer_path': 'installer.exe', 09:42:04 INFO - 'log_level': 'info', 09:42:04 INFO - 'log_name': 'talos', 09:42:04 INFO - 'log_to_console': True, 09:42:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:04 INFO - 'opt_config_files': (), 09:42:04 INFO - 'pip_index': False, 09:42:04 INFO - 'sps_profile': False, 09:42:04 INFO - 'sps_profile_interval': 0, 09:42:04 INFO - 'suite': 'dromaeojs-e10s', 09:42:04 INFO - 'system_bits': '32', 09:42:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:04 INFO - 'title': 'talos-linux64-ix-048', 09:42:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:04 INFO - 'use_talos_json': True, 09:42:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:04 INFO - 'work_dir': 'build'} 09:42:04 INFO - [mozharness: 2017-02-08 17:42:04.405162Z] Running clobber step. 09:42:04 INFO - Running pre-action listener: _resource_record_pre_action 09:42:04 INFO - Running main action method: clobber 09:42:04 INFO - rmtree: /builds/slave/test/build 09:42:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:04 INFO - Running post-action listener: _resource_record_post_action 09:42:04 INFO - [mozharness: 2017-02-08 17:42:04.877781Z] Finished clobber step (success) 09:42:04 INFO - [mozharness: 2017-02-08 17:42:04.877882Z] Running read-buildbot-config step. 09:42:04 INFO - Running pre-action listener: _resource_record_pre_action 09:42:04 INFO - Running main action method: read_buildbot_config 09:42:04 INFO - Using buildbot properties: 09:42:04 INFO - { 09:42:04 INFO - "project": "", 09:42:04 INFO - "product": "firefox", 09:42:04 INFO - "script_repo_revision": "production", 09:42:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:42:04 INFO - "repository": "", 09:42:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:42:04 INFO - "buildid": "20170208075457", 09:42:04 INFO - "pgo_build": "True", 09:42:04 INFO - "basedir": "/builds/slave/test", 09:42:04 INFO - "buildnumber": 326, 09:42:04 INFO - "slavename": "talos-linux64-ix-048", 09:42:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:42:04 INFO - "platform": "ubuntu64_hw", 09:42:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:42:04 INFO - "branch": "mozilla-beta", 09:42:04 INFO - "repo_path": "releases/mozilla-beta", 09:42:04 INFO - "revision": "8b510eefa687ab18725e2c7abce570488d1e1825", 09:42:04 INFO - "stage_platform": "linux64-pgo", 09:42:04 INFO - "builduid": "89aa009685ec48e69f75505c5e62dc2f", 09:42:04 INFO - "slavebuilddir": "test" 09:42:04 INFO - } 09:42:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:42:04 INFO - Running post-action listener: _resource_record_post_action 09:42:04 INFO - [mozharness: 2017-02-08 17:42:04.880289Z] Finished read-buildbot-config step (success) 09:42:04 INFO - [mozharness: 2017-02-08 17:42:04.880378Z] Running download-and-extract step. 09:42:04 INFO - Running pre-action listener: _resource_record_pre_action 09:42:04 INFO - Running main action method: download_and_extract 09:42:04 INFO - mkdir: /builds/slave/test/build/tests 09:42: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:42:04 INFO - trying https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:42:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/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:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/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:42:05 INFO - Downloaded 1327 bytes. 09:42:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:42:05 INFO - Using the following test package requirements: 09:42:05 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:42:05 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:05 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:42:05 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'jsshell-linux-x86_64.zip'], 09:42:05 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:05 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:42:05 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:42:05 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:42:05 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:05 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:42:05 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:42:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:42:06 INFO - Http code: 200 09:42:06 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 09:42:06 INFO - x-amz-cf-id: UW4wliWGUCWzLpQ-zpTfXLmVO2dTzIZgrqk7tZosQ8WTVTi-3i-9nA== 09:42:06 INFO - x-amz-version-id: .yZW3JXgeLmVvG8J0TRYVYaDi.CFKHGs 09:42:06 INFO - Expected file size: 21958216 09:42:06 INFO - Obtained file size: 21958216 09:42:10 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:42:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:42:11 INFO - Http code: 200 09:42:11 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:42:11 INFO - x-amz-cf-id: 5lvc5mUjQ_zXUEHxDq8DNPkuOW5ifriXnvZPd7cyIIP8Bk9MIPFu4A== 09:42:11 INFO - x-amz-version-id: .yZW3JXgeLmVvG8J0TRYVYaDi.CFKHGs 09:42:11 INFO - Expected file size: 21958216 09:42:11 INFO - Obtained file size: 21958216 09:42:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:42:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:42:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:42:16 INFO - Http code: 200 09:42:16 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:42:16 INFO - x-amz-cf-id: I_n6RMsW0i1fOkUIFsPAdrxRpQfIdGmOlU8aWux-aiySmOMMiQ4o6A== 09:42:16 INFO - x-amz-version-id: EHsvkXMy1jmPzw0koyX3761ecLBIOZfo 09:42:16 INFO - Expected file size: 14403005 09:42:16 INFO - Obtained file size: 14403005 09:42:16 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:42:16 INFO - trying https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:42:16 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/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:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/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:42:18 INFO - Downloaded 57704748 bytes. 09:42:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:42:18 INFO - mkdir: /builds/slave/test/properties 09:42:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:18 INFO - Contents: 09:42:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:42:18 INFO - Running post-action listener: _resource_record_post_action 09:42:18 INFO - Running post-action listener: set_extra_try_arguments 09:42:18 INFO - [mozharness: 2017-02-08 17:42:18.732872Z] Finished download-and-extract step (success) 09:42:18 INFO - [mozharness: 2017-02-08 17:42:18.733180Z] Running populate-webroot step. 09:42:18 INFO - Running pre-action listener: _resource_record_pre_action 09:42:18 INFO - Running main action method: populate_webroot 09:42:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:18 INFO - '--tppagecycles', 09:42:18 INFO - '7'], 09:42:18 INFO - 'tests': ['tsvgm']}}, 09:42:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['damp', 'tps']}, 09:42:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'tests': ['damp', 'tps']}, 09:42:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['dromaeo_dom']}, 09:42:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['basic_compositor_video']}, 09:42:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:42:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['a11yr', 09:42:18 INFO - 'ts_paint', 09:42:18 INFO - 'tpaint', 09:42:18 INFO - 'sessionrestore', 09:42:18 INFO - 'sessionrestore_no_auto_restore', 09:42:18 INFO - 'tabpaint']}, 09:42:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['tsvgx', 09:42:18 INFO - 'tsvgr_opacity', 09:42:18 INFO - 'tart', 09:42:18 INFO - 'tscrollx', 09:42:18 INFO - 'cart']}, 09:42:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:18 INFO - 'tsvgr_opacity', 09:42:18 INFO - 'tart', 09:42:18 INFO - 'tscrollx', 09:42:18 INFO - 'cart']}, 09:42:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'talos_options': ['--disable-e10s'], 09:42:18 INFO - 'tests': ['tp5o']}, 09:42:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'tests': ['tp5o']}, 09:42:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'talos_options': ['--disable-e10s', 09:42:18 INFO - '--xperf_path', 09:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:18 INFO - 'tests': ['tp5n']}, 09:42:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:18 INFO - 'talos_options': ['--xperf_path', 09:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:18 INFO - 'tests': ['tp5n']}}, 09:42:18 INFO - 'talos.zip': {'path': '', 09:42:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:18 INFO - Running post-action listener: _resource_record_post_action 09:42:18 INFO - [mozharness: 2017-02-08 17:42:18.753525Z] Finished populate-webroot step (success) 09:42:18 INFO - [mozharness: 2017-02-08 17:42:18.753618Z] Running create-virtualenv step. 09:42:18 INFO - Running pre-action listener: _resource_record_pre_action 09:42:18 INFO - Running main action method: create_virtualenv 09:42:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:18 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:42:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:18 INFO - Using real prefix '/usr' 09:42:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:21 INFO - Installing pip.................done. 09:42:21 INFO - Return code: 0 09:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:21 INFO - Reading from file tmpfile_stdout 09:42:21 INFO - Output received: 09:42:21 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:42:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:21 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:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:21 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:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:21 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:21 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:42:21 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:42:21 INFO - Using env: {'DISPLAY': ':0', 09:42:21 INFO - 'HOME': '/home/cltbld', 09:42:21 INFO - 'LANG': 'en_US.UTF-8', 09:42:21 INFO - 'LANGUAGE': 'en_US:en', 09:42:21 INFO - 'LOGNAME': 'cltbld', 09:42:21 INFO - 'MAIL': '/var/mail/cltbld', 09:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:21 INFO - 'MOZ_NO_REMOTE': '1', 09:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:21 INFO - 'NO_EM_RESTART': '1', 09:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:21 INFO - 'PWD': '/builds/slave/test', 09:42:21 INFO - 'SHELL': '/bin/bash', 09:42:21 INFO - 'SHLVL': '1', 09:42:21 INFO - 'TERM': 'linux', 09:42:21 INFO - 'TMOUT': '86400', 09:42:21 INFO - 'USER': 'cltbld', 09:42:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:21 INFO - '_': '/tools/buildbot/bin/python'} 09:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:21 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:42:21 INFO - Cleaning up... 09:42:21 INFO - Return code: 0 09:42:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42:21 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:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:21 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:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:21 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:21 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:42:21 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:42:21 INFO - Using env: {'DISPLAY': ':0', 09:42:21 INFO - 'HOME': '/home/cltbld', 09:42:21 INFO - 'LANG': 'en_US.UTF-8', 09:42:21 INFO - 'LANGUAGE': 'en_US:en', 09:42:21 INFO - 'LOGNAME': 'cltbld', 09:42:21 INFO - 'MAIL': '/var/mail/cltbld', 09:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:21 INFO - 'MOZ_NO_REMOTE': '1', 09:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:21 INFO - 'NO_EM_RESTART': '1', 09:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:21 INFO - 'PWD': '/builds/slave/test', 09:42:21 INFO - 'SHELL': '/bin/bash', 09:42:21 INFO - 'SHLVL': '1', 09:42:21 INFO - 'TERM': 'linux', 09:42:21 INFO - 'TMOUT': '86400', 09:42:21 INFO - 'USER': 'cltbld', 09:42:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:21 INFO - '_': '/tools/buildbot/bin/python'} 09:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:21 INFO - Downloading/unpacking psutil>=3.1.1 09:42:21 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:42:21 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:42:21 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:42:21 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:42:21 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:42:21 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:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:24 INFO - Installing collected packages: psutil 09:42:24 INFO - Running setup.py install for psutil 09:42:24 INFO - building 'psutil._psutil_linux' extension 09:42:24 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:42:24 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:42:24 INFO - building 'psutil._psutil_posix' extension 09:42:24 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:42:24 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:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:24 INFO - Successfully installed psutil 09:42:24 INFO - Cleaning up... 09:42:24 INFO - Return code: 0 09:42:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42: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:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:42:24 INFO - Using env: {'DISPLAY': ':0', 09:42:24 INFO - 'HOME': '/home/cltbld', 09:42:24 INFO - 'LANG': 'en_US.UTF-8', 09:42:24 INFO - 'LANGUAGE': 'en_US:en', 09:42:24 INFO - 'LOGNAME': 'cltbld', 09:42:24 INFO - 'MAIL': '/var/mail/cltbld', 09:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:24 INFO - 'MOZ_NO_REMOTE': '1', 09:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:24 INFO - 'NO_EM_RESTART': '1', 09:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:24 INFO - 'PWD': '/builds/slave/test', 09:42:24 INFO - 'SHELL': '/bin/bash', 09:42:24 INFO - 'SHLVL': '1', 09:42:24 INFO - 'TERM': 'linux', 09:42:24 INFO - 'TMOUT': '86400', 09:42:24 INFO - 'USER': 'cltbld', 09:42:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:24 INFO - '_': '/tools/buildbot/bin/python'} 09:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:24 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:42:24 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:42:24 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:42:24 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:42:24 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:42:24 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:42:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:26 INFO - Installing collected packages: mozsystemmonitor 09:42:26 INFO - Running setup.py install for mozsystemmonitor 09:42:26 INFO - Successfully installed mozsystemmonitor 09:42:26 INFO - Cleaning up... 09:42:27 INFO - Return code: 0 09:42:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:42:27 INFO - Using env: {'DISPLAY': ':0', 09:42:27 INFO - 'HOME': '/home/cltbld', 09:42:27 INFO - 'LANG': 'en_US.UTF-8', 09:42:27 INFO - 'LANGUAGE': 'en_US:en', 09:42:27 INFO - 'LOGNAME': 'cltbld', 09:42:27 INFO - 'MAIL': '/var/mail/cltbld', 09:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:27 INFO - 'MOZ_NO_REMOTE': '1', 09:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:27 INFO - 'NO_EM_RESTART': '1', 09:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:27 INFO - 'PWD': '/builds/slave/test', 09:42:27 INFO - 'SHELL': '/bin/bash', 09:42:27 INFO - 'SHLVL': '1', 09:42:27 INFO - 'TERM': 'linux', 09:42:27 INFO - 'TMOUT': '86400', 09:42:27 INFO - 'USER': 'cltbld', 09:42:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:27 INFO - '_': '/tools/buildbot/bin/python'} 09:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:29 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:42:29 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:42:29 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:42:29 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:42:29 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:42:29 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:42:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:29 INFO - warning: no files found matching '*.txt' 09:42:29 INFO - no previously-included directories found matching 'build' 09:42:29 INFO - no previously-included directories found matching 'dist' 09:42:29 INFO - no previously-included directories found matching '.git*' 09:42:29 INFO - Installing collected packages: jsonschema, functools32 09:42:29 INFO - Running setup.py install for functools32 09:42:29 INFO - warning: no files found matching '*.txt' 09:42:29 INFO - no previously-included directories found matching 'build' 09:42:29 INFO - no previously-included directories found matching 'dist' 09:42:29 INFO - no previously-included directories found matching '.git*' 09:42:29 INFO - Successfully installed jsonschema functools32 09:42:29 INFO - Cleaning up... 09:42:29 INFO - Return code: 0 09:42:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:42:29 INFO - Using env: {'DISPLAY': ':0', 09:42:29 INFO - 'HOME': '/home/cltbld', 09:42:29 INFO - 'LANG': 'en_US.UTF-8', 09:42:29 INFO - 'LANGUAGE': 'en_US:en', 09:42:29 INFO - 'LOGNAME': 'cltbld', 09:42:29 INFO - 'MAIL': '/var/mail/cltbld', 09:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:29 INFO - 'MOZ_NO_REMOTE': '1', 09:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:29 INFO - 'NO_EM_RESTART': '1', 09:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:29 INFO - 'PWD': '/builds/slave/test', 09:42:29 INFO - 'SHELL': '/bin/bash', 09:42:29 INFO - 'SHLVL': '1', 09:42:29 INFO - 'TERM': 'linux', 09:42:29 INFO - 'TMOUT': '86400', 09:42:29 INFO - 'USER': 'cltbld', 09:42:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:29 INFO - '_': '/tools/buildbot/bin/python'} 09:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:30 INFO - Cleaning up... 09:42:30 INFO - Return code: 0 09:42:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:30 INFO - Using env: {'DISPLAY': ':0', 09:42:30 INFO - 'HOME': '/home/cltbld', 09:42:30 INFO - 'LANG': 'en_US.UTF-8', 09:42:30 INFO - 'LANGUAGE': 'en_US:en', 09:42:30 INFO - 'LOGNAME': 'cltbld', 09:42:30 INFO - 'MAIL': '/var/mail/cltbld', 09:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:30 INFO - 'MOZ_NO_REMOTE': '1', 09:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:30 INFO - 'NO_EM_RESTART': '1', 09:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:30 INFO - 'PWD': '/builds/slave/test', 09:42:30 INFO - 'SHELL': '/bin/bash', 09:42:30 INFO - 'SHLVL': '1', 09:42:30 INFO - 'TERM': 'linux', 09:42:30 INFO - 'TMOUT': '86400', 09:42:30 INFO - 'USER': 'cltbld', 09:42:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:30 INFO - '_': '/tools/buildbot/bin/python'} 09:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:32 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:42:32 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:42:32 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:42:32 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:42:32 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:42:32 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:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:32 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:42:32 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:42:32 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:42:32 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:42:32 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:42:32 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:42:33 INFO - Downloading docopt-0.6.1.tar.gz 09:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:33 INFO - Running setup.py install for blobuploader 09:42:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:33 INFO - Running setup.py install for requests 09:42:33 INFO - Running setup.py install for docopt 09:42:33 INFO - Successfully installed blobuploader requests docopt 09:42:33 INFO - Cleaning up... 09:42:33 INFO - Return code: 0 09:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:33 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:42:33 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:42:33 INFO - Using env: {'DISPLAY': ':0', 09:42:33 INFO - 'HOME': '/home/cltbld', 09:42:33 INFO - 'LANG': 'en_US.UTF-8', 09:42:33 INFO - 'LANGUAGE': 'en_US:en', 09:42:33 INFO - 'LOGNAME': 'cltbld', 09:42:33 INFO - 'MAIL': '/var/mail/cltbld', 09:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:33 INFO - 'MOZ_NO_REMOTE': '1', 09:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:33 INFO - 'NO_EM_RESTART': '1', 09:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:33 INFO - 'PWD': '/builds/slave/test', 09:42:33 INFO - 'SHELL': '/bin/bash', 09:42:33 INFO - 'SHLVL': '1', 09:42:33 INFO - 'TERM': 'linux', 09:42:33 INFO - 'TMOUT': '86400', 09:42:33 INFO - 'USER': 'cltbld', 09:42:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:33 INFO - '_': '/tools/buildbot/bin/python'} 09:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:34 INFO - Running setup.py (path:/tmp/pip-bLT98M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:34 INFO - Running setup.py (path:/tmp/pip-BELncZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:34 INFO - Running setup.py (path:/tmp/pip-90Gr2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:34 INFO - Running setup.py (path:/tmp/pip-OGwZY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:34 INFO - Running setup.py (path:/tmp/pip-efnX1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:34 INFO - Running setup.py (path:/tmp/pip-_aL187-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:34 INFO - Running setup.py (path:/tmp/pip-TCEyc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:34 INFO - Running setup.py (path:/tmp/pip-QXUSD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:34 INFO - Running setup.py (path:/tmp/pip-ZYhMqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:34 INFO - Running setup.py (path:/tmp/pip-j1xzdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:34 INFO - Running setup.py (path:/tmp/pip-Mff0qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:34 INFO - Running setup.py (path:/tmp/pip-vzaSN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:34 INFO - Running setup.py (path:/tmp/pip-iycC9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:34 INFO - Running setup.py (path:/tmp/pip-xrZf_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:35 INFO - Running setup.py (path:/tmp/pip-wj6mLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:35 INFO - Running setup.py (path:/tmp/pip-JDxdGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:35 INFO - Running setup.py (path:/tmp/pip-EV2cvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:35 INFO - Running setup.py install for manifestparser 09:42:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:35 INFO - Running setup.py install for mozcrash 09:42:35 INFO - Running setup.py install for mozdebug 09:42:35 INFO - Running setup.py install for mozdevice 09:42:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:35 INFO - Running setup.py install for mozfile 09:42:35 INFO - Running setup.py install for mozhttpd 09:42:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:35 INFO - Running setup.py install for mozinfo 09:42:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:35 INFO - Running setup.py install for mozInstall 09:42:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Running setup.py install for mozleak 09:42:36 INFO - Running setup.py install for mozlog 09:42:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Running setup.py install for moznetwork 09:42:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Running setup.py install for mozprocess 09:42:36 INFO - Running setup.py install for mozprofile 09:42:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Running setup.py install for mozrunner 09:42:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:36 INFO - Running setup.py install for mozscreenshot 09:42:36 INFO - Running setup.py install for moztest 09:42:36 INFO - Running setup.py install for mozversion 09:42:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:37 INFO - Cleaning up... 09:42:37 INFO - Return code: 0 09:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:37 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:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:37 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:42:37 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:42:37 INFO - Using env: {'DISPLAY': ':0', 09:42:37 INFO - 'HOME': '/home/cltbld', 09:42:37 INFO - 'LANG': 'en_US.UTF-8', 09:42:37 INFO - 'LANGUAGE': 'en_US:en', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MAIL': '/var/mail/cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SHLVL': '1', 09:42:37 INFO - 'TERM': 'linux', 09:42:37 INFO - 'TMOUT': '86400', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - '_': '/tools/buildbot/bin/python'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:37 INFO - Running setup.py (path:/tmp/pip-zyUX9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:37 INFO - Running setup.py (path:/tmp/pip-T20xYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:37 INFO - Running setup.py (path:/tmp/pip-oSGLVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:37 INFO - Running setup.py (path:/tmp/pip-87a27t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:37 INFO - Running setup.py (path:/tmp/pip-Ub7lOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:37 INFO - Running setup.py (path:/tmp/pip-2HuZkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:37 INFO - Running setup.py (path:/tmp/pip-oyaRyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:37 INFO - Running setup.py (path:/tmp/pip-KrZAXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:37 INFO - Running setup.py (path:/tmp/pip-_oYfQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:37 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:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:37 INFO - Running setup.py (path:/tmp/pip-hcc6Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:38 INFO - Running setup.py (path:/tmp/pip-azsyFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:38 INFO - Running setup.py (path:/tmp/pip-mHNdCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:38 INFO - Running setup.py (path:/tmp/pip-VZ9Dtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:38 INFO - Running setup.py (path:/tmp/pip-8mrBIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:38 INFO - Running setup.py (path:/tmp/pip-9TxOJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:38 INFO - Running setup.py (path:/tmp/pip-ac8S0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:38 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:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:38 INFO - Running setup.py (path:/tmp/pip-KCG8WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:38 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:42:38 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:42:38 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:42:38 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:42:38 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:42:38 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:42:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:40 INFO - Downloading blessings-1.6.tar.gz 09:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:40 INFO - Installing collected packages: blessings 09:42:40 INFO - Running setup.py install for blessings 09:42:40 INFO - Successfully installed blessings 09:42:40 INFO - Cleaning up... 09:42:40 INFO - Return code: 0 09:42:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:41 INFO - Reading from file tmpfile_stdout 09:42:41 INFO - Current package versions: 09:42:41 INFO - argparse == 1.2.1 09:42:41 INFO - blessings == 1.6 09:42:41 INFO - blobuploader == 1.2.4 09:42:41 INFO - docopt == 0.6.1 09:42:41 INFO - functools32 == 3.2.3-2 09:42:41 INFO - jsonschema == 2.5.1 09:42:41 INFO - manifestparser == 1.1 09:42:41 INFO - mozInstall == 1.12 09:42:41 INFO - mozcrash == 1.0 09:42:41 INFO - mozdebug == 0.1 09:42:41 INFO - mozdevice == 0.48 09:42:41 INFO - mozfile == 1.2 09:42:41 INFO - mozhttpd == 0.7 09:42:41 INFO - mozinfo == 0.9 09:42:41 INFO - mozleak == 0.1 09:42:41 INFO - mozlog == 3.4 09:42:41 INFO - moznetwork == 0.27 09:42:41 INFO - mozprocess == 0.23 09:42:41 INFO - mozprofile == 0.28 09:42:41 INFO - mozrunner == 6.13 09:42:41 INFO - mozscreenshot == 0.1 09:42:41 INFO - mozsystemmonitor == 0.3 09:42:41 INFO - moztest == 0.8 09:42:41 INFO - mozversion == 1.4 09:42:41 INFO - psutil == 3.1.1 09:42:41 INFO - requests == 1.2.3 09:42:41 INFO - wsgiref == 0.1.2 09:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:41 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:41 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:42:41 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:42:41 INFO - Using env: {'DISPLAY': ':0', 09:42:41 INFO - 'HOME': '/home/cltbld', 09:42:41 INFO - 'LANG': 'en_US.UTF-8', 09:42:41 INFO - 'LANGUAGE': 'en_US:en', 09:42:41 INFO - 'LOGNAME': 'cltbld', 09:42:41 INFO - 'MAIL': '/var/mail/cltbld', 09:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:41 INFO - 'MOZ_NO_REMOTE': '1', 09:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:41 INFO - 'NO_EM_RESTART': '1', 09:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:41 INFO - 'PWD': '/builds/slave/test', 09:42:41 INFO - 'SHELL': '/bin/bash', 09:42:41 INFO - 'SHLVL': '1', 09:42:41 INFO - 'TERM': 'linux', 09:42:41 INFO - 'TMOUT': '86400', 09:42:41 INFO - 'USER': 'cltbld', 09:42:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:41 INFO - '_': '/tools/buildbot/bin/python'} 09:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 INFO - Cleaning up... 09:42:41 INFO - Return code: 0 09:42:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:41 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 0x7f0805028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2399ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, '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': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', '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:42:41 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:42:41 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:42:41 INFO - Using env: {'DISPLAY': ':0', 09:42:41 INFO - 'HOME': '/home/cltbld', 09:42:41 INFO - 'LANG': 'en_US.UTF-8', 09:42:41 INFO - 'LANGUAGE': 'en_US:en', 09:42:41 INFO - 'LOGNAME': 'cltbld', 09:42:41 INFO - 'MAIL': '/var/mail/cltbld', 09:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:41 INFO - 'MOZ_NO_REMOTE': '1', 09:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:41 INFO - 'NO_EM_RESTART': '1', 09:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:41 INFO - 'PWD': '/builds/slave/test', 09:42:41 INFO - 'SHELL': '/bin/bash', 09:42:41 INFO - 'SHLVL': '1', 09:42:41 INFO - 'TERM': 'linux', 09:42:41 INFO - 'TMOUT': '86400', 09:42:41 INFO - 'USER': 'cltbld', 09:42:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:41 INFO - '_': '/tools/buildbot/bin/python'} 09:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:42:41 INFO - Cleaning up... 09:42:41 INFO - Return code: 0 09:42:41 INFO - Running post-action listener: _resource_record_post_action 09:42:41 INFO - Running post-action listener: _start_resource_monitoring 09:42:41 INFO - Starting resource monitoring. 09:42:41 INFO - [mozharness: 2017-02-08 17:42:41.521050Z] Finished create-virtualenv step (success) 09:42:41 INFO - [mozharness: 2017-02-08 17:42:41.521558Z] Running install step. 09:42:41 INFO - Running pre-action listener: _resource_record_pre_action 09:42:41 INFO - Running main action method: install 09:42:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:41 INFO - Reading from file tmpfile_stdout 09:42:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:41 INFO - Reading from file tmpfile_stdout 09:42:41 INFO - Output received: 09:42:41 INFO - Usage: mozinstall [options] installer 09:42:41 INFO - Options: 09:42:41 INFO - -h, --help show this help message and exit 09:42:41 INFO - -d DEST, --destination=DEST 09:42:41 INFO - Directory to install application into. [default: 09:42:41 INFO - "/builds/slave/test"] 09:42:41 INFO - --app=APP Application being installed. [default: firefox] 09:42:41 INFO - mkdir: /builds/slave/test/build/application 09:42:41 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:42:41 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:42:55 INFO - Reading from file tmpfile_stdout 09:42:55 INFO - Output received: 09:42:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:42:55 INFO - Running post-action listener: _resource_record_post_action 09:42:55 INFO - [mozharness: 2017-02-08 17:42:55.449565Z] Finished install step (success) 09:42:55 INFO - [mozharness: 2017-02-08 17:42:55.449810Z] Running run-tests step. 09:42:55 INFO - Running pre-action listener: _resource_record_pre_action 09:42:55 INFO - Running main action method: run_tests 09:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:42:55 INFO - Python 2.7.3 09:42:55 INFO - Return code: 0 09:42:55 INFO - grabbing minidump binary from tooltool 09:42: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:42:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2396f60>, '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 0x2397d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23981d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:42:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:42:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:42:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:42:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:42:55 INFO - Return code: 0 09:42:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:42:55 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/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:42:55 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/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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:42:55 INFO - Using env: {'DISPLAY': ':0', 09:42:55 INFO - 'HOME': '/home/cltbld', 09:42:55 INFO - 'LANG': 'en_US.UTF-8', 09:42:55 INFO - 'LANGUAGE': 'en_US:en', 09:42:55 INFO - 'LOGNAME': 'cltbld', 09:42:55 INFO - 'MAIL': '/var/mail/cltbld', 09:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:55 INFO - 'MOZ_NO_REMOTE': '1', 09:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:55 INFO - 'NO_EM_RESTART': '1', 09:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:55 INFO - 'PWD': '/builds/slave/test', 09:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:55 INFO - 'SHELL': '/bin/bash', 09:42:55 INFO - 'SHLVL': '1', 09:42:55 INFO - 'TERM': 'linux', 09:42:55 INFO - 'TMOUT': '86400', 09:42:55 INFO - 'USER': 'cltbld', 09:42:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235', 09:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:55 INFO - '_': '/tools/buildbot/bin/python'} 09:42:55 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/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:42:55 INFO - mozversion application_buildid: 20170208075457 09:42:55 INFO - mozversion application_changeset: 8b510eefa687ab18725e2c7abce570488d1e1825 09:42:55 INFO - mozversion application_display_name: Firefox 09:42:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:42:55 INFO - mozversion application_name: Firefox 09:42:55 INFO - mozversion application_remotingname: firefox 09:42:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:42:55 INFO - mozversion application_vendor: Mozilla 09:42:55 INFO - mozversion application_version: 52.0 09:42:55 INFO - mozversion platform_buildid: 20170208075457 09:42:55 INFO - mozversion platform_changeset: 8b510eefa687ab18725e2c7abce570488d1e1825 09:42:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:42:55 INFO - mozversion platform_version: 52.0 09:42:55 INFO - using testdate: 1486575775 09:42:55 INFO - actual date: 1486575775 09:42:55 INFO - starting webserver on 'localhost:53616' 09:42:55 INFO - SUITE-START | Running 2 tests 09:42:55 INFO - TEST-START | dromaeo_css 09:42:55 INFO - operating with platform_type : linux_ 09:42:55 INFO - Initialising browser for dromaeo_css test... 09:42:55 INFO - TEST-INFO | started process 30780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXP5bZR/profile http://localhost:53616/getInfo.html) 09:43:00 INFO - PROCESS | 30780 | __metrics Screen width/height:1600/1200 09:43:00 INFO - PROCESS | 30780 | colorDepth:24 09:43:00 INFO - PROCESS | 30780 | Browser inner width/height: 1024/697 09:43:00 INFO - PROCESS | 30780 | __metrics 09:43:01 ERROR - PROCESS | 30780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:43:01 INFO - TEST-INFO | 30780: exit 0 09:43:01 INFO - Browser initialized. 09:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:01 INFO - TEST-INFO | started process 30910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXP5bZR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:13 INFO - PROCESS | 30910 | RSS: Main: 147845120 09:43:13 INFO - PROCESS | 30910 | 09:46:13 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53616/tests/dromaeo/cssquery-ext.html) 09:46:14 INFO - PROCESS | 30910 | RSS: Main: 153804800 09:46:14 INFO - PROCESS | 30910 | 09:49:16 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-ext.html (next: http://localhost:53616/tests/dromaeo/cssquery-jquery.html) 09:49:17 INFO - PROCESS | 30910 | RSS: Main: 152109056 09:49:17 INFO - PROCESS | 30910 | 09:52:19 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53616/tests/dromaeo/cssquery-mootools.html) 09:52:19 INFO - PROCESS | 30910 | RSS: Main: 151564288 09:52:19 INFO - PROCESS | 30910 | 09:55:21 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53616/tests/dromaeo/cssquery-prototype.html) 09:55:22 INFO - PROCESS | 30910 | RSS: Main: 153640960 09:55:22 INFO - PROCESS | 30910 | 09:58:24 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53616/tests/dromaeo/cssquery-yui.html) 09:58:25 INFO - PROCESS | 30910 | RSS: Main: 154808320 09:58:25 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | Cycle 1(1): loaded http://localhost:53616/tests/dromaeo/cssquery-yui.html (next: http://localhost:53616/tests/dromaeo/cssquery-dojo.html) 10:01:27 INFO - PROCESS | 30910 | RSS: Main: 154337280 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | __start_tp_report 10:01:27 INFO - PROCESS | 30910 | _x_x_mozilla_page_load 10:01:27 INFO - PROCESS | 30910 | _x_x_mozilla_page_load_details 10:01:27 INFO - PROCESS | 30910 | |i|pagename|runs| 10:01:27 INFO - PROCESS | 30910 | |0;dojo.html;3292.670732926707;3305.0910999475127;3310.3586055339124;3320.933581328372;3336.2159892425293;5643;5668.57485688573;5707.115397113449;5714.685692286923;5724.141378793183;5650.6892120933335;5663.292088488939;5692.715364231793;5713.857153571163;5748.712564371775;5158.613104017204;5186.818461353853;5201.8439446816465;5237.711925844077;5242.161254199329;5256.080185967459;5259.5529380002745;5265.552428043621;5272.340957380327;5290.920636190441;5087.211482220243;5110.718910459923;5255.185446255818;5268.288781014552;5288.312519372476;5117.769700363493;5145.2796608474655;5183.714895680736;5236.6857988520815;5264.394594621591;5127.256547800548;5203;5208.427073021964;5218.086834803894;5250.9474905250845;5462.726863656841;5671.035923892948;5673.773049078032;5748.281464816898;5748.856278593027;5901.763929442817;5947.167396564484;5964.880702385972;6092.299385570627;6143.389059649631;5971.910421343683;6103.206583144207;6106.816795496098;6106.969465152691;6112.327643959161;5679.488846003879;5690.630109042941;5693.516051135617;5706.229658996024;5723.6851973141875;6129.664444256008;6169.691515424211;6213.689315534205;6297.338779428094;6300.464460520907;5931.377205393458;5987.1318658794235;5990.5507086968655;5991.940080599138;6022.728977196037;5885.264341957255;5961.731722072517;6070.514358851281;6083.178770865965;6086.6348019119;5934.762609495572;5942.197803296586;6015.187949626745;6042;6108;6033.818985430444;6050.727717252734;6063.787767428119;6073.119397687311;6081.969590152109;4602.9769851151195;4690.249560070372;4700.529947005341;4700.858974230779;4705.247160454311;4103.651189648854;4118.91762164755;4123.60825721556;4165.146145040259;4206.978965105155;5814.883702325929;5842.38654941225;5846.824595262149;5849.590528663038;5893.381194974551;6091.725872335755;6158.04550294705;6167.969160154171;6175.907361389583;6199.132121502993;5652.547796176296;5677.574181936371;5790.392008839095;5794.88410231793;5861.6189947653265;5314.176302673091;5340.519353258225;5356.517913387814;5370.650907690988;5371.516563509303;6368.140301059298;6446.3553644636095;6455.2576453708425;6455.4835613150835;6462.612243265419;5977.790777322773;6028.5177185825905;6052.66710330936;6117.204763380732;6208.2239720034995;6345.492360611048;6373.745050198126;6402.839929001812;6416.647084410216;6424.807255782334;6026.246719160105;6050.606710563799;6061.848453788691;6071.058985857199;6073.058675905242;5877.911831322619;5933.821985340447;6022.66875321844;6156.969215153896;6175.96912015437;5878.794242201502;5969;5991.460768530853;5994.580379373402;6025.337212906489;5960.642361458153;5971.820845374646;5974.4324289192455;5976.701164941648;5986.461218490357;5670.688112153706;5737.282839645044;5926.051831706906;5935.584509084322;5937.673427961504;5873.089671100986;5965.850853728692;6004.099385092271;6046.486048685735;6057.363976782374;5879.94120058811;5897.7935772247765;5900.1149827526215;5901.2033375495475;5905.616134951214 10:01:27 INFO - PROCESS | 30910 | |1;ext.html;592.1177445606046;622.9034499652553;636.436753473176;659.8251463362207;678.4775722693529;43942.78028609856;45068;45208.32187517186;47944.52055479444;47956;45958.770206149005;46341;46406.76796616021;46408.535914640845;46517.767411162895;8981.101889811032;9065.909340906606;9088.636454541811;9116.58975346111;9118.17936385725;9054.139856713635;9129.406588571721;9134.451932884014;9139.95430022849;9142.862857057149;9115.179633832953;9159.679411220608;9164.221041211506;9165.129312715282;9169.862452063224;9113.68102116426;9136;9155.313351498664;9159.313051521129;9168.083191680811;8710.564471776386;8754.3871928965;8768.386212965095;8768.736937891874;8800.383973121883;43574.782126089485;43590.78204608988;43872.78063609693;43942.780286098685;44015.339769903476;3383.3233353329433;3389.1018879996823;3431.8455669494683;3618.4029635110173;3984.541777695544;32601.836990814892;32766.180845479055;32876.01371958845;32963.3407331852;33151.6684833151;4545.340925565807;4556.339330797049;4573;4630.560096790799;4665.230237010923;217874;218503;220023;220261;221360;59523.10715339273;59631;59925.700371497864;60044;60107.398926011054;62214;62369.37630623636;62394;62676.373236267966;62843.371566284666;17470.388536401166;17570.560735981446;17576;17602.471925842245;17607.647847042987;13729.382177801823;13812.792808107886;13840.169589824643;13875.236861972486;13880.097793643381;9442;9507.286953478517;9529.285303602257;9556.665516706882;17006.404775832787;7278.308560686726;7306.830907054846;7319.707211711472;7323.194448610649;7335.779926602104;979.4025644356936;1026.3277553202665;1079.3038490173794;1091.748897753521;1140.1961617059953;30332.84833575818;32147.357052858813;32319.50538492259;32911.34177316488;32988.50517242243;1147.8163493840946;1153.135148638521;1209.4720550640934;1211.2611307102661;1267.7527882063093;16850.662986740197;17086.316547337967;17192.398266060878;17263.82736172622;17278.308867645406;481368;485069;485766;485824;488155;58913;60025;60952.39047609467;60996;66460.66769666217;1395.860413958596;1420.155007770375;1442.185165381577;1443.2639353929571;1445.6964037552023;28332;29138.56292155662;29544.409111818073;30091.548626771055;30117.247068823453;52137;52800;53055.204171938225;53135.46864531305;53157.4684253168;430131;435399;438431;438840;441727;29364;30212.84893575518;30307.545386819656;30412.239694007825;31710.68289317077;47267.290990635855;47412.52587474081;47697.76151119222;47986;48278.275825861936;35444.46833297451;35671.82164089163;35739.28521429505;35747;36314.4552831713;40741.796291018356;41312.38031429471;41489.37765933453;41926.37110443407;42622.36066458943;39517.209655807295;41282.1743565133;41635.7918210407;42118.57881421147;45189;32464.51303230406;33209.33581328408;33841.83079084589;33899.49150762691;34014.48978265279;28137.71862281433;28440.85779571089;28541.857290713415;28613.570796438486;28625.713742862306 10:01:27 INFO - PROCESS | 30910 | |2;jquery.html;410.3475473996347;410.78433822243335;415.10751883450575;417.64708821046213;424.8385613466882;18619.4414167575;18667.06664666768;18935.147918343675;20189.293374731886;20194.798052019494;12580.559680411188;13009.284489353082;13024.934875325634;16536.173191340444;19830.20679172835;5210.16637338027;5405.162199859008;5407.486288802557;5820.185174075633;6132.233470816148;5627.043402621564;6018.729157187937;6024.879502409949;6036.3661815509395;6053.334133245339;5934.020886553713;5947.375525569818;5955.136505206742;5987.670678112702;6007.579469437142;5822.09757487588;6006.099085137221;6024.2770867495965;6070.757169713206;6128.877422451571;5932.436418540232;5934.43622855828;5935.940640593625;5945.791897283574;5956.404359564052;14125;14285.142891426443;14456.855431445656;14466.842652587768;14573.198474083922;2236.910523579055;2258.153192552793;2355.2227764837735;2539.00978618339;2676.7724743396834;9937.205023598095;10013.449260290681;10128.594856205744;10315.484225788756;10491.475426228659;1910.3027395000863;1982.2566537548419;2013.9395818125479;2022.8280596149345;2043.090824583061;82427.5878620609;82460;82913.58543207306;83299;84612.57693711492;11404.258723182966;11432.828507572392;11519.136064795006;11531.423428828524;11762.88237117635;15981.200939952956;16029.19854007295;16093.758593621105;16107;16133.596660083593;8257.42198046131;8367.707130250412;8533.146685331541;8693.782655433664;8856.291496680251;7960.761177164579;8009.23912228349;8348.039975402786;8593.44142630727;8602.78493037679;4820.180569303227;4892.902141957212;4913.31213630092;4958.57852082577;5054.974725126351;1668.8748343874015;1998.3904909002895;2023.5548179400507;2047.5188330742264;2053.640612892738;959.7360725800461;992.1864071461332;994.8308787506141;1037.4034929915329;1069.940758648932;19345;19706;19746.802531974783;19759.110840012236;19916.70124948127;991.1228562722043;1028.3675539543126;1028.7736697926443;1033.9689809305733;1057.413135709673;9315.441073535609;11134.832977505344;11175;11207.66377008691;11209.551617935354;455718;457149;462598;470315;478005;89802.55098724464;90396;92374;92938;94149.5292523533;1022.2435397805571;1077.6766969908997;1102.1788767368362;1107.457345900503;1112.821948488238;16695.582610434838;16769.580760481087;17255.309787608858;17405.65188696244;17651.029193394486;40898.79550602347;41156.58843411647;41416;42533.36199956941;42871;58400;58700;58733.70633146978;58756.4124358768;59284.40715592789;8060.838783224185;8074.434789564674;8091;8240.83518329618;8341.374396920377;10875.891241087487;13421.396037178156;13576.456941722221;13616.251106189255;13761.518346857813;8921.821563568823;11360.602378916697;11526.59656912004;11625.534978600761;11718.23831450953;10965.342079475256;11157.72105697364;11323.433828308387;11370.658880233606;11493.138014649103;6173.41352571505;7713.997180366517;10101.191904647758;11112.944435278096;11443.48504317291;7356.66894989716;7994.84010319802;8931;9049.592768325572;9123.31575131881;11292.096632269235;11550.191486596193;11667;11697.23967942081;11782.882171178522 10:01:27 INFO - PROCESS | 30910 | |3;mootools.html;1518.6734852006816;1534.0747362060613;1692.4499537650258;1791.9104044797757;1797.3349860551598;8309.293710034646;8471.068182499936;8744.519051452167;8974.775630609238;9049.909500904989;8751.343649226317;8843.823123537526;8884.866726999084;8921.866172007409;8923.821523569524;2462.8768561571937;2483.528129655369;2487.813413993949;2487.9253622391266;2490.9750902491014;2472.530219258344;2559.4113353928606;2566.486702659466;2567.5378431882255;2577.7937764978756;2455.914043008495;2462.4582591829767;2489.626556016594;2491.9750802492017;2500.1374525788665;2379;2383.642453631952;2395.8921848516684;2405.0860672944254;2416.9758302416926;2432.5499782540287;2439.1341073918857;2449.730529641738;2469.938251543708;2475.7029156501335;8521.701740439055;8638.09300023501;8804.823903521958;8870.778230544223;8871.157240062184;5324.494173053554;5448.972755136238;5499.780008799643;5506.724663766796;5515.034868897927;3376.4091284025444;3376.7129793967542;3449.6550344965553;3496.0910163357457;3506.2636846262317;1126.7690123524658;1129.0967226218993;1136.1251836086167;1170.4257773294905;1175.7178277213493;11926.880731192663;12017.63947081589;12086.697832554168;12108.091893107963;12110.757784844254;4378.978105109454;4591.127685739699;4631.8378856739855;4657.930131048037;4677.555632214934;9399.436033837992;9405.57674904631;9414.482203478738;9415.246780257563;9425.764355891157;5253.369595648546;5278.419373868871;5281.841544753664;5284.365876094893;5286;4834.105690447279;4911.803527858917;5025.773840177201;5071.746412679351;5123.052235336475;3901.43429202764;3930.665893399036;3979.6418322350546;4019.879403617896;4041.515018197835;1247.7504499100216;1264.6585421936027;1265.171312790124;1276.655303068185;1278.5780692371495;920.3235621817959;921.2215677752289;935.5602866652663;936.6066252174103;938.2494004796135;5600.691961942132;5648.858778530487;5695.515881150066;5698.145278208219;5812.128180772834;895.5387975192781;935.9906400936039;936.498973049429;956.6890760502864;979.6081567372966;3717.628237176261;3919.9608003919598;3977.8209980550946;4012.7592344459426;4040.070783719761;10600.893991059991;11034;11059;11075.944620276847;11078.169137314733;10105.090541851121;10487.423191724376;10692.893071069346;10842.186835987333;10848.349099054081;8176.3458923286;8187.631556579968;8365.707200248084;8383.580820958927;8399.41204115706;5759.337676167294;5844.707764611668;5906.468417842415;5937.732802023833;5949.167116603592;9507.619695212114;9797.216222702024;9819.16537094355;9851.753706157117;9907.356021858555;9873.851892221479;9957.502124893581;10037.247206459691;10101.49492525356;10175.084242418217;6959.61722105289;7164.2119366868565;7620.5808680523105;7884.487508311941;8054.275115239422;8462.746117616482;8584.91415085841;8586.914130858611;8608.827823443622;8613.052564217805;7323.340899319087;7392.926070739439;7424.109106907205;7526.962365188139;7674.731384401519;7632.465727399029;7718.266764657348;7745.341645960157;7780.299773020455;7820.257075577811;6674.16572928384;6725.529212955046;6781.694823732845;6787.89818152738;6817.795466136024;4929;4963.677360971526;5013.924791128063;5030.974845125751;5033.6476446648385;4981.402231732215;5039.912193174956;5050.974745126251;5092.821751238689;5190.870228244324 10:01:27 INFO - PROCESS | 30910 | |4;prototype.html;333.47767441628963;341.3786907827753;345.95675540557437;352.68434750897944;353.84961391408643;5644.463775941279;5740.397258287882;5744.109663002236;5817.476427121558;5875.5005824504915;5622.662640241578;5679.801206957757;5680.517156041741;5690.60165788394;5697.487226149646;4442.2004039272915;4448.843300741806;4448.97775511122;4460.843870464534;4471.441069866267;4357.782110894458;4379.167958087953;4433.88915277119;4486.708363956349;4491.281394976804;4367.890802729926;4369.519352871182;4380.759058251795;4383.232934236512;4409.4488188976375;4402.229609818285;4429.889252768674;4434.933475997863;4435.356873253392;4453.710508816916;3793.8763238063957;3818.179091495314;3906.0625449891822;3925.3915643075084;3928.5285765708013;5540.612157149001;5607.271054762855;5623.746931388097;5624.45327534927;5632.043177331892;5052.595792336641;5071.619628527838;5083.74581270935;5087.041489026751;5107.463716309809;5868.882622347572;5992.161097446361;6010.398960103955;6014.939915556982;6022.69886505673;4239.173361194568;4254.765987870697;4258.53156152823;4261.934516370908;4268.146370725867;6196.411340922605;6287.088372186053;6309.558330916838;6329.936700632981;6349.809315786047;4191.350340697197;4193.370994350811;4202.600752928467;4208.91582168361;4328.632066274339;4248.660107191417;4264.829406823755;4286.185624731291;4296.2481565725875;4296.2696341621995;4973.364117017986;4988.675736077216;4996.975015124901;5008.348914641073;5030.4215015272985;5687.516561092353;5777.508911742465;5915.58590898633;6041.275046994301;6075.2405949256345;1454.7672372420361;1461.7295800276984;1465.6262653023412;1469.7354476194387;1474.7022620094249;961.9519024048769;962.9662961796444;969.6218474794695;970.8252514547308;1012.4836333469837;5522.6134170608475;5546.362168350611;5548.889022219533;5571.275734154615;5612.915806262909;5940.0694774198555;5961.5230781537375;5975.462208401264;5978.880422391615;5995.940040599538;5478.733926805144;5520.972395138079;5542.362628297717;5562;5620.718964051781;3142.591463109781;3143.512755522898;3146.678395074074;3148.449021421242;3157.936841263162;5990.550708696778;6135.601185922901;6151;6194.5044396448175;6204.751809927552;6231.813045608639;6280.591761535486;6305.432511074026;6305.905411418832;6306.873862522724;6512.251091124486;6536.542442029107;6547.803565893031;6561.031690492929;6581.934180658228;6040.84897877539;6118.736067654996;6181.505479561714;6182.568674385759;6183.2686847680925;6069.423404776539;6071.483923866521;6080.817575472743;6113.969430152821;6166.352532983972;6274.811755647338;6406.711697973509;6432.581882177644;6482.930316497914;6500.772472963424;4323.610875021263;4344.326629372453;4351.825007248089;4352.78236088188;4376.693631445768;6017.909731353946;6126.142340072304;6201.627902325695;6245.500359971101;6260.780872669435;5924;5924.68937114517;5931.6441013539325;5939.524838013035;5966.373530779206;5906.940930590811;5949.304448232233;5954.76180952757;5964.196827491072;6024.186734790747;5730.770769169353;5885.823425297248;5903.468687818117;5923.4076592340425;5925.340904546734;6039.969800151147;6043.09353596964;6050.394960503914;6068.423499767515;6068.544859135494;5692.544596432358;5869.295684517885;5889.352171261244;5902.822915312548;5957.314908785545 10:01:27 INFO - PROCESS | 30910 | |5;yui.html;783.6865253898443;800.5956991719181;840.9369297302704;845.3701992015948;906.306675393324;14399.92800036001;15231.695366092672;16030.198490075494;16477.752833707505;16485.587860303498;14998.100113993169;15001.549953501413;15101.697966040672;15352.46266380677;15440.536783896472;880.6609455359701;888.8977767556717;889.8620713789373;890.4078787606234;890.4256754393413;864.2481041493909;873.7815546113471;877.8770972063916;885.5660726244126;885.822835432916;919.462114662923;922.1331947968888;925.2274350916958;928.8885333759958;929.502716046915;910.2763303173992;913.7395842184945;916.9220616247627;918.9770255743626;919.889613246408;674.8852695041854;675.5203805298244;676.1277951442634;678.1252184681755;680.0750978669006;15226.923865380713;15440.382384704599;15630.609234769108;15657.373705051785;15775.92112039444;14361.281935903164;14510.1293922365;14889.255537223204;14989.400423983137;15059.472918447802;12210.877891221151;12281.324527151002;12298.016158707282;12315.261084334968;12429.75140497185;3864;3877.0695033191832;3917.490726205575;3965.7422267552806;3972.523297204325;67635.64728705399;68022.65988670025;68128.31871681269;68153.65923170352;68270.65864670694;11133.220674552866;11464.082873370111;11493.655190344303;11587.826182607268;11683.532658693557;21008.159673612885;21075.473113172295;21105;21121.471963201042;21126.683099753514;7858.17489163641;7863.685452581833;8040.798980025546;8061.516309021477;8193.385496087698;4212.199682060399;4300.268954277781;4362.716423432466;4399;4438.822447102144;3502.422100353464;3620.9094772630897;3623.927521449556;3783.6027217141805;3811.3711237646035;620.9161763161916;622.4988883948374;625.0998562070604;632.2002666626721;633.3571425003626;618.4681174190193;625.7622103600603;641.8684169745285;653.258551544001;727.3889932456761;9292.7676808079;9801.950990245003;9892.901070989197;10198.541065652063;10228.64199753005;726.7202127181073;731.830667473206;755.7883792537988;769.6998170713426;770.1259070954507;4625.398698169217;4713.599344055794;4737.786799594027;4765.593961064746;4804.6876952997945;70686;71777.2822271781;73518.63240683763;82032.58983705043;83273;46443.30335044977;51095;51358.48641513612;73049;73696;69394;70012.14933178724;70379.59240815155;70511.17955281834;70799.2920070803;9713.125818676353;9944.204463642747;10085.445300508543;10097.949510252696;10116.29185956976;33634.15914602154;36893.26213475662;41501;43952.78023609862;45855.77072114751;57684;58369;59018.70490647519;59680.70159649174;69393.30606693869;13648.522301719393;13799.379027943565;13888.583342499742;14223.07550009246;14612.707745844811;14141.575752727435;14215.289235538388;14512;14521.636959076108;14991.550253492413;13866.306684665928;13870.791938120734;14057.648558786112;14148.151110933377;14374.496892609126;13456.932715336361;13959.790603141164;14170.57488275312;14397.784033239719;14655;13335.927289415831;13433.66415839612;13442.529511467052;13493.797593035915;13744.381502832597;11359.48882300282;11378.658640240807;11570.305781653127;11617.941910290394;11953.22304050234;11172.329660220414;11186.944065279622;11375.54497820078;11457;11590.652280431601 10:01:27 INFO - PROCESS | 30910 | __end_tp_report 10:01:27 INFO - PROCESS | 30910 | __start_cc_report 10:01:27 INFO - PROCESS | 30910 | _x_x_mozilla_cycle_collect,303 10:01:27 INFO - PROCESS | 30910 | __end_cc_report 10:01:27 INFO - PROCESS | 30910 | __startTimestamp1486576887670__endTimestamp 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | ------- Summary: start ------- 10:01:27 INFO - PROCESS | 30910 | Number of tests: 6 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#0] dojo.html Cycles:165 Average:5670.23 Median:5897.79 stddev:639.23 (10.8%) stddev-sans-first:613.38 10:01:27 INFO - PROCESS | 30910 | Values: 3292.7 3305.1 3310.4 3320.9 3336.2 5643.0 5668.6 5707.1 5714.7 5724.1 5650.7 5663.3 5692.7 5713.9 5748.7 5158.6 5186.8 5201.8 5237.7 5242.2 5256.1 5259.6 5265.6 5272.3 5290.9 5087.2 5110.7 5255.2 5268.3 5288.3 5117.8 5145.3 5183.7 5236.7 5264.4 5127.3 5203.0 5208.4 5218.1 5250.9 5462.7 5671.0 5673.8 5748.3 5748.9 5901.8 5947.2 5964.9 6092.3 6143.4 5971.9 6103.2 6106.8 6107.0 6112.3 5679.5 5690.6 5693.5 5706.2 5723.7 6129.7 6169.7 6213.7 6297.3 6300.5 5931.4 5987.1 5990.6 5991.9 6022.7 5885.3 5961.7 6070.5 6083.2 6086.6 5934.8 5942.2 6015.2 6042.0 6108.0 6033.8 6050.7 6063.8 6073.1 6082.0 4603.0 4690.2 4700.5 4700.9 4705.2 4103.7 4118.9 4123.6 4165.1 4207.0 5814.9 5842.4 5846.8 5849.6 5893.4 6091.7 6158.0 6168.0 6175.9 6199.1 5652.5 5677.6 5790.4 5794.9 5861.6 5314.2 5340.5 5356.5 5370.7 5371.5 6368.1 6446.4 6455.3 6455.5 6462.6 5977.8 6028.5 6052.7 6117.2 6208.2 6345.5 6373.7 6402.8 6416.6 6424.8 6026.2 6050.6 6061.8 6071.1 6073.1 5877.9 5933.8 6022.7 6157.0 6176.0 5878.8 5969.0 5991.5 5994.6 6025.3 5960.6 5971.8 5974.4 5976.7 5986.5 5670.7 5737.3 5926.1 5935.6 5937.7 5873.1 5965.9 6004.1 6046.5 6057.4 5879.9 5897.8 5900.1 5901.2 5905.6 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#1] ext.html Cycles:180 Average:55362.54 Median:241391.39 stddev:105547.25 (43.7%) stddev-sans-first:105763.23 10:01:27 INFO - PROCESS | 30910 | Values: 592.1 622.9 636.4 659.8 678.5 43942.8 45068.0 45208.3 47944.5 47956.0 45958.8 46341.0 46406.8 46408.5 46517.8 8981.1 9065.9 9088.6 9116.6 9118.2 9054.1 9129.4 9134.5 9140.0 9142.9 9115.2 9159.7 9164.2 9165.1 9169.9 9113.7 9136.0 9155.3 9159.3 9168.1 8710.6 8754.4 8768.4 8768.7 8800.4 43574.8 43590.8 43872.8 43942.8 44015.3 3383.3 3389.1 3431.8 3618.4 3984.5 32601.8 32766.2 32876.0 32963.3 33151.7 4545.3 4556.3 4573.0 4630.6 4665.2 217874.0 218503.0 220023.0 220261.0 221360.0 59523.1 59631.0 59925.7 60044.0 60107.4 62214.0 62369.4 62394.0 62676.4 62843.4 17470.4 17570.6 17576.0 17602.5 17607.6 13729.4 13812.8 13840.2 13875.2 13880.1 9442.0 9507.3 9529.3 9556.7 17006.4 7278.3 7306.8 7319.7 7323.2 7335.8 979.4 1026.3 1079.3 1091.7 1140.2 30332.8 32147.4 32319.5 32911.3 32988.5 1147.8 1153.1 1209.5 1211.3 1267.8 16850.7 17086.3 17192.4 17263.8 17278.3 481368.0 485069.0 485766.0 485824.0 488155.0 58913.0 60025.0 60952.4 60996.0 66460.7 1395.9 1420.2 1442.2 1443.3 1445.7 28332.0 29138.6 29544.4 30091.5 30117.2 52137.0 52800.0 53055.2 53135.5 53157.5 430131.0 435399.0 438431.0 438840.0 441727.0 29364.0 30212.8 30307.5 30412.2 31710.7 47267.3 47412.5 47697.8 47986.0 48278.3 35444.5 35671.8 35739.3 35747.0 36314.5 40741.8 41312.4 41489.4 41926.4 42622.4 39517.2 41282.2 41635.8 42118.6 45189.0 32464.5 33209.3 33841.8 33899.5 34014.5 28137.7 28440.9 28541.9 28613.6 28625.7 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#2] jquery.html Cycles:180 Average:28015.57 Median:21787.78 stddev:76886.45 (352.9%) stddev-sans-first:77074.20 10:01:27 INFO - PROCESS | 30910 | Values: 410.3 410.8 415.1 417.6 424.8 18619.4 18667.1 18935.1 20189.3 20194.8 12580.6 13009.3 13024.9 16536.2 19830.2 5210.2 5405.2 5407.5 5820.2 6132.2 5627.0 6018.7 6024.9 6036.4 6053.3 5934.0 5947.4 5955.1 5987.7 6007.6 5822.1 6006.1 6024.3 6070.8 6128.9 5932.4 5934.4 5935.9 5945.8 5956.4 14125.0 14285.1 14456.9 14466.8 14573.2 2236.9 2258.2 2355.2 2539.0 2676.8 9937.2 10013.4 10128.6 10315.5 10491.5 1910.3 1982.3 2013.9 2022.8 2043.1 82427.6 82460.0 82913.6 83299.0 84612.6 11404.3 11432.8 11519.1 11531.4 11762.9 15981.2 16029.2 16093.8 16107.0 16133.6 8257.4 8367.7 8533.1 8693.8 8856.3 7960.8 8009.2 8348.0 8593.4 8602.8 4820.2 4892.9 4913.3 4958.6 5055.0 1668.9 1998.4 2023.6 2047.5 2053.6 959.7 992.2 994.8 1037.4 1069.9 19345.0 19706.0 19746.8 19759.1 19916.7 991.1 1028.4 1028.8 1034.0 1057.4 9315.4 11134.8 11175.0 11207.7 11209.6 455718.0 457149.0 462598.0 470315.0 478005.0 89802.6 90396.0 92374.0 92938.0 94149.5 1022.2 1077.7 1102.2 1107.5 1112.8 16695.6 16769.6 17255.3 17405.7 17651.0 40898.8 41156.6 41416.0 42533.4 42871.0 58400.0 58700.0 58733.7 58756.4 59284.4 8060.8 8074.4 8091.0 8240.8 8341.4 10875.9 13421.4 13576.5 13616.3 13761.5 8921.8 11360.6 11526.6 11625.5 11718.2 10965.3 11157.7 11323.4 11370.7 11493.1 6173.4 7714.0 10101.2 11112.9 11443.5 7356.7 7994.8 8931.0 9049.6 9123.3 11292.1 11550.2 11667.0 11697.2 11782.9 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#3] mootools.html Cycles:180 Average:5753.88 Median:5107.94 stddev:3193.06 (62.5%) stddev-sans-first:3186.15 10:01:27 INFO - PROCESS | 30910 | Values: 1518.7 1534.1 1692.4 1791.9 1797.3 8309.3 8471.1 8744.5 8974.8 9049.9 8751.3 8843.8 8884.9 8921.9 8923.8 2462.9 2483.5 2487.8 2487.9 2491.0 2472.5 2559.4 2566.5 2567.5 2577.8 2455.9 2462.5 2489.6 2492.0 2500.1 2379.0 2383.6 2395.9 2405.1 2417.0 2432.5 2439.1 2449.7 2469.9 2475.7 8521.7 8638.1 8804.8 8870.8 8871.2 5324.5 5449.0 5499.8 5506.7 5515.0 3376.4 3376.7 3449.7 3496.1 3506.3 1126.8 1129.1 1136.1 1170.4 1175.7 11926.9 12017.6 12086.7 12108.1 12110.8 4379.0 4591.1 4631.8 4657.9 4677.6 9399.4 9405.6 9414.5 9415.2 9425.8 5253.4 5278.4 5281.8 5284.4 5286.0 4834.1 4911.8 5025.8 5071.7 5123.1 3901.4 3930.7 3979.6 4019.9 4041.5 1247.8 1264.7 1265.2 1276.7 1278.6 920.3 921.2 935.6 936.6 938.2 5600.7 5648.9 5695.5 5698.1 5812.1 895.5 936.0 936.5 956.7 979.6 3717.6 3920.0 3977.8 4012.8 4040.1 10600.9 11034.0 11059.0 11075.9 11078.2 10105.1 10487.4 10692.9 10842.2 10848.3 8176.3 8187.6 8365.7 8383.6 8399.4 5759.3 5844.7 5906.5 5937.7 5949.2 9507.6 9797.2 9819.2 9851.8 9907.4 9873.9 9957.5 10037.2 10101.5 10175.1 6959.6 7164.2 7620.6 7884.5 8054.3 8462.7 8584.9 8586.9 8608.8 8613.1 7323.3 7392.9 7424.1 7527.0 7674.7 7632.5 7718.3 7745.3 7780.3 7820.3 6674.2 6725.5 6781.7 6787.9 6817.8 4929.0 4963.7 5013.9 5031.0 5033.6 4981.4 5039.9 5051.0 5092.8 5190.9 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#4] prototype.html Cycles:180 Average:5013.34 Median:5689.06 stddev:1500.77 (26.4%) stddev-sans-first:1463.29 10:01:27 INFO - PROCESS | 30910 | Values: 333.5 341.4 346.0 352.7 353.8 5644.5 5740.4 5744.1 5817.5 5875.5 5622.7 5679.8 5680.5 5690.6 5697.5 4442.2 4448.8 4449.0 4460.8 4471.4 4357.8 4379.2 4433.9 4486.7 4491.3 4367.9 4369.5 4380.8 4383.2 4409.4 4402.2 4429.9 4434.9 4435.4 4453.7 3793.9 3818.2 3906.1 3925.4 3928.5 5540.6 5607.3 5623.7 5624.5 5632.0 5052.6 5071.6 5083.7 5087.0 5107.5 5868.9 5992.2 6010.4 6014.9 6022.7 4239.2 4254.8 4258.5 4261.9 4268.1 6196.4 6287.1 6309.6 6329.9 6349.8 4191.4 4193.4 4202.6 4208.9 4328.6 4248.7 4264.8 4286.2 4296.2 4296.3 4973.4 4988.7 4997.0 5008.3 5030.4 5687.5 5777.5 5915.6 6041.3 6075.2 1454.8 1461.7 1465.6 1469.7 1474.7 962.0 963.0 969.6 970.8 1012.5 5522.6 5546.4 5548.9 5571.3 5612.9 5940.1 5961.5 5975.5 5978.9 5995.9 5478.7 5521.0 5542.4 5562.0 5620.7 3142.6 3143.5 3146.7 3148.4 3157.9 5990.6 6135.6 6151.0 6194.5 6204.8 6231.8 6280.6 6305.4 6305.9 6306.9 6512.3 6536.5 6547.8 6561.0 6581.9 6040.8 6118.7 6181.5 6182.6 6183.3 6069.4 6071.5 6080.8 6114.0 6166.4 6274.8 6406.7 6432.6 6482.9 6500.8 4323.6 4344.3 4351.8 4352.8 4376.7 6017.9 6126.1 6201.6 6245.5 6260.8 5924.0 5924.7 5931.6 5939.5 5966.4 5906.9 5949.3 5954.8 5964.2 6024.2 5730.8 5885.8 5903.5 5923.4 5925.3 6040.0 6043.1 6050.4 6068.4 6068.5 5692.5 5869.3 5889.4 5902.8 5957.3 10:01:27 INFO - PROCESS | 30910 | 10:01:27 INFO - PROCESS | 30910 | [#5] yui.html Cycles:180 Average:17381.53 Median:24157.75 stddev:21652.50 (89.6%) stddev-sans-first:21677.36 10:01:27 INFO - PROCESS | 30910 | Values: 783.7 800.6 840.9 845.4 906.3 14399.9 15231.7 16030.2 16477.8 16485.6 14998.1 15001.5 15101.7 15352.5 15440.5 880.7 888.9 889.9 890.4 890.4 864.2 873.8 877.9 885.6 885.8 919.5 922.1 925.2 928.9 929.5 910.3 913.7 916.9 919.0 919.9 674.9 675.5 676.1 678.1 680.1 15226.9 15440.4 15630.6 15657.4 15775.9 14361.3 14510.1 14889.3 14989.4 15059.5 12210.9 12281.3 12298.0 12315.3 12429.8 3864.0 3877.1 3917.5 3965.7 3972.5 67635.6 68022.7 68128.3 68153.7 68270.7 11133.2 11464.1 11493.7 11587.8 11683.5 21008.2 21075.5 21105.0 21121.5 21126.7 7858.2 7863.7 8040.8 8061.5 8193.4 4212.2 4300.3 4362.7 4399.0 4438.8 3502.4 3620.9 3623.9 3783.6 3811.4 620.9 622.5 625.1 632.2 633.4 618.5 625.8 641.9 653.3 727.4 9292.8 9802.0 9892.9 10198.5 10228.6 726.7 731.8 755.8 769.7 770.1 4625.4 4713.6 4737.8 4765.6 4804.7 70686.0 71777.3 73518.6 82032.6 83273.0 46443.3 51095.0 51358.5 73049.0 73696.0 69394.0 70012.1 70379.6 70511.2 70799.3 9713.1 9944.2 10085.4 10097.9 10116.3 33634.2 36893.3 41501.0 43952.8 45855.8 57684.0 58369.0 59018.7 59680.7 69393.3 13648.5 13799.4 13888.6 14223.1 14612.7 14141.6 14215.3 14512.0 14521.6 14991.6 13866.3 13870.8 14057.6 14148.2 14374.5 13456.9 13959.8 14170.6 14397.8 14655.0 13335.9 13433.7 13442.5 13493.8 13744.4 11359.5 11378.7 11570.3 11617.9 11953.2 11172.3 11186.9 11375.5 11457.0 11590.7 10:01:27 INFO - PROCESS | 30910 | -------- Summary: end -------- 10:01:27 INFO - PROCESS | 30910 | 10:01:28 INFO - TEST-INFO | 30910: exit 0 10:01:28 INFO - TEST-OK | dromaeo_css | took 1112637ms 10:01:28 INFO - TEST-START | kraken 10:01:28 INFO - operating with platform_type : linux_ 10:01:28 INFO - Initialising browser for kraken test... 10:01:28 INFO - TEST-INFO | started process 31266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYvR7sy/profile http://localhost:53616/getInfo.html) 10:01:33 INFO - PROCESS | 31266 | __metrics Screen width/height:1600/1200 10:01:33 INFO - PROCESS | 31266 | colorDepth:24 10:01:33 INFO - PROCESS | 31266 | Browser inner width/height: 1024/697 10:01:33 INFO - PROCESS | 31266 | __metrics 10:01:33 ERROR - PROCESS | 31266 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:01:34 INFO - TEST-INFO | 31266: exit 0 10:01:34 INFO - Browser initialized. 10:01:34 INFO - Running cycle 1/1 for kraken test... 10:01:34 INFO - TEST-INFO | started process 31396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYvR7sy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:46 INFO - PROCESS | 31396 | RSS: Main: 147726336 10:01:46 INFO - PROCESS | 31396 | 10:01:49 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53616/tests/kraken/driver.html?testName=audio-beat-detection) 10:01:49 INFO - PROCESS | 31396 | RSS: Main: 153321472 10:01:49 INFO - PROCESS | 31396 | 10:01:52 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53616/tests/kraken/driver.html?testName=audio-dft) 10:01:53 INFO - PROCESS | 31396 | RSS: Main: 152031232 10:01:53 INFO - PROCESS | 31396 | 10:01:55 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53616/tests/kraken/driver.html?testName=audio-fft) 10:01:56 INFO - PROCESS | 31396 | RSS: Main: 152305664 10:01:56 INFO - PROCESS | 31396 | 10:01:58 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53616/tests/kraken/driver.html?testName=audio-oscillator) 10:01:59 INFO - PROCESS | 31396 | RSS: Main: 152670208 10:01:59 INFO - PROCESS | 31396 | 10:02:01 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:01 INFO - PROCESS | 31396 | RSS: Main: 151781376 10:02:01 INFO - PROCESS | 31396 | 10:02:04 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53616/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:05 INFO - PROCESS | 31396 | RSS: Main: 154513408 10:02:05 INFO - PROCESS | 31396 | 10:02:08 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53616/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:09 INFO - PROCESS | 31396 | RSS: Main: 155975680 10:02:09 INFO - PROCESS | 31396 | 10:02:12 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53616/tests/kraken/driver.html?testName=json-parse-financial) 10:02:12 INFO - PROCESS | 31396 | RSS: Main: 154701824 10:02:12 INFO - PROCESS | 31396 | 10:02:14 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:14 INFO - PROCESS | 31396 | RSS: Main: 153989120 10:02:14 INFO - PROCESS | 31396 | 10:02:16 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:17 INFO - PROCESS | 31396 | RSS: Main: 154054656 10:02:17 INFO - PROCESS | 31396 | 10:02:19 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:19 INFO - PROCESS | 31396 | RSS: Main: 154165248 10:02:19 INFO - PROCESS | 31396 | 10:02:22 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:23 INFO - PROCESS | 31396 | RSS: Main: 153735168 10:02:23 INFO - PROCESS | 31396 | 10:02:25 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:26 INFO - PROCESS | 31396 | RSS: Main: 154099712 10:02:26 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:53616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53616/tests/kraken/driver.html?testName=ai-astar) 10:02:28 INFO - PROCESS | 31396 | RSS: Main: 155959296 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | __start_tp_report 10:02:28 INFO - PROCESS | 31396 | _x_x_mozilla_page_load 10:02:28 INFO - PROCESS | 31396 | _x_x_mozilla_page_load_details 10:02:28 INFO - PROCESS | 31396 | |i|pagename|runs| 10:02:28 INFO - PROCESS | 31396 | |0;ai-astar;102;113;115;112;112;112;114;114;113;113 10:02:28 INFO - PROCESS | 31396 | |1;audio-beat-detection;142;118;120;162;119;117;118;122;149;119 10:02:28 INFO - PROCESS | 31396 | |2;audio-dft;163;166;165;165;162;162;163;161;163;162 10:02:28 INFO - PROCESS | 31396 | |3;audio-fft;75;75;74;107;78;75;76;75;110;78 10:02:28 INFO - PROCESS | 31396 | |4;audio-oscillator;82;81;111;82;81;81;98;82;81;110 10:02:28 INFO - PROCESS | 31396 | |5;imaging-gaussian-blur;117;119;118;117;118;118;118;118;118;117 10:02:28 INFO - PROCESS | 31396 | |6;imaging-darkroom;148;149;146;147;149;148;147;147;148;148 10:02:28 INFO - PROCESS | 31396 | |7;imaging-desaturate;85;85;84;85;86;85;85;85;86;85 10:02:28 INFO - PROCESS | 31396 | |8;json-parse-financial;49;50;51;50;53;50;57;50;50;52 10:02:28 INFO - PROCESS | 31396 | |9;json-stringify-tinderbox;58;59;58;58;58;58;59;58;58;59 10:02:28 INFO - PROCESS | 31396 | |10;stanford-crypto-aes;76;81;82;75;76;74;75;74;75;75 10:02:28 INFO - PROCESS | 31396 | |11;stanford-crypto-ccm;132;127;123;133;121;129;127;120;162;122 10:02:28 INFO - PROCESS | 31396 | |12;stanford-crypto-pbkdf2;153;155;157;161;154;158;161;155;158;158 10:02:28 INFO - PROCESS | 31396 | |13;stanford-crypto-sha256-iterative;66;63;67;70;63;62;63;61;62;62 10:02:28 INFO - PROCESS | 31396 | __end_tp_report 10:02:28 INFO - PROCESS | 31396 | __start_cc_report 10:02:28 INFO - PROCESS | 31396 | _x_x_mozilla_cycle_collect,771 10:02:28 INFO - PROCESS | 31396 | __end_cc_report 10:02:28 INFO - PROCESS | 31396 | __startTimestamp1486576948354__endTimestamp 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | ------- Summary: start ------- 10:02:28 INFO - PROCESS | 31396 | Number of tests: 14 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:1.05 10:02:28 INFO - PROCESS | 31396 | Values: 102.0 113.0 115.0 112.0 112.0 112.0 114.0 114.0 113.0 113.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:121.00 stddev:16.24 (13.4%) stddev-sans-first:16.48 10:02:28 INFO - PROCESS | 31396 | Values: 142.0 118.0 120.0 162.0 119.0 117.0 118.0 122.0 149.0 119.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 10:02:28 INFO - PROCESS | 31396 | Values: 163.0 166.0 165.0 165.0 162.0 162.0 163.0 161.0 163.0 162.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:13.89 (18.5%) stddev-sans-first:14.48 10:02:28 INFO - PROCESS | 31396 | Values: 75.0 75.0 74.0 107.0 78.0 75.0 76.0 75.0 110.0 78.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.50 stddev:12.51 (15.4%) stddev-sans-first:13.02 10:02:28 INFO - PROCESS | 31396 | Values: 82.0 81.0 111.0 82.0 81.0 81.0 98.0 82.0 81.0 110.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:02:28 INFO - PROCESS | 31396 | Values: 117.0 119.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 10:02:28 INFO - PROCESS | 31396 | Values: 148.0 149.0 146.0 147.0 149.0 148.0 147.0 147.0 148.0 148.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 10:02:28 INFO - PROCESS | 31396 | Values: 85.0 85.0 84.0 85.0 86.0 85.0 85.0 85.0 86.0 85.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:50.50 stddev:2.35 (4.6%) stddev-sans-first:2.35 10:02:28 INFO - PROCESS | 31396 | Values: 49.0 50.0 51.0 50.0 53.0 50.0 57.0 50.0 50.0 52.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:02:28 INFO - PROCESS | 31396 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 59.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:2.83 (3.7%) stddev-sans-first:3.00 10:02:28 INFO - PROCESS | 31396 | Values: 76.0 81.0 82.0 75.0 76.0 74.0 75.0 74.0 75.0 75.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:128.00 stddev:12.24 (9.6%) stddev-sans-first:12.95 10:02:28 INFO - PROCESS | 31396 | Values: 132.0 127.0 123.0 133.0 121.0 129.0 127.0 120.0 162.0 122.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:158.00 stddev:2.75 (1.7%) stddev-sans-first:2.51 10:02:28 INFO - PROCESS | 31396 | Values: 153.0 155.0 157.0 161.0 154.0 158.0 161.0 155.0 158.0 158.0 10:02:28 INFO - PROCESS | 31396 | 10:02:28 INFO - PROCESS | 31396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.00 stddev:2.85 (4.5%) stddev-sans-first:2.92 10:02:28 INFO - PROCESS | 31396 | Values: 66.0 63.0 67.0 70.0 63.0 62.0 63.0 61.0 62.0 62.0 10:02:28 INFO - PROCESS | 31396 | -------- Summary: end -------- 10:02:28 INFO - PROCESS | 31396 | 10:02:29 INFO - TEST-INFO | 31396: exit 0 10:02:29 INFO - TEST-OK | kraken | took 61016ms 10:02:29 INFO - SUITE-END | took 1173s 10:02:29 INFO - Completed test suite (00:19:33) 10:02:29 INFO - javascript benchmark 10:02:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7352.032375134011, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.670732926707, 3305.0910999475127, 3310.3586055339124, 3320.933581328372, 3336.2159892425293, 5643.0, 5668.57485688573, 5707.115397113449, 5714.685692286923, 5724.141378793183, 5650.6892120933335, 5663.292088488939, 5692.715364231793, 5713.857153571163, 5748.712564371775, 5158.613104017204, 5186.818461353853, 5201.8439446816465, 5237.711925844077, 5242.161254199329, 5256.080185967459, 5259.5529380002745, 5265.552428043621, 5272.340957380327, 5290.920636190441, 5087.211482220243, 5110.718910459923, 5255.185446255818, 5268.288781014552, 5288.312519372476, 5117.769700363493, 5145.2796608474655, 5183.714895680736, 5236.6857988520815, 5264.394594621591, 5127.256547800548, 5203.0, 5208.427073021964, 5218.086834803894, 5250.9474905250845, 5462.726863656841, 5671.035923892948, 5673.773049078032, 5748.281464816898, 5748.856278593027, 5901.763929442817, 5947.167396564484, 5964.880702385972, 6092.299385570627, 6143.389059649631, 5971.910421343683, 6103.206583144207, 6106.816795496098, 6106.969465152691, 6112.327643959161, 5679.488846003879, 5690.630109042941, 5693.516051135617, 5706.229658996024, 5723.6851973141875, 6129.664444256008, 6169.691515424211, 6213.689315534205, 6297.338779428094, 6300.464460520907, 5931.377205393458, 5987.1318658794235, 5990.5507086968655, 5991.940080599138, 6022.728977196037, 5885.264341957255, 5961.731722072517, 6070.514358851281, 6083.178770865965, 6086.6348019119, 5934.762609495572, 5942.197803296586, 6015.187949626745, 6042.0, 6108.0, 6033.818985430444, 6050.727717252734, 6063.787767428119, 6073.119397687311, 6081.969590152109, 4602.9769851151195, 4690.249560070372, 4700.529947005341, 4700.858974230779, 4705.247160454311, 4103.651189648854, 4118.91762164755, 4123.60825721556, 4165.146145040259, 4206.978965105155, 5814.883702325929, 5842.38654941225, 5846.824595262149, 5849.590528663038, 5893.381194974551, 6091.725872335755, 6158.04550294705, 6167.969160154171, 6175.907361389583, 6199.132121502993, 5652.547796176296, 5677.574181936371, 5790.392008839095, 5794.88410231793, 5861.6189947653265, 5314.176302673091, 5340.519353258225, 5356.517913387814, 5370.650907690988, 5371.516563509303, 6368.140301059298, 6446.3553644636095, 6455.2576453708425, 6455.4835613150835, 6462.612243265419, 5977.790777322773, 6028.5177185825905, 6052.66710330936, 6117.204763380732, 6208.2239720034995, 6345.492360611048, 6373.745050198126, 6402.839929001812, 6416.647084410216, 6424.807255782334, 6026.246719160105, 6050.606710563799, 6061.848453788691, 6071.058985857199, 6073.058675905242, 5877.911831322619, 5933.821985340447, 6022.66875321844, 6156.969215153896, 6175.96912015437, 5878.794242201502, 5969.0, 5991.460768530853, 5994.580379373402, 6025.337212906489, 5960.642361458153, 5971.820845374646, 5974.4324289192455, 5976.701164941648, 5986.461218490357, 5670.688112153706, 5737.282839645044, 5926.051831706906, 5935.584509084322, 5937.673427961504, 5873.089671100986, 5965.850853728692, 6004.099385092271, 6046.486048685735, 6057.363976782374, 5879.94120058811, 5897.7935772247765, 5900.1149827526215, 5901.2033375495475, 5905.616134951214], "value": 5627.383248418826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.1177445606046, 622.9034499652553, 636.436753473176, 659.8251463362207, 678.4775722693529, 43942.78028609856, 45068.0, 45208.32187517186, 47944.52055479444, 47956.0, 45958.770206149005, 46341.0, 46406.76796616021, 46408.535914640845, 46517.767411162895, 8981.101889811032, 9065.909340906606, 9088.636454541811, 9116.58975346111, 9118.17936385725, 9054.139856713635, 9129.406588571721, 9134.451932884014, 9139.95430022849, 9142.862857057149, 9115.179633832953, 9159.679411220608, 9164.221041211506, 9165.129312715282, 9169.862452063224, 9113.68102116426, 9136.0, 9155.313351498664, 9159.313051521129, 9168.083191680811, 8710.564471776386, 8754.3871928965, 8768.386212965095, 8768.736937891874, 8800.383973121883, 43574.782126089485, 43590.78204608988, 43872.78063609693, 43942.780286098685, 44015.339769903476, 3383.3233353329433, 3389.1018879996823, 3431.8455669494683, 3618.4029635110173, 3984.541777695544, 32601.836990814892, 32766.180845479055, 32876.01371958845, 32963.3407331852, 33151.6684833151, 4545.340925565807, 4556.339330797049, 4573.0, 4630.560096790799, 4665.230237010923, 217874.0, 218503.0, 220023.0, 220261.0, 221360.0, 59523.10715339273, 59631.0, 59925.700371497864, 60044.0, 60107.398926011054, 62214.0, 62369.37630623636, 62394.0, 62676.373236267966, 62843.371566284666, 17470.388536401166, 17570.560735981446, 17576.0, 17602.471925842245, 17607.647847042987, 13729.382177801823, 13812.792808107886, 13840.169589824643, 13875.236861972486, 13880.097793643381, 9442.0, 9507.286953478517, 9529.285303602257, 9556.665516706882, 17006.404775832787, 7278.308560686726, 7306.830907054846, 7319.707211711472, 7323.194448610649, 7335.779926602104, 979.4025644356936, 1026.3277553202665, 1079.3038490173794, 1091.748897753521, 1140.1961617059953, 30332.84833575818, 32147.357052858813, 32319.50538492259, 32911.34177316488, 32988.50517242243, 1147.8163493840946, 1153.135148638521, 1209.4720550640934, 1211.2611307102661, 1267.7527882063093, 16850.662986740197, 17086.316547337967, 17192.398266060878, 17263.82736172622, 17278.308867645406, 481368.0, 485069.0, 485766.0, 485824.0, 488155.0, 58913.0, 60025.0, 60952.39047609467, 60996.0, 66460.66769666217, 1395.860413958596, 1420.155007770375, 1442.185165381577, 1443.2639353929571, 1445.6964037552023, 28332.0, 29138.56292155662, 29544.409111818073, 30091.548626771055, 30117.247068823453, 52137.0, 52800.0, 53055.204171938225, 53135.46864531305, 53157.4684253168, 430131.0, 435399.0, 438431.0, 438840.0, 441727.0, 29364.0, 30212.84893575518, 30307.545386819656, 30412.239694007825, 31710.68289317077, 47267.290990635855, 47412.52587474081, 47697.76151119222, 47986.0, 48278.275825861936, 35444.46833297451, 35671.82164089163, 35739.28521429505, 35747.0, 36314.4552831713, 40741.796291018356, 41312.38031429471, 41489.37765933453, 41926.37110443407, 42622.36066458943, 39517.209655807295, 41282.1743565133, 41635.7918210407, 42118.57881421147, 45189.0, 32464.51303230406, 33209.33581328408, 33841.83079084589, 33899.49150762691, 34014.48978265279, 28137.71862281433, 28440.85779571089, 28541.857290713415, 28613.570796438486, 28625.713742862306], "value": 19878.029466258406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.3475473996347, 410.78433822243335, 415.10751883450575, 417.64708821046213, 424.8385613466882, 18619.4414167575, 18667.06664666768, 18935.147918343675, 20189.293374731886, 20194.798052019494, 12580.559680411188, 13009.284489353082, 13024.934875325634, 16536.173191340444, 19830.20679172835, 5210.16637338027, 5405.162199859008, 5407.486288802557, 5820.185174075633, 6132.233470816148, 5627.043402621564, 6018.729157187937, 6024.879502409949, 6036.3661815509395, 6053.334133245339, 5934.020886553713, 5947.375525569818, 5955.136505206742, 5987.670678112702, 6007.579469437142, 5822.09757487588, 6006.099085137221, 6024.2770867495965, 6070.757169713206, 6128.877422451571, 5932.436418540232, 5934.43622855828, 5935.940640593625, 5945.791897283574, 5956.404359564052, 14125.0, 14285.142891426443, 14456.855431445656, 14466.842652587768, 14573.198474083922, 2236.910523579055, 2258.153192552793, 2355.2227764837735, 2539.00978618339, 2676.7724743396834, 9937.205023598095, 10013.449260290681, 10128.594856205744, 10315.484225788756, 10491.475426228659, 1910.3027395000863, 1982.2566537548419, 2013.9395818125479, 2022.8280596149345, 2043.090824583061, 82427.5878620609, 82460.0, 82913.58543207306, 83299.0, 84612.57693711492, 11404.258723182966, 11432.828507572392, 11519.136064795006, 11531.423428828524, 11762.88237117635, 15981.200939952956, 16029.19854007295, 16093.758593621105, 16107.0, 16133.596660083593, 8257.42198046131, 8367.707130250412, 8533.146685331541, 8693.782655433664, 8856.291496680251, 7960.761177164579, 8009.23912228349, 8348.039975402786, 8593.44142630727, 8602.78493037679, 4820.180569303227, 4892.902141957212, 4913.31213630092, 4958.57852082577, 5054.974725126351, 1668.8748343874015, 1998.3904909002895, 2023.5548179400507, 2047.5188330742264, 2053.640612892738, 959.7360725800461, 992.1864071461332, 994.8308787506141, 1037.4034929915329, 1069.940758648932, 19345.0, 19706.0, 19746.802531974783, 19759.110840012236, 19916.70124948127, 991.1228562722043, 1028.3675539543126, 1028.7736697926443, 1033.9689809305733, 1057.413135709673, 9315.441073535609, 11134.832977505344, 11175.0, 11207.66377008691, 11209.551617935354, 455718.0, 457149.0, 462598.0, 470315.0, 478005.0, 89802.55098724464, 90396.0, 92374.0, 92938.0, 94149.5292523533, 1022.2435397805571, 1077.6766969908997, 1102.1788767368362, 1107.457345900503, 1112.821948488238, 16695.582610434838, 16769.580760481087, 17255.309787608858, 17405.65188696244, 17651.029193394486, 40898.79550602347, 41156.58843411647, 41416.0, 42533.36199956941, 42871.0, 58400.0, 58700.0, 58733.70633146978, 58756.4124358768, 59284.40715592789, 8060.838783224185, 8074.434789564674, 8091.0, 8240.83518329618, 8341.374396920377, 10875.891241087487, 13421.396037178156, 13576.456941722221, 13616.251106189255, 13761.518346857813, 8921.821563568823, 11360.602378916697, 11526.59656912004, 11625.534978600761, 11718.23831450953, 10965.342079475256, 11157.72105697364, 11323.433828308387, 11370.658880233606, 11493.138014649103, 6173.41352571505, 7713.997180366517, 10101.191904647758, 11112.944435278096, 11443.48504317291, 7356.66894989716, 7994.84010319802, 8931.0, 9049.592768325572, 9123.31575131881, 11292.096632269235, 11550.191486596193, 11667.0, 11697.23967942081, 11782.882171178522], "value": 9099.1496752447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.6734852006816, 1534.0747362060613, 1692.4499537650258, 1791.9104044797757, 1797.3349860551598, 8309.293710034646, 8471.068182499936, 8744.519051452167, 8974.775630609238, 9049.909500904989, 8751.343649226317, 8843.823123537526, 8884.866726999084, 8921.866172007409, 8923.821523569524, 2462.8768561571937, 2483.528129655369, 2487.813413993949, 2487.9253622391266, 2490.9750902491014, 2472.530219258344, 2559.4113353928606, 2566.486702659466, 2567.5378431882255, 2577.7937764978756, 2455.914043008495, 2462.4582591829767, 2489.626556016594, 2491.9750802492017, 2500.1374525788665, 2379.0, 2383.642453631952, 2395.8921848516684, 2405.0860672944254, 2416.9758302416926, 2432.5499782540287, 2439.1341073918857, 2449.730529641738, 2469.938251543708, 2475.7029156501335, 8521.701740439055, 8638.09300023501, 8804.823903521958, 8870.778230544223, 8871.157240062184, 5324.494173053554, 5448.972755136238, 5499.780008799643, 5506.724663766796, 5515.034868897927, 3376.4091284025444, 3376.7129793967542, 3449.6550344965553, 3496.0910163357457, 3506.2636846262317, 1126.7690123524658, 1129.0967226218993, 1136.1251836086167, 1170.4257773294905, 1175.7178277213493, 11926.880731192663, 12017.63947081589, 12086.697832554168, 12108.091893107963, 12110.757784844254, 4378.978105109454, 4591.127685739699, 4631.8378856739855, 4657.930131048037, 4677.555632214934, 9399.436033837992, 9405.57674904631, 9414.482203478738, 9415.246780257563, 9425.764355891157, 5253.369595648546, 5278.419373868871, 5281.841544753664, 5284.365876094893, 5286.0, 4834.105690447279, 4911.803527858917, 5025.773840177201, 5071.746412679351, 5123.052235336475, 3901.43429202764, 3930.665893399036, 3979.6418322350546, 4019.879403617896, 4041.515018197835, 1247.7504499100216, 1264.6585421936027, 1265.171312790124, 1276.655303068185, 1278.5780692371495, 920.3235621817959, 921.2215677752289, 935.5602866652663, 936.6066252174103, 938.2494004796135, 5600.691961942132, 5648.858778530487, 5695.515881150066, 5698.145278208219, 5812.128180772834, 895.5387975192781, 935.9906400936039, 936.498973049429, 956.6890760502864, 979.6081567372966, 3717.628237176261, 3919.9608003919598, 3977.8209980550946, 4012.7592344459426, 4040.070783719761, 10600.893991059991, 11034.0, 11059.0, 11075.944620276847, 11078.169137314733, 10105.090541851121, 10487.423191724376, 10692.893071069346, 10842.186835987333, 10848.349099054081, 8176.3458923286, 8187.631556579968, 8365.707200248084, 8383.580820958927, 8399.41204115706, 5759.337676167294, 5844.707764611668, 5906.468417842415, 5937.732802023833, 5949.167116603592, 9507.619695212114, 9797.216222702024, 9819.16537094355, 9851.753706157117, 9907.356021858555, 9873.851892221479, 9957.502124893581, 10037.247206459691, 10101.49492525356, 10175.084242418217, 6959.61722105289, 7164.2119366868565, 7620.5808680523105, 7884.487508311941, 8054.275115239422, 8462.746117616482, 8584.91415085841, 8586.914130858611, 8608.827823443622, 8613.052564217805, 7323.340899319087, 7392.926070739439, 7424.109106907205, 7526.962365188139, 7674.731384401519, 7632.465727399029, 7718.266764657348, 7745.341645960157, 7780.299773020455, 7820.257075577811, 6674.16572928384, 6725.529212955046, 6781.694823732845, 6787.89818152738, 6817.795466136024, 4929.0, 4963.677360971526, 5013.924791128063, 5030.974845125751, 5033.6476446648385, 4981.402231732215, 5039.912193174956, 5050.974745126251, 5092.821751238689, 5190.870228244324], "value": 4651.354826986946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.47767441628963, 341.3786907827753, 345.95675540557437, 352.68434750897944, 353.84961391408643, 5644.463775941279, 5740.397258287882, 5744.109663002236, 5817.476427121558, 5875.5005824504915, 5622.662640241578, 5679.801206957757, 5680.517156041741, 5690.60165788394, 5697.487226149646, 4442.2004039272915, 4448.843300741806, 4448.97775511122, 4460.843870464534, 4471.441069866267, 4357.782110894458, 4379.167958087953, 4433.88915277119, 4486.708363956349, 4491.281394976804, 4367.890802729926, 4369.519352871182, 4380.759058251795, 4383.232934236512, 4409.4488188976375, 4402.229609818285, 4429.889252768674, 4434.933475997863, 4435.356873253392, 4453.710508816916, 3793.8763238063957, 3818.179091495314, 3906.0625449891822, 3925.3915643075084, 3928.5285765708013, 5540.612157149001, 5607.271054762855, 5623.746931388097, 5624.45327534927, 5632.043177331892, 5052.595792336641, 5071.619628527838, 5083.74581270935, 5087.041489026751, 5107.463716309809, 5868.882622347572, 5992.161097446361, 6010.398960103955, 6014.939915556982, 6022.69886505673, 4239.173361194568, 4254.765987870697, 4258.53156152823, 4261.934516370908, 4268.146370725867, 6196.411340922605, 6287.088372186053, 6309.558330916838, 6329.936700632981, 6349.809315786047, 4191.350340697197, 4193.370994350811, 4202.600752928467, 4208.91582168361, 4328.632066274339, 4248.660107191417, 4264.829406823755, 4286.185624731291, 4296.2481565725875, 4296.2696341621995, 4973.364117017986, 4988.675736077216, 4996.975015124901, 5008.348914641073, 5030.4215015272985, 5687.516561092353, 5777.508911742465, 5915.58590898633, 6041.275046994301, 6075.2405949256345, 1454.7672372420361, 1461.7295800276984, 1465.6262653023412, 1469.7354476194387, 1474.7022620094249, 961.9519024048769, 962.9662961796444, 969.6218474794695, 970.8252514547308, 1012.4836333469837, 5522.6134170608475, 5546.362168350611, 5548.889022219533, 5571.275734154615, 5612.915806262909, 5940.0694774198555, 5961.5230781537375, 5975.462208401264, 5978.880422391615, 5995.940040599538, 5478.733926805144, 5520.972395138079, 5542.362628297717, 5562.0, 5620.718964051781, 3142.591463109781, 3143.512755522898, 3146.678395074074, 3148.449021421242, 3157.936841263162, 5990.550708696778, 6135.601185922901, 6151.0, 6194.5044396448175, 6204.751809927552, 6231.813045608639, 6280.591761535486, 6305.432511074026, 6305.905411418832, 6306.873862522724, 6512.251091124486, 6536.542442029107, 6547.803565893031, 6561.031690492929, 6581.934180658228, 6040.84897877539, 6118.736067654996, 6181.505479561714, 6182.568674385759, 6183.2686847680925, 6069.423404776539, 6071.483923866521, 6080.817575472743, 6113.969430152821, 6166.352532983972, 6274.811755647338, 6406.711697973509, 6432.581882177644, 6482.930316497914, 6500.772472963424, 4323.610875021263, 4344.326629372453, 4351.825007248089, 4352.78236088188, 4376.693631445768, 6017.909731353946, 6126.142340072304, 6201.627902325695, 6245.500359971101, 6260.780872669435, 5924.0, 5924.68937114517, 5931.6441013539325, 5939.524838013035, 5966.373530779206, 5906.940930590811, 5949.304448232233, 5954.76180952757, 5964.196827491072, 6024.186734790747, 5730.770769169353, 5885.823425297248, 5903.468687818117, 5923.4076592340425, 5925.340904546734, 6039.969800151147, 6043.09353596964, 6050.394960503914, 6068.423499767515, 6068.544859135494, 5692.544596432358, 5869.295684517885, 5889.352171261244, 5902.822915312548, 5957.314908785545], "value": 4527.378070343678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.6865253898443, 800.5956991719181, 840.9369297302704, 845.3701992015948, 906.306675393324, 14399.92800036001, 15231.695366092672, 16030.198490075494, 16477.752833707505, 16485.587860303498, 14998.100113993169, 15001.549953501413, 15101.697966040672, 15352.46266380677, 15440.536783896472, 880.6609455359701, 888.8977767556717, 889.8620713789373, 890.4078787606234, 890.4256754393413, 864.2481041493909, 873.7815546113471, 877.8770972063916, 885.5660726244126, 885.822835432916, 919.462114662923, 922.1331947968888, 925.2274350916958, 928.8885333759958, 929.502716046915, 910.2763303173992, 913.7395842184945, 916.9220616247627, 918.9770255743626, 919.889613246408, 674.8852695041854, 675.5203805298244, 676.1277951442634, 678.1252184681755, 680.0750978669006, 15226.923865380713, 15440.382384704599, 15630.609234769108, 15657.373705051785, 15775.92112039444, 14361.281935903164, 14510.1293922365, 14889.255537223204, 14989.400423983137, 15059.472918447802, 12210.877891221151, 12281.324527151002, 12298.016158707282, 12315.261084334968, 12429.75140497185, 3864.0, 3877.0695033191832, 3917.490726205575, 3965.7422267552806, 3972.523297204325, 67635.64728705399, 68022.65988670025, 68128.31871681269, 68153.65923170352, 68270.65864670694, 11133.220674552866, 11464.082873370111, 11493.655190344303, 11587.826182607268, 11683.532658693557, 21008.159673612885, 21075.473113172295, 21105.0, 21121.471963201042, 21126.683099753514, 7858.17489163641, 7863.685452581833, 8040.798980025546, 8061.516309021477, 8193.385496087698, 4212.199682060399, 4300.268954277781, 4362.716423432466, 4399.0, 4438.822447102144, 3502.422100353464, 3620.9094772630897, 3623.927521449556, 3783.6027217141805, 3811.3711237646035, 620.9161763161916, 622.4988883948374, 625.0998562070604, 632.2002666626721, 633.3571425003626, 618.4681174190193, 625.7622103600603, 641.8684169745285, 653.258551544001, 727.3889932456761, 9292.7676808079, 9801.950990245003, 9892.901070989197, 10198.541065652063, 10228.64199753005, 726.7202127181073, 731.830667473206, 755.7883792537988, 769.6998170713426, 770.1259070954507, 4625.398698169217, 4713.599344055794, 4737.786799594027, 4765.593961064746, 4804.6876952997945, 70686.0, 71777.2822271781, 73518.63240683763, 82032.58983705043, 83273.0, 46443.30335044977, 51095.0, 51358.48641513612, 73049.0, 73696.0, 69394.0, 70012.14933178724, 70379.59240815155, 70511.17955281834, 70799.2920070803, 9713.125818676353, 9944.204463642747, 10085.445300508543, 10097.949510252696, 10116.29185956976, 33634.15914602154, 36893.26213475662, 41501.0, 43952.78023609862, 45855.77072114751, 57684.0, 58369.0, 59018.70490647519, 59680.70159649174, 69393.30606693869, 13648.522301719393, 13799.379027943565, 13888.583342499742, 14223.07550009246, 14612.707745844811, 14141.575752727435, 14215.289235538388, 14512.0, 14521.636959076108, 14991.550253492413, 13866.306684665928, 13870.791938120734, 14057.648558786112, 14148.151110933377, 14374.496892609126, 13456.932715336361, 13959.790603141164, 14170.57488275312, 14397.784033239719, 14655.0, 13335.927289415831, 13433.66415839612, 13442.529511467052, 13493.797593035915, 13744.381502832597, 11359.48882300282, 11378.658640240807, 11570.305781653127, 11617.941910290394, 11953.22304050234, 11172.329660220414, 11186.944065279622, 11375.54497820078, 11457.0, 11590.652280431601], "value": 7367.108041597306, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 115.0, 112.0, 112.0, 112.0, 114.0, 114.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 120.0, 162.0, 119.0, 117.0, 118.0, 122.0, 149.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 165.0, 165.0, 162.0, 162.0, 163.0, 161.0, 163.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 107.0, 78.0, 75.0, 76.0, 75.0, 110.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 82.0, 81.0, 81.0, 98.0, 82.0, 81.0, 110.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 51.0, 50.0, 53.0, 50.0, 57.0, 50.0, 50.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 82.0, 75.0, 76.0, 74.0, 75.0, 74.0, 75.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 123.0, 133.0, 121.0, 129.0, 127.0, 120.0, 162.0, 122.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 157.0, 161.0, 154.0, 158.0, 161.0, 155.0, 158.0, 158.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 67.0, 70.0, 63.0, 62.0, 63.0, 61.0, 62.0, 62.0], "value": 63.9, "unit": "score"}]}]} 10:02:29 INFO - Return code: 0 10:02:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:29 ERROR - # TBPL SUCCESS # 10:02:29 INFO - Running post-action listener: _resource_record_post_action 10:02:29 INFO - [mozharness: 2017-02-08 18:02:29.653266Z] Finished run-tests step (success) 10:02:29 INFO - Running post-run listener: _resource_record_post_run 10:02:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317931520; Read time: 12; Write time: 240884 10:02:29 INFO - TinderboxPrint: CPU usage
13.2% 10:02:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:02:29 INFO - TinderboxPrint: I/O write bytes / time
317,931,520 / 240,884 10:02:29 INFO - TinderboxPrint: CPU idle
8,227.1 (86.8%) 10:02:29 INFO - TinderboxPrint: CPU user
1,200.9 (12.7%) 10:02:29 INFO - TinderboxPrint: Swap in / out
0 / 0 10:02:29 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101048320; Read time: 0; Write time: 87204 10:02:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 216883200; Read time: 12; Write time: 153680 10:02:30 INFO - Running post-run listener: _upload_blobber_files 10:02:30 INFO - Blob upload gear active. 10:02:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:02:30 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'] 10:02:30 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 10:02:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:31 INFO - (blobuploader) - INFO - Done attempting. 10:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:32 INFO - (blobuploader) - INFO - Done attempting. 10:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:35 INFO - (blobuploader) - INFO - Done attempting. 10:02:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:35 INFO - Return code: 0 10:02:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/159461232edf386ac4fc704b7e47ad312136e0080aa8542c47b977a61adbebe60c6c575fe90f0333b63b735853e4f7eb723fba6d82a023b3cb1320dd153369c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d207f2df1b7aac50997d124545ba610e76db61230f0a92101ab73287e892682826384173608b227a7da83d0a031930e7c0dd85df88ea9c7342ed3abf1852dea5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfcd840ab88e09319e9a49f178073bffdc4a3a1b83c258692e478055d99ac4e7384721eebac476190e539d20bf3cb1f89077c79ff2546e7ecb90e7110b80a868"} 10:02:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:35 INFO - Contents: 10:02:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/159461232edf386ac4fc704b7e47ad312136e0080aa8542c47b977a61adbebe60c6c575fe90f0333b63b735853e4f7eb723fba6d82a023b3cb1320dd153369c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d207f2df1b7aac50997d124545ba610e76db61230f0a92101ab73287e892682826384173608b227a7da83d0a031930e7c0dd85df88ea9c7342ed3abf1852dea5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfcd840ab88e09319e9a49f178073bffdc4a3a1b83c258692e478055d99ac4e7384721eebac476190e539d20bf3cb1f89077c79ff2546e7ecb90e7110b80a868"} 10:02:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:35 INFO - Copying logs to upload dir... 10:02:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.608903 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-08 10:02:35.315927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 10:02:35.319467) ========= 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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 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/159461232edf386ac4fc704b7e47ad312136e0080aa8542c47b977a61adbebe60c6c575fe90f0333b63b735853e4f7eb723fba6d82a023b3cb1320dd153369c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d207f2df1b7aac50997d124545ba610e76db61230f0a92101ab73287e892682826384173608b227a7da83d0a031930e7c0dd85df88ea9c7342ed3abf1852dea5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfcd840ab88e09319e9a49f178073bffdc4a3a1b83c258692e478055d99ac4e7384721eebac476190e539d20bf3cb1f89077c79ff2546e7ecb90e7110b80a868"} build_url:https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/ZPvYdlnTQs-DonAWqL4GJA/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/159461232edf386ac4fc704b7e47ad312136e0080aa8542c47b977a61adbebe60c6c575fe90f0333b63b735853e4f7eb723fba6d82a023b3cb1320dd153369c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d207f2df1b7aac50997d124545ba610e76db61230f0a92101ab73287e892682826384173608b227a7da83d0a031930e7c0dd85df88ea9c7342ed3abf1852dea5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfcd840ab88e09319e9a49f178073bffdc4a3a1b83c258692e478055d99ac4e7384721eebac476190e539d20bf3cb1f89077c79ff2546e7ecb90e7110b80a868"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 10:02:35.343589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:02:35.343885) ========= 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=fa44defc139c4ba8574fe040000001db-1486575722.681549-616014235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:02:35.426212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 10:02:35.426512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 10:02:35.426806) ========= ========= Total master_lag: 0.15 =========