builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1485243455.87 results: success (0) buildid: 20170123215343 builduid: bfd32c45eab04c74a269662b5c596776 revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:35.867532) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:35.868098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:35.868556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:35.895193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:35.895460) ========= 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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 23:37:36-- 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% 221M=0s 2017-01-23 23:37:36 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.032090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.032390) ========= 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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014255 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.095332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.095742) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1522cb56a651b62675f392d4064bd4365aac07f4 --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 1522cb56a651b62675f392d4064bd4365aac07f4 --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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 23:37:36,551 truncating revision to first 12 chars 2017-01-23 23:37:36,551 Setting DEBUG logging. 2017-01-23 23:37:36,551 attempt 1/10 2017-01-23 23:37:36,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1522cb56a651?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 23:37:37,236 unpacking tar archive at: mozilla-beta-1522cb56a651/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:37.050756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:37.051249) ========= script_repo_revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:37.051874) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:37.052373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:37.070108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-23 23:37:37.070557) ========= /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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:37:37 INFO - MultiFileLogger online at 20170123 23:37:37 in /builds/slave/test 23:37:37 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 23:37:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:37:37 INFO - {'append_to_log': False, 23:37:37 INFO - 'base_work_dir': '/builds/slave/test', 23:37:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:37:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:37:37 INFO - 'branch': 'Mozilla-Beta', 23:37:37 INFO - 'buildbot_json_path': 'buildprops.json', 23:37:37 INFO - 'config_files': ('talos/linux_config.py',), 23:37:37 INFO - 'default_actions': ('clobber', 23:37:37 INFO - 'read-buildbot-config', 23:37:37 INFO - 'download-and-extract', 23:37:37 INFO - 'populate-webroot', 23:37:37 INFO - 'create-virtualenv', 23:37:37 INFO - 'install', 23:37:37 INFO - 'run-tests'), 23:37:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:37:37 INFO - 'download_minidump_stackwalk': True, 23:37:37 INFO - 'download_symbols': 'ondemand', 23:37:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:37:37 INFO - 'tooltool.py': '/tools/tooltool.py', 23:37:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:37:37 INFO - '/tools/misc-python/virtualenv.py')}, 23:37:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:37:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:37:37 INFO - 'installer_path': 'installer.exe', 23:37:37 INFO - 'log_level': 'info', 23:37:37 INFO - 'log_name': 'talos', 23:37:37 INFO - 'log_to_console': True, 23:37:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:37:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:37:37 INFO - 'opt_config_files': (), 23:37:37 INFO - 'pip_index': False, 23:37:37 INFO - 'sps_profile': False, 23:37:37 INFO - 'sps_profile_interval': 0, 23:37:37 INFO - 'suite': 'dromaeojs-e10s', 23:37:37 INFO - 'system_bits': '32', 23:37:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:37:37 INFO - 'title': 'talos-linux64-ix-026', 23:37:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:37:37 INFO - 'use_talos_json': True, 23:37:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:37:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:37:37 INFO - 'work_dir': 'build'} 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.625679Z] Running clobber step. 23:37:37 INFO - Running pre-action listener: _resource_record_pre_action 23:37:37 INFO - Running main action method: clobber 23:37:37 INFO - rmtree: /builds/slave/test/build 23:37:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:37:38 INFO - Running post-action listener: _resource_record_post_action 23:37:38 INFO - [mozharness: 2017-01-24 07:37:38.622288Z] Finished clobber step (success) 23:37:38 INFO - [mozharness: 2017-01-24 07:37:38.622387Z] Running read-buildbot-config step. 23:37:38 INFO - Running pre-action listener: _resource_record_pre_action 23:37:38 INFO - Running main action method: read_buildbot_config 23:37:38 INFO - Using buildbot properties: 23:37:38 INFO - { 23:37:38 INFO - "project": "", 23:37:38 INFO - "product": "firefox", 23:37:38 INFO - "script_repo_revision": "production", 23:37:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:37:38 INFO - "repository": "", 23:37:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:37:38 INFO - "buildid": "20170123215343", 23:37:38 INFO - "pgo_build": "True", 23:37:38 INFO - "basedir": "/builds/slave/test", 23:37:38 INFO - "buildnumber": 46, 23:37:38 INFO - "slavename": "talos-linux64-ix-026", 23:37:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:37:38 INFO - "platform": "ubuntu64_hw", 23:37:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:37:38 INFO - "branch": "mozilla-beta", 23:37:38 INFO - "repo_path": "releases/mozilla-beta", 23:37:38 INFO - "revision": "1522cb56a651b62675f392d4064bd4365aac07f4", 23:37:38 INFO - "stage_platform": "linux64-pgo", 23:37:38 INFO - "builduid": "bfd32c45eab04c74a269662b5c596776", 23:37:38 INFO - "slavebuilddir": "test" 23:37:38 INFO - } 23:37:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 23:37:38 INFO - Running post-action listener: _resource_record_post_action 23:37:38 INFO - [mozharness: 2017-01-24 07:37:38.624817Z] Finished read-buildbot-config step (success) 23:37:38 INFO - [mozharness: 2017-01-24 07:37:38.624906Z] Running download-and-extract step. 23:37:38 INFO - Running pre-action listener: _resource_record_pre_action 23:37:38 INFO - Running main action method: download_and_extract 23:37:38 INFO - mkdir: /builds/slave/test/build/tests 23:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:37:38 INFO - trying https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:37:38 INFO - Downloading https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:39 INFO - Downloaded 1327 bytes. 23:37:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:37:39 INFO - Using the following test package requirements: 23:37:39 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:37:39 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:37:39 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 23:37:39 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'jsshell-linux-x86_64.zip'], 23:37:39 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:37:39 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:37:39 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 23:37:39 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 23:37:39 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:37:39 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:39 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:37:39 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:37:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:37:39 INFO - Http code: 200 23:37:39 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 23:37:39 INFO - x-amz-cf-id: MvgPLeZHM7jMZaMGU-KP4wValaG0XCnGxBmI391oRvUMFWpWJMmPgA== 23:37:39 INFO - x-amz-version-id: UOkRhVrUn__KnCFIQZag48EpYDIi_5f9 23:37:40 INFO - Expected file size: 21950328 23:37:40 INFO - Obtained file size: 21950328 23:37:44 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 23:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:37:44 INFO - Http code: 200 23:37:44 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 23:37:44 INFO - x-amz-cf-id: NtX1mLObi6LWQBsG4sYsbvteGhCIzAod9mwXQWaob-ypu573ulwBXw== 23:37:44 INFO - x-amz-version-id: UOkRhVrUn__KnCFIQZag48EpYDIi_5f9 23:37:44 INFO - Expected file size: 21950328 23:37:44 INFO - Obtained file size: 21950328 23:37:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 23:37:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:37:49 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 23:37:49 INFO - Http code: 200 23:37:49 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 23:37:49 INFO - x-amz-cf-id: CgrDNIzLnUL0HPKfrsbL44U0tXOfB6OhnpBnTSOlXqHCsF5WBr9tPA== 23:37:49 INFO - x-amz-version-id: VCl0zhyCKKu0czv99TM3mmcPJHOyqOgS 23:37:50 INFO - Expected file size: 14402992 23:37:50 INFO - Obtained file size: 14402992 23:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:37:50 INFO - trying https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:50 INFO - Downloading https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:51 INFO - Downloaded 57695407 bytes. 23:37:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:51 INFO - mkdir: /builds/slave/test/properties 23:37:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:37:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:37:51 INFO - Contents: 23:37:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:52 INFO - Running post-action listener: _resource_record_post_action 23:37:52 INFO - Running post-action listener: set_extra_try_arguments 23:37:52 INFO - [mozharness: 2017-01-24 07:37:52.017485Z] Finished download-and-extract step (success) 23:37:52 INFO - [mozharness: 2017-01-24 07:37:52.017714Z] Running populate-webroot step. 23:37:52 INFO - Running pre-action listener: _resource_record_pre_action 23:37:52 INFO - Running main action method: populate_webroot 23:37:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:37:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:37:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:37:52 INFO - '--tppagecycles', 23:37:52 INFO - '7'], 23:37:52 INFO - 'tests': ['tsvgm']}}, 23:37:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:37:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:37:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:37:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:37:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['damp', 'tps']}, 23:37:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'tests': ['damp', 'tps']}, 23:37:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['dromaeo_dom']}, 23:37:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:37:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['basic_compositor_video']}, 23:37:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:37:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['a11yr', 23:37:52 INFO - 'ts_paint', 23:37:52 INFO - 'tpaint', 23:37:52 INFO - 'sessionrestore', 23:37:52 INFO - 'sessionrestore_no_auto_restore', 23:37:52 INFO - 'tabpaint']}, 23:37:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['tsvgx', 23:37:52 INFO - 'tsvgr_opacity', 23:37:52 INFO - 'tart', 23:37:52 INFO - 'tscrollx', 23:37:52 INFO - 'cart']}, 23:37:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:37:52 INFO - 'tsvgr_opacity', 23:37:52 INFO - 'tart', 23:37:52 INFO - 'tscrollx', 23:37:52 INFO - 'cart']}, 23:37:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'talos_options': ['--disable-e10s'], 23:37:52 INFO - 'tests': ['tp5o']}, 23:37:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'tests': ['tp5o']}, 23:37:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'talos_options': ['--disable-e10s', 23:37:52 INFO - '--xperf_path', 23:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:52 INFO - 'tests': ['tp5n']}, 23:37:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:52 INFO - 'talos_options': ['--xperf_path', 23:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:52 INFO - 'tests': ['tp5n']}}, 23:37:52 INFO - 'talos.zip': {'path': '', 23:37:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:37:52 INFO - Running post-action listener: _resource_record_post_action 23:37:52 INFO - [mozharness: 2017-01-24 07:37:52.040214Z] Finished populate-webroot step (success) 23:37:52 INFO - [mozharness: 2017-01-24 07:37:52.040312Z] Running create-virtualenv step. 23:37:52 INFO - Running pre-action listener: _resource_record_pre_action 23:37:52 INFO - Running main action method: create_virtualenv 23:37:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:37:52 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 23:37:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:37:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:37:52 INFO - Using real prefix '/usr' 23:37:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:37:52 INFO - Installing distribute.............................................................................................................................................................................................done. 23:37:54 INFO - Installing pip.................done. 23:37:54 INFO - Return code: 0 23:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:37:54 INFO - Reading from file tmpfile_stdout 23:37:54 INFO - Output received: 23:37:54 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) 23:37:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:37:54 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')]} 23:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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')]} 23:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:37:54 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 23:37:54 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 23:37:54 INFO - Using env: {'DISPLAY': ':0', 23:37:54 INFO - 'HOME': '/home/cltbld', 23:37:54 INFO - 'LANG': 'en_US.UTF-8', 23:37:54 INFO - 'LANGUAGE': 'en_US:en', 23:37:54 INFO - 'LOGNAME': 'cltbld', 23:37:54 INFO - 'MAIL': '/var/mail/cltbld', 23:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:54 INFO - 'MOZ_NO_REMOTE': '1', 23:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:54 INFO - 'NO_EM_RESTART': '1', 23:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:54 INFO - 'PWD': '/builds/slave/test', 23:37:54 INFO - 'SHELL': '/bin/bash', 23:37:54 INFO - 'SHLVL': '1', 23:37:54 INFO - 'TERM': 'linux', 23:37:54 INFO - 'TMOUT': '86400', 23:37:54 INFO - 'USER': 'cltbld', 23:37:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:54 INFO - '_': '/tools/buildbot/bin/python'} 23:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:55 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 23:37:55 INFO - Cleaning up... 23:37:55 INFO - Return code: 0 23:37:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:37: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')]} 23:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37: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')]} 23:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:37:55 INFO - Using env: {'DISPLAY': ':0', 23:37:55 INFO - 'HOME': '/home/cltbld', 23:37:55 INFO - 'LANG': 'en_US.UTF-8', 23:37:55 INFO - 'LANGUAGE': 'en_US:en', 23:37:55 INFO - 'LOGNAME': 'cltbld', 23:37:55 INFO - 'MAIL': '/var/mail/cltbld', 23:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:55 INFO - 'MOZ_NO_REMOTE': '1', 23:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:55 INFO - 'NO_EM_RESTART': '1', 23:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:55 INFO - 'PWD': '/builds/slave/test', 23:37:55 INFO - 'SHELL': '/bin/bash', 23:37:55 INFO - 'SHLVL': '1', 23:37:55 INFO - 'TERM': 'linux', 23:37:55 INFO - 'TMOUT': '86400', 23:37:55 INFO - 'USER': 'cltbld', 23:37:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:55 INFO - '_': '/tools/buildbot/bin/python'} 23:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:55 INFO - Downloading/unpacking psutil>=3.1.1 23:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:57 INFO - Installing collected packages: psutil 23:37:57 INFO - Running setup.py install for psutil 23:37:57 INFO - building 'psutil._psutil_linux' extension 23:37:57 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 23:37:57 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 23:37:57 INFO - building 'psutil._psutil_posix' extension 23:37:57 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 23:37:57 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 23:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:57 INFO - Successfully installed psutil 23:37:57 INFO - Cleaning up... 23:37:57 INFO - Return code: 0 23:37:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:37:57 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')]} 23:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:57 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')]} 23:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:57 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:37:57 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 23:37:57 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 23:37:57 INFO - Using env: {'DISPLAY': ':0', 23:37:57 INFO - 'HOME': '/home/cltbld', 23:37:57 INFO - 'LANG': 'en_US.UTF-8', 23:37:57 INFO - 'LANGUAGE': 'en_US:en', 23:37:57 INFO - 'LOGNAME': 'cltbld', 23:37:57 INFO - 'MAIL': '/var/mail/cltbld', 23:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:57 INFO - 'MOZ_NO_REMOTE': '1', 23:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:57 INFO - 'NO_EM_RESTART': '1', 23:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:57 INFO - 'PWD': '/builds/slave/test', 23:37:57 INFO - 'SHELL': '/bin/bash', 23:37:57 INFO - 'SHLVL': '1', 23:37:57 INFO - 'TERM': 'linux', 23:37:57 INFO - 'TMOUT': '86400', 23:37:57 INFO - 'USER': 'cltbld', 23:37:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:57 INFO - '_': '/tools/buildbot/bin/python'} 23:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:37:58 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 23:37:58 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 23:37:58 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 23:37:58 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 23:37:58 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 23:37:58 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 23:38:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:38:00 INFO - Installing collected packages: mozsystemmonitor 23:38:00 INFO - Running setup.py install for mozsystemmonitor 23:38:00 INFO - Successfully installed mozsystemmonitor 23:38:00 INFO - Cleaning up... 23:38:00 INFO - Return code: 0 23:38:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:00 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:00 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 23:38:00 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 23:38:00 INFO - Using env: {'DISPLAY': ':0', 23:38:00 INFO - 'HOME': '/home/cltbld', 23:38:00 INFO - 'LANG': 'en_US.UTF-8', 23:38:00 INFO - 'LANGUAGE': 'en_US:en', 23:38:00 INFO - 'LOGNAME': 'cltbld', 23:38:00 INFO - 'MAIL': '/var/mail/cltbld', 23:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:00 INFO - 'MOZ_NO_REMOTE': '1', 23:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:00 INFO - 'NO_EM_RESTART': '1', 23:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:00 INFO - 'PWD': '/builds/slave/test', 23:38:00 INFO - 'SHELL': '/bin/bash', 23:38:00 INFO - 'SHLVL': '1', 23:38:00 INFO - 'TERM': 'linux', 23:38:00 INFO - 'TMOUT': '86400', 23:38:00 INFO - 'USER': 'cltbld', 23:38:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:00 INFO - '_': '/tools/buildbot/bin/python'} 23:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:00 INFO - Downloading/unpacking jsonschema==2.5.1 23:38:00 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 23:38:00 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 23:38:00 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 23:38:00 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 23:38:00 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 23:38:00 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 23:38:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:38:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:38:02 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 23:38:02 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 23:38:02 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 23:38:02 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 23:38:02 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 23:38:02 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 23:38:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:38:02 INFO - warning: no files found matching '*.txt' 23:38:02 INFO - no previously-included directories found matching 'build' 23:38:02 INFO - no previously-included directories found matching 'dist' 23:38:02 INFO - no previously-included directories found matching '.git*' 23:38:02 INFO - Installing collected packages: jsonschema, functools32 23:38:02 INFO - Running setup.py install for functools32 23:38:03 INFO - warning: no files found matching '*.txt' 23:38:03 INFO - no previously-included directories found matching 'build' 23:38:03 INFO - no previously-included directories found matching 'dist' 23:38:03 INFO - no previously-included directories found matching '.git*' 23:38:03 INFO - Successfully installed jsonschema functools32 23:38:03 INFO - Cleaning up... 23:38:03 INFO - Return code: 0 23:38:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:38:03 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')]} 23:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:03 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')]} 23:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:03 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:03 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 23:38:03 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 23:38:03 INFO - Using env: {'DISPLAY': ':0', 23:38:03 INFO - 'HOME': '/home/cltbld', 23:38:03 INFO - 'LANG': 'en_US.UTF-8', 23:38:03 INFO - 'LANGUAGE': 'en_US:en', 23:38:03 INFO - 'LOGNAME': 'cltbld', 23:38:03 INFO - 'MAIL': '/var/mail/cltbld', 23:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:03 INFO - 'MOZ_NO_REMOTE': '1', 23:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:03 INFO - 'NO_EM_RESTART': '1', 23:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:03 INFO - 'PWD': '/builds/slave/test', 23:38:03 INFO - 'SHELL': '/bin/bash', 23:38:03 INFO - 'SHLVL': '1', 23:38:03 INFO - 'TERM': 'linux', 23:38:03 INFO - 'TMOUT': '86400', 23:38:03 INFO - 'USER': 'cltbld', 23:38:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:03 INFO - '_': '/tools/buildbot/bin/python'} 23:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:38:03 INFO - Cleaning up... 23:38:03 INFO - Return code: 0 23:38:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:38:03 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')]} 23:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:03 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')]} 23:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:03 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:03 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 23:38:03 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 23:38:03 INFO - Using env: {'DISPLAY': ':0', 23:38:03 INFO - 'HOME': '/home/cltbld', 23:38:03 INFO - 'LANG': 'en_US.UTF-8', 23:38:03 INFO - 'LANGUAGE': 'en_US:en', 23:38:03 INFO - 'LOGNAME': 'cltbld', 23:38:03 INFO - 'MAIL': '/var/mail/cltbld', 23:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:03 INFO - 'MOZ_NO_REMOTE': '1', 23:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:03 INFO - 'NO_EM_RESTART': '1', 23:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:03 INFO - 'PWD': '/builds/slave/test', 23:38:03 INFO - 'SHELL': '/bin/bash', 23:38:03 INFO - 'SHLVL': '1', 23:38:03 INFO - 'TERM': 'linux', 23:38:03 INFO - 'TMOUT': '86400', 23:38:03 INFO - 'USER': 'cltbld', 23:38:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:03 INFO - '_': '/tools/buildbot/bin/python'} 23:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:38:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:38:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 INFO - Downloading docopt-0.6.1.tar.gz 23:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:38:06 INFO - Running setup.py install for blobuploader 23:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:38:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:38:06 INFO - Running setup.py install for requests 23:38:06 INFO - Running setup.py install for docopt 23:38:06 INFO - Successfully installed blobuploader requests docopt 23:38:06 INFO - Cleaning up... 23:38:06 INFO - Return code: 0 23:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:06 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')]} 23:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:06 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')]} 23:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:06 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:06 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 23:38:06 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 23:38:06 INFO - Using env: {'DISPLAY': ':0', 23:38:06 INFO - 'HOME': '/home/cltbld', 23:38:06 INFO - 'LANG': 'en_US.UTF-8', 23:38:06 INFO - 'LANGUAGE': 'en_US:en', 23:38:06 INFO - 'LOGNAME': 'cltbld', 23:38:06 INFO - 'MAIL': '/var/mail/cltbld', 23:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:06 INFO - 'MOZ_NO_REMOTE': '1', 23:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:06 INFO - 'NO_EM_RESTART': '1', 23:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:06 INFO - 'PWD': '/builds/slave/test', 23:38:06 INFO - 'SHELL': '/bin/bash', 23:38:06 INFO - 'SHLVL': '1', 23:38:06 INFO - 'TERM': 'linux', 23:38:06 INFO - 'TMOUT': '86400', 23:38:06 INFO - 'USER': 'cltbld', 23:38:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:06 INFO - '_': '/tools/buildbot/bin/python'} 23:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:38:07 INFO - Running setup.py (path:/tmp/pip-fb799p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:38:07 INFO - Running setup.py (path:/tmp/pip-SLjwwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:38:07 INFO - Running setup.py (path:/tmp/pip-E6h225-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:38:07 INFO - Running setup.py (path:/tmp/pip-Iqok6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:38:07 INFO - Running setup.py (path:/tmp/pip-SlMPWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:38:07 INFO - Running setup.py (path:/tmp/pip-qN6RDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:38:07 INFO - Running setup.py (path:/tmp/pip-Ud8izn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:38:07 INFO - Running setup.py (path:/tmp/pip-I0vNhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:38:07 INFO - Running setup.py (path:/tmp/pip-zbyfwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:38:07 INFO - Running setup.py (path:/tmp/pip-5JiKgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:38:07 INFO - Running setup.py (path:/tmp/pip-4Uq7Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:38:07 INFO - Running setup.py (path:/tmp/pip-bO8EAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:38:08 INFO - Running setup.py (path:/tmp/pip-gt__xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:38:08 INFO - Running setup.py (path:/tmp/pip-i7SCTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:08 INFO - Running setup.py (path:/tmp/pip-KCN8RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:38:08 INFO - Running setup.py (path:/tmp/pip-zyUQ6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:38:08 INFO - Running setup.py (path:/tmp/pip-FX8dff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:38:08 INFO - Running setup.py install for manifestparser 23:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:38:08 INFO - Running setup.py install for mozcrash 23:38:08 INFO - Running setup.py install for mozdebug 23:38:08 INFO - Running setup.py install for mozdevice 23:38:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:38:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:38:08 INFO - Running setup.py install for mozfile 23:38:08 INFO - Running setup.py install for mozhttpd 23:38:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:38:08 INFO - Running setup.py install for mozinfo 23:38:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozInstall 23:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozleak 23:38:09 INFO - Running setup.py install for mozlog 23:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for moznetwork 23:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozprocess 23:38:09 INFO - Running setup.py install for mozprofile 23:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozrunner 23:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozscreenshot 23:38:09 INFO - Running setup.py install for moztest 23:38:10 INFO - Running setup.py install for mozversion 23:38:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:38:10 INFO - Cleaning up... 23:38:10 INFO - Return code: 0 23:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:10 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:10 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 23:38:10 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 23:38:10 INFO - Using env: {'DISPLAY': ':0', 23:38:10 INFO - 'HOME': '/home/cltbld', 23:38:10 INFO - 'LANG': 'en_US.UTF-8', 23:38:10 INFO - 'LANGUAGE': 'en_US:en', 23:38:10 INFO - 'LOGNAME': 'cltbld', 23:38:10 INFO - 'MAIL': '/var/mail/cltbld', 23:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:10 INFO - 'MOZ_NO_REMOTE': '1', 23:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:10 INFO - 'NO_EM_RESTART': '1', 23:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:10 INFO - 'PWD': '/builds/slave/test', 23:38:10 INFO - 'SHELL': '/bin/bash', 23:38:10 INFO - 'SHLVL': '1', 23:38:10 INFO - 'TERM': 'linux', 23:38:10 INFO - 'TMOUT': '86400', 23:38:10 INFO - 'USER': 'cltbld', 23:38:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:10 INFO - '_': '/tools/buildbot/bin/python'} 23:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:38:10 INFO - Running setup.py (path:/tmp/pip-KSITpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:38:10 INFO - Running setup.py (path:/tmp/pip-yfaOVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:38:10 INFO - Running setup.py (path:/tmp/pip-vHyjl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:38:10 INFO - Running setup.py (path:/tmp/pip-ntEzTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:38:10 INFO - Running setup.py (path:/tmp/pip-EBFV2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:38:10 INFO - Running setup.py (path:/tmp/pip-WQFzcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:38:10 INFO - Running setup.py (path:/tmp/pip-gVq6YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:38:10 INFO - Running setup.py (path:/tmp/pip-CxnASf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:38:10 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)) 23:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:38:10 INFO - Running setup.py (path:/tmp/pip-X_rYYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:38:11 INFO - Running setup.py (path:/tmp/pip-QUjA2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:38:11 INFO - Running setup.py (path:/tmp/pip-yQNd6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:38:11 INFO - Running setup.py (path:/tmp/pip-sbxSIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:38:11 INFO - Running setup.py (path:/tmp/pip-QDgm2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:38:11 INFO - Running setup.py (path:/tmp/pip-L7Qlfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:11 INFO - Running setup.py (path:/tmp/pip-kc7fus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:38:11 INFO - Running setup.py (path:/tmp/pip-HLRaSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:38:11 INFO - Running setup.py (path:/tmp/pip-cNZrba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:38:11 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)) 23:38:11 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)) 23:38:11 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)) 23:38:11 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)) 23:38:11 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)) 23:38:11 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)) 23:38:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:38:11 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 23:38:11 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 23:38:11 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 23:38:11 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 23:38:11 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 23:38:11 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 23:38:13 INFO - Downloading blessings-1.6.tar.gz 23:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:38:13 INFO - Installing collected packages: blessings 23:38:13 INFO - Running setup.py install for blessings 23:38:13 INFO - Successfully installed blessings 23:38:13 INFO - Cleaning up... 23:38:13 INFO - Return code: 0 23:38:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:14 INFO - Reading from file tmpfile_stdout 23:38:14 INFO - Current package versions: 23:38:14 INFO - argparse == 1.2.1 23:38:14 INFO - blessings == 1.6 23:38:14 INFO - blobuploader == 1.2.4 23:38:14 INFO - docopt == 0.6.1 23:38:14 INFO - functools32 == 3.2.3-2 23:38:14 INFO - jsonschema == 2.5.1 23:38:14 INFO - manifestparser == 1.1 23:38:14 INFO - mozInstall == 1.12 23:38:14 INFO - mozcrash == 1.0 23:38:14 INFO - mozdebug == 0.1 23:38:14 INFO - mozdevice == 0.48 23:38:14 INFO - mozfile == 1.2 23:38:14 INFO - mozhttpd == 0.7 23:38:14 INFO - mozinfo == 0.9 23:38:14 INFO - mozleak == 0.1 23:38:14 INFO - mozlog == 3.4 23:38:14 INFO - moznetwork == 0.27 23:38:14 INFO - mozprocess == 0.23 23:38:14 INFO - mozprofile == 0.28 23:38:14 INFO - mozrunner == 6.13 23:38:14 INFO - mozscreenshot == 0.1 23:38:14 INFO - mozsystemmonitor == 0.3 23:38:14 INFO - moztest == 0.8 23:38:14 INFO - mozversion == 1.4 23:38:14 INFO - psutil == 3.1.1 23:38:14 INFO - requests == 1.2.3 23:38:14 INFO - wsgiref == 0.1.2 23:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:14 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 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:14 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 23:38:14 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 23:38:14 INFO - Using env: {'DISPLAY': ':0', 23:38:14 INFO - 'HOME': '/home/cltbld', 23:38:14 INFO - 'LANG': 'en_US.UTF-8', 23:38:14 INFO - 'LANGUAGE': 'en_US:en', 23:38:14 INFO - 'LOGNAME': 'cltbld', 23:38:14 INFO - 'MAIL': '/var/mail/cltbld', 23:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:14 INFO - 'MOZ_NO_REMOTE': '1', 23:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:14 INFO - 'NO_EM_RESTART': '1', 23:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:14 INFO - 'PWD': '/builds/slave/test', 23:38:14 INFO - 'SHELL': '/bin/bash', 23:38:14 INFO - 'SHLVL': '1', 23:38:14 INFO - 'TERM': 'linux', 23:38:14 INFO - 'TMOUT': '86400', 23:38:14 INFO - 'USER': 'cltbld', 23:38:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:14 INFO - '_': '/tools/buildbot/bin/python'} 23:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 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)) 23:38:14 INFO - Cleaning up... 23:38:14 INFO - Return code: 0 23:38:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb43baef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, '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': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', '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 23:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:38:14 INFO - Using env: {'DISPLAY': ':0', 23:38:14 INFO - 'HOME': '/home/cltbld', 23:38:14 INFO - 'LANG': 'en_US.UTF-8', 23:38:14 INFO - 'LANGUAGE': 'en_US:en', 23:38:14 INFO - 'LOGNAME': 'cltbld', 23:38:14 INFO - 'MAIL': '/var/mail/cltbld', 23:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:14 INFO - 'MOZ_NO_REMOTE': '1', 23:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:14 INFO - 'NO_EM_RESTART': '1', 23:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:14 INFO - 'PWD': '/builds/slave/test', 23:38:14 INFO - 'SHELL': '/bin/bash', 23:38:14 INFO - 'SHLVL': '1', 23:38:14 INFO - 'TERM': 'linux', 23:38:14 INFO - 'TMOUT': '86400', 23:38:14 INFO - 'USER': 'cltbld', 23:38:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:14 INFO - '_': '/tools/buildbot/bin/python'} 23:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:38:14 INFO - Cleaning up... 23:38:14 INFO - Return code: 0 23:38:14 INFO - Running post-action listener: _resource_record_post_action 23:38:14 INFO - Running post-action listener: _start_resource_monitoring 23:38:14 INFO - Starting resource monitoring. 23:38:14 INFO - [mozharness: 2017-01-24 07:38:14.609408Z] Finished create-virtualenv step (success) 23:38:14 INFO - [mozharness: 2017-01-24 07:38:14.609868Z] Running install step. 23:38:14 INFO - Running pre-action listener: _resource_record_pre_action 23:38:14 INFO - Running main action method: install 23:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:14 INFO - Reading from file tmpfile_stdout 23:38:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:38:14 INFO - Reading from file tmpfile_stdout 23:38:14 INFO - Output received: 23:38:14 INFO - Usage: mozinstall [options] installer 23:38:14 INFO - Options: 23:38:14 INFO - -h, --help show this help message and exit 23:38:14 INFO - -d DEST, --destination=DEST 23:38:14 INFO - Directory to install application into. [default: 23:38:14 INFO - "/builds/slave/test"] 23:38:14 INFO - --app=APP Application being installed. [default: firefox] 23:38:14 INFO - mkdir: /builds/slave/test/build/application 23:38:14 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'] 23:38:14 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 23:38:28 INFO - Reading from file tmpfile_stdout 23:38:28 INFO - Output received: 23:38:28 INFO - /builds/slave/test/build/application/firefox/firefox 23:38:28 INFO - Running post-action listener: _resource_record_post_action 23:38:28 INFO - [mozharness: 2017-01-24 07:38:28.544623Z] Finished install step (success) 23:38:28 INFO - [mozharness: 2017-01-24 07:38:28.544866Z] Running run-tests step. 23:38:28 INFO - Running pre-action listener: _resource_record_pre_action 23:38:28 INFO - Running main action method: run_tests 23:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:38:28 INFO - Python 2.7.3 23:38:28 INFO - Return code: 0 23:38:28 INFO - grabbing minidump binary from tooltool 23:38:28 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')]} 23:38:28 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 0x10a1f60>, '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 0x10a2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:38:28 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 23:38:28 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 23:38:28 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 23:38:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:38:28 INFO - Return code: 0 23:38:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:38:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:38:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:38:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:38:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:38:28 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/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:38:28 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/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 23:38:28 INFO - Using env: {'DISPLAY': ':0', 23:38:28 INFO - 'HOME': '/home/cltbld', 23:38:28 INFO - 'LANG': 'en_US.UTF-8', 23:38:28 INFO - 'LANGUAGE': 'en_US:en', 23:38:28 INFO - 'LOGNAME': 'cltbld', 23:38:28 INFO - 'MAIL': '/var/mail/cltbld', 23:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:28 INFO - 'MOZ_NO_REMOTE': '1', 23:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:28 INFO - 'NO_EM_RESTART': '1', 23:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:28 INFO - 'PWD': '/builds/slave/test', 23:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:38:28 INFO - 'SHELL': '/bin/bash', 23:38:28 INFO - 'SHLVL': '1', 23:38:28 INFO - 'TERM': 'linux', 23:38:28 INFO - 'TMOUT': '86400', 23:38:28 INFO - 'USER': 'cltbld', 23:38:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106', 23:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:28 INFO - '_': '/tools/buildbot/bin/python'} 23:38:28 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/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:38:28 INFO - mozversion application_buildid: 20170123215343 23:38:28 INFO - mozversion application_changeset: 1522cb56a651b62675f392d4064bd4365aac07f4 23:38:28 INFO - mozversion application_display_name: Firefox 23:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:38:28 INFO - mozversion application_name: Firefox 23:38:28 INFO - mozversion application_remotingname: firefox 23:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:38:28 INFO - mozversion application_vendor: Mozilla 23:38:28 INFO - mozversion application_version: 52.0 23:38:28 INFO - mozversion platform_buildid: 20170123215343 23:38:28 INFO - mozversion platform_changeset: 1522cb56a651b62675f392d4064bd4365aac07f4 23:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:38:28 INFO - mozversion platform_version: 52.0 23:38:28 INFO - using testdate: 1485243508 23:38:28 INFO - actual date: 1485243508 23:38:28 INFO - starting webserver on 'localhost:43467' 23:38:28 INFO - SUITE-START | Running 2 tests 23:38:28 INFO - TEST-START | dromaeo_css 23:38:28 INFO - operating with platform_type : linux_ 23:38:28 INFO - Initialising browser for dromaeo_css test... 23:38:28 INFO - TEST-INFO | started process 21862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbmM3v/profile http://localhost:43467/getInfo.html) 23:38:33 INFO - PROCESS | 21862 | __metrics Screen width/height:1600/1200 23:38:33 INFO - PROCESS | 21862 | colorDepth:24 23:38:33 INFO - PROCESS | 21862 | Browser inner width/height: 1024/697 23:38:33 INFO - PROCESS | 21862 | __metrics 23:38:33 ERROR - PROCESS | 21862 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 23:38:34 INFO - TEST-INFO | 21862: exit 0 23:38:34 INFO - Browser initialized. 23:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 23:38:34 INFO - TEST-INFO | started process 21992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbmM3v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:46 INFO - PROCESS | 21992 | RSS: Main: 148541440 23:38:46 INFO - PROCESS | 21992 | 23:41:45 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43467/tests/dromaeo/cssquery-ext.html) 23:41:46 INFO - PROCESS | 21992 | RSS: Main: 154882048 23:41:46 INFO - PROCESS | 21992 | 23:44:48 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-ext.html (next: http://localhost:43467/tests/dromaeo/cssquery-jquery.html) 23:44:49 INFO - PROCESS | 21992 | RSS: Main: 152363008 23:44:49 INFO - PROCESS | 21992 | 23:47:51 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43467/tests/dromaeo/cssquery-mootools.html) 23:47:51 INFO - PROCESS | 21992 | RSS: Main: 152506368 23:47:51 INFO - PROCESS | 21992 | 23:50:53 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43467/tests/dromaeo/cssquery-prototype.html) 23:50:54 INFO - PROCESS | 21992 | RSS: Main: 154120192 23:50:54 INFO - PROCESS | 21992 | 23:53:56 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43467/tests/dromaeo/cssquery-yui.html) 23:53:57 INFO - PROCESS | 21992 | RSS: Main: 155213824 23:53:57 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:43467/tests/dromaeo/cssquery-yui.html (next: http://localhost:43467/tests/dromaeo/cssquery-dojo.html) 23:56:59 INFO - PROCESS | 21992 | RSS: Main: 155168768 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | __start_tp_report 23:56:59 INFO - PROCESS | 21992 | _x_x_mozilla_page_load 23:56:59 INFO - PROCESS | 21992 | _x_x_mozilla_page_load_details 23:56:59 INFO - PROCESS | 21992 | |i|pagename|runs| 23:56:59 INFO - PROCESS | 21992 | |0;dojo.html;3230.693084157005;3234.5471633971247;3252.268239646079;3253.3655937092276;3257.234549880779;5622.690752008643;5663.8955403696245;5665.4334566543375;5668.206451096849;5670.914936275959;5729.971350143254;5772.249607551013;5781.219535362725;5786.537077033838;5790;5161.66449180803;5225.555827754626;5233.685978841263;5264.8157314494;5279.9208011879855;5282.07563676357;5289.259503669489;5290.6825590464505;5291.761870715808;5311.123664595337;5040.924386134211;5075.365579302587;5124.359455068116;5284.867878303035;5285.392179899303;5174.43081261061;5248.029114613771;5251.186066159713;5260.815871444519;5273.947260527384;5146.125158722989;5220.138677118271;5227.242049902743;5230.372355317349;5233.581313494911;5471.753771080311;5541.473560011793;5641.182028605829;5657.462541058593;5754;5999.800039991976;6057.757689692407;6083;6083.270007599072;6145.832291864576;6175.96912015437;6182.289036760785;6187.412195841388;6199;6219.440250377443;5620.185073164368;5742.425757424224;5745.798897038583;5753.798617048383;5762.769489220426;6190.350013248544;6300.338464461257;6307.716152773136;6311.021791622214;6311.779087731908;6020.09698545213;6028.065649824284;6045.274567051982;6051.848703782441;6053.485453736482;6034.758609655652;6072.574919755575;6076.848078798065;6115.052166914135;6129.724162412702;6108.5418593605655;6110.969445152746;6111.052786818051;6120.540959428061;6129.019356902963;6107.541934354941;6114.357992410822;6114.908276375858;6120.204373431515;6121.204243448323;4561.521040290788;4592.058627981256;4620.491745907947;4625.884352891205;4653.488116307203;4138.627523522898;4148.502179738391;4152.501699796044;4165.12532368206;4192.24539582878;5798.159266906359;5829.621074630136;5841.094630332305;5847.678377689268;5854.2974843018255;5992;6043.395660433922;6071.817845464643;6134.294556126013;6140.815775526652;5765.279340082489;5866.501347385435;5883.17635531026;5883.911741323884;5899.46904778572;5304.814331498379;5306.8407947761625;5312.654677445954;5330.387005494418;5340.893182136336;6104.694765261808;6196.81409557714;6402.807915762534;6415.871682566322;6437.742490300336;6068.6358818471035;6093.025115981422;6137.468918203611;6195.411435913581;6200.100985357008;6388.329225431263;6442.581232219891;6445.065465507569;6447.548671592944;6448.451881590117;5748.252727145445;6047.848803779941;6072.14989901423;6077.24034495688;6079.088136779518;5949.6430214187285;6088.6042407243385;6109.358517355614;6144.815655530341;6190.133381326528;5974;6009.669468179292;6028.09578563219;6030.03519436888;6033;5975.103734439869;6001.729922153426;6010.579259451796;6010.789622363196;6040.486558642565;5682.857928551819;5833.883322333614;5900.527957763283;5969.224000879858;5971.970140149271;5972.940270597239;6006.309274433322;6048.4858787003595;6051.3041000283765;6052.90920636182;5665.12190610456;5888.646681199141;5889.52883769306;5889.941100589111;5892.558058145742 23:56:59 INFO - PROCESS | 21992 | |1;ext.html;571.2744814086111;615.1910238036982;651.8207492939442;665.843526771209;678.0947435174043;43533.34699979499;44333.33499997503;44756.552434475685;49422;49491;44773.776131119295;45026;45299.547004529944;45343.54656453434;45431;8971.46171229725;9152.908470915305;9156.175944165025;9157.175854173123;9158.86261706075;9047.366684332099;9130.817383652324;9132.178103970642;9134.954325228398;9135.862962055542;9146.31402644801;9147.039560846115;9162.496062716547;9178.816423671522;9182.219511341544;9149.451032938045;9150.86273705895;9184.540772961325;9189.540522973857;9204.033576474474;8992.370534062618;9062.093790620951;9074.18332350085;9106.726798195998;9109.681161159328;44332.556674433166;44613.33080003803;44776.77611611954;44789;44881.32678009832;3424.229548351626;3726.9440958385644;3858.0162058675137;4099.590040995907;4222.071144348239;32486.35027299441;32836.3432731344;33019.66980330214;33496.33007339864;33553;4323.848665296699;4521.570450807168;4539.182947069559;4548.727076375428;4565.315202719618;257984;258277;258353;259031;259648;59691;59712.40287597155;59799.701001494715;59932.70033649804;60021;64079.67960160263;64109.358906411275;64114.0382894257;64129;64318.35681643217;17489.125543723017;17490.562735931704;17543.29826806939;17637.29450821953;17680.381186658404;14451.638709032148;14646.780298295535;14687.632809179857;14747.631309217355;14764.335604897806;16077.919610401874;16474.917625411796;16485;16628.916855415646;16857.15714214309;6059.666718330534;6167.383261673886;6189.288231853305;6201.379862013853;6298.370162983665;978.4178413843752;1041.6146025970288;1042.1558537584428;1070.0675019304026;1083.8374243863484;31447.84276078651;31528;32139.196520087185;32267.838660806545;32367;1082.3884505254507;1084.6149616885891;1144.181909934401;1177.923434976741;1198.532572296805;16201.189940502927;16594.50216493507;16826.495205143867;17229.138543072797;17382.478525644252;505594;508223;509126;509795;513850;59968.10047849286;60148.69925650344;60239;60303;60345.698271508365;1232.8705485924029;1253.3983687829893;1328.0371730495506;1371.9931400343135;1411.266141606359;31410.52884206693;31906.840465797522;32016;32176.517352239265;32894.34211315712;52230.21654675259;52596;52638;52683;52836.20745688741;462925;465695;467139;472863;473007;28905.421891562473;29040.564391534568;29052.709472905844;29124.27189320284;29348.706512934597;45732;46729.53270467252;47054.76472617615;47149.76425117852;47623.761881190374;39528.209435810546;39939;40245.37670719631;41038.17923641451;41765;38713.61286387213;40588.594114058484;40910.386344204264;41404.1719165621;41501;40576.39135412912;40649.18701625892;40893.38659920044;41076;41214.38178427266;34955.82522087373;36178.4573231407;36871.89384318475;36872.26255474929;36964;23074.884625576764;23185.188518401774;23289.3013209604;23326.76673233246;23505.74540517306 23:56:59 INFO - PROCESS | 21992 | |2;jquery.html;404.77939522959986;429.44601464111287;432.3881707384051;432.84791607020685;432.99999999999983;19101.522461938443;19876.40370788875;20309.593808123827;20332.18671253152;20742;19001.239950401967;19222;19347.419577412664;19382.321618743346;19917.800821991776;5704.572157088214;5884.293884733838;5914.260717410324;5915.378885217055;5915.911261331084;5636.323641163046;5778.24882765242;5788.47903688668;5854.29748430189;5882.294124705041;5741.540676745871;5741.569382296324;5775.942240577603;5795.072788353864;5796.391378905218;5568.832935011936;5742.08126699726;5756.597038207327;5766.538676905859;5795.1017592273265;5251.76367063483;5252.133397989327;5252.816151434719;5256.737163141827;5260.736963151827;24325.148619798398;24356.269311920492;24501.38746531333;24606;24740.628890566655;2464.913728019511;2576.7680908718116;2699.9055033073746;3141.952088695294;3171.777975541713;14946.551603451913;15174.24128793556;15436.073835569901;15437.768433473508;15671.138087405188;1976.6145601607693;2008.0562135796151;2089.185217765073;2125;2141.796529329711;85959;86362.99999999937;86622;87884;89140;10962.671119866416;11040.171987101;11139.498722557504;11276.436178191057;11549.249298795552;16383.09892955875;16410.507684769476;16423.91788041052;16424.260908259155;16427.425040123777;8263.876041859377;8494.74515764528;8504.532250726146;8676.089010653917;8733.995590507046;7904.920950790533;7981.082175549886;8124.471909325875;8223;8437.95781021091;6933.618650974245;7049.577025378494;7200.099987501562;7233;7235.602041887747;2012.8872663435004;2087.6137914485867;2107.903889977203;2132.1130799242783;2153.300177442306;911.5032307392487;1028.0313200221642;1058.6188971970084;1075.4138994248153;1146.5986904583497;19165.808341916403;19768;20289.898550507154;20428.0807363669;20623.071961761758;1034.1209971524295;1035.5184839049878;1043.4991204222015;1048.8479170520231;1064.2603390643428;11245.212835101627;11380.374079425712;11542.422878856023;11613.535458581562;11765.11761617882;504766;529235;533578;541011;548643;82555.5872220647;85670;89196.5540172295;99168;102897.48551257196;1042.6507120114695;1060.114804138553;1074.897884700952;1076.590895459736;1085.175266797224;18223.45329640113;18622.348217812312;18798.15408306602;18814.717779233048;18961.241550337832;33187.50218746769;44108.11783764371;45514.999999998676;45515.77242113901;45813.770931146464;62951.6852415735;63346.36653633405;65403.345966539724;65646.34353656594;66116;7926.801829954297;8293.751187464386;8865;8939.195472407515;9042.773930651787;13821.378037988114;13917.440938402075;14029.508967186099;14219.64450888736;14242.501512447014;12174;12207.389630518615;12250.571230007263;12367;12501.687457813627;11627.302361858316;11934.880651193724;12013.399330033639;12122.939385303018;12130.272183669009;12022.158448908493;12164.939175304067;12172.939135304267;12441.564545240873;12485.12604117703;7968.482048666818;8128.918710812816;8256.958715206385;8323.916760832315;8672.26285765717;11689.357085360387;12088.335141566946;12110;12127.272363658209;12424.06819488524 23:56:59 INFO - PROCESS | 21992 | |3;mootools.html;1510.2146883620514;1549.907005579665;1644.1943447710626;1773.405909020478;1808.61114860305;8546.102659220785;8808.251298639623;9123.863142052875;9133.99999999999;9140.40587361821;9017.143371379725;9128.224100951427;9172.449653020823;9189.77025574361;9300.395474294166;2422.3580751100926;2483.292261705414;2487.340854673513;2495.4884248728968;2495.9251222463354;2425.139075628153;2505.4863752930605;2521.2940376694555;2531.253280282312;2531.4304281536597;2423.684920960273;2430.16159424999;2470.036685692581;2470.567650661136;2474.6782918220606;2356.4108972756726;2363.5981883079917;2377.619580867062;2379.6073647848084;2381.4165529445395;2382.1662418153683;2399.9760002399926;2401.7598240176017;2415.3599296186526;2420.310211589706;9000.729978100668;9090.909090909072;9133.132352426508;9161.49611771359;9164.175224229852;5425.9728701356635;5598.076317407623;5655.1517272409465;5661.207430959669;5664.971675141639;3435.3301106284034;3455.6544345565244;3461.4807778833124;3464.8787292444645;3546.2730140321173;1113.9944300278446;1135.1372956552996;1135.4833550734395;1161.349644199251;1200.6578125234353;12334.81497777534;12350.258984460872;12408.379581020912;12412.255264684149;12429.129960902741;4344.152890186447;4669.976650116728;4705.106029854317;4852.078105160008;4857.271409288564;9744.658936937172;9790.314677972474;9796.755081123029;9798.510074496247;9807.950960245153;5278.630495865329;5289.3917199521775;5321.787128514816;5349.491798279158;5353.7590808413715;4887.266909963534;5065.670731402447;5069.1635880079375;5121.61587880903;5180.792768289301;4095.4165690638024;4102.979485102555;4113.568075352105;4123.299039163349;4152.792360381969;1263.4314558448734;1271.2690203133236;1275.304958797439;1278.8081787731728;1289.5937779599396;826.6156237349661;988.1008282462924;993.3841018568389;993.9403635781877;1018.3126389686931;5736;5736.139579063174;5749.85625359361;5840.2991641003355;5979.5515336349945;458.43841294414074;463.4924757390652;463.9164950308977;471.6886854675966;475.379629583397;3900.083480382108;3986.5814089520763;4015.698822588259;4035.3543433050572;4045.8786236412957;10862.511186996446;11127.554897803997;11194.160437967184;11208.21542492034;11247.887521124847;11085.944570277097;11103.722406939729;11115.055220306203;11128.833067503994;11138.721531961766;8277.875831862406;8466.449680770731;8487.575621218914;8521.829563408697;8581.485110893367;5705.62913410627;5889.676067816311;5926.081457374114;5931.576421658857;5969.611975221596;9345.439273643604;10215.927327630492;10230.48847557634;10291.33106348085;10365.689029329133;9736.22110231194;9935.850962235427;9949.204063674744;10010.199184065112;10037.899621003697;7763.184865589032;7846.646900889587;7977.122516523062;7991.120976692676;8034.035915690155;8673.262772664395;8762;8766.649334026568;8810.515421651871;8811.251043661361;7601.923980760122;7688.961555192188;7827.9608601956625;7875.133735288999;7910.288074073361;7425.480216384801;7489.625518723933;7613.238676132342;7624.618769061635;7638.427117966064;6623;6637.6017438951885;6643.368879956396;6704.597724136567;6720;4816.446108697544;4822.493638168082;4829.492903245108;4861.805527778849;5146.382434107931;4866.245731911559;4916.041371932439;5004.324416203912;5055.064813009605;5173.793048278027 23:56:59 INFO - PROCESS | 21992 | |4;prototype.html;341.3275846582234;351.62551882245407;351.67294416192965;356.1328165915994;360.6015353034898;5573.386927437979;5702.657840529571;5725.713714314284;5740.48335649792;5767.855803604912;5522.502974732273;5560.666360018402;5592.748326325325;5610.186522954169;5628.352739434966;4347.5217726050105;4385.714928529651;4397.252467080588;4400.889977750549;4402.6037656610815;4181.665466762667;4267.78661066947;4334.45819272591;4370.868873933787;4389.978050109745;4271.807768650403;4274;4279.507856596485;4284;4295.4201182840225;4290.914181716379;4307.956920430787;4309.676774241944;4313.590208930146;4335.631471324941;3680.411134218512;3802.4106263529197;3803.923921521554;3815.2178803345246;3822.48396466479;5381.515663590296;5386.165144402624;5421.2952316199035;5430.8548123491;5448.291722076145;4957.82647607332;4975.5522003019905;4978.352814134176;4988.426330971948;4991.550760431543;5573.885222955385;5787.768489260425;5796.2464879565805;5806.5354771618595;5856.418766932904;4182.811773470201;4183.518895327046;4186.204621121977;4193.937090943638;4234.407182994383;6044.758209671608;6090.634561926255;6107.358727333655;6110.236220472441;6111.205543279345;4186.937195942063;4225.514065882401;4260.657892763769;4370.344448332776;4378.584034516716;4318.244307246282;4325.286327755885;4326.545712700121;4330.870073897788;4339.34909763538;4976.278439626234;4988.700677959261;4990.255359552231;4993.675411098339;5013.298138260647;5718.822099283088;5888.793892213752;5891.617044892068;5892.646441213541;5920.7862388210315;1459.3651761483789;1474.2186641080245;1476.933537990793;1478.460361967874;1479.4526025370467;969.4231932000448;990.960361585543;1012.987012987013;1014.2291858187683;1023.6366090038078;5429.511343979061;5429.986357571507;5460.590455715757;5461.399246082928;5463.863403414867;5836.941630583725;5842.737076831553;5843.1235314703135;5861.120831875252;5896.469317761336;5330.653507521999;5456.645318054393;5475.890482190334;5699.202111704365;5727.856803579861;3141.6701246368802;3145.8427078645977;3155.2742869140225;3164.936701265962;3174.746020318369;5963.463288304073;6096.664683442454;6109.20580324555;6117.938820611826;6159.19930409044;6123.846903827351;6168.722407491674;6183.227096612924;6194.38056194377;6194.752209911643;6251.593646412968;6298.7795427160745;6324.936750632435;6326.999999999908;6355.650439225795;5916.171735956884;5969.492593129633;6007.339192688888;6008.978473659401;6058.636481811105;5986.491148252448;6000.159977603226;6003.789867354796;6011.729472173675;6016.232533034853;6124.693765311806;6131.9105142732315;6255.96872015637;6286.5599408041;6292.370762923854;4189.874303770892;4289.485261768607;4329.328954012133;4330.133973205435;4343.913121737484;6052.425019623129;6094.847628809138;6104.786332478342;6111.449969502766;6111.816645500642;5674.177244299471;5821.650700957956;5913.911291330547;5946.286445626552;5950.791722289872;5795.82612521625;5853.590248682552;5868.23712917318;5883.61756485827;5897.823065307876;5866.941330586639;5883.734292637974;5888;5907.468327850343;5916.437938395846;5744.224529688438;5823.310076406098;5825.417458254141;5865.765369385177;5871.6183448077445;5751.223584815996;5758.280214973129;5766.711664416678;5790;5798.159266906359 23:56:59 INFO - PROCESS | 21992 | |5;yui.html;775.8952541406916;796.522086747951;815.8898548695928;842.6545116502234;875.0767939823484;15223.391064357413;16154;16191.190440477958;16218.351265949348;16221.675566488679;14205.644858878508;14549.490767823128;14636.121832690045;14639.560813175594;14709.264536773146;834.0366876257932;844.8901642786429;845.4546817302836;850.9957450212771;851.3487182305541;834.4909605140859;839.668331009251;840.4117118017382;840.5629072882098;842.1410161635129;870.6952566601702;873.7902903303193;876.3077169036485;878.1394233650994;882.4176043811086;873.0876234335135;876.023234093987;876.1501343696636;878.8989266234337;879.9692010779625;641.8844607970564;649.4187702006725;649.89276769333;650.0379438431102;650.3593959949446;13154.408051637603;13184.86815131846;13185.86814131856;13192;13762.724745505135;12271;12627.684307892285;12873.22760634365;12878.162919410208;13057.86942130576;12199.20705154171;12201;12346.320952347618;12741.299228542426;12774.169678970837;3889.9027524311837;3941.8226179821977;3944.447777311179;4001.0597509585223;4010.0977280112033;45329;46874.06251874977;51179.232311515356;64408;65180.674096629686;11505.769884602261;11677.591284305008;11785.823212651818;11849.348285844362;11927.701807454883;16542;16601.91699041497;16983;19338.323158689378;20094.598108037757;8424.831503369898;8579.669068481631;8678.566071696516;8844.425112367675;8890.33322500815;4600.125976064537;4694.43666759991;4695.272232803921;4704.647151463585;4803.303520989437;3501.089716673632;3624.0939765058733;3831.6743076838225;3959.1685745993664;3990.521137463465;661.0711949710665;677.7289084366195;679.9762008329685;686.4096876686046;696.4985210648325;737.8450525389728;769.9499532530367;782.1044903585363;784.3920961254959;793.6388943030908;10060.24548158891;10088.74778130538;10115.494225288707;10168.186545076376;10390.220733445021;603.1585937617087;633.9841503962438;644.6003477843767;697.6965020216121;733.974310899116;4606.286025666027;4851.223804191312;4868.318435419044;4896.167651499253;4925.408950925912;67331.32668673349;86756.56621716851;87008.5649571748;91010;92103;70330;80412.59793700994;81439;82988;86981;58463.70768146132;59562;61269.69365153146;64358.67820660867;67100.3289967094;10071.395716257048;10155.949220253851;10396.844047339448;10500.26498145153;10607.840882386616;32878.506822397205;42532.78733606312;46465.303020455394;47467;47533.52466475291;56492.717536412056;62301;63264.68367658132;63541;65382.34617653763;13003.739925201255;13159.473621055433;13286.734265314833;13454.66363340885;13484.528041518499;14199;14391.928040359731;14403.927980360031;14409.279536023367;14517.85482145165;12541.561045363369;12785.552505662257;13608.523701670394;13663.521776738164;14196.787048194079;13063.216207027608;13192.538261160813;13350.933245333712;13509;13879.583612491642;12861.935690321863;13015.219086854819;13107;13118.803217951929;13783.793243101562;10836;11011.44942752843;11296.152788540729;11403;11570.305781653127;10851.891481085087;11607;11786;11812.173147879566;11955.342456164994 23:56:59 INFO - PROCESS | 21992 | __end_tp_report 23:56:59 INFO - PROCESS | 21992 | __start_cc_report 23:56:59 INFO - PROCESS | 21992 | _x_x_mozilla_cycle_collect,316 23:56:59 INFO - PROCESS | 21992 | __end_cc_report 23:56:59 INFO - PROCESS | 21992 | __startTimestamp1485244619759__endTimestamp 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | ------- Summary: start ------- 23:56:59 INFO - PROCESS | 21992 | Number of tests: 6 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#0] dojo.html Cycles:165 Average:5687.14 Median:5899.47 stddev:657.85 (11.2%) stddev-sans-first:631.01 23:56:59 INFO - PROCESS | 21992 | Values: 3230.7 3234.5 3252.3 3253.4 3257.2 5622.7 5663.9 5665.4 5668.2 5670.9 5730.0 5772.2 5781.2 5786.5 5790.0 5161.7 5225.6 5233.7 5264.8 5279.9 5282.1 5289.3 5290.7 5291.8 5311.1 5040.9 5075.4 5124.4 5284.9 5285.4 5174.4 5248.0 5251.2 5260.8 5273.9 5146.1 5220.1 5227.2 5230.4 5233.6 5471.8 5541.5 5641.2 5657.5 5754.0 5999.8 6057.8 6083.0 6083.3 6145.8 6176.0 6182.3 6187.4 6199.0 6219.4 5620.2 5742.4 5745.8 5753.8 5762.8 6190.4 6300.3 6307.7 6311.0 6311.8 6020.1 6028.1 6045.3 6051.8 6053.5 6034.8 6072.6 6076.8 6115.1 6129.7 6108.5 6111.0 6111.1 6120.5 6129.0 6107.5 6114.4 6114.9 6120.2 6121.2 4561.5 4592.1 4620.5 4625.9 4653.5 4138.6 4148.5 4152.5 4165.1 4192.2 5798.2 5829.6 5841.1 5847.7 5854.3 5992.0 6043.4 6071.8 6134.3 6140.8 5765.3 5866.5 5883.2 5883.9 5899.5 5304.8 5306.8 5312.7 5330.4 5340.9 6104.7 6196.8 6402.8 6415.9 6437.7 6068.6 6093.0 6137.5 6195.4 6200.1 6388.3 6442.6 6445.1 6447.5 6448.5 5748.3 6047.8 6072.1 6077.2 6079.1 5949.6 6088.6 6109.4 6144.8 6190.1 5974.0 6009.7 6028.1 6030.0 6033.0 5975.1 6001.7 6010.6 6010.8 6040.5 5682.9 5833.9 5900.5 5969.2 5972.0 5972.9 6006.3 6048.5 6051.3 6052.9 5665.1 5888.6 5889.5 5889.9 5892.6 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#1] ext.html Cycles:180 Average:58162.92 Median:43932.95 stddev:113198.88 (257.7%) stddev-sans-first:113433.84 23:56:59 INFO - PROCESS | 21992 | Values: 571.3 615.2 651.8 665.8 678.1 43533.3 44333.3 44756.6 49422.0 49491.0 44773.8 45026.0 45299.5 45343.5 45431.0 8971.5 9152.9 9156.2 9157.2 9158.9 9047.4 9130.8 9132.2 9135.0 9135.9 9146.3 9147.0 9162.5 9178.8 9182.2 9149.5 9150.9 9184.5 9189.5 9204.0 8992.4 9062.1 9074.2 9106.7 9109.7 44332.6 44613.3 44776.8 44789.0 44881.3 3424.2 3726.9 3858.0 4099.6 4222.1 32486.4 32836.3 33019.7 33496.3 33553.0 4323.8 4521.6 4539.2 4548.7 4565.3 257984.0 258277.0 258353.0 259031.0 259648.0 59691.0 59712.4 59799.7 59932.7 60021.0 64079.7 64109.4 64114.0 64129.0 64318.4 17489.1 17490.6 17543.3 17637.3 17680.4 14451.6 14646.8 14687.6 14747.6 14764.3 16077.9 16474.9 16485.0 16628.9 16857.2 6059.7 6167.4 6189.3 6201.4 6298.4 978.4 1041.6 1042.2 1070.1 1083.8 31447.8 31528.0 32139.2 32267.8 32367.0 1082.4 1084.6 1144.2 1177.9 1198.5 16201.2 16594.5 16826.5 17229.1 17382.5 505594.0 508223.0 509126.0 509795.0 513850.0 59968.1 60148.7 60239.0 60303.0 60345.7 1232.9 1253.4 1328.0 1372.0 1411.3 31410.5 31906.8 32016.0 32176.5 32894.3 52230.2 52596.0 52638.0 52683.0 52836.2 462925.0 465695.0 467139.0 472863.0 473007.0 28905.4 29040.6 29052.7 29124.3 29348.7 45732.0 46729.5 47054.8 47149.8 47623.8 39528.2 39939.0 40245.4 41038.2 41765.0 38713.6 40588.6 40910.4 41404.2 41501.0 40576.4 40649.2 40893.4 41076.0 41214.4 34955.8 36178.5 36871.9 36872.3 36964.0 23074.9 23185.2 23289.3 23326.8 23505.7 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#2] jquery.html Cycles:180 Average:31041.86 Median:24340.71 stddev:87535.97 (359.6%) stddev-sans-first:87751.30 23:56:59 INFO - PROCESS | 21992 | Values: 404.8 429.4 432.4 432.8 433.0 19101.5 19876.4 20309.6 20332.2 20742.0 19001.2 19222.0 19347.4 19382.3 19917.8 5704.6 5884.3 5914.3 5915.4 5915.9 5636.3 5778.2 5788.5 5854.3 5882.3 5741.5 5741.6 5775.9 5795.1 5796.4 5568.8 5742.1 5756.6 5766.5 5795.1 5251.8 5252.1 5252.8 5256.7 5260.7 24325.1 24356.3 24501.4 24606.0 24740.6 2464.9 2576.8 2699.9 3142.0 3171.8 14946.6 15174.2 15436.1 15437.8 15671.1 1976.6 2008.1 2089.2 2125.0 2141.8 85959.0 86363.0 86622.0 87884.0 89140.0 10962.7 11040.2 11139.5 11276.4 11549.2 16383.1 16410.5 16423.9 16424.3 16427.4 8263.9 8494.7 8504.5 8676.1 8734.0 7904.9 7981.1 8124.5 8223.0 8438.0 6933.6 7049.6 7200.1 7233.0 7235.6 2012.9 2087.6 2107.9 2132.1 2153.3 911.5 1028.0 1058.6 1075.4 1146.6 19165.8 19768.0 20289.9 20428.1 20623.1 1034.1 1035.5 1043.5 1048.8 1064.3 11245.2 11380.4 11542.4 11613.5 11765.1 504766.0 529235.0 533578.0 541011.0 548643.0 82555.6 85670.0 89196.6 99168.0 102897.5 1042.7 1060.1 1074.9 1076.6 1085.2 18223.5 18622.3 18798.2 18814.7 18961.2 33187.5 44108.1 45515.0 45515.8 45813.8 62951.7 63346.4 65403.3 65646.3 66116.0 7926.8 8293.8 8865.0 8939.2 9042.8 13821.4 13917.4 14029.5 14219.6 14242.5 12174.0 12207.4 12250.6 12367.0 12501.7 11627.3 11934.9 12013.4 12122.9 12130.3 12022.2 12164.9 12172.9 12441.6 12485.1 7968.5 8128.9 8257.0 8323.9 8672.3 11689.4 12088.3 12110.0 12127.3 12424.1 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#3] mootools.html Cycles:180 Average:5844.25 Median:4864.03 stddev:3320.05 (68.3%) stddev-sans-first:3313.39 23:56:59 INFO - PROCESS | 21992 | Values: 1510.2 1549.9 1644.2 1773.4 1808.6 8546.1 8808.3 9123.9 9134.0 9140.4 9017.1 9128.2 9172.4 9189.8 9300.4 2422.4 2483.3 2487.3 2495.5 2495.9 2425.1 2505.5 2521.3 2531.3 2531.4 2423.7 2430.2 2470.0 2470.6 2474.7 2356.4 2363.6 2377.6 2379.6 2381.4 2382.2 2400.0 2401.8 2415.4 2420.3 9000.7 9090.9 9133.1 9161.5 9164.2 5426.0 5598.1 5655.2 5661.2 5665.0 3435.3 3455.7 3461.5 3464.9 3546.3 1114.0 1135.1 1135.5 1161.3 1200.7 12334.8 12350.3 12408.4 12412.3 12429.1 4344.2 4670.0 4705.1 4852.1 4857.3 9744.7 9790.3 9796.8 9798.5 9808.0 5278.6 5289.4 5321.8 5349.5 5353.8 4887.3 5065.7 5069.2 5121.6 5180.8 4095.4 4103.0 4113.6 4123.3 4152.8 1263.4 1271.3 1275.3 1278.8 1289.6 826.6 988.1 993.4 993.9 1018.3 5736.0 5736.1 5749.9 5840.3 5979.6 458.4 463.5 463.9 471.7 475.4 3900.1 3986.6 4015.7 4035.4 4045.9 10862.5 11127.6 11194.2 11208.2 11247.9 11085.9 11103.7 11115.1 11128.8 11138.7 8277.9 8466.4 8487.6 8521.8 8581.5 5705.6 5889.7 5926.1 5931.6 5969.6 9345.4 10215.9 10230.5 10291.3 10365.7 9736.2 9935.9 9949.2 10010.2 10037.9 7763.2 7846.6 7977.1 7991.1 8034.0 8673.3 8762.0 8766.6 8810.5 8811.3 7601.9 7689.0 7828.0 7875.1 7910.3 7425.5 7489.6 7613.2 7624.6 7638.4 6623.0 6637.6 6643.4 6704.6 6720.0 4816.4 4822.5 4829.5 4861.8 5146.4 4866.2 4916.0 5004.3 5055.1 5173.8 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#4] prototype.html Cycles:180 Average:4930.30 Median:5601.47 stddev:1457.29 (26.0%) stddev-sans-first:1420.10 23:56:59 INFO - PROCESS | 21992 | Values: 341.3 351.6 351.7 356.1 360.6 5573.4 5702.7 5725.7 5740.5 5767.9 5522.5 5560.7 5592.7 5610.2 5628.4 4347.5 4385.7 4397.3 4400.9 4402.6 4181.7 4267.8 4334.5 4370.9 4390.0 4271.8 4274.0 4279.5 4284.0 4295.4 4290.9 4308.0 4309.7 4313.6 4335.6 3680.4 3802.4 3803.9 3815.2 3822.5 5381.5 5386.2 5421.3 5430.9 5448.3 4957.8 4975.6 4978.4 4988.4 4991.6 5573.9 5787.8 5796.2 5806.5 5856.4 4182.8 4183.5 4186.2 4193.9 4234.4 6044.8 6090.6 6107.4 6110.2 6111.2 4186.9 4225.5 4260.7 4370.3 4378.6 4318.2 4325.3 4326.5 4330.9 4339.3 4976.3 4988.7 4990.3 4993.7 5013.3 5718.8 5888.8 5891.6 5892.6 5920.8 1459.4 1474.2 1476.9 1478.5 1479.5 969.4 991.0 1013.0 1014.2 1023.6 5429.5 5430.0 5460.6 5461.4 5463.9 5836.9 5842.7 5843.1 5861.1 5896.5 5330.7 5456.6 5475.9 5699.2 5727.9 3141.7 3145.8 3155.3 3164.9 3174.7 5963.5 6096.7 6109.2 6117.9 6159.2 6123.8 6168.7 6183.2 6194.4 6194.8 6251.6 6298.8 6324.9 6327.0 6355.7 5916.2 5969.5 6007.3 6009.0 6058.6 5986.5 6000.2 6003.8 6011.7 6016.2 6124.7 6131.9 6256.0 6286.6 6292.4 4189.9 4289.5 4329.3 4330.1 4343.9 6052.4 6094.8 6104.8 6111.4 6111.8 5674.2 5821.7 5913.9 5946.3 5950.8 5795.8 5853.6 5868.2 5883.6 5897.8 5866.9 5883.7 5888.0 5907.5 5916.4 5744.2 5823.3 5825.4 5865.8 5871.6 5751.2 5758.3 5766.7 5790.0 5798.2 23:56:59 INFO - PROCESS | 21992 | 23:56:59 INFO - PROCESS | 21992 | [#5] yui.html Cycles:180 Average:17505.55 Median:23271.44 stddev:22689.06 (97.5%) stddev-sans-first:22717.93 23:56:59 INFO - PROCESS | 21992 | Values: 775.9 796.5 815.9 842.7 875.1 15223.4 16154.0 16191.2 16218.4 16221.7 14205.6 14549.5 14636.1 14639.6 14709.3 834.0 844.9 845.5 851.0 851.3 834.5 839.7 840.4 840.6 842.1 870.7 873.8 876.3 878.1 882.4 873.1 876.0 876.2 878.9 880.0 641.9 649.4 649.9 650.0 650.4 13154.4 13184.9 13185.9 13192.0 13762.7 12271.0 12627.7 12873.2 12878.2 13057.9 12199.2 12201.0 12346.3 12741.3 12774.2 3889.9 3941.8 3944.4 4001.1 4010.1 45329.0 46874.1 51179.2 64408.0 65180.7 11505.8 11677.6 11785.8 11849.3 11927.7 16542.0 16601.9 16983.0 19338.3 20094.6 8424.8 8579.7 8678.6 8844.4 8890.3 4600.1 4694.4 4695.3 4704.6 4803.3 3501.1 3624.1 3831.7 3959.2 3990.5 661.1 677.7 680.0 686.4 696.5 737.8 769.9 782.1 784.4 793.6 10060.2 10088.7 10115.5 10168.2 10390.2 603.2 634.0 644.6 697.7 734.0 4606.3 4851.2 4868.3 4896.2 4925.4 67331.3 86756.6 87008.6 91010.0 92103.0 70330.0 80412.6 81439.0 82988.0 86981.0 58463.7 59562.0 61269.7 64358.7 67100.3 10071.4 10155.9 10396.8 10500.3 10607.8 32878.5 42532.8 46465.3 47467.0 47533.5 56492.7 62301.0 63264.7 63541.0 65382.3 13003.7 13159.5 13286.7 13454.7 13484.5 14199.0 14391.9 14403.9 14409.3 14517.9 12541.6 12785.6 13608.5 13663.5 14196.8 13063.2 13192.5 13350.9 13509.0 13879.6 12861.9 13015.2 13107.0 13118.8 13783.8 10836.0 11011.4 11296.2 11403.0 11570.3 10851.9 11607.0 11786.0 11812.2 11955.3 23:56:59 INFO - PROCESS | 21992 | -------- Summary: end -------- 23:56:59 INFO - PROCESS | 21992 | 23:57:00 INFO - TEST-INFO | 21992: exit 0 23:57:00 INFO - TEST-OK | dromaeo_css | took 1111698ms 23:57:00 INFO - TEST-START | kraken 23:57:00 INFO - operating with platform_type : linux_ 23:57:00 INFO - Initialising browser for kraken test... 23:57:00 INFO - TEST-INFO | started process 22361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhPN1O/profile http://localhost:43467/getInfo.html) 23:57:04 INFO - PROCESS | 22361 | __metrics Screen width/height:1600/1200 23:57:04 INFO - PROCESS | 22361 | colorDepth:24 23:57:04 INFO - PROCESS | 22361 | Browser inner width/height: 1024/697 23:57:04 INFO - PROCESS | 22361 | __metrics 23:57:05 ERROR - PROCESS | 22361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 23:57:06 INFO - TEST-INFO | 22361: exit 0 23:57:06 INFO - Browser initialized. 23:57:06 INFO - Running cycle 1/1 for kraken test... 23:57:06 INFO - TEST-INFO | started process 22496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhPN1O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:17 INFO - PROCESS | 22496 | RSS: Main: 148975616 23:57:17 INFO - PROCESS | 22496 | 23:57:20 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43467/tests/kraken/driver.html?testName=audio-beat-detection) 23:57:21 INFO - PROCESS | 22496 | RSS: Main: 154099712 23:57:21 INFO - PROCESS | 22496 | 23:57:23 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43467/tests/kraken/driver.html?testName=audio-dft) 23:57:24 INFO - PROCESS | 22496 | RSS: Main: 152973312 23:57:24 INFO - PROCESS | 22496 | 23:57:27 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43467/tests/kraken/driver.html?testName=audio-fft) 23:57:28 INFO - PROCESS | 22496 | RSS: Main: 153407488 23:57:28 INFO - PROCESS | 22496 | 23:57:30 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43467/tests/kraken/driver.html?testName=audio-oscillator) 23:57:30 INFO - PROCESS | 22496 | RSS: Main: 153251840 23:57:30 INFO - PROCESS | 22496 | 23:57:32 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43467/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:57:33 INFO - PROCESS | 22496 | RSS: Main: 153128960 23:57:33 INFO - PROCESS | 22496 | 23:57:36 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43467/tests/kraken/driver.html?testName=imaging-darkroom) 23:57:36 INFO - PROCESS | 22496 | RSS: Main: 156672000 23:57:36 INFO - PROCESS | 22496 | 23:57:40 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43467/tests/kraken/driver.html?testName=imaging-desaturate) 23:57:40 INFO - PROCESS | 22496 | RSS: Main: 156536832 23:57:40 INFO - PROCESS | 22496 | 23:57:43 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43467/tests/kraken/driver.html?testName=json-parse-financial) 23:57:44 INFO - PROCESS | 22496 | RSS: Main: 156737536 23:57:44 INFO - PROCESS | 22496 | 23:57:45 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43467/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:57:46 INFO - PROCESS | 22496 | RSS: Main: 155762688 23:57:46 INFO - PROCESS | 22496 | 23:57:48 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:57:48 INFO - PROCESS | 22496 | RSS: Main: 155844608 23:57:48 INFO - PROCESS | 22496 | 23:57:50 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:57:51 INFO - PROCESS | 22496 | RSS: Main: 155656192 23:57:51 INFO - PROCESS | 22496 | 23:57:53 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:57:54 INFO - PROCESS | 22496 | RSS: Main: 156545024 23:57:54 INFO - PROCESS | 22496 | 23:57:57 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:57:57 INFO - PROCESS | 22496 | RSS: Main: 156512256 23:57:57 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | Cycle 1(1): loaded http://localhost:43467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43467/tests/kraken/driver.html?testName=ai-astar) 23:57:59 INFO - PROCESS | 22496 | RSS: Main: 157749248 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | __start_tp_report 23:57:59 INFO - PROCESS | 22496 | _x_x_mozilla_page_load 23:57:59 INFO - PROCESS | 22496 | _x_x_mozilla_page_load_details 23:57:59 INFO - PROCESS | 22496 | |i|pagename|runs| 23:57:59 INFO - PROCESS | 22496 | |0;ai-astar;106;112;112;112;112;112;112;111;111;112 23:57:59 INFO - PROCESS | 22496 | |1;audio-beat-detection;149;118;123;160;124;123;127;126;145;121 23:57:59 INFO - PROCESS | 22496 | |2;audio-dft;164;162;167;163;163;162;164;161;161;163 23:57:59 INFO - PROCESS | 22496 | |3;audio-fft;75;75;75;113;77;77;77;75;94;76 23:57:59 INFO - PROCESS | 22496 | |4;audio-oscillator;83;82;121;83;81;81;93;83;82;105 23:57:59 INFO - PROCESS | 22496 | |5;imaging-gaussian-blur;119;118;117;118;118;118;117;118;117;118 23:57:59 INFO - PROCESS | 22496 | |6;imaging-darkroom;146;147;147;149;148;147;147;146;147;148 23:57:59 INFO - PROCESS | 22496 | |7;imaging-desaturate;85;85;87;85;85;86;86;85;85;85 23:57:59 INFO - PROCESS | 22496 | |8;json-parse-financial;50;51;52;50;52;51;55;51;52;51 23:57:59 INFO - PROCESS | 22496 | |9;json-stringify-tinderbox;61;62;69;61;61;60;60;62;61;61 23:57:59 INFO - PROCESS | 22496 | |10;stanford-crypto-aes;74;82;74;74;77;76;73;79;75;74 23:57:59 INFO - PROCESS | 22496 | |11;stanford-crypto-ccm;133;129;129;120;132;119;121;123;156;120 23:57:59 INFO - PROCESS | 22496 | |12;stanford-crypto-pbkdf2;154;156;172;154;153;160;155;154;160;154 23:57:59 INFO - PROCESS | 22496 | |13;stanford-crypto-sha256-iterative;65;66;62;61;62;61;65;60;64;63 23:57:59 INFO - PROCESS | 22496 | __end_tp_report 23:57:59 INFO - PROCESS | 22496 | __start_cc_report 23:57:59 INFO - PROCESS | 22496 | _x_x_mozilla_cycle_collect,751 23:57:59 INFO - PROCESS | 22496 | __end_cc_report 23:57:59 INFO - PROCESS | 22496 | __startTimestamp1485244679807__endTimestamp 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | ------- Summary: start ------- 23:57:59 INFO - PROCESS | 22496 | Number of tests: 14 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.87 (1.7%) stddev-sans-first:0.44 23:57:59 INFO - PROCESS | 22496 | Values: 106.0 112.0 112.0 112.0 112.0 112.0 112.0 111.0 111.0 112.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:126.50 stddev:14.32 (11.3%) stddev-sans-first:13.73 23:57:59 INFO - PROCESS | 22496 | Values: 149.0 118.0 123.0 160.0 124.0 123.0 127.0 126.0 145.0 121.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.76 (1.1%) stddev-sans-first:1.83 23:57:59 INFO - PROCESS | 22496 | Values: 164.0 162.0 167.0 163.0 163.0 162.0 164.0 161.0 161.0 163.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:12.51 (16.4%) stddev-sans-first:13.05 23:57:59 INFO - PROCESS | 22496 | Values: 75.0 75.0 75.0 113.0 77.0 77.0 77.0 75.0 94.0 76.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.50 stddev:13.45 (16.3%) stddev-sans-first:14.07 23:57:59 INFO - PROCESS | 22496 | Values: 83.0 82.0 121.0 83.0 81.0 81.0 93.0 83.0 82.0 105.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 23:57:59 INFO - PROCESS | 22496 | Values: 119.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 23:57:59 INFO - PROCESS | 22496 | Values: 146.0 147.0 147.0 149.0 148.0 147.0 147.0 146.0 147.0 148.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 23:57:59 INFO - PROCESS | 22496 | Values: 85.0 85.0 87.0 85.0 85.0 86.0 86.0 85.0 85.0 85.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.43 (2.8%) stddev-sans-first:1.41 23:57:59 INFO - PROCESS | 22496 | Values: 50.0 51.0 52.0 50.0 52.0 51.0 55.0 51.0 52.0 51.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:2.62 (4.3%) stddev-sans-first:2.76 23:57:59 INFO - PROCESS | 22496 | Values: 61.0 62.0 69.0 61.0 61.0 60.0 60.0 62.0 61.0 61.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:2.82 (3.7%) stddev-sans-first:2.92 23:57:59 INFO - PROCESS | 22496 | Values: 74.0 82.0 74.0 74.0 77.0 76.0 73.0 79.0 75.0 74.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.00 stddev:11.10 (8.6%) stddev-sans-first:11.64 23:57:59 INFO - PROCESS | 22496 | Values: 133.0 129.0 129.0 120.0 132.0 119.0 121.0 123.0 156.0 120.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:155.50 stddev:5.77 (3.7%) stddev-sans-first:6.00 23:57:59 INFO - PROCESS | 22496 | Values: 154.0 156.0 172.0 154.0 153.0 160.0 155.0 154.0 160.0 154.0 23:57:59 INFO - PROCESS | 22496 | 23:57:59 INFO - PROCESS | 22496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:2.02 (3.2%) stddev-sans-first:2.00 23:57:59 INFO - PROCESS | 22496 | Values: 65.0 66.0 62.0 61.0 62.0 61.0 65.0 60.0 64.0 63.0 23:57:59 INFO - PROCESS | 22496 | -------- Summary: end -------- 23:57:59 INFO - PROCESS | 22496 | 23:58:00 INFO - TEST-INFO | 22496: exit 0 23:58:00 INFO - TEST-OK | kraken | took 60266ms 23:58:00 INFO - SUITE-END | took 1171s 23:58:00 INFO - Completed test suite (00:19:32) 23:58:00 INFO - javascript benchmark 23:58:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7429.55967337851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.693084157005, 3234.5471633971247, 3252.268239646079, 3253.3655937092276, 3257.234549880779, 5622.690752008643, 5663.8955403696245, 5665.4334566543375, 5668.206451096849, 5670.914936275959, 5729.971350143254, 5772.249607551013, 5781.219535362725, 5786.537077033838, 5790.0, 5161.66449180803, 5225.555827754626, 5233.685978841263, 5264.8157314494, 5279.9208011879855, 5282.07563676357, 5289.259503669489, 5290.6825590464505, 5291.761870715808, 5311.123664595337, 5040.924386134211, 5075.365579302587, 5124.359455068116, 5284.867878303035, 5285.392179899303, 5174.43081261061, 5248.029114613771, 5251.186066159713, 5260.815871444519, 5273.947260527384, 5146.125158722989, 5220.138677118271, 5227.242049902743, 5230.372355317349, 5233.581313494911, 5471.753771080311, 5541.473560011793, 5641.182028605829, 5657.462541058593, 5754.0, 5999.800039991976, 6057.757689692407, 6083.0, 6083.270007599072, 6145.832291864576, 6175.96912015437, 6182.289036760785, 6187.412195841388, 6199.0, 6219.440250377443, 5620.185073164368, 5742.425757424224, 5745.798897038583, 5753.798617048383, 5762.769489220426, 6190.350013248544, 6300.338464461257, 6307.716152773136, 6311.021791622214, 6311.779087731908, 6020.09698545213, 6028.065649824284, 6045.274567051982, 6051.848703782441, 6053.485453736482, 6034.758609655652, 6072.574919755575, 6076.848078798065, 6115.052166914135, 6129.724162412702, 6108.5418593605655, 6110.969445152746, 6111.052786818051, 6120.540959428061, 6129.019356902963, 6107.541934354941, 6114.357992410822, 6114.908276375858, 6120.204373431515, 6121.204243448323, 4561.521040290788, 4592.058627981256, 4620.491745907947, 4625.884352891205, 4653.488116307203, 4138.627523522898, 4148.502179738391, 4152.501699796044, 4165.12532368206, 4192.24539582878, 5798.159266906359, 5829.621074630136, 5841.094630332305, 5847.678377689268, 5854.2974843018255, 5992.0, 6043.395660433922, 6071.817845464643, 6134.294556126013, 6140.815775526652, 5765.279340082489, 5866.501347385435, 5883.17635531026, 5883.911741323884, 5899.46904778572, 5304.814331498379, 5306.8407947761625, 5312.654677445954, 5330.387005494418, 5340.893182136336, 6104.694765261808, 6196.81409557714, 6402.807915762534, 6415.871682566322, 6437.742490300336, 6068.6358818471035, 6093.025115981422, 6137.468918203611, 6195.411435913581, 6200.100985357008, 6388.329225431263, 6442.581232219891, 6445.065465507569, 6447.548671592944, 6448.451881590117, 5748.252727145445, 6047.848803779941, 6072.14989901423, 6077.24034495688, 6079.088136779518, 5949.6430214187285, 6088.6042407243385, 6109.358517355614, 6144.815655530341, 6190.133381326528, 5974.0, 6009.669468179292, 6028.09578563219, 6030.03519436888, 6033.0, 5975.103734439869, 6001.729922153426, 6010.579259451796, 6010.789622363196, 6040.486558642565, 5682.857928551819, 5833.883322333614, 5900.527957763283, 5969.224000879858, 5971.970140149271, 5972.940270597239, 6006.309274433322, 6048.4858787003595, 6051.3041000283765, 6052.90920636182, 5665.12190610456, 5888.646681199141, 5889.52883769306, 5889.941100589111, 5892.558058145742], "value": 5641.462989917109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2744814086111, 615.1910238036982, 651.8207492939442, 665.843526771209, 678.0947435174043, 43533.34699979499, 44333.33499997503, 44756.552434475685, 49422.0, 49491.0, 44773.776131119295, 45026.0, 45299.547004529944, 45343.54656453434, 45431.0, 8971.46171229725, 9152.908470915305, 9156.175944165025, 9157.175854173123, 9158.86261706075, 9047.366684332099, 9130.817383652324, 9132.178103970642, 9134.954325228398, 9135.862962055542, 9146.31402644801, 9147.039560846115, 9162.496062716547, 9178.816423671522, 9182.219511341544, 9149.451032938045, 9150.86273705895, 9184.540772961325, 9189.540522973857, 9204.033576474474, 8992.370534062618, 9062.093790620951, 9074.18332350085, 9106.726798195998, 9109.681161159328, 44332.556674433166, 44613.33080003803, 44776.77611611954, 44789.0, 44881.32678009832, 3424.229548351626, 3726.9440958385644, 3858.0162058675137, 4099.590040995907, 4222.071144348239, 32486.35027299441, 32836.3432731344, 33019.66980330214, 33496.33007339864, 33553.0, 4323.848665296699, 4521.570450807168, 4539.182947069559, 4548.727076375428, 4565.315202719618, 257984.0, 258277.0, 258353.0, 259031.0, 259648.0, 59691.0, 59712.40287597155, 59799.701001494715, 59932.70033649804, 60021.0, 64079.67960160263, 64109.358906411275, 64114.0382894257, 64129.0, 64318.35681643217, 17489.125543723017, 17490.562735931704, 17543.29826806939, 17637.29450821953, 17680.381186658404, 14451.638709032148, 14646.780298295535, 14687.632809179857, 14747.631309217355, 14764.335604897806, 16077.919610401874, 16474.917625411796, 16485.0, 16628.916855415646, 16857.15714214309, 6059.666718330534, 6167.383261673886, 6189.288231853305, 6201.379862013853, 6298.370162983665, 978.4178413843752, 1041.6146025970288, 1042.1558537584428, 1070.0675019304026, 1083.8374243863484, 31447.84276078651, 31528.0, 32139.196520087185, 32267.838660806545, 32367.0, 1082.3884505254507, 1084.6149616885891, 1144.181909934401, 1177.923434976741, 1198.532572296805, 16201.189940502927, 16594.50216493507, 16826.495205143867, 17229.138543072797, 17382.478525644252, 505594.0, 508223.0, 509126.0, 509795.0, 513850.0, 59968.10047849286, 60148.69925650344, 60239.0, 60303.0, 60345.698271508365, 1232.8705485924029, 1253.3983687829893, 1328.0371730495506, 1371.9931400343135, 1411.266141606359, 31410.52884206693, 31906.840465797522, 32016.0, 32176.517352239265, 32894.34211315712, 52230.21654675259, 52596.0, 52638.0, 52683.0, 52836.20745688741, 462925.0, 465695.0, 467139.0, 472863.0, 473007.0, 28905.421891562473, 29040.564391534568, 29052.709472905844, 29124.27189320284, 29348.706512934597, 45732.0, 46729.53270467252, 47054.76472617615, 47149.76425117852, 47623.761881190374, 39528.209435810546, 39939.0, 40245.37670719631, 41038.17923641451, 41765.0, 38713.61286387213, 40588.594114058484, 40910.386344204264, 41404.1719165621, 41501.0, 40576.39135412912, 40649.18701625892, 40893.38659920044, 41076.0, 41214.38178427266, 34955.82522087373, 36178.4573231407, 36871.89384318475, 36872.26255474929, 36964.0, 23074.884625576764, 23185.188518401774, 23289.3013209604, 23326.76673233246, 23505.74540517306], "value": 20151.325595754184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.77939522959986, 429.44601464111287, 432.3881707384051, 432.84791607020685, 432.99999999999983, 19101.522461938443, 19876.40370788875, 20309.593808123827, 20332.18671253152, 20742.0, 19001.239950401967, 19222.0, 19347.419577412664, 19382.321618743346, 19917.800821991776, 5704.572157088214, 5884.293884733838, 5914.260717410324, 5915.378885217055, 5915.911261331084, 5636.323641163046, 5778.24882765242, 5788.47903688668, 5854.29748430189, 5882.294124705041, 5741.540676745871, 5741.569382296324, 5775.942240577603, 5795.072788353864, 5796.391378905218, 5568.832935011936, 5742.08126699726, 5756.597038207327, 5766.538676905859, 5795.1017592273265, 5251.76367063483, 5252.133397989327, 5252.816151434719, 5256.737163141827, 5260.736963151827, 24325.148619798398, 24356.269311920492, 24501.38746531333, 24606.0, 24740.628890566655, 2464.913728019511, 2576.7680908718116, 2699.9055033073746, 3141.952088695294, 3171.777975541713, 14946.551603451913, 15174.24128793556, 15436.073835569901, 15437.768433473508, 15671.138087405188, 1976.6145601607693, 2008.0562135796151, 2089.185217765073, 2125.0, 2141.796529329711, 85959.0, 86362.99999999937, 86622.0, 87884.0, 89140.0, 10962.671119866416, 11040.171987101, 11139.498722557504, 11276.436178191057, 11549.249298795552, 16383.09892955875, 16410.507684769476, 16423.91788041052, 16424.260908259155, 16427.425040123777, 8263.876041859377, 8494.74515764528, 8504.532250726146, 8676.089010653917, 8733.995590507046, 7904.920950790533, 7981.082175549886, 8124.471909325875, 8223.0, 8437.95781021091, 6933.618650974245, 7049.577025378494, 7200.099987501562, 7233.0, 7235.602041887747, 2012.8872663435004, 2087.6137914485867, 2107.903889977203, 2132.1130799242783, 2153.300177442306, 911.5032307392487, 1028.0313200221642, 1058.6188971970084, 1075.4138994248153, 1146.5986904583497, 19165.808341916403, 19768.0, 20289.898550507154, 20428.0807363669, 20623.071961761758, 1034.1209971524295, 1035.5184839049878, 1043.4991204222015, 1048.8479170520231, 1064.2603390643428, 11245.212835101627, 11380.374079425712, 11542.422878856023, 11613.535458581562, 11765.11761617882, 504766.0, 529235.0, 533578.0, 541011.0, 548643.0, 82555.5872220647, 85670.0, 89196.5540172295, 99168.0, 102897.48551257196, 1042.6507120114695, 1060.114804138553, 1074.897884700952, 1076.590895459736, 1085.175266797224, 18223.45329640113, 18622.348217812312, 18798.15408306602, 18814.717779233048, 18961.241550337832, 33187.50218746769, 44108.11783764371, 45514.999999998676, 45515.77242113901, 45813.770931146464, 62951.6852415735, 63346.36653633405, 65403.345966539724, 65646.34353656594, 66116.0, 7926.801829954297, 8293.751187464386, 8865.0, 8939.195472407515, 9042.773930651787, 13821.378037988114, 13917.440938402075, 14029.508967186099, 14219.64450888736, 14242.501512447014, 12174.0, 12207.389630518615, 12250.571230007263, 12367.0, 12501.687457813627, 11627.302361858316, 11934.880651193724, 12013.399330033639, 12122.939385303018, 12130.272183669009, 12022.158448908493, 12164.939175304067, 12172.939135304267, 12441.564545240873, 12485.12604117703, 7968.482048666818, 8128.918710812816, 8256.958715206385, 8323.916760832315, 8672.26285765717, 11689.357085360387, 12088.335141566946, 12110.0, 12127.272363658209, 12424.06819488524], "value": 9825.365653126768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.2146883620514, 1549.907005579665, 1644.1943447710626, 1773.405909020478, 1808.61114860305, 8546.102659220785, 8808.251298639623, 9123.863142052875, 9133.99999999999, 9140.40587361821, 9017.143371379725, 9128.224100951427, 9172.449653020823, 9189.77025574361, 9300.395474294166, 2422.3580751100926, 2483.292261705414, 2487.340854673513, 2495.4884248728968, 2495.9251222463354, 2425.139075628153, 2505.4863752930605, 2521.2940376694555, 2531.253280282312, 2531.4304281536597, 2423.684920960273, 2430.16159424999, 2470.036685692581, 2470.567650661136, 2474.6782918220606, 2356.4108972756726, 2363.5981883079917, 2377.619580867062, 2379.6073647848084, 2381.4165529445395, 2382.1662418153683, 2399.9760002399926, 2401.7598240176017, 2415.3599296186526, 2420.310211589706, 9000.729978100668, 9090.909090909072, 9133.132352426508, 9161.49611771359, 9164.175224229852, 5425.9728701356635, 5598.076317407623, 5655.1517272409465, 5661.207430959669, 5664.971675141639, 3435.3301106284034, 3455.6544345565244, 3461.4807778833124, 3464.8787292444645, 3546.2730140321173, 1113.9944300278446, 1135.1372956552996, 1135.4833550734395, 1161.349644199251, 1200.6578125234353, 12334.81497777534, 12350.258984460872, 12408.379581020912, 12412.255264684149, 12429.129960902741, 4344.152890186447, 4669.976650116728, 4705.106029854317, 4852.078105160008, 4857.271409288564, 9744.658936937172, 9790.314677972474, 9796.755081123029, 9798.510074496247, 9807.950960245153, 5278.630495865329, 5289.3917199521775, 5321.787128514816, 5349.491798279158, 5353.7590808413715, 4887.266909963534, 5065.670731402447, 5069.1635880079375, 5121.61587880903, 5180.792768289301, 4095.4165690638024, 4102.979485102555, 4113.568075352105, 4123.299039163349, 4152.792360381969, 1263.4314558448734, 1271.2690203133236, 1275.304958797439, 1278.8081787731728, 1289.5937779599396, 826.6156237349661, 988.1008282462924, 993.3841018568389, 993.9403635781877, 1018.3126389686931, 5736.0, 5736.139579063174, 5749.85625359361, 5840.2991641003355, 5979.5515336349945, 458.43841294414074, 463.4924757390652, 463.9164950308977, 471.6886854675966, 475.379629583397, 3900.083480382108, 3986.5814089520763, 4015.698822588259, 4035.3543433050572, 4045.8786236412957, 10862.511186996446, 11127.554897803997, 11194.160437967184, 11208.21542492034, 11247.887521124847, 11085.944570277097, 11103.722406939729, 11115.055220306203, 11128.833067503994, 11138.721531961766, 8277.875831862406, 8466.449680770731, 8487.575621218914, 8521.829563408697, 8581.485110893367, 5705.62913410627, 5889.676067816311, 5926.081457374114, 5931.576421658857, 5969.611975221596, 9345.439273643604, 10215.927327630492, 10230.48847557634, 10291.33106348085, 10365.689029329133, 9736.22110231194, 9935.850962235427, 9949.204063674744, 10010.199184065112, 10037.899621003697, 7763.184865589032, 7846.646900889587, 7977.122516523062, 7991.120976692676, 8034.035915690155, 8673.262772664395, 8762.0, 8766.649334026568, 8810.515421651871, 8811.251043661361, 7601.923980760122, 7688.961555192188, 7827.9608601956625, 7875.133735288999, 7910.288074073361, 7425.480216384801, 7489.625518723933, 7613.238676132342, 7624.618769061635, 7638.427117966064, 6623.0, 6637.6017438951885, 6643.368879956396, 6704.597724136567, 6720.0, 4816.446108697544, 4822.493638168082, 4829.492903245108, 4861.805527778849, 5146.382434107931, 4866.245731911559, 4916.041371932439, 5004.324416203912, 5055.064813009605, 5173.793048278027], "value": 4618.053387201657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3275846582234, 351.62551882245407, 351.67294416192965, 356.1328165915994, 360.6015353034898, 5573.386927437979, 5702.657840529571, 5725.713714314284, 5740.48335649792, 5767.855803604912, 5522.502974732273, 5560.666360018402, 5592.748326325325, 5610.186522954169, 5628.352739434966, 4347.5217726050105, 4385.714928529651, 4397.252467080588, 4400.889977750549, 4402.6037656610815, 4181.665466762667, 4267.78661066947, 4334.45819272591, 4370.868873933787, 4389.978050109745, 4271.807768650403, 4274.0, 4279.507856596485, 4284.0, 4295.4201182840225, 4290.914181716379, 4307.956920430787, 4309.676774241944, 4313.590208930146, 4335.631471324941, 3680.411134218512, 3802.4106263529197, 3803.923921521554, 3815.2178803345246, 3822.48396466479, 5381.515663590296, 5386.165144402624, 5421.2952316199035, 5430.8548123491, 5448.291722076145, 4957.82647607332, 4975.5522003019905, 4978.352814134176, 4988.426330971948, 4991.550760431543, 5573.885222955385, 5787.768489260425, 5796.2464879565805, 5806.5354771618595, 5856.418766932904, 4182.811773470201, 4183.518895327046, 4186.204621121977, 4193.937090943638, 4234.407182994383, 6044.758209671608, 6090.634561926255, 6107.358727333655, 6110.236220472441, 6111.205543279345, 4186.937195942063, 4225.514065882401, 4260.657892763769, 4370.344448332776, 4378.584034516716, 4318.244307246282, 4325.286327755885, 4326.545712700121, 4330.870073897788, 4339.34909763538, 4976.278439626234, 4988.700677959261, 4990.255359552231, 4993.675411098339, 5013.298138260647, 5718.822099283088, 5888.793892213752, 5891.617044892068, 5892.646441213541, 5920.7862388210315, 1459.3651761483789, 1474.2186641080245, 1476.933537990793, 1478.460361967874, 1479.4526025370467, 969.4231932000448, 990.960361585543, 1012.987012987013, 1014.2291858187683, 1023.6366090038078, 5429.511343979061, 5429.986357571507, 5460.590455715757, 5461.399246082928, 5463.863403414867, 5836.941630583725, 5842.737076831553, 5843.1235314703135, 5861.120831875252, 5896.469317761336, 5330.653507521999, 5456.645318054393, 5475.890482190334, 5699.202111704365, 5727.856803579861, 3141.6701246368802, 3145.8427078645977, 3155.2742869140225, 3164.936701265962, 3174.746020318369, 5963.463288304073, 6096.664683442454, 6109.20580324555, 6117.938820611826, 6159.19930409044, 6123.846903827351, 6168.722407491674, 6183.227096612924, 6194.38056194377, 6194.752209911643, 6251.593646412968, 6298.7795427160745, 6324.936750632435, 6326.999999999908, 6355.650439225795, 5916.171735956884, 5969.492593129633, 6007.339192688888, 6008.978473659401, 6058.636481811105, 5986.491148252448, 6000.159977603226, 6003.789867354796, 6011.729472173675, 6016.232533034853, 6124.693765311806, 6131.9105142732315, 6255.96872015637, 6286.5599408041, 6292.370762923854, 4189.874303770892, 4289.485261768607, 4329.328954012133, 4330.133973205435, 4343.913121737484, 6052.425019623129, 6094.847628809138, 6104.786332478342, 6111.449969502766, 6111.816645500642, 5674.177244299471, 5821.650700957956, 5913.911291330547, 5946.286445626552, 5950.791722289872, 5795.82612521625, 5853.590248682552, 5868.23712917318, 5883.61756485827, 5897.823065307876, 5866.941330586639, 5883.734292637974, 5888.0, 5907.468327850343, 5916.437938395846, 5744.224529688438, 5823.310076406098, 5825.417458254141, 5865.765369385177, 5871.6183448077445, 5751.223584815996, 5758.280214973129, 5766.711664416678, 5790.0, 5798.159266906359], "value": 4466.012310267665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.8952541406916, 796.522086747951, 815.8898548695928, 842.6545116502234, 875.0767939823484, 15223.391064357413, 16154.0, 16191.190440477958, 16218.351265949348, 16221.675566488679, 14205.644858878508, 14549.490767823128, 14636.121832690045, 14639.560813175594, 14709.264536773146, 834.0366876257932, 844.8901642786429, 845.4546817302836, 850.9957450212771, 851.3487182305541, 834.4909605140859, 839.668331009251, 840.4117118017382, 840.5629072882098, 842.1410161635129, 870.6952566601702, 873.7902903303193, 876.3077169036485, 878.1394233650994, 882.4176043811086, 873.0876234335135, 876.023234093987, 876.1501343696636, 878.8989266234337, 879.9692010779625, 641.8844607970564, 649.4187702006725, 649.89276769333, 650.0379438431102, 650.3593959949446, 13154.408051637603, 13184.86815131846, 13185.86814131856, 13192.0, 13762.724745505135, 12271.0, 12627.684307892285, 12873.22760634365, 12878.162919410208, 13057.86942130576, 12199.20705154171, 12201.0, 12346.320952347618, 12741.299228542426, 12774.169678970837, 3889.9027524311837, 3941.8226179821977, 3944.447777311179, 4001.0597509585223, 4010.0977280112033, 45329.0, 46874.06251874977, 51179.232311515356, 64408.0, 65180.674096629686, 11505.769884602261, 11677.591284305008, 11785.823212651818, 11849.348285844362, 11927.701807454883, 16542.0, 16601.91699041497, 16983.0, 19338.323158689378, 20094.598108037757, 8424.831503369898, 8579.669068481631, 8678.566071696516, 8844.425112367675, 8890.33322500815, 4600.125976064537, 4694.43666759991, 4695.272232803921, 4704.647151463585, 4803.303520989437, 3501.089716673632, 3624.0939765058733, 3831.6743076838225, 3959.1685745993664, 3990.521137463465, 661.0711949710665, 677.7289084366195, 679.9762008329685, 686.4096876686046, 696.4985210648325, 737.8450525389728, 769.9499532530367, 782.1044903585363, 784.3920961254959, 793.6388943030908, 10060.24548158891, 10088.74778130538, 10115.494225288707, 10168.186545076376, 10390.220733445021, 603.1585937617087, 633.9841503962438, 644.6003477843767, 697.6965020216121, 733.974310899116, 4606.286025666027, 4851.223804191312, 4868.318435419044, 4896.167651499253, 4925.408950925912, 67331.32668673349, 86756.56621716851, 87008.5649571748, 91010.0, 92103.0, 70330.0, 80412.59793700994, 81439.0, 82988.0, 86981.0, 58463.70768146132, 59562.0, 61269.69365153146, 64358.67820660867, 67100.3289967094, 10071.395716257048, 10155.949220253851, 10396.844047339448, 10500.26498145153, 10607.840882386616, 32878.506822397205, 42532.78733606312, 46465.303020455394, 47467.0, 47533.52466475291, 56492.717536412056, 62301.0, 63264.68367658132, 63541.0, 65382.34617653763, 13003.739925201255, 13159.473621055433, 13286.734265314833, 13454.66363340885, 13484.528041518499, 14199.0, 14391.928040359731, 14403.927980360031, 14409.279536023367, 14517.85482145165, 12541.561045363369, 12785.552505662257, 13608.523701670394, 13663.521776738164, 14196.787048194079, 13063.216207027608, 13192.538261160813, 13350.933245333712, 13509.0, 13879.583612491642, 12861.935690321863, 13015.219086854819, 13107.0, 13118.803217951929, 13783.793243101562, 10836.0, 11011.44942752843, 11296.152788540729, 11403.0, 11570.305781653127, 10851.891481085087, 11607.0, 11786.0, 11812.173147879566, 11955.342456164994], "value": 7299.829649193759, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 123.0, 160.0, 124.0, 123.0, 127.0, 126.0, 145.0, 121.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 167.0, 163.0, 163.0, 162.0, 164.0, 161.0, 161.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 77.0, 77.0, 77.0, 75.0, 94.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 121.0, 83.0, 81.0, 81.0, 93.0, 83.0, 82.0, 105.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 50.0, 52.0, 51.0, 55.0, 51.0, 52.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 69.0, 61.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 74.0, 77.0, 76.0, 73.0, 79.0, 75.0, 74.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 129.0, 120.0, 132.0, 119.0, 121.0, 123.0, 156.0, 120.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 172.0, 154.0, 153.0, 160.0, 155.0, 154.0, 160.0, 154.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 62.0, 61.0, 62.0, 61.0, 65.0, 60.0, 64.0, 63.0], "value": 62.9, "unit": "score"}]}]} 23:58:01 INFO - Return code: 0 23:58:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:58:01 ERROR - # TBPL SUCCESS # 23:58:01 INFO - Running post-action listener: _resource_record_post_action 23:58:01 INFO - [mozharness: 2017-01-24 07:58:01.147100Z] Finished run-tests step (success) 23:58:01 INFO - Running post-run listener: _resource_record_post_run 23:58:01 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 337776640; Read time: 12; Write time: 169444 23:58:01 INFO - TinderboxPrint: CPU usage
13.2% 23:58:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:58:01 INFO - TinderboxPrint: I/O write bytes / time
337,776,640 / 169,444 23:58:01 INFO - TinderboxPrint: CPU idle
8,216.3 (86.8%) 23:58:01 INFO - TinderboxPrint: CPU user
1,198.2 (12.7%) 23:58:01 INFO - TinderboxPrint: Swap in / out
0 / 0 23:58:01 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 117911552; Read time: 0; Write time: 65360 23:58:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219865088; Read time: 12; Write time: 104084 23:58:01 INFO - Running post-run listener: _upload_blobber_files 23:58:01 INFO - Blob upload gear active. 23:58:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:58:01 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 23:58:01 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'] 23:58:01 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 23:58:02 INFO - (blobuploader) - INFO - Open directory for files ... 23:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:03 INFO - (blobuploader) - INFO - Done attempting. 23:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:03 INFO - (blobuploader) - INFO - Done attempting. 23:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:08 INFO - (blobuploader) - INFO - Done attempting. 23:58:08 INFO - (blobuploader) - INFO - Iteration through files over. 23:58:08 INFO - Return code: 0 23:58:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:58:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:58:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9fa2015a3c2fa6384b3ff7d5397773f30d79323cfa37ddef621e8ee3ade24788110f7452b76aab1e87d3209acce8f7e71028c9c60f28ea07e970afb0b491ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3f101c86d79ba9849c1ac76722bd13bcb6478712175b257577e3a1634f5ad7aea660c6139cffb38db996b66497b7e9e0e794321bd90877ad346d23d569abded", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdf47c56c5bdbe747f22feeb04df12db875ce99a7a78bf68cd3ba8969a9c1406bec46d47a8997a81e733e952b9362b8c769709bf9f3ccb21a134fde72e3e729"} 23:58:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:58:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:58:08 INFO - Contents: 23:58:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9fa2015a3c2fa6384b3ff7d5397773f30d79323cfa37ddef621e8ee3ade24788110f7452b76aab1e87d3209acce8f7e71028c9c60f28ea07e970afb0b491ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3f101c86d79ba9849c1ac76722bd13bcb6478712175b257577e3a1634f5ad7aea660c6139cffb38db996b66497b7e9e0e794321bd90877ad346d23d569abded", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdf47c56c5bdbe747f22feeb04df12db875ce99a7a78bf68cd3ba8969a9c1406bec46d47a8997a81e733e952b9362b8c769709bf9f3ccb21a134fde72e3e729"} 23:58:08 INFO - Running post-run listener: copy_logs_to_upload_dir 23:58:08 INFO - Copying logs to upload dir... 23:58:08 INFO - mkdir: /builds/slave/test/build/upload/logs 23:58:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.380399 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-23 23:58:08.466112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:08.471608) ========= 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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 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/e9fa2015a3c2fa6384b3ff7d5397773f30d79323cfa37ddef621e8ee3ade24788110f7452b76aab1e87d3209acce8f7e71028c9c60f28ea07e970afb0b491ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3f101c86d79ba9849c1ac76722bd13bcb6478712175b257577e3a1634f5ad7aea660c6139cffb38db996b66497b7e9e0e794321bd90877ad346d23d569abded", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdf47c56c5bdbe747f22feeb04df12db875ce99a7a78bf68cd3ba8969a9c1406bec46d47a8997a81e733e952b9362b8c769709bf9f3ccb21a134fde72e3e729"} build_url:https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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/e9fa2015a3c2fa6384b3ff7d5397773f30d79323cfa37ddef621e8ee3ade24788110f7452b76aab1e87d3209acce8f7e71028c9c60f28ea07e970afb0b491ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3f101c86d79ba9849c1ac76722bd13bcb6478712175b257577e3a1634f5ad7aea660c6139cffb38db996b66497b7e9e0e794321bd90877ad346d23d569abded", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdf47c56c5bdbe747f22feeb04df12db875ce99a7a78bf68cd3ba8969a9c1406bec46d47a8997a81e733e952b9362b8c769709bf9f3ccb21a134fde72e3e729"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:08.496715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:08.497105) ========= 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=41bf3e9aed84707956354da8000001c5-1485243142.861020-2009462106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:08.581893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:58:08.582235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:58:08.582556) ========= ========= Total master_lag: 0.20 =========