builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1487817078.84 results: success (0) buildid: 20170222164422 builduid: fbf3bca91a61499d8efa0dcc537a7aea revision: e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.839861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.840329) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.840599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.859073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.859456) ========= 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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-22 18:31:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.0M=0s 2017-02-22 18:31:19 (41.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.986970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:18.990558) ========= 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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:19.040210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 18:31:19.040689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 --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 e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 --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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-22 18:31:19,898 truncating revision to first 12 chars 2017-02-22 18:31:19,898 Setting DEBUG logging. 2017-02-22 18:31:19,898 attempt 1/10 2017-02-22 18:31:19,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e2a6d2b4f1b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 18:31:20,946 unpacking tar archive at: mozilla-beta-e2a6d2b4f1b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.359985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 18:31:20.417045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:20.418108) ========= script_repo_revision: e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:20.418531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:20.418784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 18:31:20.432740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-22 18:31:20.433139) ========= /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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:21 INFO - MultiFileLogger online at 20170222 18:31:21 in /builds/slave/test 18:31:21 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 18:31:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:21 INFO - {'append_to_log': False, 18:31:21 INFO - 'base_work_dir': '/builds/slave/test', 18:31:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:31:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:21 INFO - 'branch': 'Mozilla-Beta', 18:31:21 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:21 INFO - 'config_files': ('talos/linux_config.py',), 18:31:21 INFO - 'default_actions': ('clobber', 18:31:21 INFO - 'read-buildbot-config', 18:31:21 INFO - 'download-and-extract', 18:31:21 INFO - 'populate-webroot', 18:31:21 INFO - 'create-virtualenv', 18:31:21 INFO - 'install', 18:31:21 INFO - 'run-tests'), 18:31:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:21 INFO - 'download_minidump_stackwalk': True, 18:31:21 INFO - 'download_symbols': 'ondemand', 18:31:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:21 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:21 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:21 INFO - 'installer_path': 'installer.exe', 18:31:21 INFO - 'log_level': 'info', 18:31:21 INFO - 'log_name': 'talos', 18:31:21 INFO - 'log_to_console': True, 18:31:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:21 INFO - 'opt_config_files': (), 18:31:21 INFO - 'pip_index': False, 18:31:21 INFO - 'sps_profile': False, 18:31:21 INFO - 'sps_profile_interval': 0, 18:31:21 INFO - 'suite': 'dromaeojs-e10s', 18:31:21 INFO - 'system_bits': '32', 18:31:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:21 INFO - 'title': 'talos-linux64-ix-025', 18:31:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:21 INFO - 'use_talos_json': True, 18:31:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:21 INFO - 'work_dir': 'build'} 18:31:21 INFO - [mozharness: 2017-02-23 02:31:21.387448Z] Running clobber step. 18:31:21 INFO - Running pre-action listener: _resource_record_pre_action 18:31:21 INFO - Running main action method: clobber 18:31:21 INFO - rmtree: /builds/slave/test/build 18:31:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:23 INFO - Running post-action listener: _resource_record_post_action 18:31:23 INFO - [mozharness: 2017-02-23 02:31:23.020769Z] Finished clobber step (success) 18:31:23 INFO - [mozharness: 2017-02-23 02:31:23.020868Z] Running read-buildbot-config step. 18:31:23 INFO - Running pre-action listener: _resource_record_pre_action 18:31:23 INFO - Running main action method: read_buildbot_config 18:31:23 INFO - Using buildbot properties: 18:31:23 INFO - { 18:31:23 INFO - "project": "", 18:31:23 INFO - "product": "firefox", 18:31:23 INFO - "script_repo_revision": "production", 18:31:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:31:23 INFO - "repository": "", 18:31:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 18:31:23 INFO - "buildid": "20170222164422", 18:31:23 INFO - "pgo_build": "True", 18:31:23 INFO - "basedir": "/builds/slave/test", 18:31:23 INFO - "buildnumber": 347, 18:31:23 INFO - "slavename": "talos-linux64-ix-025", 18:31:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:31:23 INFO - "platform": "ubuntu64_hw", 18:31:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:31:23 INFO - "branch": "mozilla-beta", 18:31:23 INFO - "repo_path": "releases/mozilla-beta", 18:31:23 INFO - "revision": "e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5", 18:31:23 INFO - "stage_platform": "linux64-pgo", 18:31:23 INFO - "builduid": "fbf3bca91a61499d8efa0dcc537a7aea", 18:31:23 INFO - "slavebuilddir": "test" 18:31:23 INFO - } 18:31:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 18:31:23 INFO - Running post-action listener: _resource_record_post_action 18:31:23 INFO - [mozharness: 2017-02-23 02:31:23.023500Z] Finished read-buildbot-config step (success) 18:31:23 INFO - [mozharness: 2017-02-23 02:31:23.023619Z] Running download-and-extract step. 18:31:23 INFO - Running pre-action listener: _resource_record_pre_action 18:31:23 INFO - Running main action method: download_and_extract 18:31:23 INFO - mkdir: /builds/slave/test/build/tests 18:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:23 INFO - trying https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:31:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/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 18:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/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 18:31:23 INFO - Downloaded 1327 bytes. 18:31:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:31:23 INFO - Using the following test package requirements: 18:31:23 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:31:23 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:31:23 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 18:31:23 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'jsshell-linux-x86_64.zip'], 18:31:23 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:31:23 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:31:23 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 18:31:23 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 18:31:23 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:31:23 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:31:23 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:31:23 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:31:24 INFO - Http code: 200 18:31:24 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 18:31:24 INFO - x-amz-cf-id: iSO2r6OzhHebh-MJOGGdfRXOaXalVVTTFJV0ORs__LI3vRmvwqINDw== 18:31:24 INFO - x-amz-version-id: elKSOfAO5OOjsBM7Sn5tl.2E3mL0j_5o 18:31:24 INFO - Expected file size: 21963771 18:31:24 INFO - Obtained file size: 21963771 18:31:28 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 18:31:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:31:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:31:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:31:29 INFO - Http code: 200 18:31:29 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 18:31:29 INFO - x-amz-cf-id: ozmjQc372OX5tnfwAur5jSVXYkoQrC-CheYw3yTDyXxxVHjt-Yh9RA== 18:31:29 INFO - x-amz-version-id: elKSOfAO5OOjsBM7Sn5tl.2E3mL0j_5o 18:31:29 INFO - Expected file size: 21963771 18:31:29 INFO - Obtained file size: 21963771 18:31:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 18:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:31:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 18:31:34 INFO - Http code: 200 18:31:34 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 18:31:34 INFO - x-amz-cf-id: BEFaXrQzjt-IaMDpm8zhgWRyq1XTcmtcwIqHGhAO1s5qJRhClcAnnw== 18:31:34 INFO - x-amz-version-id: e2xALpq5uSwPXtQGxuqkxXaOcz0TsIi9 18:31:34 INFO - Expected file size: 14403005 18:31:34 INFO - Obtained file size: 14403005 18:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:34 INFO - trying https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:31:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/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 18:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/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 18:31:36 INFO - Downloaded 57730202 bytes. 18:31:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - mkdir: /builds/slave/test/properties 18:31:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:36 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:36 INFO - Contents: 18:31:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - Running post-action listener: _resource_record_post_action 18:31:36 INFO - Running post-action listener: set_extra_try_arguments 18:31:36 INFO - [mozharness: 2017-02-23 02:31:36.935858Z] Finished download-and-extract step (success) 18:31:36 INFO - [mozharness: 2017-02-23 02:31:36.936089Z] Running populate-webroot step. 18:31:36 INFO - Running pre-action listener: _resource_record_pre_action 18:31:36 INFO - Running main action method: populate_webroot 18:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:36 INFO - '--tppagecycles', 18:31:36 INFO - '7'], 18:31:36 INFO - 'tests': ['tsvgm']}}, 18:31:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['damp', 'tps']}, 18:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['damp', 'tps']}, 18:31:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['dromaeo_dom']}, 18:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['basic_compositor_video']}, 18:31:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tsvgx', 18:31:36 INFO - 'tsvgr_opacity', 18:31:36 INFO - 'tart', 18:31:36 INFO - 'tscrollx', 18:31:36 INFO - 'cart']}, 18:31:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:36 INFO - 'tsvgr_opacity', 18:31:36 INFO - 'tart', 18:31:36 INFO - 'tscrollx', 18:31:36 INFO - 'cart']}, 18:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tp5o']}, 18:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['tp5o']}, 18:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s', 18:31:36 INFO - '--xperf_path', 18:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:36 INFO - 'tests': ['tp5n']}, 18:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--xperf_path', 18:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:36 INFO - 'tests': ['tp5n']}}, 18:31:36 INFO - 'talos.zip': {'path': '', 18:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:36 INFO - Running post-action listener: _resource_record_post_action 18:31:36 INFO - [mozharness: 2017-02-23 02:31:36.951639Z] Finished populate-webroot step (success) 18:31:36 INFO - [mozharness: 2017-02-23 02:31:36.951728Z] Running create-virtualenv step. 18:31:36 INFO - Running pre-action listener: _resource_record_pre_action 18:31:36 INFO - Running main action method: create_virtualenv 18:31:36 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:36 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 18:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:37 INFO - Using real prefix '/usr' 18:31:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:39 INFO - Installing pip.................done. 18:31:39 INFO - Return code: 0 18:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:39 INFO - Reading from file tmpfile_stdout 18:31:39 INFO - Output received: 18:31:39 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) 18:31:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:39 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')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 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')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:39 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 18:31:39 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 18:31:39 INFO - Using env: {'DISPLAY': ':0', 18:31:39 INFO - 'HOME': '/home/cltbld', 18:31:39 INFO - 'LANG': 'en_US.UTF-8', 18:31:39 INFO - 'LANGUAGE': 'en_US:en', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MAIL': '/var/mail/cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SHLVL': '1', 18:31:39 INFO - 'TERM': 'linux', 18:31:39 INFO - 'TMOUT': '86400', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - '_': '/tools/buildbot/bin/python'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 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 18:31:39 INFO - Cleaning up... 18:31:39 INFO - Return code: 0 18:31:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:39 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')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 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')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:39 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 18:31:39 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 18:31:39 INFO - Using env: {'DISPLAY': ':0', 18:31:39 INFO - 'HOME': '/home/cltbld', 18:31:39 INFO - 'LANG': 'en_US.UTF-8', 18:31:39 INFO - 'LANGUAGE': 'en_US:en', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MAIL': '/var/mail/cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SHLVL': '1', 18:31:39 INFO - 'TERM': 'linux', 18:31:39 INFO - 'TMOUT': '86400', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - '_': '/tools/buildbot/bin/python'} 18:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:40 INFO - Downloading/unpacking psutil>=3.1.1 18:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:42 INFO - Installing collected packages: psutil 18:31:42 INFO - Running setup.py install for psutil 18:31:42 INFO - building 'psutil._psutil_linux' extension 18:31:42 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 18:31:42 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 18:31:42 INFO - building 'psutil._psutil_posix' extension 18:31:42 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 18:31:42 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 18:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:42 INFO - Successfully installed psutil 18:31:42 INFO - Cleaning up... 18:31:42 INFO - Return code: 0 18:31:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:42 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')]} 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 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')]} 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:42 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 18:31:42 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 18:31:42 INFO - Using env: {'DISPLAY': ':0', 18:31:42 INFO - 'HOME': '/home/cltbld', 18:31:42 INFO - 'LANG': 'en_US.UTF-8', 18:31:42 INFO - 'LANGUAGE': 'en_US:en', 18:31:42 INFO - 'LOGNAME': 'cltbld', 18:31:42 INFO - 'MAIL': '/var/mail/cltbld', 18:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:42 INFO - 'MOZ_NO_REMOTE': '1', 18:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:42 INFO - 'NO_EM_RESTART': '1', 18:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:42 INFO - 'PWD': '/builds/slave/test', 18:31:42 INFO - 'SHELL': '/bin/bash', 18:31:42 INFO - 'SHLVL': '1', 18:31:42 INFO - 'TERM': 'linux', 18:31:42 INFO - 'TMOUT': '86400', 18:31:42 INFO - 'USER': 'cltbld', 18:31:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:42 INFO - '_': '/tools/buildbot/bin/python'} 18:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:43 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 18:31:43 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 18:31:43 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 18:31:43 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 18:31:43 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 18:31:43 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 18:31:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:45 INFO - Installing collected packages: mozsystemmonitor 18:31:45 INFO - Running setup.py install for mozsystemmonitor 18:31:45 INFO - Successfully installed mozsystemmonitor 18:31:45 INFO - Cleaning up... 18:31:45 INFO - Return code: 0 18:31:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:45 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 18:31:45 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 18:31:45 INFO - Using env: {'DISPLAY': ':0', 18:31:45 INFO - 'HOME': '/home/cltbld', 18:31:45 INFO - 'LANG': 'en_US.UTF-8', 18:31:45 INFO - 'LANGUAGE': 'en_US:en', 18:31:45 INFO - 'LOGNAME': 'cltbld', 18:31:45 INFO - 'MAIL': '/var/mail/cltbld', 18:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:45 INFO - 'MOZ_NO_REMOTE': '1', 18:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:45 INFO - 'NO_EM_RESTART': '1', 18:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:45 INFO - 'PWD': '/builds/slave/test', 18:31:45 INFO - 'SHELL': '/bin/bash', 18:31:45 INFO - 'SHLVL': '1', 18:31:45 INFO - 'TERM': 'linux', 18:31:45 INFO - 'TMOUT': '86400', 18:31:45 INFO - 'USER': 'cltbld', 18:31:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:45 INFO - '_': '/tools/buildbot/bin/python'} 18:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:47 INFO - warning: no files found matching '*.txt' 18:31:47 INFO - no previously-included directories found matching 'build' 18:31:47 INFO - no previously-included directories found matching 'dist' 18:31:47 INFO - no previously-included directories found matching '.git*' 18:31:47 INFO - Installing collected packages: jsonschema, functools32 18:31:48 INFO - Running setup.py install for functools32 18:31:48 INFO - warning: no files found matching '*.txt' 18:31:48 INFO - no previously-included directories found matching 'build' 18:31:48 INFO - no previously-included directories found matching 'dist' 18:31:48 INFO - no previously-included directories found matching '.git*' 18:31:48 INFO - Successfully installed jsonschema functools32 18:31:48 INFO - Cleaning up... 18:31:48 INFO - Return code: 0 18:31:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31:48 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')]} 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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')]} 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:48 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 18:31:48 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 18:31:48 INFO - Using env: {'DISPLAY': ':0', 18:31:48 INFO - 'HOME': '/home/cltbld', 18:31:48 INFO - 'LANG': 'en_US.UTF-8', 18:31:48 INFO - 'LANGUAGE': 'en_US:en', 18:31:48 INFO - 'LOGNAME': 'cltbld', 18:31:48 INFO - 'MAIL': '/var/mail/cltbld', 18:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:48 INFO - 'MOZ_NO_REMOTE': '1', 18:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:48 INFO - 'NO_EM_RESTART': '1', 18:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:48 INFO - 'PWD': '/builds/slave/test', 18:31:48 INFO - 'SHELL': '/bin/bash', 18:31:48 INFO - 'SHLVL': '1', 18:31:48 INFO - 'TERM': 'linux', 18:31:48 INFO - 'TMOUT': '86400', 18:31:48 INFO - 'USER': 'cltbld', 18:31:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:48 INFO - '_': '/tools/buildbot/bin/python'} 18:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:48 INFO - Cleaning up... 18:31:48 INFO - Return code: 0 18:31:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:48 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')]} 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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')]} 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:48 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 18:31:48 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 18:31:48 INFO - Using env: {'DISPLAY': ':0', 18:31:48 INFO - 'HOME': '/home/cltbld', 18:31:48 INFO - 'LANG': 'en_US.UTF-8', 18:31:48 INFO - 'LANGUAGE': 'en_US:en', 18:31:48 INFO - 'LOGNAME': 'cltbld', 18:31:48 INFO - 'MAIL': '/var/mail/cltbld', 18:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:48 INFO - 'MOZ_NO_REMOTE': '1', 18:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:48 INFO - 'NO_EM_RESTART': '1', 18:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:48 INFO - 'PWD': '/builds/slave/test', 18:31:48 INFO - 'SHELL': '/bin/bash', 18:31:48 INFO - 'SHLVL': '1', 18:31:48 INFO - 'TERM': 'linux', 18:31:48 INFO - 'TMOUT': '86400', 18:31:48 INFO - 'USER': 'cltbld', 18:31:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:48 INFO - '_': '/tools/buildbot/bin/python'} 18:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:50 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 18:31:50 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 18:31:50 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 18:31:50 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 18:31:50 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 18:31:50 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 18:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:51 INFO - Downloading docopt-0.6.1.tar.gz 18:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:51 INFO - Running setup.py install for blobuploader 18:31:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:51 INFO - Running setup.py install for requests 18:31:51 INFO - Running setup.py install for docopt 18:31:51 INFO - Successfully installed blobuploader requests docopt 18:31:51 INFO - Cleaning up... 18:31:52 INFO - Return code: 0 18:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:52 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')]} 18:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:52 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')]} 18:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:52 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:52 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 18:31:52 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 18:31:52 INFO - Using env: {'DISPLAY': ':0', 18:31:52 INFO - 'HOME': '/home/cltbld', 18:31:52 INFO - 'LANG': 'en_US.UTF-8', 18:31:52 INFO - 'LANGUAGE': 'en_US:en', 18:31:52 INFO - 'LOGNAME': 'cltbld', 18:31:52 INFO - 'MAIL': '/var/mail/cltbld', 18:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:52 INFO - 'MOZ_NO_REMOTE': '1', 18:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:52 INFO - 'NO_EM_RESTART': '1', 18:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:52 INFO - 'PWD': '/builds/slave/test', 18:31:52 INFO - 'SHELL': '/bin/bash', 18:31:52 INFO - 'SHLVL': '1', 18:31:52 INFO - 'TERM': 'linux', 18:31:52 INFO - 'TMOUT': '86400', 18:31:52 INFO - 'USER': 'cltbld', 18:31:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:52 INFO - '_': '/tools/buildbot/bin/python'} 18:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:52 INFO - Running setup.py (path:/tmp/pip-8PR0Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:52 INFO - Running setup.py (path:/tmp/pip-37uykq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:52 INFO - Running setup.py (path:/tmp/pip-mdwLXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:52 INFO - Running setup.py (path:/tmp/pip-2EUGwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:52 INFO - Running setup.py (path:/tmp/pip-z1_x1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:52 INFO - Running setup.py (path:/tmp/pip-Md74Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 INFO - Running setup.py (path:/tmp/pip-L9gTwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 INFO - Running setup.py (path:/tmp/pip-Q6qSVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:52 INFO - Running setup.py (path:/tmp/pip-ei_VPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:52 INFO - Running setup.py (path:/tmp/pip-mh2mXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:53 INFO - Running setup.py (path:/tmp/pip-C5Ol1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:53 INFO - Running setup.py (path:/tmp/pip-iW5x4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:53 INFO - Running setup.py (path:/tmp/pip-L1J5d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:53 INFO - Running setup.py (path:/tmp/pip-dwUuUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:53 INFO - Running setup.py (path:/tmp/pip-7qooox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:53 INFO - Running setup.py (path:/tmp/pip-rf5HCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:53 INFO - Running setup.py (path:/tmp/pip-XGZQc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:53 INFO - Running setup.py install for manifestparser 18:31:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozcrash 18:31:53 INFO - Running setup.py install for mozdebug 18:31:53 INFO - Running setup.py install for mozdevice 18:31:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozfile 18:31:54 INFO - Running setup.py install for mozhttpd 18:31:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozinfo 18:31:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozInstall 18:31:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozleak 18:31:54 INFO - Running setup.py install for mozlog 18:31:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for moznetwork 18:31:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozprocess 18:31:54 INFO - Running setup.py install for mozprofile 18:31:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozrunner 18:31:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Running setup.py install for mozscreenshot 18:31:55 INFO - Running setup.py install for moztest 18:31:55 INFO - Running setup.py install for mozversion 18:31:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:55 INFO - Cleaning up... 18:31:55 INFO - Return code: 0 18:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:55 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 18:31:55 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 18:31:55 INFO - Using env: {'DISPLAY': ':0', 18:31:55 INFO - 'HOME': '/home/cltbld', 18:31:55 INFO - 'LANG': 'en_US.UTF-8', 18:31:55 INFO - 'LANGUAGE': 'en_US:en', 18:31:55 INFO - 'LOGNAME': 'cltbld', 18:31:55 INFO - 'MAIL': '/var/mail/cltbld', 18:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:55 INFO - 'MOZ_NO_REMOTE': '1', 18:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:55 INFO - 'NO_EM_RESTART': '1', 18:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:55 INFO - 'PWD': '/builds/slave/test', 18:31:55 INFO - 'SHELL': '/bin/bash', 18:31:55 INFO - 'SHLVL': '1', 18:31:55 INFO - 'TERM': 'linux', 18:31:55 INFO - 'TMOUT': '86400', 18:31:55 INFO - 'USER': 'cltbld', 18:31:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:55 INFO - '_': '/tools/buildbot/bin/python'} 18:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:55 INFO - Running setup.py (path:/tmp/pip-VTQPub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:55 INFO - Running setup.py (path:/tmp/pip-SOxEXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:55 INFO - Running setup.py (path:/tmp/pip-6rbqFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:55 INFO - Running setup.py (path:/tmp/pip-9LsjdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:55 INFO - Running setup.py (path:/tmp/pip-l8mQFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:55 INFO - Running setup.py (path:/tmp/pip-W29YVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:55 INFO - Running setup.py (path:/tmp/pip-69fpR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:56 INFO - Running setup.py (path:/tmp/pip-wLw3Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:56 INFO - Running setup.py (path:/tmp/pip-c0HgaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:56 INFO - Running setup.py (path:/tmp/pip-Z1A2K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:56 INFO - Running setup.py (path:/tmp/pip-9coIid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:56 INFO - Running setup.py (path:/tmp/pip-wOu20p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:56 INFO - Running setup.py (path:/tmp/pip-E5_MBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:56 INFO - Running setup.py (path:/tmp/pip-gCMwKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:56 INFO - Running setup.py (path:/tmp/pip-99DAWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:56 INFO - Running setup.py (path:/tmp/pip-1lfruv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:56 INFO - Running setup.py (path:/tmp/pip-ULNDlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:56 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)) 18:31:56 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)) 18:31:56 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)) 18:31:56 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)) 18:31:56 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)) 18:31:56 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)) 18:31:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:58 INFO - Downloading blessings-1.6.tar.gz 18:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:58 INFO - Installing collected packages: blessings 18:31:58 INFO - Running setup.py install for blessings 18:31:58 INFO - Successfully installed blessings 18:31:58 INFO - Cleaning up... 18:31:59 INFO - Return code: 0 18:31:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:59 INFO - Reading from file tmpfile_stdout 18:31:59 INFO - Current package versions: 18:31:59 INFO - argparse == 1.2.1 18:31:59 INFO - blessings == 1.6 18:31:59 INFO - blobuploader == 1.2.4 18:31:59 INFO - docopt == 0.6.1 18:31:59 INFO - functools32 == 3.2.3-2 18:31:59 INFO - jsonschema == 2.5.1 18:31:59 INFO - manifestparser == 1.1 18:31:59 INFO - mozInstall == 1.12 18:31:59 INFO - mozcrash == 1.0 18:31:59 INFO - mozdebug == 0.1 18:31:59 INFO - mozdevice == 0.48 18:31:59 INFO - mozfile == 1.2 18:31:59 INFO - mozhttpd == 0.7 18:31:59 INFO - mozinfo == 0.9 18:31:59 INFO - mozleak == 0.1 18:31:59 INFO - mozlog == 3.4 18:31:59 INFO - moznetwork == 0.27 18:31:59 INFO - mozprocess == 0.23 18:31:59 INFO - mozprofile == 0.28 18:31:59 INFO - mozrunner == 6.13 18:31:59 INFO - mozscreenshot == 0.1 18:31:59 INFO - mozsystemmonitor == 0.3 18:31:59 INFO - moztest == 0.8 18:31:59 INFO - mozversion == 1.4 18:31:59 INFO - psutil == 3.1.1 18:31:59 INFO - requests == 1.2.3 18:31:59 INFO - wsgiref == 0.1.2 18:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:59 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')]} 18:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:59 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')]} 18:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:59 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:59 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 18:31:59 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 18:31:59 INFO - Using env: {'DISPLAY': ':0', 18:31:59 INFO - 'HOME': '/home/cltbld', 18:31:59 INFO - 'LANG': 'en_US.UTF-8', 18:31:59 INFO - 'LANGUAGE': 'en_US:en', 18:31:59 INFO - 'LOGNAME': 'cltbld', 18:31:59 INFO - 'MAIL': '/var/mail/cltbld', 18:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:59 INFO - 'MOZ_NO_REMOTE': '1', 18:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:59 INFO - 'NO_EM_RESTART': '1', 18:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:59 INFO - 'PWD': '/builds/slave/test', 18:31:59 INFO - 'SHELL': '/bin/bash', 18:31:59 INFO - 'SHLVL': '1', 18:31:59 INFO - 'TERM': 'linux', 18:31:59 INFO - 'TMOUT': '86400', 18:31:59 INFO - 'USER': 'cltbld', 18:31:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:59 INFO - '_': '/tools/buildbot/bin/python'} 18:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 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)) 18:31:59 INFO - Cleaning up... 18:31:59 INFO - Return code: 0 18:31:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:59 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')]} 18:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:59 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')]} 18:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:59 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 0x7f54c825df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, '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': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', '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 18:31:59 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 18:31:59 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 18:31:59 INFO - Using env: {'DISPLAY': ':0', 18:31:59 INFO - 'HOME': '/home/cltbld', 18:31:59 INFO - 'LANG': 'en_US.UTF-8', 18:31:59 INFO - 'LANGUAGE': 'en_US:en', 18:31:59 INFO - 'LOGNAME': 'cltbld', 18:31:59 INFO - 'MAIL': '/var/mail/cltbld', 18:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:59 INFO - 'MOZ_NO_REMOTE': '1', 18:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:59 INFO - 'NO_EM_RESTART': '1', 18:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:59 INFO - 'PWD': '/builds/slave/test', 18:31:59 INFO - 'SHELL': '/bin/bash', 18:31:59 INFO - 'SHLVL': '1', 18:31:59 INFO - 'TERM': 'linux', 18:31:59 INFO - 'TMOUT': '86400', 18:31:59 INFO - 'USER': 'cltbld', 18:31:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:59 INFO - '_': '/tools/buildbot/bin/python'} 18:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:59 INFO - Cleaning up... 18:31:59 INFO - Return code: 0 18:31:59 INFO - Running post-action listener: _resource_record_post_action 18:31:59 INFO - Running post-action listener: _start_resource_monitoring 18:31:59 INFO - Starting resource monitoring. 18:31:59 INFO - [mozharness: 2017-02-23 02:31:59.737041Z] Finished create-virtualenv step (success) 18:31:59 INFO - [mozharness: 2017-02-23 02:31:59.737549Z] Running install step. 18:31:59 INFO - Running pre-action listener: _resource_record_pre_action 18:31:59 INFO - Running main action method: install 18:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:59 INFO - Reading from file tmpfile_stdout 18:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:00 INFO - Reading from file tmpfile_stdout 18:32:00 INFO - Output received: 18:32:00 INFO - Usage: mozinstall [options] installer 18:32:00 INFO - Options: 18:32:00 INFO - -h, --help show this help message and exit 18:32:00 INFO - -d DEST, --destination=DEST 18:32:00 INFO - Directory to install application into. [default: 18:32:00 INFO - "/builds/slave/test"] 18:32:00 INFO - --app=APP Application being installed. [default: firefox] 18:32:00 INFO - mkdir: /builds/slave/test/build/application 18:32:00 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'] 18:32:00 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 18:32:13 INFO - Reading from file tmpfile_stdout 18:32:13 INFO - Output received: 18:32:13 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:13 INFO - Running post-action listener: _resource_record_post_action 18:32:13 INFO - [mozharness: 2017-02-23 02:32:13.675896Z] Finished install step (success) 18:32:13 INFO - [mozharness: 2017-02-23 02:32:13.676142Z] Running run-tests step. 18:32:13 INFO - Running pre-action listener: _resource_record_pre_action 18:32:13 INFO - Running main action method: run_tests 18:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:13 INFO - Python 2.7.3 18:32:13 INFO - Return code: 0 18:32:13 INFO - grabbing minidump binary from tooltool 18:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:13 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 0xd4ff60>, '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 0xd50d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd511d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:13 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 18:32:13 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 18:32:13 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 18:32:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:13 INFO - Return code: 0 18:32:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:13 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/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:32:13 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/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 18:32:13 INFO - Using env: {'DISPLAY': ':0', 18:32:13 INFO - 'HOME': '/home/cltbld', 18:32:13 INFO - 'LANG': 'en_US.UTF-8', 18:32:13 INFO - 'LANGUAGE': 'en_US:en', 18:32:13 INFO - 'LOGNAME': 'cltbld', 18:32:13 INFO - 'MAIL': '/var/mail/cltbld', 18:32:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:13 INFO - 'MOZ_NO_REMOTE': '1', 18:32:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:13 INFO - 'NO_EM_RESTART': '1', 18:32:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:13 INFO - 'PWD': '/builds/slave/test', 18:32:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:13 INFO - 'SHELL': '/bin/bash', 18:32:13 INFO - 'SHLVL': '1', 18:32:13 INFO - 'TERM': 'linux', 18:32:13 INFO - 'TMOUT': '86400', 18:32:13 INFO - 'USER': 'cltbld', 18:32:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1487817078.894717-953513393', 18:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:13 INFO - '_': '/tools/buildbot/bin/python'} 18:32:13 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/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:32:13 INFO - mozversion application_buildid: 20170222164422 18:32:13 INFO - mozversion application_changeset: e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 18:32:13 INFO - mozversion application_display_name: Firefox 18:32:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:13 INFO - mozversion application_name: Firefox 18:32:13 INFO - mozversion application_remotingname: firefox 18:32:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:32:13 INFO - mozversion application_vendor: Mozilla 18:32:13 INFO - mozversion application_version: 52.0 18:32:13 INFO - mozversion platform_buildid: 20170222164422 18:32:13 INFO - mozversion platform_changeset: e2a6d2b4f1b4b8e0c77d057bc012fb20a18df2f5 18:32:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:32:13 INFO - mozversion platform_version: 52.0 18:32:13 INFO - using testdate: 1487817133 18:32:13 INFO - actual date: 1487817133 18:32:13 INFO - starting webserver on 'localhost:32986' 18:32:13 INFO - SUITE-START | Running 2 tests 18:32:13 INFO - TEST-START | dromaeo_css 18:32:13 INFO - operating with platform_type : linux_ 18:32:13 INFO - Initialising browser for dromaeo_css test... 18:32:13 INFO - TEST-INFO | started process 7793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUGxzN/profile http://localhost:32986/getInfo.html) 18:32:18 INFO - PROCESS | 7793 | __metrics Screen width/height:1600/1200 18:32:18 INFO - PROCESS | 7793 | colorDepth:24 18:32:18 INFO - PROCESS | 7793 | Browser inner width/height: 1024/697 18:32:18 INFO - PROCESS | 7793 | __metrics 18:32:18 ERROR - PROCESS | 7793 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 18:32:19 INFO - TEST-INFO | 7793: exit 0 18:32:19 INFO - Browser initialized. 18:32:19 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:19 INFO - TEST-INFO | started process 7923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUGxzN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:31 INFO - PROCESS | 7923 | RSS: Main: 147283968 18:32:31 INFO - PROCESS | 7923 | 18:35:31 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32986/tests/dromaeo/cssquery-ext.html) 18:35:32 INFO - PROCESS | 7923 | RSS: Main: 154509312 18:35:32 INFO - PROCESS | 7923 | 18:38:35 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-ext.html (next: http://localhost:32986/tests/dromaeo/cssquery-jquery.html) 18:38:35 INFO - PROCESS | 7923 | RSS: Main: 152756224 18:38:35 INFO - PROCESS | 7923 | 18:41:37 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32986/tests/dromaeo/cssquery-mootools.html) 18:41:38 INFO - PROCESS | 7923 | RSS: Main: 152154112 18:41:38 INFO - PROCESS | 7923 | 18:44:39 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32986/tests/dromaeo/cssquery-prototype.html) 18:44:40 INFO - PROCESS | 7923 | RSS: Main: 153337856 18:44:40 INFO - PROCESS | 7923 | 18:47:42 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32986/tests/dromaeo/cssquery-yui.html) 18:47:43 INFO - PROCESS | 7923 | RSS: Main: 155099136 18:47:43 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | Cycle 1(1): loaded http://localhost:32986/tests/dromaeo/cssquery-yui.html (next: http://localhost:32986/tests/dromaeo/cssquery-dojo.html) 18:50:46 INFO - PROCESS | 7923 | RSS: Main: 155504640 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | __start_tp_report 18:50:46 INFO - PROCESS | 7923 | _x_x_mozilla_page_load 18:50:46 INFO - PROCESS | 7923 | _x_x_mozilla_page_load_details 18:50:46 INFO - PROCESS | 7923 | |i|pagename|runs| 18:50:46 INFO - PROCESS | 7923 | |0;dojo.html;3203.0550987458696;3208.3743669984347;3229.079712282;3230.1763050422146;3231.3537292541496;5572.3870374258795;5637.605367624268;5664.943350566493;5671.801486947952;5677.858053548658;5656.151577263413;5709.914351284734;5717.77128914844;5720.628159169662;5765.596408251414;5138.434772175057;5174.611904107188;5185.792568297264;5226.111561034633;5231.555317797973;5219;5224.21636754488;5230.476952304758;5235.136202526579;5240.34495688039;5052.7726252318735;5099.031184075014;5242.764075616587;5252.343457067866;5261.526462618363;5145.511176438233;5164.767585458663;5174.844754657329;5191.870203244911;5221.738913054332;5135.229715542661;5225.764840582183;5227.137522308814;5243.134882744343;5250.7112108834;5722.885542289173;5754.367019627837;5771.682557459338;5780.479756821865;5786.334571524287;5929.91105133419;5999;6023.608465449732;6054.8183554493;6098.176746139259;6073.362296958844;6092;6101.603395779304;6142.692865356759;6171.043488259327;5751.309842818847;5756.366799652035;5759.884802304015;5762.1068734346245;5768.971155144198;6091.634501929899;6120.724567394478;6134.00801433197;6283.340249273851;6303.936960630427;5944.227250457413;5960.731767070492;5964;5964.850878728066;5987.401259873977;6045.455908968214;6045.939540604626;6046.2139921809885;6054.3642917493025;6063.090536419484;5806;5833.387494313036;5934.287885453773;5978.432048955342;5986.610870293417;5897.76408943646;6015.969920150371;6023.397660233942;6036.185115009505;6071.453569178795;4631.096936097496;4683.039976804815;4688.226442636927;4692.577668009895;4715.834945776881;4043.9595604043584;4072.3891416287793;4094.6314831665295;4122.2786012447705;4163.875083747493;5790.768369265266;5829.679367634736;5837.124431335249;5848.152017957457;5869.266341707286;6054.66699331541;6133.754649814046;6134.141220229171;6136.417040381157;6141.232345956755;5632.915506267409;5718.170865224519;5783.421657834183;5821.18503409523;5825.854353641108;5249.553787927993;5305.522502974751;5341.5192632662465;5346.19807028941;5375.75809088592;6344.555881088279;6388.456981156561;6389.041643753474;6389.712462939179;6397.328280530571;5907.32065812437;5944.613600115978;6115.205023346936;6171.938280617316;6177.598456100339;6281.403266689657;6342.334054924167;6343.55595108338;6363.93636063652;6408.967955160194;6063.636181829104;6065.7876974307455;6067.059605761114;6078.756849725962;6084.543659225665;5842.415758424124;6162.291336496181;6190.380961903774;6195.597286176564;6197.96901015492;5783.595148339576;5902.996490596523;5941.168236446814;5979.222701048836;6031.517478601789;5881.2942446906645;5976.9103463448955;5990.910136348046;5999.070144127667;6001.2498437695285;5874.118882167709;5922.318933322723;5924.555658325557;5928.318243402064;5928.436798504135;5647.661140331593;5797.739101740347;5801.129830525455;5855.94144058554;5910.7340169693325;5732.082866741302;5738.110592858114;5742.712864356849;5749.540036796962;5749.913751293818 18:50:46 INFO - PROCESS | 7923 | |1;ext.html;573.9426057394261;604.4408921747382;625.3215261441336;693.4348505967633;697.4908316928645;40392.798036009815;41250.79374603127;44940.77529612347;44963.775181124045;45084.549154508444;44390.556094439045;45590.31614525776;45607.77196114015;45618;45703;8322.750317490485;8567.271781898515;8939;10715.464226788668;11023.228374013823;10895.455227238646;11026.503807328649;11032.393218372987;11046;11064.391458469781;11026.393548354838;11072;11077.169212309069;11086.279391839545;11097.667069987914;10996.28524145932;11001.889981100247;11013.614523491638;11037.724056898602;11039.227254092217;10278.33190842593;10413;10414.739631509197;10420.895791042069;10424.061834434937;44108;44400.555994440285;44426.55573444289;44472.555274447164;44498.33252501215;3838.712096592739;3940.310445671996;4060.593940605945;4144.730592511477;4303.139372125587;32838.34323313544;32852.507212391836;33030.97809256446;33065.6693433065;33097.50353744672;4523.751193684346;4566.1780879441685;4568.1548913451115;4599.2871104978785;4647.930281045787;513287;524697;527635;531982;533444;64299.35700643027;64972.67513662401;65011;65136.674316628116;65467.345326547074;69005;69386;69419;69422.3057769426;69515.65242173757;18389.724154137697;18820.341288054853;18885.961272130164;18985.81014189868;19002.334918277793;14333.498327558485;14601.78097328541;14717.92641036788;15094.622634434007;15094.924525377523;20024.49938751543;20061.398158055283;20095.698564521543;20187;20478.180872764922;7288.416926645856;7484.925150748531;7537.773866784005;7538.246175382527;7630.2751238632245;970.9368891022061;1023.9078482936422;1082.875469321038;1105.690406686129;1141.937193454368;31467.685323146932;31825;31983.88056418014;32338;32612.673873260963;1115.7768446310608;1136.3749937534324;1179.3690375648987;1217.9634610961684;1222.914395992272;16795.496135115965;16959;16987.575310617332;17022.659546808994;17048.2328295227;519784;523227;525343;526312;526572;40733;40796.184076318306;41178.1764364717;41325.380119298236;41405.58594414017;1375.6217040313793;1422.8363738170035;1427.2578259305103;1433.8709516143597;1443.2639353929362;30510.84744576263;31305.686943130277;32045.839770800998;32253.677463226006;32406.83796581002;53247.73376133094;53486.19770703365;53604;53948;53986.46013539814;501194;501333;502080;504352;504724;30059;30689.232769180948;30906.53640195444;31051;32675.183120422178;48625.270620940006;48973.26540101973;49062.50937490579;49782.75108624434;50089.24866126938;41289.79355103205;41735.34365065959;42175.57824421839;42206.577934220266;42795.35806962836;40881.18237635171;41263.381049284886;41287.96780080402;42593.57406425896;42978.78510607427;40469;40552;40869.18261634691;41776;42017.369739454545;36437.27125457529;37534;37862.810685946395;37972;38020;28453.50109682489;28532.42935141327;29038;29074.27314317159;29137.85431072831 18:50:46 INFO - PROCESS | 7923 | |2;jquery.html;423.80293163678886;424.57966613053065;425.8594663760959;432.8160531773996;447.7693987596388;18343.724844127348;19662.410127696174;20369.694454583176;20612.48468788281;20773.584528309464;19116.5220869478;19715.309964151256;20078.397648070546;20293.0868110935;20337.796622033777;5673.8581535461535;5948.970255148718;5966.433188847052;5976.61152025117;5980.162777211172;4102.548719640837;4364.454443194601;5841.415858414146;5941.494972927285;6439.323870993549;6523.18460192476;6524.739010439576;6530.967345163292;6543.345665433442;6546.901796473033;6360.109584658151;6464.644444555547;6471.417572418505;6476.255230648489;6548.9345106549035;5761.88476230473;5771.336296325934;5771.769129234825;5779.479846813807;5794.97102514489;14675.192864392455;14870.851291487055;14974.62563435912;14990.325435355435;15003.1748253846;2365.6215005599192;2443.4624382635793;2504.5742223821994;2544.5038217547585;2594.8443093414458;10606.78786424275;10751.462426878625;10793.406362650052;10820.891791082146;11317.264377815416;1967.8720883142694;1970.0740651893586;1979.8218160365493;1993.511589660528;2041.4896275931017;84169;88543;88608.55695721545;88902;89744;11536.365499897585;11787;11807;11870.050395968301;12078.939605301917;16915.323387064378;16926;16942.57643558921;16946.915265423595;16948.661026779395;8625.91374086251;8840.204381605687;8918.286537077018;8934.41926274803;9026.774330641787;8607.65569377218;8627.309815214769;8651.567421629019;8890.33322500802;8892.46645201277;5032.924506132411;5043.773030213649;5048.343715317059;5115.897682046339;5160.225966105114;2028.8072633099832;2088.3004193595316;2108.441263065289;2111.6515774897275;2146.248812915467;937.5452905340904;1037.7146284771597;1053.2258789789498;1098.181854518373;1136.4374634555948;19178;19242.518937026405;19511.219551217793;19581.706274405897;19625.31311404094;1051.358671210561;1071.614218881202;1074.9032587067202;1077.6174458067273;1145.255583870491;10253.33353332031;10973.670789876316;11007.944960275147;11020.834687479693;11095.50070246841;461286;476830;484467;488042;497670;91243.54378228067;93768;97071.51464242775;101999;102799.48600256951;1026.312370711625;1060.3107979813183;1076.3272954403499;1076.4402510694395;1076.9784604308027;17702.91148544249;17875.73186402231;17934.5516362092;18028.63942721112;18449.907750461163;43730.562694372646;43957.56042439535;44319.33520997252;45073.54926450693;45085;59308;60321.396786031575;61063;61893;62301.37698622956;8889.866652000095;8908;8996.415233009833;9044.502552359683;9380.48407337603;12722.681932951751;13617.931910340385;13687.31563421805;13698.931505342409;13781.310934453037;11579.247348922294;11765.764684706086;11847.822282665595;12106.394680266128;12181.451834667285;11287.379194144401;11582.420878956187;11727.413629318671;11769.705757356134;12146.635600931986;11287.43562821872;11969.222000569935;12031.338276394883;12179.512819487121;12452.31512266834;9039.096090390909;9101.317401195069;9158.67944621935;9185.954070229605;9338.906610933804;9057.864132037894;11885.82171267449;12095.153339266168;12358.938205308916;12494.875051249372 18:50:46 INFO - PROCESS | 7923 | |3;mootools.html;1522.7411340072188;1531.321811864753;1675.4303536797486;1733.6879361714903;1808.9638207235848;8334.37492188086;8835;9016.864747028783;9022.368434209608;9027.638894444222;9141.680041198559;9236.722898313044;9285.489298088602;9292.767680807983;9309.767255818608;2466.2108125399923;2515.157422263544;2516.169664010872;2516.7860731837723;2520.218732193017;2501.0996041425074;2560.1551488008913;2571.280041588349;2584.095566551711;2585.017693276552;2400.72391674957;2406.1217655555683;2450.816188785839;2451.7915977141874;2458.115078571722;2371.1819422299277;2398.052769156191;2404.446977195255;2414.311921102486;2420.576399130145;2494.3514686181543;2524.482481091372;2531.8354306969986;2539.3270783242456;2540.110961163578;8417.789555261106;8429.957850210709;8496.915030849674;8886.555672216364;8945.955270223607;5427.864303392407;5551.306086739158;5570.582206334541;5571.275734154575;5582.078956972095;3485.9651403485896;3515.5605549306338;3598;3669.889903302905;3681.9263614727556;1092.1644941619668;1123.2698745815203;1133.9773204535863;1252.1610520950985;1260.9873901260962;12388.566400176041;12513.499460021589;12518.37408129599;12531.561395351118;12596.81104783429;4665.206914824488;4710.6589052487;4799.928001079987;4809.422869255642;4878.536539028786;9810.705678829647;9835.114839664464;9861.556229969668;9868.703938881845;9909.35589186715;5373.811916582901;5471.097268950658;5477.068898287301;5525.613207075467;5562.749676264578;5061.898762024739;5188.844334669966;5341.919871201935;5356.223347614652;5389.730513474311;3974;4045.2314060328445;4107.63031327176;4131.814068366871;4141.668666506672;1238.746057058301;1246.7781574057474;1258.6916205529703;1263.6145975477568;1272.401971073594;925.2459245714721;1022.1822541966397;1044.5612842606124;1050.3435352904435;1050.6270274052602;6133.938660613337;6233.283172435228;6269.404406581368;6376.936230637727;6406.551541392151;969.2439896880445;997.1225321716988;1000.1298869983161;1021.1014307409432;1042.7914417116608;4010.2154541228874;4033.556308806029;4056.59434056592;4082.6937979651643;4194.517630472474;10962.287451315638;11227.831582526269;11261.21171517986;11291.604793832177;11322.26405283654;11129.499172537255;11190.720231994103;11247.831282530606;11278.887211127947;11293.887061129448;7807.960960195276;7983.241592048862;7983.800404989805;8095.554744488992;8254.092049874509;5970.402959704169;6055.303640081271;6076.179715738319;6254.906176407449;6369.8726025480155;10035.799284014132;10133.898661013296;10135.189184865341;10166.135878450414;10178.49107544605;9718.805623887341;10089.899101008896;10114;10317.48412579383;10395.792084158124;7586.3930885527925;7776.261255180749;7838.059432868093;7975.840483190188;8155.388345874202;8650.697225597074;8696.521691307038;8705.782355441164;8714.956425217833;8719.782005449915;7697.422693297913;7735.303822655988;7743.419243556643;7744.341730952707;7872.645730942236;7596.08846938371;7707.190744971697;7713.961430192813;7723.53658780475;7841.882371764542;7130.500864939404;7163.928360716326;7178.676959536938;7272.200057993511;7284.125904891447;5261.921071183859;5359.062164121341;5366.168243922199;5375.059364611256;5556.083246264483;5444.047291723853;5457.945420545744;5547.278853748987;5575.553955683455;5604.495595396434 18:50:46 INFO - PROCESS | 7923 | |4;prototype.html;350.7106637024454;362.9038304849215;364.37327796190544;369.79291596705866;370.9415866183319;5425.620206585536;5640.379558248589;5684.37471878093;5711.343195532515;5712.514436272922;5580.218769372291;5588.748506317215;5598.384177740445;5609.411011843759;5620.903923734873;3953.7627742335408;4239.978800106011;4382.904273931517;4407.250767369539;4415.359772832937;4335.0679603885155;4351.71713838601;4354.303311470166;4358.128374325148;4362.149380870732;4307.935380969288;4309.806058727365;4315.82736690532;4341.674374421915;4341.956580434203;4260.382244574519;4330.2638551446325;4339.435873336478;4349.717268377562;4365.454318210223;3785.8296376663116;3801.144742432958;3802.961970380316;3816.580176180618;3829.7319187656594;5443.8094666686875;5450.754716037788;5454.890902181974;5473.890522189534;5475.917861232085;4976.253561965698;5012;5016.498350164954;5018.172001619729;5028.270900719412;5653.519450846683;5849.859277440901;5850.590458667895;5879.52963762898;5888.057910734305;4228.788560571959;4230.344296634026;4230.576942305775;4236.322188449833;4239.04621460169;5763.7607914298205;6123.2039834821635;6134.693265336716;6136.907946380852;6150.261968563801;4215.114825886598;4233.518268606025;4246.681498887596;4255.510616279105;4264.33902745075;4290.034742182984;4290.957090429056;4310.814526005311;4314.180305741899;4323.697341186087;4882.194437917775;4934.432540257844;4953.151937635874;4980.779708971325;4984.152694042022;5846.210761547221;5899.852503687356;5901.822945311647;5911.615744976562;5921.703914804242;1486.4797320937585;1488.4641529049534;1500.2423775993054;1504.8720858727131;1511.3727802961648;995.576879826071;1011.4625768831335;1042.4318746283293;1043.8225501664735;1046.6127532812757;5563.582731295169;5592.105263157875;5612.494875461228;5628.200964349048;5630.155476678531;5869.911951320733;5872.911906321408;5914.852128696731;5933.199018132583;5976.924153652298;5391.595630327741;5555.666660000413;5592.412796656374;5614.410486898899;5616.943830561724;3138.666066921595;3149.9527507087414;3157.2422618571836;3166.651668316483;3168.746500279972;5930.495907847881;6053.7578496860515;6095.603785753912;6103.267607887082;6128.846778830565;5896.911546326808;5907.320658124285;5944.751602163594;5945.3757355477055;5958.731857066356;6014.6391216527145;6032.849178770566;6034.487068599218;6049.153118563405;6053.122297266872;5590.720463976866;5848.385919478394;5896.7518908170905;5900.232969713909;5902.4097590240635;5756.625819321731;5761.91357129635;5790.870780197821;5811.331696854916;5812;6094.963856144377;6143.477804386498;6292.930201865603;6331.525135614939;6373.649449280334;4360;4380.759058251827;4382;4394.736315821061;4400.1199760047475;6004.42957918997;6121.632702037892;6125.173101631222;6143.586974995686;6154.230721159855;5925.348211696796;5947.197128387612;5952.375000625046;5954.404559544184;5984.431479009487;5957.49361304294;5961.821145365646;5964.761409543743;5965.194698715618;5975.014122669711;5708.286464191976;5883.058710606282;5903.0555111182;5936.525077993837;5961.940380596138;5988.580799344004;6004.159417681615;6011.579189456696;6035;6037.818865434044;5672.858178545569;5864.472197502245;5878.529717622666;5884.411558844081;5903.321118071477 18:50:46 INFO - PROCESS | 7923 | |5;yui.html;740.866644004079;778.7975126467117;799.4363973398753;810.6514198894473;889.1242126505393;14730;15517.844821551795;15666.53000409988;16015.519534413957;16306.347746090141;14688.559343219693;14785;14834.109953402776;14837.703245935074;15194.16432096237;825.286127499713;852.4288726553224;852.995735021324;853.6713365354352;854.7264875239925;818.54161669465;846.9957650211741;849.7493239494333;852.9019162796264;856.1609622569886;895.5611750242399;896.7175339767953;901.2744740483907;902.1114202510522;904.4256896870469;900.837849187146;900.8423525882944;901.4681338010572;903.20969151992;903.742433406476;657.5660064357548;663.5952069237761;664.3588936676083;665.0655828560831;665.3579295979355;15383.61540961485;15607.609809754733;15764.921175394049;15810.288537015862;15841.366345346172;13873.930630346884;14186.07790493625;14223.786643200361;14396.208208548525;14501.501590794203;12215.206011609305;12407.813882791765;12421.751564968741;12485.687857803627;12504.937475312656;3769.7361184716806;3825.9234815303817;3833.3483307837455;3852.7303088783797;3966.6231707987695;66743.66628166876;67379.66310168417;67494.3250567488;67773.66113169403;68409;10376.325538839952;10524.158067354747;11259.211855170222;11420.486078126503;11542.826857597143;17110.058946758047;17178.828211717722;17249.310027599007;18164.545886352946;21013.159473620883;7854.057513098464;7896.526208427513;7964.163762804822;8035.437519373588;8092.635831387602;4364.4980827204645;4382.496012958487;4416.624586910084;4467.5532446755715;4564.132814765184;3297.653746356598;3351.4302568563403;3390.677885600864;3406.489026646023;3425.9657403425645;620.959637623553;642.5149012495536;644.8097811145723;656.9474442044625;658.8503062156567;655.7213184396708;706.720845266117;709.4785332780402;722.7831650504828;724;9443.76390590227;9698.321117521848;9829.017098290115;9912.256580756472;9913.900860991298;757.5984728094119;757.7802437293234;768.2970082374676;770.8959290495824;776.7281451491932;4515.435570553681;4594.816207351735;4613.354130421743;4631.120087183424;4669.182892993713;56159.43840561624;56359.154612680846;57198.42801571931;93062.53468732613;95364;65594.01608975869;68122.97815532771;80326.59836700778;82223.5888820552;82750;43059.569404305556;44253.77873110614;59345.10982335269;60562.39437605656;65679.01481477782;10205.693829185137;10438.895611043792;10647.680569582924;10746.892531074589;10763.246572739834;44233.77883110692;44639.776801117085;44689.32966005577;45188.322175166744;46609.53390466052;52986.735066325964;53230.20154697605;53396.4660353407;54555;61288.69355653193;12717.682057948625;12940.935295323463;12977.870221298044;13150.868491314965;13198.934005329911;14405.351759170653;14539.78190327167;14563.854361456673;14756;15070.607569771062;13201.735965280832;13577.253251070892;13753.862461375258;14729.926350368609;14746;13680.31598420095;13888.722225555635;14018.439262429389;14768.778468323198;14773.778393324324;13207.405666745211;13730.176189428666;13760.93119534396;13925.094868833494;14332.355044022836;10433.108182262837;10825.51285192184;11093.389863557582;11121.27711698737;11675;11125.499352528994;11233;11264.66206013821;11275.801493193072;11504.482298296429 18:50:46 INFO - PROCESS | 7923 | __end_tp_report 18:50:46 INFO - PROCESS | 7923 | __start_cc_report 18:50:46 INFO - PROCESS | 7923 | _x_x_mozilla_cycle_collect,315 18:50:46 INFO - PROCESS | 7923 | __end_cc_report 18:50:46 INFO - PROCESS | 7923 | __startTimestamp1487818246560__endTimestamp 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | ------- Summary: start ------- 18:50:46 INFO - PROCESS | 7923 | Number of tests: 6 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#0] dojo.html Cycles:165 Average:5651.97 Median:5833.39 stddev:647.01 (11.1%) stddev-sans-first:619.81 18:50:46 INFO - PROCESS | 7923 | Values: 3203.1 3208.4 3229.1 3230.2 3231.4 5572.4 5637.6 5664.9 5671.8 5677.9 5656.2 5709.9 5717.8 5720.6 5765.6 5138.4 5174.6 5185.8 5226.1 5231.6 5219.0 5224.2 5230.5 5235.1 5240.3 5052.8 5099.0 5242.8 5252.3 5261.5 5145.5 5164.8 5174.8 5191.9 5221.7 5135.2 5225.8 5227.1 5243.1 5250.7 5722.9 5754.4 5771.7 5780.5 5786.3 5929.9 5999.0 6023.6 6054.8 6098.2 6073.4 6092.0 6101.6 6142.7 6171.0 5751.3 5756.4 5759.9 5762.1 5769.0 6091.6 6120.7 6134.0 6283.3 6303.9 5944.2 5960.7 5964.0 5964.9 5987.4 6045.5 6045.9 6046.2 6054.4 6063.1 5806.0 5833.4 5934.3 5978.4 5986.6 5897.8 6016.0 6023.4 6036.2 6071.5 4631.1 4683.0 4688.2 4692.6 4715.8 4044.0 4072.4 4094.6 4122.3 4163.9 5790.8 5829.7 5837.1 5848.2 5869.3 6054.7 6133.8 6134.1 6136.4 6141.2 5632.9 5718.2 5783.4 5821.2 5825.9 5249.6 5305.5 5341.5 5346.2 5375.8 6344.6 6388.5 6389.0 6389.7 6397.3 5907.3 5944.6 6115.2 6171.9 6177.6 6281.4 6342.3 6343.6 6363.9 6409.0 6063.6 6065.8 6067.1 6078.8 6084.5 5842.4 6162.3 6190.4 6195.6 6198.0 5783.6 5903.0 5941.2 5979.2 6031.5 5881.3 5976.9 5990.9 5999.1 6001.2 5874.1 5922.3 5924.6 5928.3 5928.4 5647.7 5797.7 5801.1 5855.9 5910.7 5732.1 5738.1 5742.7 5749.5 5749.9 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#1] ext.html Cycles:180 Average:67444.71 Median:22306.30 stddev:137433.54 (616.1%) stddev-sans-first:137727.36 18:50:46 INFO - PROCESS | 7923 | Values: 573.9 604.4 625.3 693.4 697.5 40392.8 41250.8 44940.8 44963.8 45084.5 44390.6 45590.3 45607.8 45618.0 45703.0 8322.8 8567.3 8939.0 10715.5 11023.2 10895.5 11026.5 11032.4 11046.0 11064.4 11026.4 11072.0 11077.2 11086.3 11097.7 10996.3 11001.9 11013.6 11037.7 11039.2 10278.3 10413.0 10414.7 10420.9 10424.1 44108.0 44400.6 44426.6 44472.6 44498.3 3838.7 3940.3 4060.6 4144.7 4303.1 32838.3 32852.5 33031.0 33065.7 33097.5 4523.8 4566.2 4568.2 4599.3 4647.9 513287.0 524697.0 527635.0 531982.0 533444.0 64299.4 64972.7 65011.0 65136.7 65467.3 69005.0 69386.0 69419.0 69422.3 69515.7 18389.7 18820.3 18886.0 18985.8 19002.3 14333.5 14601.8 14717.9 15094.6 15094.9 20024.5 20061.4 20095.7 20187.0 20478.2 7288.4 7484.9 7537.8 7538.2 7630.3 970.9 1023.9 1082.9 1105.7 1141.9 31467.7 31825.0 31983.9 32338.0 32612.7 1115.8 1136.4 1179.4 1218.0 1222.9 16795.5 16959.0 16987.6 17022.7 17048.2 519784.0 523227.0 525343.0 526312.0 526572.0 40733.0 40796.2 41178.2 41325.4 41405.6 1375.6 1422.8 1427.3 1433.9 1443.3 30510.8 31305.7 32045.8 32253.7 32406.8 53247.7 53486.2 53604.0 53948.0 53986.5 501194.0 501333.0 502080.0 504352.0 504724.0 30059.0 30689.2 30906.5 31051.0 32675.2 48625.3 48973.3 49062.5 49782.8 50089.2 41289.8 41735.3 42175.6 42206.6 42795.4 40881.2 41263.4 41288.0 42593.6 42978.8 40469.0 40552.0 40869.2 41776.0 42017.4 36437.3 37534.0 37862.8 37972.0 38020.0 28453.5 28532.4 29038.0 29074.3 29137.9 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#2] jquery.html Cycles:180 Average:29358.15 Median:11430.94 stddev:79756.59 (697.7%) stddev-sans-first:79950.74 18:50:46 INFO - PROCESS | 7923 | Values: 423.8 424.6 425.9 432.8 447.8 18343.7 19662.4 20369.7 20612.5 20773.6 19116.5 19715.3 20078.4 20293.1 20337.8 5673.9 5949.0 5966.4 5976.6 5980.2 4102.5 4364.5 5841.4 5941.5 6439.3 6523.2 6524.7 6531.0 6543.3 6546.9 6360.1 6464.6 6471.4 6476.3 6548.9 5761.9 5771.3 5771.8 5779.5 5795.0 14675.2 14870.9 14974.6 14990.3 15003.2 2365.6 2443.5 2504.6 2544.5 2594.8 10606.8 10751.5 10793.4 10820.9 11317.3 1967.9 1970.1 1979.8 1993.5 2041.5 84169.0 88543.0 88608.6 88902.0 89744.0 11536.4 11787.0 11807.0 11870.1 12078.9 16915.3 16926.0 16942.6 16946.9 16948.7 8625.9 8840.2 8918.3 8934.4 9026.8 8607.7 8627.3 8651.6 8890.3 8892.5 5032.9 5043.8 5048.3 5115.9 5160.2 2028.8 2088.3 2108.4 2111.7 2146.2 937.5 1037.7 1053.2 1098.2 1136.4 19178.0 19242.5 19511.2 19581.7 19625.3 1051.4 1071.6 1074.9 1077.6 1145.3 10253.3 10973.7 11007.9 11020.8 11095.5 461286.0 476830.0 484467.0 488042.0 497670.0 91243.5 93768.0 97071.5 101999.0 102799.5 1026.3 1060.3 1076.3 1076.4 1077.0 17702.9 17875.7 17934.6 18028.6 18449.9 43730.6 43957.6 44319.3 45073.5 45085.0 59308.0 60321.4 61063.0 61893.0 62301.4 8889.9 8908.0 8996.4 9044.5 9380.5 12722.7 13617.9 13687.3 13698.9 13781.3 11579.2 11765.8 11847.8 12106.4 12181.5 11287.4 11582.4 11727.4 11769.7 12146.6 11287.4 11969.2 12031.3 12179.5 12452.3 9039.1 9101.3 9158.7 9186.0 9338.9 9057.9 11885.8 12095.2 12358.9 12494.9 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#3] mootools.html Cycles:180 Average:5937.64 Median:4970.22 stddev:3286.76 (66.1%) stddev-sans-first:3279.23 18:50:46 INFO - PROCESS | 7923 | Values: 1522.7 1531.3 1675.4 1733.7 1809.0 8334.4 8835.0 9016.9 9022.4 9027.6 9141.7 9236.7 9285.5 9292.8 9309.8 2466.2 2515.2 2516.2 2516.8 2520.2 2501.1 2560.2 2571.3 2584.1 2585.0 2400.7 2406.1 2450.8 2451.8 2458.1 2371.2 2398.1 2404.4 2414.3 2420.6 2494.4 2524.5 2531.8 2539.3 2540.1 8417.8 8430.0 8496.9 8886.6 8946.0 5427.9 5551.3 5570.6 5571.3 5582.1 3486.0 3515.6 3598.0 3669.9 3681.9 1092.2 1123.3 1134.0 1252.2 1261.0 12388.6 12513.5 12518.4 12531.6 12596.8 4665.2 4710.7 4799.9 4809.4 4878.5 9810.7 9835.1 9861.6 9868.7 9909.4 5373.8 5471.1 5477.1 5525.6 5562.7 5061.9 5188.8 5341.9 5356.2 5389.7 3974.0 4045.2 4107.6 4131.8 4141.7 1238.7 1246.8 1258.7 1263.6 1272.4 925.2 1022.2 1044.6 1050.3 1050.6 6133.9 6233.3 6269.4 6376.9 6406.6 969.2 997.1 1000.1 1021.1 1042.8 4010.2 4033.6 4056.6 4082.7 4194.5 10962.3 11227.8 11261.2 11291.6 11322.3 11129.5 11190.7 11247.8 11278.9 11293.9 7808.0 7983.2 7983.8 8095.6 8254.1 5970.4 6055.3 6076.2 6254.9 6369.9 10035.8 10133.9 10135.2 10166.1 10178.5 9718.8 10089.9 10114.0 10317.5 10395.8 7586.4 7776.3 7838.1 7975.8 8155.4 8650.7 8696.5 8705.8 8715.0 8719.8 7697.4 7735.3 7743.4 7744.3 7872.6 7596.1 7707.2 7714.0 7723.5 7841.9 7130.5 7163.9 7178.7 7272.2 7284.1 5261.9 5359.1 5366.2 5375.1 5556.1 5444.0 5457.9 5547.3 5575.6 5604.5 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#4] prototype.html Cycles:180 Average:4929.56 Median:5613.45 stddev:1445.37 (25.7%) stddev-sans-first:1407.97 18:50:46 INFO - PROCESS | 7923 | Values: 350.7 362.9 364.4 369.8 370.9 5425.6 5640.4 5684.4 5711.3 5712.5 5580.2 5588.7 5598.4 5609.4 5620.9 3953.8 4240.0 4382.9 4407.3 4415.4 4335.1 4351.7 4354.3 4358.1 4362.1 4307.9 4309.8 4315.8 4341.7 4342.0 4260.4 4330.3 4339.4 4349.7 4365.5 3785.8 3801.1 3803.0 3816.6 3829.7 5443.8 5450.8 5454.9 5473.9 5475.9 4976.3 5012.0 5016.5 5018.2 5028.3 5653.5 5849.9 5850.6 5879.5 5888.1 4228.8 4230.3 4230.6 4236.3 4239.0 5763.8 6123.2 6134.7 6136.9 6150.3 4215.1 4233.5 4246.7 4255.5 4264.3 4290.0 4291.0 4310.8 4314.2 4323.7 4882.2 4934.4 4953.2 4980.8 4984.2 5846.2 5899.9 5901.8 5911.6 5921.7 1486.5 1488.5 1500.2 1504.9 1511.4 995.6 1011.5 1042.4 1043.8 1046.6 5563.6 5592.1 5612.5 5628.2 5630.2 5869.9 5872.9 5914.9 5933.2 5976.9 5391.6 5555.7 5592.4 5614.4 5616.9 3138.7 3150.0 3157.2 3166.7 3168.7 5930.5 6053.8 6095.6 6103.3 6128.8 5896.9 5907.3 5944.8 5945.4 5958.7 6014.6 6032.8 6034.5 6049.2 6053.1 5590.7 5848.4 5896.8 5900.2 5902.4 5756.6 5761.9 5790.9 5811.3 5812.0 6095.0 6143.5 6292.9 6331.5 6373.6 4360.0 4380.8 4382.0 4394.7 4400.1 6004.4 6121.6 6125.2 6143.6 6154.2 5925.3 5947.2 5952.4 5954.4 5984.4 5957.5 5961.8 5964.8 5965.2 5975.0 5708.3 5883.1 5903.1 5936.5 5961.9 5988.6 6004.2 6011.6 6035.0 6037.8 5672.9 5864.5 5878.5 5884.4 5903.3 18:50:46 INFO - PROCESS | 7923 | 18:50:46 INFO - PROCESS | 7923 | [#5] yui.html Cycles:180 Average:17093.62 Median:44446.78 stddev:21498.28 (48.4%) stddev-sans-first:21523.52 18:50:46 INFO - PROCESS | 7923 | Values: 740.9 778.8 799.4 810.7 889.1 14730.0 15517.8 15666.5 16015.5 16306.3 14688.6 14785.0 14834.1 14837.7 15194.2 825.3 852.4 853.0 853.7 854.7 818.5 847.0 849.7 852.9 856.2 895.6 896.7 901.3 902.1 904.4 900.8 900.8 901.5 903.2 903.7 657.6 663.6 664.4 665.1 665.4 15383.6 15607.6 15764.9 15810.3 15841.4 13873.9 14186.1 14223.8 14396.2 14501.5 12215.2 12407.8 12421.8 12485.7 12504.9 3769.7 3825.9 3833.3 3852.7 3966.6 66743.7 67379.7 67494.3 67773.7 68409.0 10376.3 10524.2 11259.2 11420.5 11542.8 17110.1 17178.8 17249.3 18164.5 21013.2 7854.1 7896.5 7964.2 8035.4 8092.6 4364.5 4382.5 4416.6 4467.6 4564.1 3297.7 3351.4 3390.7 3406.5 3426.0 621.0 642.5 644.8 656.9 658.9 655.7 706.7 709.5 722.8 724.0 9443.8 9698.3 9829.0 9912.3 9913.9 757.6 757.8 768.3 770.9 776.7 4515.4 4594.8 4613.4 4631.1 4669.2 56159.4 56359.2 57198.4 93062.5 95364.0 65594.0 68123.0 80326.6 82223.6 82750.0 43059.6 44253.8 59345.1 60562.4 65679.0 10205.7 10438.9 10647.7 10746.9 10763.2 44233.8 44639.8 44689.3 45188.3 46609.5 52986.7 53230.2 53396.5 54555.0 61288.7 12717.7 12940.9 12977.9 13150.9 13198.9 14405.4 14539.8 14563.9 14756.0 15070.6 13201.7 13577.3 13753.9 14729.9 14746.0 13680.3 13888.7 14018.4 14768.8 14773.8 13207.4 13730.2 13760.9 13925.1 14332.4 10433.1 10825.5 11093.4 11121.3 11675.0 11125.5 11233.0 11264.7 11275.8 11504.5 18:50:46 INFO - PROCESS | 7923 | -------- Summary: end -------- 18:50:46 INFO - PROCESS | 7923 | 18:50:47 INFO - TEST-INFO | 7923: exit 0 18:50:47 INFO - TEST-OK | dromaeo_css | took 1113342ms 18:50:47 INFO - TEST-START | kraken 18:50:47 INFO - operating with platform_type : linux_ 18:50:47 INFO - Initialising browser for kraken test... 18:50:47 INFO - TEST-INFO | started process 8287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gXa4K/profile http://localhost:32986/getInfo.html) 18:50:51 INFO - PROCESS | 8287 | __metrics Screen width/height:1600/1200 18:50:51 INFO - PROCESS | 8287 | colorDepth:24 18:50:51 INFO - PROCESS | 8287 | Browser inner width/height: 1024/697 18:50:51 INFO - PROCESS | 8287 | __metrics 18:50:52 ERROR - PROCESS | 8287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 18:50:53 INFO - TEST-INFO | 8287: exit 0 18:50:53 INFO - Browser initialized. 18:50:53 INFO - Running cycle 1/1 for kraken test... 18:50:53 INFO - TEST-INFO | started process 8419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gXa4K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:04 INFO - PROCESS | 8419 | RSS: Main: 146939904 18:51:04 INFO - PROCESS | 8419 | 18:51:07 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32986/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:08 INFO - PROCESS | 8419 | RSS: Main: 153694208 18:51:08 INFO - PROCESS | 8419 | 18:51:10 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32986/tests/kraken/driver.html?testName=audio-dft) 18:51:11 INFO - PROCESS | 8419 | RSS: Main: 153059328 18:51:11 INFO - PROCESS | 8419 | 18:51:14 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32986/tests/kraken/driver.html?testName=audio-fft) 18:51:14 INFO - PROCESS | 8419 | RSS: Main: 152948736 18:51:14 INFO - PROCESS | 8419 | 18:51:16 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32986/tests/kraken/driver.html?testName=audio-oscillator) 18:51:17 INFO - PROCESS | 8419 | RSS: Main: 152338432 18:51:17 INFO - PROCESS | 8419 | 18:51:19 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:20 INFO - PROCESS | 8419 | RSS: Main: 152649728 18:51:20 INFO - PROCESS | 8419 | 18:51:23 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32986/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:23 INFO - PROCESS | 8419 | RSS: Main: 155545600 18:51:23 INFO - PROCESS | 8419 | 18:51:27 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32986/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:27 INFO - PROCESS | 8419 | RSS: Main: 156078080 18:51:27 INFO - PROCESS | 8419 | 18:51:30 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32986/tests/kraken/driver.html?testName=json-parse-financial) 18:51:31 INFO - PROCESS | 8419 | RSS: Main: 156151808 18:51:31 INFO - PROCESS | 8419 | 18:51:32 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:33 INFO - PROCESS | 8419 | RSS: Main: 155279360 18:51:33 INFO - PROCESS | 8419 | 18:51:35 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:35 INFO - PROCESS | 8419 | RSS: Main: 155201536 18:51:35 INFO - PROCESS | 8419 | 18:51:37 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:38 INFO - PROCESS | 8419 | RSS: Main: 155303936 18:51:38 INFO - PROCESS | 8419 | 18:51:40 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:41 INFO - PROCESS | 8419 | RSS: Main: 155054080 18:51:41 INFO - PROCESS | 8419 | 18:51:44 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:44 INFO - PROCESS | 8419 | RSS: Main: 155344896 18:51:44 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | Cycle 1(1): loaded http://localhost:32986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32986/tests/kraken/driver.html?testName=ai-astar) 18:51:46 INFO - PROCESS | 8419 | RSS: Main: 156618752 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | __start_tp_report 18:51:46 INFO - PROCESS | 8419 | _x_x_mozilla_page_load 18:51:46 INFO - PROCESS | 8419 | _x_x_mozilla_page_load_details 18:51:46 INFO - PROCESS | 8419 | |i|pagename|runs| 18:51:46 INFO - PROCESS | 8419 | |0;ai-astar;102;113;112;112;114;113;111;111;111;111 18:51:46 INFO - PROCESS | 8419 | |1;audio-beat-detection;145;118;121;155;121;123;119;120;151;121 18:51:46 INFO - PROCESS | 8419 | |2;audio-dft;164;163;165;162;162;162;162;164;163;162 18:51:46 INFO - PROCESS | 8419 | |3;audio-fft;77;74;75;104;78;76;75;76;100;75 18:51:46 INFO - PROCESS | 8419 | |4;audio-oscillator;85;81;114;81;81;81;96;82;81;101 18:51:46 INFO - PROCESS | 8419 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 18:51:46 INFO - PROCESS | 8419 | |6;imaging-darkroom;147;147;147;147;147;146;147;146;147;148 18:51:46 INFO - PROCESS | 8419 | |7;imaging-desaturate;85;84;84;86;86;85;84;89;84;84 18:51:46 INFO - PROCESS | 8419 | |8;json-parse-financial;53;54;54;58;54;55;57;53;53;55 18:51:46 INFO - PROCESS | 8419 | |9;json-stringify-tinderbox;59;59;59;59;60;59;58;59;61;62 18:51:46 INFO - PROCESS | 8419 | |10;stanford-crypto-aes;74;74;75;76;75;76;75;76;77;80 18:51:46 INFO - PROCESS | 8419 | |11;stanford-crypto-ccm;130;131;124;121;122;122;130;120;166;127 18:51:46 INFO - PROCESS | 8419 | |12;stanford-crypto-pbkdf2;163;156;167;157;161;157;162;161;157;159 18:51:46 INFO - PROCESS | 8419 | |13;stanford-crypto-sha256-iterative;67;65;64;69;67;64;67;63;64;64 18:51:46 INFO - PROCESS | 8419 | __end_tp_report 18:51:46 INFO - PROCESS | 8419 | __start_cc_report 18:51:46 INFO - PROCESS | 8419 | _x_x_mozilla_cycle_collect,781 18:51:46 INFO - PROCESS | 8419 | __end_cc_report 18:51:46 INFO - PROCESS | 8419 | __startTimestamp1487818306913__endTimestamp 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | ------- Summary: start ------- 18:51:46 INFO - PROCESS | 8419 | Number of tests: 14 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.33 (3.0%) stddev-sans-first:1.12 18:51:46 INFO - PROCESS | 8419 | Values: 102.0 113.0 112.0 112.0 114.0 113.0 111.0 111.0 111.0 111.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:122.00 stddev:14.70 (12.0%) stddev-sans-first:14.47 18:51:46 INFO - PROCESS | 8419 | Values: 145.0 118.0 121.0 155.0 121.0 123.0 119.0 120.0 151.0 121.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 18:51:46 INFO - PROCESS | 8419 | Values: 164.0 163.0 165.0 162.0 162.0 162.0 162.0 164.0 163.0 162.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:11.17 (14.8%) stddev-sans-first:11.75 18:51:46 INFO - PROCESS | 8419 | Values: 77.0 74.0 75.0 104.0 78.0 76.0 75.0 76.0 100.0 75.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:81.00 stddev:11.54 (14.2%) stddev-sans-first:12.18 18:51:46 INFO - PROCESS | 8419 | Values: 85.0 81.0 114.0 81.0 81.0 81.0 96.0 82.0 81.0 101.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:51:46 INFO - PROCESS | 8419 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:51:46 INFO - PROCESS | 8419 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 148.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 18:51:46 INFO - PROCESS | 8419 | Values: 85.0 84.0 84.0 86.0 86.0 85.0 84.0 89.0 84.0 84.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.71 (3.1%) stddev-sans-first:1.72 18:51:46 INFO - PROCESS | 8419 | Values: 53.0 54.0 54.0 58.0 54.0 55.0 57.0 53.0 53.0 55.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:1.18 (2.0%) stddev-sans-first:1.24 18:51:46 INFO - PROCESS | 8419 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 58.0 59.0 61.0 62.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.75 (2.3%) stddev-sans-first:1.73 18:51:46 INFO - PROCESS | 8419 | Values: 74.0 74.0 75.0 76.0 75.0 76.0 75.0 76.0 77.0 80.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.50 stddev:13.52 (10.5%) stddev-sans-first:14.34 18:51:46 INFO - PROCESS | 8419 | Values: 130.0 131.0 124.0 121.0 122.0 122.0 130.0 120.0 166.0 127.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.00 stddev:3.46 (2.2%) stddev-sans-first:3.50 18:51:46 INFO - PROCESS | 8419 | Values: 163.0 156.0 167.0 157.0 161.0 157.0 162.0 161.0 157.0 159.0 18:51:46 INFO - PROCESS | 8419 | 18:51:46 INFO - PROCESS | 8419 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.96 (3.0%) stddev-sans-first:1.99 18:51:46 INFO - PROCESS | 8419 | Values: 67.0 65.0 64.0 69.0 67.0 64.0 67.0 63.0 64.0 64.0 18:51:46 INFO - PROCESS | 8419 | -------- Summary: end -------- 18:51:46 INFO - PROCESS | 8419 | 18:51:47 INFO - TEST-INFO | 8419: exit 0 18:51:47 INFO - TEST-OK | kraken | took 60682ms 18:51:47 INFO - SUITE-END | took 1174s 18:51:48 INFO - Completed test suite (00:19:34) 18:51:48 INFO - javascript benchmark 18:51:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.188532604693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.0550987458696, 3208.3743669984347, 3229.079712282, 3230.1763050422146, 3231.3537292541496, 5572.3870374258795, 5637.605367624268, 5664.943350566493, 5671.801486947952, 5677.858053548658, 5656.151577263413, 5709.914351284734, 5717.77128914844, 5720.628159169662, 5765.596408251414, 5138.434772175057, 5174.611904107188, 5185.792568297264, 5226.111561034633, 5231.555317797973, 5219.0, 5224.21636754488, 5230.476952304758, 5235.136202526579, 5240.34495688039, 5052.7726252318735, 5099.031184075014, 5242.764075616587, 5252.343457067866, 5261.526462618363, 5145.511176438233, 5164.767585458663, 5174.844754657329, 5191.870203244911, 5221.738913054332, 5135.229715542661, 5225.764840582183, 5227.137522308814, 5243.134882744343, 5250.7112108834, 5722.885542289173, 5754.367019627837, 5771.682557459338, 5780.479756821865, 5786.334571524287, 5929.91105133419, 5999.0, 6023.608465449732, 6054.8183554493, 6098.176746139259, 6073.362296958844, 6092.0, 6101.603395779304, 6142.692865356759, 6171.043488259327, 5751.309842818847, 5756.366799652035, 5759.884802304015, 5762.1068734346245, 5768.971155144198, 6091.634501929899, 6120.724567394478, 6134.00801433197, 6283.340249273851, 6303.936960630427, 5944.227250457413, 5960.731767070492, 5964.0, 5964.850878728066, 5987.401259873977, 6045.455908968214, 6045.939540604626, 6046.2139921809885, 6054.3642917493025, 6063.090536419484, 5806.0, 5833.387494313036, 5934.287885453773, 5978.432048955342, 5986.610870293417, 5897.76408943646, 6015.969920150371, 6023.397660233942, 6036.185115009505, 6071.453569178795, 4631.096936097496, 4683.039976804815, 4688.226442636927, 4692.577668009895, 4715.834945776881, 4043.9595604043584, 4072.3891416287793, 4094.6314831665295, 4122.2786012447705, 4163.875083747493, 5790.768369265266, 5829.679367634736, 5837.124431335249, 5848.152017957457, 5869.266341707286, 6054.66699331541, 6133.754649814046, 6134.141220229171, 6136.417040381157, 6141.232345956755, 5632.915506267409, 5718.170865224519, 5783.421657834183, 5821.18503409523, 5825.854353641108, 5249.553787927993, 5305.522502974751, 5341.5192632662465, 5346.19807028941, 5375.75809088592, 6344.555881088279, 6388.456981156561, 6389.041643753474, 6389.712462939179, 6397.328280530571, 5907.32065812437, 5944.613600115978, 6115.205023346936, 6171.938280617316, 6177.598456100339, 6281.403266689657, 6342.334054924167, 6343.55595108338, 6363.93636063652, 6408.967955160194, 6063.636181829104, 6065.7876974307455, 6067.059605761114, 6078.756849725962, 6084.543659225665, 5842.415758424124, 6162.291336496181, 6190.380961903774, 6195.597286176564, 6197.96901015492, 5783.595148339576, 5902.996490596523, 5941.168236446814, 5979.222701048836, 6031.517478601789, 5881.2942446906645, 5976.9103463448955, 5990.910136348046, 5999.070144127667, 6001.2498437695285, 5874.118882167709, 5922.318933322723, 5924.555658325557, 5928.318243402064, 5928.436798504135, 5647.661140331593, 5797.739101740347, 5801.129830525455, 5855.94144058554, 5910.7340169693325, 5732.082866741302, 5738.110592858114, 5742.712864356849, 5749.540036796962, 5749.913751293818], "value": 5607.286074545293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9426057394261, 604.4408921747382, 625.3215261441336, 693.4348505967633, 697.4908316928645, 40392.798036009815, 41250.79374603127, 44940.77529612347, 44963.775181124045, 45084.549154508444, 44390.556094439045, 45590.31614525776, 45607.77196114015, 45618.0, 45703.0, 8322.750317490485, 8567.271781898515, 8939.0, 10715.464226788668, 11023.228374013823, 10895.455227238646, 11026.503807328649, 11032.393218372987, 11046.0, 11064.391458469781, 11026.393548354838, 11072.0, 11077.169212309069, 11086.279391839545, 11097.667069987914, 10996.28524145932, 11001.889981100247, 11013.614523491638, 11037.724056898602, 11039.227254092217, 10278.33190842593, 10413.0, 10414.739631509197, 10420.895791042069, 10424.061834434937, 44108.0, 44400.555994440285, 44426.55573444289, 44472.555274447164, 44498.33252501215, 3838.712096592739, 3940.310445671996, 4060.593940605945, 4144.730592511477, 4303.139372125587, 32838.34323313544, 32852.507212391836, 33030.97809256446, 33065.6693433065, 33097.50353744672, 4523.751193684346, 4566.1780879441685, 4568.1548913451115, 4599.2871104978785, 4647.930281045787, 513287.0, 524697.0, 527635.0, 531982.0, 533444.0, 64299.35700643027, 64972.67513662401, 65011.0, 65136.674316628116, 65467.345326547074, 69005.0, 69386.0, 69419.0, 69422.3057769426, 69515.65242173757, 18389.724154137697, 18820.341288054853, 18885.961272130164, 18985.81014189868, 19002.334918277793, 14333.498327558485, 14601.78097328541, 14717.92641036788, 15094.622634434007, 15094.924525377523, 20024.49938751543, 20061.398158055283, 20095.698564521543, 20187.0, 20478.180872764922, 7288.416926645856, 7484.925150748531, 7537.773866784005, 7538.246175382527, 7630.2751238632245, 970.9368891022061, 1023.9078482936422, 1082.875469321038, 1105.690406686129, 1141.937193454368, 31467.685323146932, 31825.0, 31983.88056418014, 32338.0, 32612.673873260963, 1115.7768446310608, 1136.3749937534324, 1179.3690375648987, 1217.9634610961684, 1222.914395992272, 16795.496135115965, 16959.0, 16987.575310617332, 17022.659546808994, 17048.2328295227, 519784.0, 523227.0, 525343.0, 526312.0, 526572.0, 40733.0, 40796.184076318306, 41178.1764364717, 41325.380119298236, 41405.58594414017, 1375.6217040313793, 1422.8363738170035, 1427.2578259305103, 1433.8709516143597, 1443.2639353929362, 30510.84744576263, 31305.686943130277, 32045.839770800998, 32253.677463226006, 32406.83796581002, 53247.73376133094, 53486.19770703365, 53604.0, 53948.0, 53986.46013539814, 501194.0, 501333.0, 502080.0, 504352.0, 504724.0, 30059.0, 30689.232769180948, 30906.53640195444, 31051.0, 32675.183120422178, 48625.270620940006, 48973.26540101973, 49062.50937490579, 49782.75108624434, 50089.24866126938, 41289.79355103205, 41735.34365065959, 42175.57824421839, 42206.577934220266, 42795.35806962836, 40881.18237635171, 41263.381049284886, 41287.96780080402, 42593.57406425896, 42978.78510607427, 40469.0, 40552.0, 40869.18261634691, 41776.0, 42017.369739454545, 36437.27125457529, 37534.0, 37862.810685946395, 37972.0, 38020.0, 28453.50109682489, 28532.42935141327, 29038.0, 29074.27314317159, 29137.85431072831], "value": 21525.926522273694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.80293163678886, 424.57966613053065, 425.8594663760959, 432.8160531773996, 447.7693987596388, 18343.724844127348, 19662.410127696174, 20369.694454583176, 20612.48468788281, 20773.584528309464, 19116.5220869478, 19715.309964151256, 20078.397648070546, 20293.0868110935, 20337.796622033777, 5673.8581535461535, 5948.970255148718, 5966.433188847052, 5976.61152025117, 5980.162777211172, 4102.548719640837, 4364.454443194601, 5841.415858414146, 5941.494972927285, 6439.323870993549, 6523.18460192476, 6524.739010439576, 6530.967345163292, 6543.345665433442, 6546.901796473033, 6360.109584658151, 6464.644444555547, 6471.417572418505, 6476.255230648489, 6548.9345106549035, 5761.88476230473, 5771.336296325934, 5771.769129234825, 5779.479846813807, 5794.97102514489, 14675.192864392455, 14870.851291487055, 14974.62563435912, 14990.325435355435, 15003.1748253846, 2365.6215005599192, 2443.4624382635793, 2504.5742223821994, 2544.5038217547585, 2594.8443093414458, 10606.78786424275, 10751.462426878625, 10793.406362650052, 10820.891791082146, 11317.264377815416, 1967.8720883142694, 1970.0740651893586, 1979.8218160365493, 1993.511589660528, 2041.4896275931017, 84169.0, 88543.0, 88608.55695721545, 88902.0, 89744.0, 11536.365499897585, 11787.0, 11807.0, 11870.050395968301, 12078.939605301917, 16915.323387064378, 16926.0, 16942.57643558921, 16946.915265423595, 16948.661026779395, 8625.91374086251, 8840.204381605687, 8918.286537077018, 8934.41926274803, 9026.774330641787, 8607.65569377218, 8627.309815214769, 8651.567421629019, 8890.33322500802, 8892.46645201277, 5032.924506132411, 5043.773030213649, 5048.343715317059, 5115.897682046339, 5160.225966105114, 2028.8072633099832, 2088.3004193595316, 2108.441263065289, 2111.6515774897275, 2146.248812915467, 937.5452905340904, 1037.7146284771597, 1053.2258789789498, 1098.181854518373, 1136.4374634555948, 19178.0, 19242.518937026405, 19511.219551217793, 19581.706274405897, 19625.31311404094, 1051.358671210561, 1071.614218881202, 1074.9032587067202, 1077.6174458067273, 1145.255583870491, 10253.33353332031, 10973.670789876316, 11007.944960275147, 11020.834687479693, 11095.50070246841, 461286.0, 476830.0, 484467.0, 488042.0, 497670.0, 91243.54378228067, 93768.0, 97071.51464242775, 101999.0, 102799.48600256951, 1026.312370711625, 1060.3107979813183, 1076.3272954403499, 1076.4402510694395, 1076.9784604308027, 17702.91148544249, 17875.73186402231, 17934.5516362092, 18028.63942721112, 18449.907750461163, 43730.562694372646, 43957.56042439535, 44319.33520997252, 45073.54926450693, 45085.0, 59308.0, 60321.396786031575, 61063.0, 61893.0, 62301.37698622956, 8889.866652000095, 8908.0, 8996.415233009833, 9044.502552359683, 9380.48407337603, 12722.681932951751, 13617.931910340385, 13687.31563421805, 13698.931505342409, 13781.310934453037, 11579.247348922294, 11765.764684706086, 11847.822282665595, 12106.394680266128, 12181.451834667285, 11287.379194144401, 11582.420878956187, 11727.413629318671, 11769.705757356134, 12146.635600931986, 11287.43562821872, 11969.222000569935, 12031.338276394883, 12179.512819487121, 12452.31512266834, 9039.096090390909, 9101.317401195069, 9158.67944621935, 9185.954070229605, 9338.906610933804, 9057.864132037894, 11885.82171267449, 12095.153339266168, 12358.938205308916, 12494.875051249372], "value": 9556.816681603777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.7411340072188, 1531.321811864753, 1675.4303536797486, 1733.6879361714903, 1808.9638207235848, 8334.37492188086, 8835.0, 9016.864747028783, 9022.368434209608, 9027.638894444222, 9141.680041198559, 9236.722898313044, 9285.489298088602, 9292.767680807983, 9309.767255818608, 2466.2108125399923, 2515.157422263544, 2516.169664010872, 2516.7860731837723, 2520.218732193017, 2501.0996041425074, 2560.1551488008913, 2571.280041588349, 2584.095566551711, 2585.017693276552, 2400.72391674957, 2406.1217655555683, 2450.816188785839, 2451.7915977141874, 2458.115078571722, 2371.1819422299277, 2398.052769156191, 2404.446977195255, 2414.311921102486, 2420.576399130145, 2494.3514686181543, 2524.482481091372, 2531.8354306969986, 2539.3270783242456, 2540.110961163578, 8417.789555261106, 8429.957850210709, 8496.915030849674, 8886.555672216364, 8945.955270223607, 5427.864303392407, 5551.306086739158, 5570.582206334541, 5571.275734154575, 5582.078956972095, 3485.9651403485896, 3515.5605549306338, 3598.0, 3669.889903302905, 3681.9263614727556, 1092.1644941619668, 1123.2698745815203, 1133.9773204535863, 1252.1610520950985, 1260.9873901260962, 12388.566400176041, 12513.499460021589, 12518.37408129599, 12531.561395351118, 12596.81104783429, 4665.206914824488, 4710.6589052487, 4799.928001079987, 4809.422869255642, 4878.536539028786, 9810.705678829647, 9835.114839664464, 9861.556229969668, 9868.703938881845, 9909.35589186715, 5373.811916582901, 5471.097268950658, 5477.068898287301, 5525.613207075467, 5562.749676264578, 5061.898762024739, 5188.844334669966, 5341.919871201935, 5356.223347614652, 5389.730513474311, 3974.0, 4045.2314060328445, 4107.63031327176, 4131.814068366871, 4141.668666506672, 1238.746057058301, 1246.7781574057474, 1258.6916205529703, 1263.6145975477568, 1272.401971073594, 925.2459245714721, 1022.1822541966397, 1044.5612842606124, 1050.3435352904435, 1050.6270274052602, 6133.938660613337, 6233.283172435228, 6269.404406581368, 6376.936230637727, 6406.551541392151, 969.2439896880445, 997.1225321716988, 1000.1298869983161, 1021.1014307409432, 1042.7914417116608, 4010.2154541228874, 4033.556308806029, 4056.59434056592, 4082.6937979651643, 4194.517630472474, 10962.287451315638, 11227.831582526269, 11261.21171517986, 11291.604793832177, 11322.26405283654, 11129.499172537255, 11190.720231994103, 11247.831282530606, 11278.887211127947, 11293.887061129448, 7807.960960195276, 7983.241592048862, 7983.800404989805, 8095.554744488992, 8254.092049874509, 5970.402959704169, 6055.303640081271, 6076.179715738319, 6254.906176407449, 6369.8726025480155, 10035.799284014132, 10133.898661013296, 10135.189184865341, 10166.135878450414, 10178.49107544605, 9718.805623887341, 10089.899101008896, 10114.0, 10317.48412579383, 10395.792084158124, 7586.3930885527925, 7776.261255180749, 7838.059432868093, 7975.840483190188, 8155.388345874202, 8650.697225597074, 8696.521691307038, 8705.782355441164, 8714.956425217833, 8719.782005449915, 7697.422693297913, 7735.303822655988, 7743.419243556643, 7744.341730952707, 7872.645730942236, 7596.08846938371, 7707.190744971697, 7713.961430192813, 7723.53658780475, 7841.882371764542, 7130.500864939404, 7163.928360716326, 7178.676959536938, 7272.200057993511, 7284.125904891447, 5261.921071183859, 5359.062164121341, 5366.168243922199, 5375.059364611256, 5556.083246264483, 5444.047291723853, 5457.945420545744, 5547.278853748987, 5575.553955683455, 5604.495595396434], "value": 4798.659804545897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7106637024454, 362.9038304849215, 364.37327796190544, 369.79291596705866, 370.9415866183319, 5425.620206585536, 5640.379558248589, 5684.37471878093, 5711.343195532515, 5712.514436272922, 5580.218769372291, 5588.748506317215, 5598.384177740445, 5609.411011843759, 5620.903923734873, 3953.7627742335408, 4239.978800106011, 4382.904273931517, 4407.250767369539, 4415.359772832937, 4335.0679603885155, 4351.71713838601, 4354.303311470166, 4358.128374325148, 4362.149380870732, 4307.935380969288, 4309.806058727365, 4315.82736690532, 4341.674374421915, 4341.956580434203, 4260.382244574519, 4330.2638551446325, 4339.435873336478, 4349.717268377562, 4365.454318210223, 3785.8296376663116, 3801.144742432958, 3802.961970380316, 3816.580176180618, 3829.7319187656594, 5443.8094666686875, 5450.754716037788, 5454.890902181974, 5473.890522189534, 5475.917861232085, 4976.253561965698, 5012.0, 5016.498350164954, 5018.172001619729, 5028.270900719412, 5653.519450846683, 5849.859277440901, 5850.590458667895, 5879.52963762898, 5888.057910734305, 4228.788560571959, 4230.344296634026, 4230.576942305775, 4236.322188449833, 4239.04621460169, 5763.7607914298205, 6123.2039834821635, 6134.693265336716, 6136.907946380852, 6150.261968563801, 4215.114825886598, 4233.518268606025, 4246.681498887596, 4255.510616279105, 4264.33902745075, 4290.034742182984, 4290.957090429056, 4310.814526005311, 4314.180305741899, 4323.697341186087, 4882.194437917775, 4934.432540257844, 4953.151937635874, 4980.779708971325, 4984.152694042022, 5846.210761547221, 5899.852503687356, 5901.822945311647, 5911.615744976562, 5921.703914804242, 1486.4797320937585, 1488.4641529049534, 1500.2423775993054, 1504.8720858727131, 1511.3727802961648, 995.576879826071, 1011.4625768831335, 1042.4318746283293, 1043.8225501664735, 1046.6127532812757, 5563.582731295169, 5592.105263157875, 5612.494875461228, 5628.200964349048, 5630.155476678531, 5869.911951320733, 5872.911906321408, 5914.852128696731, 5933.199018132583, 5976.924153652298, 5391.595630327741, 5555.666660000413, 5592.412796656374, 5614.410486898899, 5616.943830561724, 3138.666066921595, 3149.9527507087414, 3157.2422618571836, 3166.651668316483, 3168.746500279972, 5930.495907847881, 6053.7578496860515, 6095.603785753912, 6103.267607887082, 6128.846778830565, 5896.911546326808, 5907.320658124285, 5944.751602163594, 5945.3757355477055, 5958.731857066356, 6014.6391216527145, 6032.849178770566, 6034.487068599218, 6049.153118563405, 6053.122297266872, 5590.720463976866, 5848.385919478394, 5896.7518908170905, 5900.232969713909, 5902.4097590240635, 5756.625819321731, 5761.91357129635, 5790.870780197821, 5811.331696854916, 5812.0, 6094.963856144377, 6143.477804386498, 6292.930201865603, 6331.525135614939, 6373.649449280334, 4360.0, 4380.759058251827, 4382.0, 4394.736315821061, 4400.1199760047475, 6004.42957918997, 6121.632702037892, 6125.173101631222, 6143.586974995686, 6154.230721159855, 5925.348211696796, 5947.197128387612, 5952.375000625046, 5954.404559544184, 5984.431479009487, 5957.49361304294, 5961.821145365646, 5964.761409543743, 5965.194698715618, 5975.014122669711, 5708.286464191976, 5883.058710606282, 5903.0555111182, 5936.525077993837, 5961.940380596138, 5988.580799344004, 6004.159417681615, 6011.579189456696, 6035.0, 6037.818865434044, 5672.858178545569, 5864.472197502245, 5878.529717622666, 5884.411558844081, 5903.321118071477], "value": 4474.658849640719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.866644004079, 778.7975126467117, 799.4363973398753, 810.6514198894473, 889.1242126505393, 14730.0, 15517.844821551795, 15666.53000409988, 16015.519534413957, 16306.347746090141, 14688.559343219693, 14785.0, 14834.109953402776, 14837.703245935074, 15194.16432096237, 825.286127499713, 852.4288726553224, 852.995735021324, 853.6713365354352, 854.7264875239925, 818.54161669465, 846.9957650211741, 849.7493239494333, 852.9019162796264, 856.1609622569886, 895.5611750242399, 896.7175339767953, 901.2744740483907, 902.1114202510522, 904.4256896870469, 900.837849187146, 900.8423525882944, 901.4681338010572, 903.20969151992, 903.742433406476, 657.5660064357548, 663.5952069237761, 664.3588936676083, 665.0655828560831, 665.3579295979355, 15383.61540961485, 15607.609809754733, 15764.921175394049, 15810.288537015862, 15841.366345346172, 13873.930630346884, 14186.07790493625, 14223.786643200361, 14396.208208548525, 14501.501590794203, 12215.206011609305, 12407.813882791765, 12421.751564968741, 12485.687857803627, 12504.937475312656, 3769.7361184716806, 3825.9234815303817, 3833.3483307837455, 3852.7303088783797, 3966.6231707987695, 66743.66628166876, 67379.66310168417, 67494.3250567488, 67773.66113169403, 68409.0, 10376.325538839952, 10524.158067354747, 11259.211855170222, 11420.486078126503, 11542.826857597143, 17110.058946758047, 17178.828211717722, 17249.310027599007, 18164.545886352946, 21013.159473620883, 7854.057513098464, 7896.526208427513, 7964.163762804822, 8035.437519373588, 8092.635831387602, 4364.4980827204645, 4382.496012958487, 4416.624586910084, 4467.5532446755715, 4564.132814765184, 3297.653746356598, 3351.4302568563403, 3390.677885600864, 3406.489026646023, 3425.9657403425645, 620.959637623553, 642.5149012495536, 644.8097811145723, 656.9474442044625, 658.8503062156567, 655.7213184396708, 706.720845266117, 709.4785332780402, 722.7831650504828, 724.0, 9443.76390590227, 9698.321117521848, 9829.017098290115, 9912.256580756472, 9913.900860991298, 757.5984728094119, 757.7802437293234, 768.2970082374676, 770.8959290495824, 776.7281451491932, 4515.435570553681, 4594.816207351735, 4613.354130421743, 4631.120087183424, 4669.182892993713, 56159.43840561624, 56359.154612680846, 57198.42801571931, 93062.53468732613, 95364.0, 65594.01608975869, 68122.97815532771, 80326.59836700778, 82223.5888820552, 82750.0, 43059.569404305556, 44253.77873110614, 59345.10982335269, 60562.39437605656, 65679.01481477782, 10205.693829185137, 10438.895611043792, 10647.680569582924, 10746.892531074589, 10763.246572739834, 44233.77883110692, 44639.776801117085, 44689.32966005577, 45188.322175166744, 46609.53390466052, 52986.735066325964, 53230.20154697605, 53396.4660353407, 54555.0, 61288.69355653193, 12717.682057948625, 12940.935295323463, 12977.870221298044, 13150.868491314965, 13198.934005329911, 14405.351759170653, 14539.78190327167, 14563.854361456673, 14756.0, 15070.607569771062, 13201.735965280832, 13577.253251070892, 13753.862461375258, 14729.926350368609, 14746.0, 13680.31598420095, 13888.722225555635, 14018.439262429389, 14768.778468323198, 14773.778393324324, 13207.405666745211, 13730.176189428666, 13760.93119534396, 13925.094868833494, 14332.355044022836, 10433.108182262837, 10825.51285192184, 11093.389863557582, 11121.27711698737, 11675.0, 11125.499352528994, 11233.0, 11264.66206013821, 11275.801493193072, 11504.482298296429], "value": 7260.965965050365, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 112.0, 114.0, 113.0, 111.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 121.0, 155.0, 121.0, 123.0, 119.0, 120.0, 151.0, 121.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 162.0, 162.0, 162.0, 162.0, 164.0, 163.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 104.0, 78.0, 76.0, 75.0, 76.0, 100.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 114.0, 81.0, 81.0, 81.0, 96.0, 82.0, 81.0, 101.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 86.0, 85.0, 84.0, 89.0, 84.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 58.0, 54.0, 55.0, 57.0, 53.0, 53.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0, 59.0, 61.0, 62.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 76.0, 75.0, 76.0, 75.0, 76.0, 77.0, 80.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 124.0, 121.0, 122.0, 122.0, 130.0, 120.0, 166.0, 127.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 156.0, 167.0, 157.0, 161.0, 157.0, 162.0, 161.0, 157.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 69.0, 67.0, 64.0, 67.0, 63.0, 64.0, 64.0], "value": 65.4, "unit": "score"}]}]} 18:51:48 INFO - Return code: 0 18:51:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:48 ERROR - # TBPL SUCCESS # 18:51:48 INFO - Running post-action listener: _resource_record_post_action 18:51:48 INFO - [mozharness: 2017-02-23 02:51:48.220370Z] Finished run-tests step (success) 18:51:48 INFO - Running post-run listener: _resource_record_post_run 18:51:48 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321536000; Read time: 8; Write time: 181768 18:51:48 INFO - TinderboxPrint: CPU usage
13.2% 18:51:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:51:48 INFO - TinderboxPrint: I/O write bytes / time
321,536,000 / 181,768 18:51:48 INFO - TinderboxPrint: CPU idle
8,222.7 (86.7%) 18:51:48 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 18:51:48 INFO - TinderboxPrint: Swap in / out
0 / 0 18:51:48 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97312768; Read time: 0; Write time: 74420 18:51:48 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219828224; Read time: 8; Write time: 106952 18:51:48 INFO - Running post-run listener: _upload_blobber_files 18:51:48 INFO - Blob upload gear active. 18:51:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:48 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 18:51:48 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'] 18:51:48 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 18:51:49 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:52 INFO - (blobuploader) - INFO - Done attempting. 18:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:53 INFO - (blobuploader) - INFO - Done attempting. 18:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:54 INFO - (blobuploader) - INFO - Done attempting. 18:51:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:54 INFO - Return code: 0 18:51:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbcfde41715e3736ee9ec7f0510968f21c32a013b4a216cb28a6f48922cb37c16b06e280e0f54e4fb107c85cb34a8429459b541e33eaf1e178cd81a15555a8c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e546d93099e1ca11735045af4fc7aa1f7935ec03c12abb4e7d27fcca835430b3290c58a56362bf880d63b8be4178eeffe52586ad1a690aecac4b44778d9bb5e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/780017120c855f384cc7f0360f85b4419d2487789b6be35fa7eaf5e4ba7d7f9a54ea48794aece6558df9eb89bad17fdb6cdd3707d8b29cab676b23b511fc5c2a"} 18:51:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:54 INFO - Contents: 18:51:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbcfde41715e3736ee9ec7f0510968f21c32a013b4a216cb28a6f48922cb37c16b06e280e0f54e4fb107c85cb34a8429459b541e33eaf1e178cd81a15555a8c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e546d93099e1ca11735045af4fc7aa1f7935ec03c12abb4e7d27fcca835430b3290c58a56362bf880d63b8be4178eeffe52586ad1a690aecac4b44778d9bb5e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/780017120c855f384cc7f0360f85b4419d2487789b6be35fa7eaf5e4ba7d7f9a54ea48794aece6558df9eb89bad17fdb6cdd3707d8b29cab676b23b511fc5c2a"} 18:51:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:54 INFO - Copying logs to upload dir... 18:51:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.193027 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-22 18:51:53.626798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 18:51:53.630074) ========= 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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 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/dbcfde41715e3736ee9ec7f0510968f21c32a013b4a216cb28a6f48922cb37c16b06e280e0f54e4fb107c85cb34a8429459b541e33eaf1e178cd81a15555a8c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e546d93099e1ca11735045af4fc7aa1f7935ec03c12abb4e7d27fcca835430b3290c58a56362bf880d63b8be4178eeffe52586ad1a690aecac4b44778d9bb5e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/780017120c855f384cc7f0360f85b4419d2487789b6be35fa7eaf5e4ba7d7f9a54ea48794aece6558df9eb89bad17fdb6cdd3707d8b29cab676b23b511fc5c2a"} build_url:https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/Kgq_JIC1SoSq9GAmfk-lDw/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/dbcfde41715e3736ee9ec7f0510968f21c32a013b4a216cb28a6f48922cb37c16b06e280e0f54e4fb107c85cb34a8429459b541e33eaf1e178cd81a15555a8c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e546d93099e1ca11735045af4fc7aa1f7935ec03c12abb4e7d27fcca835430b3290c58a56362bf880d63b8be4178eeffe52586ad1a690aecac4b44778d9bb5e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/780017120c855f384cc7f0360f85b4419d2487789b6be35fa7eaf5e4ba7d7f9a54ea48794aece6558df9eb89bad17fdb6cdd3707d8b29cab676b23b511fc5c2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 18:51:53.657994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:51:53.658615) ========= 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=232498196343f89f466a4a9a000001c8-1487817078.894717-953513393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 18:51:53.740268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 18:51:53.740593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 18:51:53.740887) ========= ========= Total master_lag: 0.15 =========