builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1479906700.61 results: success (0) buildid: 20161123024236 builduid: 85a1cea35edb4fd995bfdfa93b1c438a revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.608656) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.609100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.609391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.623802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.624071) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 05:11:41-- 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% 40.6M=0s 2016-11-23 05:11:41 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.737505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.737825) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:40.786977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 05:11:40.787341) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 05:11:41,481 truncating revision to first 12 chars 2016-11-23 05:11:41,481 Setting DEBUG logging. 2016-11-23 05:11:41,481 attempt 1/10 2016-11-23 05:11:41,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/e5ed1abefc08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 05:11:42,356 unpacking tar archive at: cedar-e5ed1abefc08/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 05:11:42.263032) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:42.263573) ========= script_repo_revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:42.264186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:42.264646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 05:11:42.276170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-23 05:11:42.276557) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:43 INFO - MultiFileLogger online at 20161123 05:11:43 in /builds/slave/test 05:11:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 05:11:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:43 INFO - {'append_to_log': False, 05:11:43 INFO - 'base_work_dir': '/builds/slave/test', 05:11:43 INFO - 'blob_upload_branch': 'Cedar', 05:11:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:43 INFO - 'branch': 'Cedar', 05:11:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:43 INFO - 'config_files': ('talos/linux_config.py',), 05:11:43 INFO - 'default_actions': ('clobber', 05:11:43 INFO - 'read-buildbot-config', 05:11:43 INFO - 'download-and-extract', 05:11:43 INFO - 'populate-webroot', 05:11:43 INFO - 'create-virtualenv', 05:11:43 INFO - 'install', 05:11:43 INFO - 'run-tests'), 05:11:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:43 INFO - 'download_minidump_stackwalk': True, 05:11:43 INFO - 'download_symbols': 'ondemand', 05:11:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:43 INFO - 'installer_path': 'installer.exe', 05:11:43 INFO - 'log_level': 'info', 05:11:43 INFO - 'log_name': 'talos', 05:11:43 INFO - 'log_to_console': True, 05:11:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:43 INFO - 'opt_config_files': (), 05:11:43 INFO - 'pip_index': False, 05:11:43 INFO - 'sps_profile': False, 05:11:43 INFO - 'sps_profile_interval': 0, 05:11:43 INFO - 'suite': 'dromaeojs-e10s', 05:11:43 INFO - 'system_bits': '32', 05:11:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:43 INFO - 'title': 'talos-linux64-ix-048', 05:11:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:43 INFO - 'use_talos_json': True, 05:11:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:43 INFO - 'work_dir': 'build'} 05:11:43 INFO - [mozharness: 2016-11-23 13:11:43.060519Z] Running clobber step. 05:11:43 INFO - Running pre-action listener: _resource_record_pre_action 05:11:43 INFO - Running main action method: clobber 05:11:43 INFO - rmtree: /builds/slave/test/build 05:11:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:43 INFO - Running post-action listener: _resource_record_post_action 05:11:43 INFO - [mozharness: 2016-11-23 13:11:43.590289Z] Finished clobber step (success) 05:11:43 INFO - [mozharness: 2016-11-23 13:11:43.590386Z] Running read-buildbot-config step. 05:11:43 INFO - Running pre-action listener: _resource_record_pre_action 05:11:43 INFO - Running main action method: read_buildbot_config 05:11:43 INFO - Using buildbot properties: 05:11:43 INFO - { 05:11:43 INFO - "project": "", 05:11:43 INFO - "product": "firefox", 05:11:43 INFO - "script_repo_revision": "default", 05:11:43 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 05:11:43 INFO - "repository": "", 05:11:43 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 05:11:43 INFO - "buildid": "20161123024236", 05:11:43 INFO - "pgo_build": "False", 05:11:43 INFO - "basedir": "/builds/slave/test", 05:11:43 INFO - "buildnumber": 6, 05:11:43 INFO - "slavename": "talos-linux64-ix-048", 05:11:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:43 INFO - "platform": "ubuntu64_hw", 05:11:43 INFO - "scheduler": "tests-cedar-linux64-talos", 05:11:43 INFO - "branch": "cedar", 05:11:43 INFO - "repo_path": "projects/cedar", 05:11:43 INFO - "revision": "e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7", 05:11:43 INFO - "stage_platform": "linux64", 05:11:43 INFO - "builduid": "85a1cea35edb4fd995bfdfa93b1c438a", 05:11:43 INFO - "slavebuilddir": "test" 05:11:43 INFO - } 05:11:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:11:43 INFO - Running post-action listener: _resource_record_post_action 05:11:43 INFO - [mozharness: 2016-11-23 13:11:43.593754Z] Finished read-buildbot-config step (success) 05:11:43 INFO - [mozharness: 2016-11-23 13:11:43.593964Z] Running download-and-extract step. 05:11:43 INFO - Running pre-action listener: _resource_record_pre_action 05:11:43 INFO - Running main action method: download_and_extract 05:11:43 INFO - mkdir: /builds/slave/test/build/tests 05:11:43 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')]} 05:11:43 INFO - trying https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:43 INFO - Downloading https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:11:44 INFO - Downloaded 1361 bytes. 05:11:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:11:44 INFO - Using the following test package requirements: 05:11:44 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'jsshell-linux-x86_64.zip'], 05:11:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:44 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:11:44 INFO - Http code: 200 05:11:44 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 05:11:44 INFO - x-amz-cf-id: ho0zX543yAqU4T5HxRWQxMnAXKDuKADR9kmXbj9lTBpYi2fxRxG4Hw== 05:11:44 INFO - x-amz-version-id: lJC.UN25z4b5NnWRVFD7F4uPfjEtcaPl 05:11:44 INFO - Expected file size: 20201941 05:11:44 INFO - Obtained file size: 20201941 05:11:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:11:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:11:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:48 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:11:49 INFO - Http code: 200 05:11:49 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 05:11:49 INFO - x-amz-cf-id: wFJEFUF0BLVC0KP3JxYGTNHJvVWF2lhZVEWI72ZKnPRdKTX1MVcLXA== 05:11:49 INFO - x-amz-version-id: lJC.UN25z4b5NnWRVFD7F4uPfjEtcaPl 05:11:49 INFO - Expected file size: 20201941 05:11:49 INFO - Obtained file size: 20201941 05:11:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:54 INFO - Fetch https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:11:54 INFO - Http code: 200 05:11:54 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:11:54 INFO - x-amz-cf-id: wbj5Rs3ySqbk68Kc_W_f9F_cmKalWF8Rn1AobF5b2e7sGwKbosPQbw== 05:11:54 INFO - x-amz-version-id: fcuN1gxwydgFVsPbjAGFwqv_1eqmf3aT 05:11:54 INFO - Expected file size: 14409506 05:11:54 INFO - Obtained file size: 14409506 05:11: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')]} 05:11:55 INFO - trying https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:56 INFO - Downloaded 55624268 bytes. 05:11:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:56 INFO - mkdir: /builds/slave/test/properties 05:11:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:56 INFO - Contents: 05:11:56 INFO - build_url:https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:11:56 INFO - Running post-action listener: _resource_record_post_action 05:11:56 INFO - Running post-action listener: set_extra_try_arguments 05:11:56 INFO - [mozharness: 2016-11-23 13:11:56.791136Z] Finished download-and-extract step (success) 05:11:56 INFO - [mozharness: 2016-11-23 13:11:56.791361Z] Running populate-webroot step. 05:11:56 INFO - Running pre-action listener: _resource_record_pre_action 05:11:56 INFO - Running main action method: populate_webroot 05:11:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:56 INFO - '--tppagecycles', 05:11:56 INFO - '7'], 05:11:56 INFO - 'tests': ['tsvgm']}}, 05:11:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['damp', 'tps']}, 05:11:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'tests': ['damp', 'tps']}, 05:11:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['dromaeo_dom']}, 05:11:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['basic_compositor_video']}, 05:11:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['a11yr', 05:11:56 INFO - 'ts_paint', 05:11:56 INFO - 'tpaint', 05:11:56 INFO - 'sessionrestore', 05:11:56 INFO - 'sessionrestore_no_auto_restore', 05:11:56 INFO - 'tabpaint']}, 05:11:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['tsvgx', 05:11:56 INFO - 'tsvgr_opacity', 05:11:56 INFO - 'tart', 05:11:56 INFO - 'tscrollx', 05:11:56 INFO - 'cart']}, 05:11:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:56 INFO - 'tsvgr_opacity', 05:11:56 INFO - 'tart', 05:11:56 INFO - 'tscrollx', 05:11:56 INFO - 'cart']}, 05:11:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'talos_options': ['--disable-e10s'], 05:11:56 INFO - 'tests': ['tp5o']}, 05:11:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:11:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'talos_options': ['--disable-e10s', 05:11:56 INFO - '--xperf_path', 05:11:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:56 INFO - 'tests': ['tp5n']}, 05:11:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:11:56 INFO - 'talos_options': ['--xperf_path', 05:11:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:56 INFO - 'tests': ['tp5n']}}, 05:11:56 INFO - 'talos.zip': {'path': '', 05:11:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:56 INFO - Running post-action listener: _resource_record_post_action 05:11:56 INFO - [mozharness: 2016-11-23 13:11:56.807208Z] Finished populate-webroot step (success) 05:11:56 INFO - [mozharness: 2016-11-23 13:11:56.807295Z] Running create-virtualenv step. 05:11:56 INFO - Running pre-action listener: _resource_record_pre_action 05:11:56 INFO - Running main action method: create_virtualenv 05:11:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:56 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 05:11:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:56 INFO - Using real prefix '/usr' 05:11:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:59 INFO - Installing pip.................done. 05:11:59 INFO - Return code: 0 05:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:59 INFO - Reading from file tmpfile_stdout 05:11:59 INFO - Output received: 05:11:59 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) 05:11:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:11: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', 'pip>=1.5'] in /builds/slave/test/build 05:11: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 pip>=1.5 05:11:59 INFO - Using env: {'DISPLAY': ':0', 05:11:59 INFO - 'HOME': '/home/cltbld', 05:11:59 INFO - 'LANG': 'en_US.UTF-8', 05:11:59 INFO - 'LANGUAGE': 'en_US:en', 05:11:59 INFO - 'LOGNAME': 'cltbld', 05:11:59 INFO - 'MAIL': '/var/mail/cltbld', 05:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:59 INFO - 'MOZ_NO_REMOTE': '1', 05:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:59 INFO - 'NO_EM_RESTART': '1', 05:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:59 INFO - 'PWD': '/builds/slave/test', 05:11:59 INFO - 'SHELL': '/bin/bash', 05:11:59 INFO - 'SHLVL': '1', 05:11:59 INFO - 'TERM': 'linux', 05:11:59 INFO - 'TMOUT': '86400', 05:11:59 INFO - 'USER': 'cltbld', 05:11:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:59 INFO - '_': '/tools/buildbot/bin/python'} 05:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:59 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 05:11:59 INFO - Cleaning up... 05:11:59 INFO - Return code: 0 05:11:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11: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 psutil>=3.1.1 05:11:59 INFO - Using env: {'DISPLAY': ':0', 05:11:59 INFO - 'HOME': '/home/cltbld', 05:11:59 INFO - 'LANG': 'en_US.UTF-8', 05:11:59 INFO - 'LANGUAGE': 'en_US:en', 05:11:59 INFO - 'LOGNAME': 'cltbld', 05:11:59 INFO - 'MAIL': '/var/mail/cltbld', 05:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:59 INFO - 'MOZ_NO_REMOTE': '1', 05:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:59 INFO - 'NO_EM_RESTART': '1', 05:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:59 INFO - 'PWD': '/builds/slave/test', 05:11:59 INFO - 'SHELL': '/bin/bash', 05:11:59 INFO - 'SHLVL': '1', 05:11:59 INFO - 'TERM': 'linux', 05:11:59 INFO - 'TMOUT': '86400', 05:11:59 INFO - 'USER': 'cltbld', 05:11:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:59 INFO - '_': '/tools/buildbot/bin/python'} 05:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:00 INFO - Downloading/unpacking psutil>=3.1.1 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:02 INFO - Installing collected packages: psutil 05:12:02 INFO - Running setup.py install for psutil 05:12:02 INFO - building 'psutil._psutil_linux' extension 05:12:02 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 05:12:02 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 05:12:02 INFO - building 'psutil._psutil_posix' extension 05:12:02 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 05:12:02 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 05:12:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:02 INFO - Successfully installed psutil 05:12:02 INFO - Cleaning up... 05:12:02 INFO - Return code: 0 05:12:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:12:02 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')]} 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 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')]} 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:02 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 05:12:02 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 05:12:02 INFO - Using env: {'DISPLAY': ':0', 05:12:02 INFO - 'HOME': '/home/cltbld', 05:12:02 INFO - 'LANG': 'en_US.UTF-8', 05:12:02 INFO - 'LANGUAGE': 'en_US:en', 05:12:02 INFO - 'LOGNAME': 'cltbld', 05:12:02 INFO - 'MAIL': '/var/mail/cltbld', 05:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:02 INFO - 'MOZ_NO_REMOTE': '1', 05:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:02 INFO - 'NO_EM_RESTART': '1', 05:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:02 INFO - 'PWD': '/builds/slave/test', 05:12:02 INFO - 'SHELL': '/bin/bash', 05:12:02 INFO - 'SHLVL': '1', 05:12:02 INFO - 'TERM': 'linux', 05:12:02 INFO - 'TMOUT': '86400', 05:12:02 INFO - 'USER': 'cltbld', 05:12:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:02 INFO - '_': '/tools/buildbot/bin/python'} 05:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:12:04 INFO - Installing collected packages: mozsystemmonitor 05:12:04 INFO - Running setup.py install for mozsystemmonitor 05:12:04 INFO - Successfully installed mozsystemmonitor 05:12:04 INFO - Cleaning up... 05:12:04 INFO - Return code: 0 05:12:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:05 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 05:12:05 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 05:12:05 INFO - Using env: {'DISPLAY': ':0', 05:12:05 INFO - 'HOME': '/home/cltbld', 05:12:05 INFO - 'LANG': 'en_US.UTF-8', 05:12:05 INFO - 'LANGUAGE': 'en_US:en', 05:12:05 INFO - 'LOGNAME': 'cltbld', 05:12:05 INFO - 'MAIL': '/var/mail/cltbld', 05:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:05 INFO - 'MOZ_NO_REMOTE': '1', 05:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:05 INFO - 'NO_EM_RESTART': '1', 05:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:05 INFO - 'PWD': '/builds/slave/test', 05:12:05 INFO - 'SHELL': '/bin/bash', 05:12:05 INFO - 'SHLVL': '1', 05:12:05 INFO - 'TERM': 'linux', 05:12:05 INFO - 'TMOUT': '86400', 05:12:05 INFO - 'USER': 'cltbld', 05:12:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:05 INFO - '_': '/tools/buildbot/bin/python'} 05:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:05 INFO - Downloading/unpacking jsonschema==2.5.1 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:12:07 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 05:12:07 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 05:12:07 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 05:12:07 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 05:12:07 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 05:12:07 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 05:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:07 INFO - warning: no files found matching '*.txt' 05:12:07 INFO - no previously-included directories found matching 'build' 05:12:07 INFO - no previously-included directories found matching 'dist' 05:12:07 INFO - no previously-included directories found matching '.git*' 05:12:07 INFO - Installing collected packages: jsonschema, functools32 05:12:07 INFO - Running setup.py install for functools32 05:12:07 INFO - warning: no files found matching '*.txt' 05:12:07 INFO - no previously-included directories found matching 'build' 05:12:07 INFO - no previously-included directories found matching 'dist' 05:12:07 INFO - no previously-included directories found matching '.git*' 05:12:07 INFO - Successfully installed jsonschema functools32 05:12:07 INFO - Cleaning up... 05:12:07 INFO - Return code: 0 05:12:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:12:07 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')]} 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:07 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')]} 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:07 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:07 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 05:12:07 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 05:12:07 INFO - Using env: {'DISPLAY': ':0', 05:12:07 INFO - 'HOME': '/home/cltbld', 05:12:07 INFO - 'LANG': 'en_US.UTF-8', 05:12:07 INFO - 'LANGUAGE': 'en_US:en', 05:12:07 INFO - 'LOGNAME': 'cltbld', 05:12:07 INFO - 'MAIL': '/var/mail/cltbld', 05:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:07 INFO - 'MOZ_NO_REMOTE': '1', 05:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:07 INFO - 'NO_EM_RESTART': '1', 05:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:07 INFO - 'PWD': '/builds/slave/test', 05:12:07 INFO - 'SHELL': '/bin/bash', 05:12:07 INFO - 'SHLVL': '1', 05:12:07 INFO - 'TERM': 'linux', 05:12:07 INFO - 'TMOUT': '86400', 05:12:07 INFO - 'USER': 'cltbld', 05:12:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:07 INFO - '_': '/tools/buildbot/bin/python'} 05:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:12:07 INFO - Cleaning up... 05:12:07 INFO - Return code: 0 05:12:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:07 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')]} 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:07 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')]} 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:07 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:07 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 05:12:07 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 05:12:07 INFO - Using env: {'DISPLAY': ':0', 05:12:07 INFO - 'HOME': '/home/cltbld', 05:12:07 INFO - 'LANG': 'en_US.UTF-8', 05:12:07 INFO - 'LANGUAGE': 'en_US:en', 05:12:07 INFO - 'LOGNAME': 'cltbld', 05:12:07 INFO - 'MAIL': '/var/mail/cltbld', 05:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:07 INFO - 'MOZ_NO_REMOTE': '1', 05:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:07 INFO - 'NO_EM_RESTART': '1', 05:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:07 INFO - 'PWD': '/builds/slave/test', 05:12:07 INFO - 'SHELL': '/bin/bash', 05:12:07 INFO - 'SHLVL': '1', 05:12:07 INFO - 'TERM': 'linux', 05:12:07 INFO - 'TMOUT': '86400', 05:12:07 INFO - 'USER': 'cltbld', 05:12:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:07 INFO - '_': '/tools/buildbot/bin/python'} 05:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:08 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 05:12:08 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 05:12:08 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 05:12:08 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 05:12:08 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 05:12:08 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 05:12:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 INFO - Downloading docopt-0.6.1.tar.gz 05:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:10 INFO - Running setup.py install for blobuploader 05:12:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:10 INFO - Running setup.py install for requests 05:12:11 INFO - Running setup.py install for docopt 05:12:11 INFO - Successfully installed blobuploader requests docopt 05:12:11 INFO - Cleaning up... 05:12:11 INFO - Return code: 0 05:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:11 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')]} 05:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:11 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')]} 05:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:11 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:11 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 05:12:11 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 05:12:11 INFO - Using env: {'DISPLAY': ':0', 05:12:11 INFO - 'HOME': '/home/cltbld', 05:12:11 INFO - 'LANG': 'en_US.UTF-8', 05:12:11 INFO - 'LANGUAGE': 'en_US:en', 05:12:11 INFO - 'LOGNAME': 'cltbld', 05:12:11 INFO - 'MAIL': '/var/mail/cltbld', 05:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:11 INFO - 'MOZ_NO_REMOTE': '1', 05:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:11 INFO - 'NO_EM_RESTART': '1', 05:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:11 INFO - 'PWD': '/builds/slave/test', 05:12:11 INFO - 'SHELL': '/bin/bash', 05:12:11 INFO - 'SHLVL': '1', 05:12:11 INFO - 'TERM': 'linux', 05:12:11 INFO - 'TMOUT': '86400', 05:12:11 INFO - 'USER': 'cltbld', 05:12:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:11 INFO - '_': '/tools/buildbot/bin/python'} 05:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:11 INFO - Running setup.py (path:/tmp/pip-_lU7Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:11 INFO - Running setup.py (path:/tmp/pip-yi03P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:11 INFO - Running setup.py (path:/tmp/pip-9MxZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:11 INFO - Running setup.py (path:/tmp/pip-2WzxKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:11 INFO - Running setup.py (path:/tmp/pip-nvz3lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:11 INFO - Running setup.py (path:/tmp/pip-tqI2ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:12 INFO - Running setup.py (path:/tmp/pip-7ktJXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:12 INFO - Running setup.py (path:/tmp/pip-O97dRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:12 INFO - Running setup.py (path:/tmp/pip-w7WG5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:12 INFO - Running setup.py (path:/tmp/pip-hY5LtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:12 INFO - Running setup.py (path:/tmp/pip-tcmq5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:12 INFO - Running setup.py (path:/tmp/pip-hkLeBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:12 INFO - Running setup.py (path:/tmp/pip-IieshC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:12 INFO - Running setup.py (path:/tmp/pip-e51ynU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:12 INFO - Running setup.py (path:/tmp/pip-iAkL3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:12 INFO - Running setup.py (path:/tmp/pip-71dXTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:12 INFO - Running setup.py (path:/tmp/pip-rrWB3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:12 INFO - Running setup.py install for manifestparser 05:12:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:12 INFO - Running setup.py install for mozcrash 05:12:13 INFO - Running setup.py install for mozdebug 05:12:13 INFO - Running setup.py install for mozdevice 05:12:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for mozfile 05:12:13 INFO - Running setup.py install for mozhttpd 05:12:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for mozinfo 05:12:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for mozInstall 05:12:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for mozleak 05:12:13 INFO - Running setup.py install for mozlog 05:12:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for moznetwork 05:12:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:13 INFO - Running setup.py install for mozprocess 05:12:14 INFO - Running setup.py install for mozprofile 05:12:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:14 INFO - Running setup.py install for mozrunner 05:12:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:14 INFO - Running setup.py install for mozscreenshot 05:12:14 INFO - Running setup.py install for moztest 05:12:14 INFO - Running setup.py install for mozversion 05:12:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:14 INFO - Cleaning up... 05:12:14 INFO - Return code: 0 05:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:14 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:14 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 05:12:14 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 05:12:14 INFO - Using env: {'DISPLAY': ':0', 05:12:14 INFO - 'HOME': '/home/cltbld', 05:12:14 INFO - 'LANG': 'en_US.UTF-8', 05:12:14 INFO - 'LANGUAGE': 'en_US:en', 05:12:14 INFO - 'LOGNAME': 'cltbld', 05:12:14 INFO - 'MAIL': '/var/mail/cltbld', 05:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:14 INFO - 'MOZ_NO_REMOTE': '1', 05:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:14 INFO - 'NO_EM_RESTART': '1', 05:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:14 INFO - 'PWD': '/builds/slave/test', 05:12:14 INFO - 'SHELL': '/bin/bash', 05:12:14 INFO - 'SHLVL': '1', 05:12:14 INFO - 'TERM': 'linux', 05:12:14 INFO - 'TMOUT': '86400', 05:12:14 INFO - 'USER': 'cltbld', 05:12:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:14 INFO - '_': '/tools/buildbot/bin/python'} 05:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:14 INFO - Running setup.py (path:/tmp/pip-XO81LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:14 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)) 05:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:14 INFO - Running setup.py (path:/tmp/pip-d02VWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:15 INFO - Running setup.py (path:/tmp/pip-rFzFaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:15 INFO - Running setup.py (path:/tmp/pip-Ek0Ye6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:15 INFO - Running setup.py (path:/tmp/pip-S3aM9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:15 INFO - Running setup.py (path:/tmp/pip-qQ8B07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:15 INFO - Running setup.py (path:/tmp/pip-OFlYJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:15 INFO - Running setup.py (path:/tmp/pip-9cFGL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:15 INFO - Running setup.py (path:/tmp/pip-GTki0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:15 INFO - Running setup.py (path:/tmp/pip-nOQkeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:15 INFO - Running setup.py (path:/tmp/pip-K_Afhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:15 INFO - Running setup.py (path:/tmp/pip-KjpVXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:15 INFO - Running setup.py (path:/tmp/pip-OWzveG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:15 INFO - Running setup.py (path:/tmp/pip-fuUtqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:15 INFO - Running setup.py (path:/tmp/pip-icwiRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:15 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)) 05:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:15 INFO - Running setup.py (path:/tmp/pip-VnpUfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:16 INFO - Running setup.py (path:/tmp/pip-n_zNCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:16 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)) 05:12:16 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)) 05:12:16 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)) 05:12:16 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)) 05:12:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:17 INFO - Downloading blessings-1.6.tar.gz 05:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:18 INFO - Installing collected packages: blessings 05:12:18 INFO - Running setup.py install for blessings 05:12:18 INFO - Successfully installed blessings 05:12:18 INFO - Cleaning up... 05:12:18 INFO - Return code: 0 05:12:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:18 INFO - Reading from file tmpfile_stdout 05:12:18 INFO - Current package versions: 05:12:18 INFO - argparse == 1.2.1 05:12:18 INFO - blessings == 1.6 05:12:18 INFO - blobuploader == 1.2.4 05:12:18 INFO - docopt == 0.6.1 05:12:18 INFO - functools32 == 3.2.3-2 05:12:18 INFO - jsonschema == 2.5.1 05:12:18 INFO - manifestparser == 1.1 05:12:18 INFO - mozInstall == 1.12 05:12:18 INFO - mozcrash == 1.0 05:12:18 INFO - mozdebug == 0.1 05:12:18 INFO - mozdevice == 0.49 05:12:18 INFO - mozfile == 1.2 05:12:18 INFO - mozhttpd == 0.7 05:12:18 INFO - mozinfo == 0.9 05:12:18 INFO - mozleak == 0.1 05:12:18 INFO - mozlog == 3.4 05:12:18 INFO - moznetwork == 0.27 05:12:18 INFO - mozprocess == 0.23 05:12:18 INFO - mozprofile == 0.28 05:12:18 INFO - mozrunner == 6.13 05:12:18 INFO - mozscreenshot == 0.1 05:12:18 INFO - mozsystemmonitor == 0.3 05:12:18 INFO - moztest == 0.7 05:12:18 INFO - mozversion == 1.4 05:12:18 INFO - psutil == 3.1.1 05:12:18 INFO - requests == 1.2.3 05:12:18 INFO - wsgiref == 0.1.2 05:12:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:18 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')]} 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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')]} 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:18 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 05:12:18 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 05:12:18 INFO - Using env: {'DISPLAY': ':0', 05:12:18 INFO - 'HOME': '/home/cltbld', 05:12:18 INFO - 'LANG': 'en_US.UTF-8', 05:12:18 INFO - 'LANGUAGE': 'en_US:en', 05:12:18 INFO - 'LOGNAME': 'cltbld', 05:12:18 INFO - 'MAIL': '/var/mail/cltbld', 05:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:18 INFO - 'MOZ_NO_REMOTE': '1', 05:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:18 INFO - 'NO_EM_RESTART': '1', 05:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:18 INFO - 'PWD': '/builds/slave/test', 05:12:18 INFO - 'SHELL': '/bin/bash', 05:12:18 INFO - 'SHLVL': '1', 05:12:18 INFO - 'TERM': 'linux', 05:12:18 INFO - 'TMOUT': '86400', 05:12:18 INFO - 'USER': 'cltbld', 05:12:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:18 INFO - '_': '/tools/buildbot/bin/python'} 05:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 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)) 05:12:18 INFO - Cleaning up... 05:12:18 INFO - Return code: 0 05:12:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:18 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')]} 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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')]} 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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 0x7fb855cabe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', '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 05:12:18 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 05:12:18 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 05:12:18 INFO - Using env: {'DISPLAY': ':0', 05:12:18 INFO - 'HOME': '/home/cltbld', 05:12:18 INFO - 'LANG': 'en_US.UTF-8', 05:12:18 INFO - 'LANGUAGE': 'en_US:en', 05:12:18 INFO - 'LOGNAME': 'cltbld', 05:12:18 INFO - 'MAIL': '/var/mail/cltbld', 05:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:18 INFO - 'MOZ_NO_REMOTE': '1', 05:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:18 INFO - 'NO_EM_RESTART': '1', 05:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:18 INFO - 'PWD': '/builds/slave/test', 05:12:18 INFO - 'SHELL': '/bin/bash', 05:12:18 INFO - 'SHLVL': '1', 05:12:18 INFO - 'TERM': 'linux', 05:12:18 INFO - 'TMOUT': '86400', 05:12:18 INFO - 'USER': 'cltbld', 05:12:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:18 INFO - '_': '/tools/buildbot/bin/python'} 05:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:18 INFO - Cleaning up... 05:12:18 INFO - Return code: 0 05:12:18 INFO - Running post-action listener: _resource_record_post_action 05:12:18 INFO - Running post-action listener: _start_resource_monitoring 05:12:18 INFO - Starting resource monitoring. 05:12:18 INFO - [mozharness: 2016-11-23 13:12:18.990050Z] Finished create-virtualenv step (success) 05:12:18 INFO - [mozharness: 2016-11-23 13:12:18.990555Z] Running install step. 05:12:18 INFO - Running pre-action listener: _resource_record_pre_action 05:12:18 INFO - Running main action method: install 05:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:19 INFO - Reading from file tmpfile_stdout 05:12:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:19 INFO - Reading from file tmpfile_stdout 05:12:19 INFO - Output received: 05:12:19 INFO - Usage: mozinstall [options] installer 05:12:19 INFO - Options: 05:12:19 INFO - -h, --help show this help message and exit 05:12:19 INFO - -d DEST, --destination=DEST 05:12:19 INFO - Directory to install application into. [default: 05:12:19 INFO - "/builds/slave/test"] 05:12:19 INFO - --app=APP Application being installed. [default: firefox] 05:12:19 INFO - mkdir: /builds/slave/test/build/application 05:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:12:35 INFO - Reading from file tmpfile_stdout 05:12:35 INFO - Output received: 05:12:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:35 INFO - Running post-action listener: _resource_record_post_action 05:12:35 INFO - [mozharness: 2016-11-23 13:12:35.306879Z] Finished install step (success) 05:12:35 INFO - [mozharness: 2016-11-23 13:12:35.307131Z] Running run-tests step. 05:12:35 INFO - Running pre-action listener: _resource_record_pre_action 05:12:35 INFO - Running main action method: run_tests 05:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:35 INFO - Python 2.7.3 05:12:35 INFO - Return code: 0 05:12:35 INFO - grabbing minidump binary from tooltool 05:12:35 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')]} 05:12:35 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 0x2205fc0>, '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 0x2206ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2207350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:35 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 05:12:35 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 05:12:35 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 05:12:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:35 INFO - Return code: 0 05:12:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:12:35 INFO - Using env: {'DISPLAY': ':0', 05:12:35 INFO - 'HOME': '/home/cltbld', 05:12:35 INFO - 'LANG': 'en_US.UTF-8', 05:12:35 INFO - 'LANGUAGE': 'en_US:en', 05:12:35 INFO - 'LOGNAME': 'cltbld', 05:12:35 INFO - 'MAIL': '/var/mail/cltbld', 05:12:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:35 INFO - 'MOZ_NO_REMOTE': '1', 05:12:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:35 INFO - 'NO_EM_RESTART': '1', 05:12:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:35 INFO - 'PWD': '/builds/slave/test', 05:12:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:35 INFO - 'SHELL': '/bin/bash', 05:12:35 INFO - 'SHLVL': '1', 05:12:35 INFO - 'TERM': 'linux', 05:12:35 INFO - 'TMOUT': '86400', 05:12:35 INFO - 'USER': 'cltbld', 05:12:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811', 05:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:35 INFO - '_': '/tools/buildbot/bin/python'} 05:12:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:12:35 INFO - mozversion application_buildid: 20161123024236 05:12:35 INFO - mozversion application_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 05:12:35 INFO - mozversion application_display_name: Nightly 05:12:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:35 INFO - mozversion application_name: Firefox 05:12:35 INFO - mozversion application_remotingname: firefox 05:12:35 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 05:12:35 INFO - mozversion application_vendor: Mozilla 05:12:35 INFO - mozversion application_version: 53.0a1 05:12:35 INFO - mozversion platform_buildid: 20161123024236 05:12:35 INFO - mozversion platform_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 05:12:35 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 05:12:35 INFO - mozversion platform_version: 53.0a1 05:12:35 INFO - using testdate: 1479906755 05:12:35 INFO - actual date: 1479906755 05:12:35 INFO - starting webserver on 'localhost:51290' 05:12:35 INFO - SUITE-START | Running 2 tests 05:12:35 INFO - TEST-START | dromaeo_css 05:12:35 INFO - operating with platform_type : linux_ 05:12:35 INFO - Initialising browser for dromaeo_css test... 05:12:35 INFO - TEST-INFO | started process 28369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEGzUms/profile http://localhost:51290/getInfo.html) 05:12:40 INFO - PROCESS | 28369 | __metrics Screen width/height:1600/1200 05:12:40 INFO - PROCESS | 28369 | colorDepth:24 05:12:40 INFO - PROCESS | 28369 | Browser inner width/height: 1024/697 05:12:40 INFO - PROCESS | 28369 | __metrics 05:12:41 ERROR - PROCESS | 28369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 05:12:42 INFO - TEST-INFO | 28369: exit 0 05:12:42 INFO - Browser initialized. 05:12:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:42 INFO - TEST-INFO | started process 28492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEGzUms/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:54 INFO - PROCESS | 28492 | RSS: Main: 187027456 05:12:54 INFO - PROCESS | 28492 | 05:13:44 INFO - PROCESS | 28492 | 1479906824457 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:58 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51290/tests/dromaeo/cssquery-ext.html) 05:15:59 INFO - PROCESS | 28492 | RSS: Main: 197046272 05:15:59 INFO - PROCESS | 28492 | 05:19:02 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-ext.html (next: http://localhost:51290/tests/dromaeo/cssquery-jquery.html) 05:19:02 INFO - PROCESS | 28492 | RSS: Main: 196861952 05:19:02 INFO - PROCESS | 28492 | 05:22:05 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51290/tests/dromaeo/cssquery-mootools.html) 05:22:05 INFO - PROCESS | 28492 | RSS: Main: 198643712 05:22:05 INFO - PROCESS | 28492 | 05:25:07 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51290/tests/dromaeo/cssquery-prototype.html) 05:25:08 INFO - PROCESS | 28492 | RSS: Main: 195244032 05:25:08 INFO - PROCESS | 28492 | 05:28:11 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51290/tests/dromaeo/cssquery-yui.html) 05:28:12 INFO - PROCESS | 28492 | RSS: Main: 198381568 05:28:12 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:51290/tests/dromaeo/cssquery-yui.html (next: http://localhost:51290/tests/dromaeo/cssquery-dojo.html) 05:31:15 INFO - PROCESS | 28492 | RSS: Main: 199266304 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | __start_tp_report 05:31:15 INFO - PROCESS | 28492 | _x_x_mozilla_page_load 05:31:15 INFO - PROCESS | 28492 | _x_x_mozilla_page_load_details 05:31:15 INFO - PROCESS | 28492 | |i|pagename|runs| 05:31:15 INFO - PROCESS | 28492 | |0;dojo.html;2613.5687611544095;2618.5941179117244;2636.3277364272108;2640.313518485194;2659.2819938616576;4530.682852200347;4701.388819453475;4718.811247550098;4743.8814029649275;4753.500882407349;4581.770911454422;4677.76611169441;4710.057988402325;4712.0575884823;4791.161546729317;4269.274223382017;4346.500152482474;4356;4445.0443154721725;4460.754658493782;4002.3996400540004;4409.426774519324;4414.050979039506;4443.46678398591;4447.132809102226;4148.004478925066;4325.718828276184;4339.696221264513;4378;4425.822967081329;4187.183499217654;4276.422682937795;4326.805293761789;4368.803403846835;4430.224710675619;4314.525402205755;4343.5656434356315;4346.76092814895;4355.150745604608;4385.254506733863;4693.272542755878;4694.953050469486;4709.71741695496;4718.787654555519;4724.952750472486;4817.397825271841;4863.756812159378;4864.513548645143;4929.309896614441;4938.654294199408;4948.035133149037;4958.87602809929;4961.082199793013;4962.057209130254;5016.247562865563;4694.2254528002495;4709.270063140219;4719.716816990923;4753.382060332135;4754.168020596382;5136.357955255593;5136.614753893473;5142.485751424828;5155.381354237516;5182.844514664566;4699.694519856198;4741.454732705714;4791.257355109963;4897.41231052276;4957.281194226817;4826.469088400273;4892.926606100911;4937.1606826839525;4999.575036121898;5015.297858299841;4813.711177329372;4870.318155458239;4888.291197776302;4914.140025495524;4947.505249475095;4894.975525122423;4895;4919.385076865392;4939.997323300659;4957.107720610325;4017.015831121394;4050.6556942659613;4137.338025915839;4163;4215.494140703074;3612.440071788877;3624.7462677612316;3657.4330978698345;3696.611855755161;3699.7595156314756;4366;4367.301231802896;4378.8029538670835;4405.955940440619;4418.8453404130705;5067.391912970394;5070.6957582545165;5070.923936140961;5081.18701007837;5082.872928176751;4203.285441474956;4235.745855248695;4237.597428244312;4279.358096285582;4373.234683930299;4413.823447062082;4419.911601768011;4432.024954510002;4437.911241775147;4466.4640243171025;4735.597474214593;4749.738764367855;4756.6908150970075;4789.4971028042255;4798.7840547175465;5050.217216331474;5052.873678158076;5053.494650534917;5080.517350851663;5086.720230387216;4493.056458143827;4505.32420136969;4550.908981820279;4752.2158843790385;4758.034138894914;4882.194437917704;4907.362042934538;4950.282209079735;4956.925646115384;5005.1241032819835;5020.899582008266;5032.245163225399;5034.546890779701;5037;5086.21163719624;4687.554682305175;4877.292792545132;4883;4893.045856058035;4930.926036109389;4718.268668356411;4762.52374762521;4806.639502037291;4810.11012962603;4811.941372897957;4706.435227772552;4810.95189048105;4818.084563932842;4869.537393947569;4931.13705101613;4970.726610036482;4983.476734942778;4989.052080104769;4989.625778066732;4997.900041999067;4805.3512775774825;4823.927641085316;4835.661503694708;4857.368542089505;4893 05:31:15 INFO - PROCESS | 28492 | |1;ext.html;532.8694469854885;549.072068204734;549.4231057389742;554.3015800091883;562.0894151474612;37301.25397492052;38525.22949541011;38615.61384386155;43131.3530297045;43148.35277470833;38252.61747382525;38401.807990960006;38508;38862;38917.41623875644;7481.326680598759;7670.923290767105;7698.730544430946;9540.093691099335;9908.157806586449;9634.181094606933;9708.75728106796;9720.659776907809;9729.464879431629;9735.269854760885;9671.854922176173;9740.951295243514;9765.876924153707;9812.754681132958;9833;9730.56212470437;9764.658236961708;9779.755506112333;9790.21678265737;9791.216702663769;9837.90162098377;9883.901160988442;9904.851427228597;9909.454979976099;9910.10809027191;37073.443898341546;37222;37274.52705675309;37287.254254915024;37625.435618465744;2834.319763256824;2917.6061231733656;3051.5727798108283;3080.3531258435755;3258.9837050814594;28031;28267;28311;28755.85622071897;29817.701822981708;3401.523786669868;3433.6909678129086;3438.7249020078334;3439.8624055038017;3447.844846981867;241786;241998;243432;245442;246709;51297.487025129274;51717;51956.22065669018;52212.21681674778;52230.21654675183;54219;54325.72837135789;54401;54504;54527.72736136294;13488.39302231402;13866.029377943447;14051.297435128203;14067.577972660836;14080.577582672537;9771.560279787427;9979.251556133318;10649.574017039387;10775.6228532001;10946.890531094747;17086.40197593078;17154.485365439057;17217.139143042798;17281.740773888403;17358.479245622653;6783.525153239325;6824;6920.653967301615;6957.373836354753;7037.4018208451835;765.7894079128284;773.1456740301998;869.3219288954499;912.2929729459589;968.2399316536626;25342.493150136896;26955.191344259703;26958.460830783275;27096.72903270942;27362;895.713371721043;915.9862602060974;919.6781126605634;954.355809828363;996.2229461020415;14540.437592789835;14566.4901728439;14617.634559136106;14728.852711472962;14802.851971480362;326150;326239;326507;327618;329725;47520.7623961878;47977.76011119992;48217.517824822;48237.517624824;48305.75847120742;1162.0587324267372;1186.489809381974;1190.214458457414;1198.0774803401332;1201.585453018707;25166.748332517174;26098;26897.865510673106;27253;27417.45165096727;40410.595894040685;40721.1855762889;40806;40856.38715419212;40898.59101408948;287555.8066403081;288655;289167;289417;289918;21766.89116554407;22312.77687223172;22853.771462285164;24251.757482425655;24318.27045188647;39873.20253594854;39931.80034099811;39951.600483994785;40138.598614013485;40837;34075.65924340725;34268.31463370768;34410;34705.65294347125;34876.47685284672;33565.83217083997;33900.66099339074;34098.829505852314;34517;34782.47826282557;33762.15594610154;34392;34665.48001779925;34679;34851.12872178216;30531;31463.842680787366;31969.360612788078;32122.357552848345;32209.51685724763;23544.29367118989;24214.75785242125;24394.634080488453;24901.377465563506;24920.501589968462 05:31:15 INFO - PROCESS | 28492 | |2;jquery.html;341.8273771745268;358.2244440785699;367.7756568493219;369.98890033298994;387.03627966363746;15157.696846063085;16401.83598164018;16600.833991660078;16661.83338166618;16719.414820481285;15278.312475938581;16387.42644007457;16448.75326870098;16532.66934661306;16547.751783723255;4932.580730637891;5173.637845350827;5206.114960456732;5209.1404918188455;5215.973920130394;3720.4047352423618;3886.689064874817;5022.59819214462;5124.231365295198;5402.486763757456;3911.823967921436;3947.5262968443685;6198.194234749476;6202.131701561785;6226.782062627809;5889.440503152194;6104.481119104881;6128.877422451548;6176.752929882799;6199.907001394983;5412.56699464042;5420.403755586883;5424.511793938565;5429.864253393696;5434;16504.917475412545;18658.90670546652;20545.075471603814;21094.894525527427;21335.146594136215;1829.4511646506128;1857.6563335782923;1859.3956963986623;1870.9158087885942;1941.3302410668439;12870.549530766471;12916.547920822726;13082.542111026163;13201.73596528064;13586.38861251246;1688.4343744845369;1700.104027344333;1711.1102226842097;1736.722124460093;1741.112032863249;65963.67018164927;66209.33790662128;67750.66124669394;69829.25426864318;71356.64321678359;9220.170184683411;9263.583138758771;9329.11373419524;9443.811123777487;9658.71023869285;13344.666383340495;13400.597982060553;13423.328833558284;13443.193408395528;13474.258915759532;7320.267973202637;7361.227071157558;7515.6242187891485;7573;7581.886271705929;6933.861322773516;6943.6875340609795;6976;7095.503314767917;7243.311885370881;6105.419985101408;6189.164462797555;6191;6193.907091393633;6227.346128656426;1700.7108791505473;1803.2877013579562;1817.8909265443851;1826.6711991841596;1827.2690923630655;882.2104216726123;892.9732108036769;900.2348004196381;914.6844338703137;920.3695468604028;16917.49247522576;17042.219350494608;17534.210960506807;18058.09709514519;18460.538486537946;843.9367047471342;846.7417437681567;857.6012154348258;875.4090988582681;912.5710915869531;9101.908980910106;9796.755081122887;10127.594896204217;10189.694309170736;10299;370951;371593;372609;381214;385941;79564;79859;81600;82742;84557.57721211477;871.7210492642421;894.9239314658327;933.5658918602746;933.8879334479906;933.9346245762868;15430.5370838875;15567.455139070078;15718.607034824221;16051.518454446385;16191.514254572381;35611.82194089117;37183;37975.430368543944;38463.423048653734;39011.41482877702;52336;52564;53013.204801928776;53209.46790532045;53418.73290633522;7323.890141647986;7339.339459448462;7384.52000619958;7419;7763.184865589258;10835.837462437912;11092;11145.609903653332;11336;11485.19603627738;9951.950240248752;10257.897421025993;10304.587816487257;10598.25812193139;10886.61896833607;10169.338992965433;10211;10403.94798026005;10474.633387831695;10563.207759418228;10248.077673009466;10597.364158150536;10616;10674.146068314361;10722.303050301705;7272.8909066362985;7344.522606030805;7382.593957332183;7532.359749421361;7544.509606875536;9395.624175032923;9455.24358051368;10187.541560629641;10221.284510084222;10335 05:31:15 INFO - PROCESS | 28492 | |3;mootools.html;1346.2393747532644;1389.798479220513;1443.667956370035;1620.0676775037177;1665.2589597629053;6146.262448506174;6254.718537665804;6938.618375989318;7392.630368481575;7425.36884364829;6928.510370270404;7179.246179151192;7183.640817959107;7361.5583065016135;7380.335769780719;2075.616011037955;2096.2348742708955;2117.068489864462;2118.7881211878844;2122.246602456129;2069;2110.261408507018;2126.5853158634072;2147.2591955775233;2148.8388370872167;2096.6540520814046;2099.580083983202;2113.953592971481;2116.91532338707;2135.8184554312825;2087.530305681217;2113.059688438653;2114.9577008459746;2115.5663089066707;2117.68234764785;2005.1678553400322;2094.068139677844;2098.7586427560873;2100.7689154193026;2106.9262575809926;7292.45306602007;7323.304286092813;7375.852482950365;7386;7403.37071348936;4277.230098582254;4412.536683648235;4415.690901636886;4428.380026796219;4435.246008178618;2718.0894400375896;2790.511660459432;2833.164216556121;2882.164172390025;2904.6804851466322;845.750503601439;880.5421180985916;892.0455113029061;901.7430032440723;907.2424525521131;9908.157806586449;9938.602455901828;9959.103680668775;9966.850497242547;9968.601255949754;3780.4707340972286;4039.6768258539246;4043.353063509824;4134.710570260113;4140.3375459926265;8249.29880960113;8249.628766705513;8265.256126948603;8265.297449716722;8267.917320826835;4397.1205758848355;4398.142362239332;4401.735895846259;4455.799489023002;4464.464264288306;3445.8277086145595;3522.4011917974008;3908.5309762828074;4013.5986401360215;4022.6379625833815;3323;3328.417526932777;3439.8108104054018;3450;3460.723142148622;1114.7491814341709;1138.5047504335475;1151.125144889873;1151.861776586815;1156.109795457493;813.259933460548;816.8856360109589;817.3134566963779;826.8304997475503;841.5876220651836;4908.288298196741;4965.652404331734;4975.90048199034;5025.899482010339;5092.6180536459915;366.87892995311483;371.86798686466454;382.36909099985246;385.76853887667176;390.16310015017626;3355.2282974915906;3358.7984720916825;3359.412102881986;3393.7963722176746;3477.669621385964;8367.581620918929;8906.688265910661;8911;8919.910800892038;8926.973398059177;8860.86708699357;8863.936327640724;8866.33502487316;8866.911330886609;8906.910930890737;6869.862602747917;6890.621015844176;6995.300469952964;7020.333068358498;7056.929430705627;4877.926831097466;4903.950960490492;5027.271045698426;5028.296038554532;5212.348456442945;8114.472559283628;8135.837283254184;8211.95894020526;8233.46482478637;8322.126176751353;8338.166183381856;8339.45793523419;8351.665933362598;8411.789705257417;8478.703245386629;6110.663913484801;6291.653959032297;6297;6360.586561873463;6379.649119298483;7019.3682568569075;7075.292470752884;7108.964455177691;7112.182099058675;7122.109736282965;6336.239651241881;6435.967820160869;6449.161608990801;6469.223693156851;6590.373914478117;6346.079818426395;6364.077208804605;6371.585846919936;6494;6551.574147680385;5939.346671866005;6016.338202797601;6049.364816694184;6049.66726830011;6052.334243233329;4385.627221686193;4412.933805992977;4511.1654343946475;4515.9774201128785;4536.140182525149;4398.648108151404;4411.933820992624;4532.388127602731;4555.293929440942;4657.67396282257 05:31:15 INFO - PROCESS | 28492 | |4;prototype.html;295.6422728498517;295.6599910103381;298.66400299662877;302.9394121175765;303.4916514837647;4970.875728106795;5023.070731914599;5026.567428282931;5042.949570504298;5072.264521644369;4906.681065730725;4913.3612630358;4936.407631084266;4937.80248790048;4946.851594452172;3667.2482141161063;3759.4360845873202;3784.545854497464;3883.0486530799994;3891.6886649068006;3870.9032274193087;3879.398693202544;3886.9399218414146;3895.4156876468473;3905.863294784683;3861.6717579005817;3862.2082473093087;3877.1696661437168;3883.8834834954855;3884.9028774280587;3587;3766.190269092131;3845.5193100862393;3861.768293902375;3887.5918028607157;3283.670113603994;3298.752593555493;3301.966980330214;3312.5031245313153;3314.751393645462;4758.357621721093;4826.975865120687;4855.5387238212315;4865.82969596066;4866.902661946741;4320.481542214923;4323.351497275403;4329.631981281595;4332.610065094157;4344.174606824725;5012.77442515084;5069.366329208849;5093.18509038552;5093.974530127362;5128.153854613985;3454.809985450799;3469.5663042119736;3477.95661301611;3478.3217272631846;3484.52958850557;5312.814051508179;5320.201969704536;5336.4930331618825;5339.172428273624;5366.973165134149;3562.6259242779133;3594.8202589870402;3624.8006359649944;3645.781253124821;3651.507046548682;3639.7816131032223;3653.2510835278704;3660.158163622382;3682.116292089933;3686.635944700478;4216.427978932848;4238.788060596958;4242.830286788494;4247.214265360918;4273.380359847867;4944.909431605247;5076.147206269685;5099.521138869761;5127.256547800548;5156.561692256125;1227.2268470863298;1244.3280628460711;1247.9937600311941;1251.7997120460682;1254.3289340202948;839.1482645115213;854.4318028511095;864.2524216552637;873.746613482083;879.6261588824724;4246.384274280212;4373;4413.602775750198;4500.189965806187;4501.7974191161475;5291.232771248147;5309.973450132725;5310.522053015247;5338.626296159309;5339;4537.137943790735;4541.364209010741;4541.772911354419;4548.295014272793;4571.291449825282;2597.935051623687;2711.3086163028697;2725.38678797273;2726.6142125640067;2729.7543221110195;4734.455537613149;4752.881177970578;4778.737169455713;4784.593309568726;4789.568938795455;4995.550400463976;5252.343457067866;5259.21111833228;5274.630775845654;5298.947010529922;4679.906401872012;4718.834840780625;4761.857144285677;4776.928346074812;4787.257975013808;5020.849374518771;5118.617973147155;5145.3568303962;5148.639595228448;5178.249153872743;4763.69036012658;4981.452040275494;4984.077945580079;4988.251762235694;5014.398272207359;4752.833650822205;4762.475887779482;4786.832460863853;4786.994731106507;4788.353572267699;3533.3816582098543;3534.550834157983;3537.557805274341;3542.557180352456;3560.7151427885187;5134.149387959031;5141.38303403594;5143.588512918883;5176.249443830548;5253.159494480865;4876.731779752147;5125.846224613268;5131.10205714006;5152.510511501551;5184.403793563789;5115.907274180715;5166.354205724285;5168.2169651470185;5182.1190397631735;5208.635395522277;4870.95129048705;5057.519535644108;5089.618278629044;5095.592352611856;5102.719350435762;5047.747612619428;5130.743462826918;5167.689938603696;5172.612054096033;5195.81814636501;5102.413222479314;5105.693658380509;5118.594260697466;5123.513266239701;5163.4578369270685 05:31:15 INFO - PROCESS | 28492 | |5;yui.html;580.0313476494255;715.1239731329123;720.837811492414;737.7122922060397;740.551966060533;11776.470058847352;12287.569935052275;12366.258024518513;12797.744045119103;12834.358282085894;11796.823047654292;12104.12386080159;12106.636800895965;12130.636080917564;12140.69648258794;616.7193926763312;742.2948199210758;760.8288135169598;762.8321769210793;763.2825144364308;631.5200447659789;741.7292688168834;752.8795392737163;757.795395243284;758.0600055930662;784.9921500785005;788.9013873265842;791.3748138970207;796.9322607578363;797.3939805747644;789.6920201121567;789.7196495244192;789.873620220762;793.2662287384176;793.3811626931004;580.6719203649966;580.7125472890904;580.7967211475992;581.3198557687516;582.3826743651742;12091.697707557381;12163.331016794073;12169.452374643162;12170;12205.755884882341;10632.840507392395;10658.680239592824;10733.248672592921;11138.164637652128;11467.36929468879;10898.509567069501;10976.506057227443;11035.39305338206;11255.81813909536;11332.320060796379;4026.8993275168064;4055.3105971984537;4077.7757223352705;4089.5705950875326;4199.748015119103;41664.79167604142;43344.34983475282;47354;47364.579062628174;47406;9708;10080.546375412978;10192.898071019343;10358.792824143475;10612.681619551426;17935.37226197077;18140.90929545344;18157.818421815613;18163;18169;6616.735330586819;6665.566738162004;6822.761203357859;6909.239983601799;7008.159020917523;3465.4108801503803;3520.0847779577493;3533.9293214135573;3600.765950213228;3636.4363523653874;2611.7257687942874;2701.081632245007;2813.08574713219;2938.6326709161353;2940.955885661717;482.2043628013735;498.9675671081368;508.45595213122346;510.364596077878;514.362190883302;534.8128155145668;551.5973339462215;588.7792077970761;613.310026220502;620.3300435529708;7820.385972276385;7891.053073631087;8037.598120093972;8042.798930026796;8209.38429617781;588.9617174883618;602.9336772954971;607.5807692692028;625.8028720952885;639;3878.069263376826;3958.7426817256787;3962.4848769660334;4032.9798351008058;4125.628693417607;40032;61976.69011654913;62528;68216.65891670609;68312;52442.47557524452;54967.725161373935;56208.43791562032;56934.7153264231;61504;48720.269195962086;50134.49865501371;51345;51763.74118129385;52197;7882.842343153219;8129.837403251783;8248.422610417454;8310.501369917823;8542.957285213533;30475;34345.48481772726;36104.63895361013;36961;39034.41448378334;30262.243443914078;30553.847230763702;31081.222969425944;31974.52038219382;46556.7672161637;9415.826708191871;9668.85496717564;9681.322307438411;9995.500224988577;10025.598976040877;10646.73383165427;11449.885501145216;11497.827532587185;11905.880941190824;12209.738199619658;10245.180385569285;10556.419396933243;10632.096271816983;10718.785624287626;11073.446327683745;11144.387058711849;11328.433578321215;11661.825072623747;11786.823197652213;11790.94104529472;11285.943570282096;11562.479688413874;11665.650030499099;12155.939220303842;12174.208676436003;8832.072632373765;9106.838816001884;9437.373878643883;9666.709998700051;9726.076022777825;7689.154193038873;8110.188981101843;8287.875681864898;8342.124076972073;8550.187732165434 05:31:15 INFO - PROCESS | 28492 | __end_tp_report 05:31:15 INFO - PROCESS | 28492 | __start_cc_report 05:31:15 INFO - PROCESS | 28492 | _x_x_mozilla_cycle_collect,339 05:31:15 INFO - PROCESS | 28492 | __end_cc_report 05:31:15 INFO - PROCESS | 28492 | __startTimestamp1479907875422__endTimestamp 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | ------- Summary: start ------- 05:31:15 INFO - PROCESS | 28492 | Number of tests: 6 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#0] dojo.html Cycles:165 Average:4617.54 Median:4753.38 stddev:483.54 (10.2%) stddev-sans-first:458.76 05:31:15 INFO - PROCESS | 28492 | Values: 2613.6 2618.6 2636.3 2640.3 2659.3 4530.7 4701.4 4718.8 4743.9 4753.5 4581.8 4677.8 4710.1 4712.1 4791.2 4269.3 4346.5 4356.0 4445.0 4460.8 4002.4 4409.4 4414.1 4443.5 4447.1 4148.0 4325.7 4339.7 4378.0 4425.8 4187.2 4276.4 4326.8 4368.8 4430.2 4314.5 4343.6 4346.8 4355.2 4385.3 4693.3 4695.0 4709.7 4718.8 4725.0 4817.4 4863.8 4864.5 4929.3 4938.7 4948.0 4958.9 4961.1 4962.1 5016.2 4694.2 4709.3 4719.7 4753.4 4754.2 5136.4 5136.6 5142.5 5155.4 5182.8 4699.7 4741.5 4791.3 4897.4 4957.3 4826.5 4892.9 4937.2 4999.6 5015.3 4813.7 4870.3 4888.3 4914.1 4947.5 4895.0 4895.0 4919.4 4940.0 4957.1 4017.0 4050.7 4137.3 4163.0 4215.5 3612.4 3624.7 3657.4 3696.6 3699.8 4366.0 4367.3 4378.8 4406.0 4418.8 5067.4 5070.7 5070.9 5081.2 5082.9 4203.3 4235.7 4237.6 4279.4 4373.2 4413.8 4419.9 4432.0 4437.9 4466.5 4735.6 4749.7 4756.7 4789.5 4798.8 5050.2 5052.9 5053.5 5080.5 5086.7 4493.1 4505.3 4550.9 4752.2 4758.0 4882.2 4907.4 4950.3 4956.9 5005.1 5020.9 5032.2 5034.5 5037.0 5086.2 4687.6 4877.3 4883.0 4893.0 4930.9 4718.3 4762.5 4806.6 4810.1 4811.9 4706.4 4811.0 4818.1 4869.5 4931.1 4970.7 4983.5 4989.1 4989.6 4997.9 4805.4 4823.9 4835.7 4857.4 4893.0 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#1] ext.html Cycles:180 Average:44339.26 Median:34816.80 stddev:75538.05 (217.0%) stddev-sans-first:75678.34 05:31:15 INFO - PROCESS | 28492 | Values: 532.9 549.1 549.4 554.3 562.1 37301.3 38525.2 38615.6 43131.4 43148.4 38252.6 38401.8 38508.0 38862.0 38917.4 7481.3 7670.9 7698.7 9540.1 9908.2 9634.2 9708.8 9720.7 9729.5 9735.3 9671.9 9741.0 9765.9 9812.8 9833.0 9730.6 9764.7 9779.8 9790.2 9791.2 9837.9 9883.9 9904.9 9909.5 9910.1 37073.4 37222.0 37274.5 37287.3 37625.4 2834.3 2917.6 3051.6 3080.4 3259.0 28031.0 28267.0 28311.0 28755.9 29817.7 3401.5 3433.7 3438.7 3439.9 3447.8 241786.0 241998.0 243432.0 245442.0 246709.0 51297.5 51717.0 51956.2 52212.2 52230.2 54219.0 54325.7 54401.0 54504.0 54527.7 13488.4 13866.0 14051.3 14067.6 14080.6 9771.6 9979.3 10649.6 10775.6 10946.9 17086.4 17154.5 17217.1 17281.7 17358.5 6783.5 6824.0 6920.7 6957.4 7037.4 765.8 773.1 869.3 912.3 968.2 25342.5 26955.2 26958.5 27096.7 27362.0 895.7 916.0 919.7 954.4 996.2 14540.4 14566.5 14617.6 14728.9 14802.9 326150.0 326239.0 326507.0 327618.0 329725.0 47520.8 47977.8 48217.5 48237.5 48305.8 1162.1 1186.5 1190.2 1198.1 1201.6 25166.7 26098.0 26897.9 27253.0 27417.5 40410.6 40721.2 40806.0 40856.4 40898.6 287555.8 288655.0 289167.0 289417.0 289918.0 21766.9 22312.8 22853.8 24251.8 24318.3 39873.2 39931.8 39951.6 40138.6 40837.0 34075.7 34268.3 34410.0 34705.7 34876.5 33565.8 33900.7 34098.8 34517.0 34782.5 33762.2 34392.0 34665.5 34679.0 34851.1 30531.0 31463.8 31969.4 32122.4 32209.5 23544.3 24214.8 24394.6 24901.4 24920.5 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#2] jquery.html Cycles:180 Average:24203.49 Median:21449.05 stddev:62355.74 (290.7%) stddev-sans-first:62504.93 05:31:15 INFO - PROCESS | 28492 | Values: 341.8 358.2 367.8 370.0 387.0 15157.7 16401.8 16600.8 16661.8 16719.4 15278.3 16387.4 16448.8 16532.7 16547.8 4932.6 5173.6 5206.1 5209.1 5216.0 3720.4 3886.7 5022.6 5124.2 5402.5 3911.8 3947.5 6198.2 6202.1 6226.8 5889.4 6104.5 6128.9 6176.8 6199.9 5412.6 5420.4 5424.5 5429.9 5434.0 16504.9 18658.9 20545.1 21094.9 21335.1 1829.5 1857.7 1859.4 1870.9 1941.3 12870.5 12916.5 13082.5 13201.7 13586.4 1688.4 1700.1 1711.1 1736.7 1741.1 65963.7 66209.3 67750.7 69829.3 71356.6 9220.2 9263.6 9329.1 9443.8 9658.7 13344.7 13400.6 13423.3 13443.2 13474.3 7320.3 7361.2 7515.6 7573.0 7581.9 6933.9 6943.7 6976.0 7095.5 7243.3 6105.4 6189.2 6191.0 6193.9 6227.3 1700.7 1803.3 1817.9 1826.7 1827.3 882.2 893.0 900.2 914.7 920.4 16917.5 17042.2 17534.2 18058.1 18460.5 843.9 846.7 857.6 875.4 912.6 9101.9 9796.8 10127.6 10189.7 10299.0 370951.0 371593.0 372609.0 381214.0 385941.0 79564.0 79859.0 81600.0 82742.0 84557.6 871.7 894.9 933.6 933.9 933.9 15430.5 15567.5 15718.6 16051.5 16191.5 35611.8 37183.0 37975.4 38463.4 39011.4 52336.0 52564.0 53013.2 53209.5 53418.7 7323.9 7339.3 7384.5 7419.0 7763.2 10835.8 11092.0 11145.6 11336.0 11485.2 9952.0 10257.9 10304.6 10598.3 10886.6 10169.3 10211.0 10403.9 10474.6 10563.2 10248.1 10597.4 10616.0 10674.1 10722.3 7272.9 7344.5 7382.6 7532.4 7544.5 9395.6 9455.2 10187.5 10221.3 10335.0 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#3] mootools.html Cycles:180 Average:4822.15 Median:5026.59 stddev:2657.84 (52.9%) stddev-sans-first:2652.46 05:31:15 INFO - PROCESS | 28492 | Values: 1346.2 1389.8 1443.7 1620.1 1665.3 6146.3 6254.7 6938.6 7392.6 7425.4 6928.5 7179.2 7183.6 7361.6 7380.3 2075.6 2096.2 2117.1 2118.8 2122.2 2069.0 2110.3 2126.6 2147.3 2148.8 2096.7 2099.6 2114.0 2116.9 2135.8 2087.5 2113.1 2115.0 2115.6 2117.7 2005.2 2094.1 2098.8 2100.8 2106.9 7292.5 7323.3 7375.9 7386.0 7403.4 4277.2 4412.5 4415.7 4428.4 4435.2 2718.1 2790.5 2833.2 2882.2 2904.7 845.8 880.5 892.0 901.7 907.2 9908.2 9938.6 9959.1 9966.9 9968.6 3780.5 4039.7 4043.4 4134.7 4140.3 8249.3 8249.6 8265.3 8265.3 8267.9 4397.1 4398.1 4401.7 4455.8 4464.5 3445.8 3522.4 3908.5 4013.6 4022.6 3323.0 3328.4 3439.8 3450.0 3460.7 1114.7 1138.5 1151.1 1151.9 1156.1 813.3 816.9 817.3 826.8 841.6 4908.3 4965.7 4975.9 5025.9 5092.6 366.9 371.9 382.4 385.8 390.2 3355.2 3358.8 3359.4 3393.8 3477.7 8367.6 8906.7 8911.0 8919.9 8927.0 8860.9 8863.9 8866.3 8866.9 8906.9 6869.9 6890.6 6995.3 7020.3 7056.9 4877.9 4904.0 5027.3 5028.3 5212.3 8114.5 8135.8 8212.0 8233.5 8322.1 8338.2 8339.5 8351.7 8411.8 8478.7 6110.7 6291.7 6297.0 6360.6 6379.6 7019.4 7075.3 7109.0 7112.2 7122.1 6336.2 6436.0 6449.2 6469.2 6590.4 6346.1 6364.1 6371.6 6494.0 6551.6 5939.3 6016.3 6049.4 6049.7 6052.3 4385.6 4412.9 4511.2 4516.0 4536.1 4398.6 4411.9 4532.4 4555.3 4657.7 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#4] prototype.html Cycles:180 Average:4208.26 Median:4781.67 stddev:1236.93 (25.9%) stddev-sans-first:1205.04 05:31:15 INFO - PROCESS | 28492 | Values: 295.6 295.7 298.7 302.9 303.5 4970.9 5023.1 5026.6 5042.9 5072.3 4906.7 4913.4 4936.4 4937.8 4946.9 3667.2 3759.4 3784.5 3883.0 3891.7 3870.9 3879.4 3886.9 3895.4 3905.9 3861.7 3862.2 3877.2 3883.9 3884.9 3587.0 3766.2 3845.5 3861.8 3887.6 3283.7 3298.8 3302.0 3312.5 3314.8 4758.4 4827.0 4855.5 4865.8 4866.9 4320.5 4323.4 4329.6 4332.6 4344.2 5012.8 5069.4 5093.2 5094.0 5128.2 3454.8 3469.6 3478.0 3478.3 3484.5 5312.8 5320.2 5336.5 5339.2 5367.0 3562.6 3594.8 3624.8 3645.8 3651.5 3639.8 3653.3 3660.2 3682.1 3686.6 4216.4 4238.8 4242.8 4247.2 4273.4 4944.9 5076.1 5099.5 5127.3 5156.6 1227.2 1244.3 1248.0 1251.8 1254.3 839.1 854.4 864.3 873.7 879.6 4246.4 4373.0 4413.6 4500.2 4501.8 5291.2 5310.0 5310.5 5338.6 5339.0 4537.1 4541.4 4541.8 4548.3 4571.3 2597.9 2711.3 2725.4 2726.6 2729.8 4734.5 4752.9 4778.7 4784.6 4789.6 4995.6 5252.3 5259.2 5274.6 5298.9 4679.9 4718.8 4761.9 4776.9 4787.3 5020.8 5118.6 5145.4 5148.6 5178.2 4763.7 4981.5 4984.1 4988.3 5014.4 4752.8 4762.5 4786.8 4787.0 4788.4 3533.4 3534.6 3537.6 3542.6 3560.7 5134.1 5141.4 5143.6 5176.2 5253.2 4876.7 5125.8 5131.1 5152.5 5184.4 5115.9 5166.4 5168.2 5182.1 5208.6 4871.0 5057.5 5089.6 5095.6 5102.7 5047.7 5130.7 5167.7 5172.6 5195.8 5102.4 5105.7 5118.6 5123.5 5163.5 05:31:15 INFO - PROCESS | 28492 | 05:31:15 INFO - PROCESS | 28492 | [#5] yui.html Cycles:180 Average:13488.79 Median:23944.10 stddev:16391.26 (68.5%) stddev-sans-first:16408.58 05:31:15 INFO - PROCESS | 28492 | Values: 580.0 715.1 720.8 737.7 740.6 11776.5 12287.6 12366.3 12797.7 12834.4 11796.8 12104.1 12106.6 12130.6 12140.7 616.7 742.3 760.8 762.8 763.3 631.5 741.7 752.9 757.8 758.1 785.0 788.9 791.4 796.9 797.4 789.7 789.7 789.9 793.3 793.4 580.7 580.7 580.8 581.3 582.4 12091.7 12163.3 12169.5 12170.0 12205.8 10632.8 10658.7 10733.2 11138.2 11467.4 10898.5 10976.5 11035.4 11255.8 11332.3 4026.9 4055.3 4077.8 4089.6 4199.7 41664.8 43344.3 47354.0 47364.6 47406.0 9708.0 10080.5 10192.9 10358.8 10612.7 17935.4 18140.9 18157.8 18163.0 18169.0 6616.7 6665.6 6822.8 6909.2 7008.2 3465.4 3520.1 3533.9 3600.8 3636.4 2611.7 2701.1 2813.1 2938.6 2941.0 482.2 499.0 508.5 510.4 514.4 534.8 551.6 588.8 613.3 620.3 7820.4 7891.1 8037.6 8042.8 8209.4 589.0 602.9 607.6 625.8 639.0 3878.1 3958.7 3962.5 4033.0 4125.6 40032.0 61976.7 62528.0 68216.7 68312.0 52442.5 54967.7 56208.4 56934.7 61504.0 48720.3 50134.5 51345.0 51763.7 52197.0 7882.8 8129.8 8248.4 8310.5 8543.0 30475.0 34345.5 36104.6 36961.0 39034.4 30262.2 30553.8 31081.2 31974.5 46556.8 9415.8 9668.9 9681.3 9995.5 10025.6 10646.7 11449.9 11497.8 11905.9 12209.7 10245.2 10556.4 10632.1 10718.8 11073.4 11144.4 11328.4 11661.8 11786.8 11790.9 11285.9 11562.5 11665.7 12155.9 12174.2 8832.1 9106.8 9437.4 9666.7 9726.1 7689.2 8110.2 8287.9 8342.1 8550.2 05:31:15 INFO - PROCESS | 28492 | -------- Summary: end -------- 05:31:15 INFO - PROCESS | 28492 | 05:31:16 INFO - TEST-INFO | 28492: exit 0 05:31:16 INFO - TEST-OK | dromaeo_css | took 1120951ms 05:31:16 INFO - TEST-START | kraken 05:31:16 INFO - operating with platform_type : linux_ 05:31:16 INFO - Initialising browser for kraken test... 05:31:16 INFO - TEST-INFO | started process 28851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSyTg18/profile http://localhost:51290/getInfo.html) 05:31:21 INFO - PROCESS | 28851 | __metrics Screen width/height:1600/1200 05:31:21 INFO - PROCESS | 28851 | colorDepth:24 05:31:21 INFO - PROCESS | 28851 | Browser inner width/height: 1024/697 05:31:21 INFO - PROCESS | 28851 | __metrics 05:31:21 ERROR - PROCESS | 28851 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 05:31:23 INFO - TEST-INFO | 28851: exit 0 05:31:23 INFO - Browser initialized. 05:31:23 INFO - Running cycle 1/1 for kraken test... 05:31:23 INFO - TEST-INFO | started process 28973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSyTg18/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:35 INFO - PROCESS | 28973 | RSS: Main: 186757120 05:31:35 INFO - PROCESS | 28973 | 05:31:38 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51290/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:39 INFO - PROCESS | 28973 | RSS: Main: 199544832 05:31:39 INFO - PROCESS | 28973 | 05:31:42 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51290/tests/kraken/driver.html?testName=audio-dft) 05:31:42 INFO - PROCESS | 28973 | RSS: Main: 197509120 05:31:42 INFO - PROCESS | 28973 | 05:31:45 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51290/tests/kraken/driver.html?testName=audio-fft) 05:31:46 INFO - PROCESS | 28973 | RSS: Main: 194322432 05:31:46 INFO - PROCESS | 28973 | 05:31:48 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51290/tests/kraken/driver.html?testName=audio-oscillator) 05:31:49 INFO - PROCESS | 28973 | RSS: Main: 194129920 05:31:49 INFO - PROCESS | 28973 | 05:31:51 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:51 INFO - PROCESS | 28973 | RSS: Main: 194633728 05:31:51 INFO - PROCESS | 28973 | 05:31:55 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51290/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:55 INFO - PROCESS | 28973 | RSS: Main: 200003584 05:31:55 INFO - PROCESS | 28973 | 05:31:59 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51290/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:59 INFO - PROCESS | 28973 | RSS: Main: 196292608 05:31:59 INFO - PROCESS | 28973 | 05:32:02 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51290/tests/kraken/driver.html?testName=json-parse-financial) 05:32:03 INFO - PROCESS | 28973 | RSS: Main: 197312512 05:32:03 INFO - PROCESS | 28973 | 05:32:05 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:05 INFO - PROCESS | 28973 | RSS: Main: 197017600 05:32:05 INFO - PROCESS | 28973 | 05:32:07 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:08 INFO - PROCESS | 28973 | RSS: Main: 197259264 05:32:08 INFO - PROCESS | 28973 | 05:32:10 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:11 INFO - PROCESS | 28973 | RSS: Main: 197595136 05:32:11 INFO - PROCESS | 28973 | 05:32:14 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:14 INFO - PROCESS | 28973 | RSS: Main: 197885952 05:32:14 INFO - PROCESS | 28973 | 05:32:18 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:18 INFO - PROCESS | 28973 | RSS: Main: 202567680 05:32:18 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | Cycle 1(1): loaded http://localhost:51290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51290/tests/kraken/driver.html?testName=ai-astar) 05:32:20 INFO - PROCESS | 28973 | RSS: Main: 204582912 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | __start_tp_report 05:32:20 INFO - PROCESS | 28973 | _x_x_mozilla_page_load 05:32:20 INFO - PROCESS | 28973 | _x_x_mozilla_page_load_details 05:32:20 INFO - PROCESS | 28973 | |i|pagename|runs| 05:32:20 INFO - PROCESS | 28973 | |0;ai-astar;107;116;117;114;116;115;117;115;115;117 05:32:20 INFO - PROCESS | 28973 | |1;audio-beat-detection;161;137;131;165;136;135;131;133;152;135 05:32:20 INFO - PROCESS | 28973 | |2;audio-dft;169;169;165;163;165;163;166;165;163;164 05:32:20 INFO - PROCESS | 28973 | |3;audio-fft;77;76;79;107;79;80;76;76;97;79 05:32:20 INFO - PROCESS | 28973 | |4;audio-oscillator;85;83;105;84;84;84;94;84;84;98 05:32:20 INFO - PROCESS | 28973 | |5;imaging-gaussian-blur;119;119;119;119;120;120;118;118;118;117 05:32:20 INFO - PROCESS | 28973 | |6;imaging-darkroom;148;148;147;149;148;150;147;148;149;149 05:32:20 INFO - PROCESS | 28973 | |7;imaging-desaturate;97;96;95;96;97;96;97;97;96;96 05:32:20 INFO - PROCESS | 28973 | |8;json-parse-financial;65;65;66;65;66;67;67;65;65;68 05:32:20 INFO - PROCESS | 28973 | |9;json-stringify-tinderbox;66;67;67;66;67;67;67;66;66;67 05:32:20 INFO - PROCESS | 28973 | |10;stanford-crypto-aes;94;95;88;88;92;89;87;87;85;88 05:32:20 INFO - PROCESS | 28973 | |11;stanford-crypto-ccm;151;149;145;153;158;147;150;147;204;151 05:32:20 INFO - PROCESS | 28973 | |12;stanford-crypto-pbkdf2;184;181;180;180;184;186;186;180;183;185 05:32:20 INFO - PROCESS | 28973 | |13;stanford-crypto-sha256-iterative;74;75;71;71;70;70;71;71;73;70 05:32:20 INFO - PROCESS | 28973 | __end_tp_report 05:32:20 INFO - PROCESS | 28973 | __start_cc_report 05:32:20 INFO - PROCESS | 28973 | _x_x_mozilla_cycle_collect,896 05:32:20 INFO - PROCESS | 28973 | __end_cc_report 05:32:20 INFO - PROCESS | 28973 | __startTimestamp1479907940691__endTimestamp 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | ------- Summary: start ------- 05:32:20 INFO - PROCESS | 28973 | Number of tests: 14 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 05:32:20 INFO - PROCESS | 28973 | Values: 107.0 116.0 117.0 114.0 116.0 115.0 117.0 115.0 115.0 117.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:136.50 stddev:12.78 (9.4%) stddev-sans-first:11.47 05:32:20 INFO - PROCESS | 28973 | Values: 161.0 137.0 131.0 165.0 136.0 135.0 131.0 133.0 152.0 135.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.25 (1.4%) stddev-sans-first:1.92 05:32:20 INFO - PROCESS | 28973 | Values: 169.0 169.0 165.0 163.0 165.0 163.0 166.0 165.0 163.0 164.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#3] audio-fft Cycles:10 Average:82.60 Median:79.00 stddev:10.60 (13.4%) stddev-sans-first:11.04 05:32:20 INFO - PROCESS | 28973 | Values: 77.0 76.0 79.0 107.0 79.0 80.0 76.0 76.0 97.0 79.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:84.00 stddev:7.72 (9.2%) stddev-sans-first:8.08 05:32:20 INFO - PROCESS | 28973 | Values: 85.0 83.0 105.0 84.0 84.0 84.0 94.0 84.0 84.0 98.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 05:32:20 INFO - PROCESS | 28973 | Values: 119.0 119.0 119.0 119.0 120.0 120.0 118.0 118.0 118.0 117.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:32:20 INFO - PROCESS | 28973 | Values: 148.0 148.0 147.0 149.0 148.0 150.0 147.0 148.0 149.0 149.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:32:20 INFO - PROCESS | 28973 | Values: 97.0 96.0 95.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 05:32:20 INFO - PROCESS | 28973 | Values: 65.0 65.0 66.0 65.0 66.0 67.0 67.0 65.0 65.0 68.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:32:20 INFO - PROCESS | 28973 | Values: 66.0 67.0 67.0 66.0 67.0 67.0 67.0 66.0 66.0 67.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.50 stddev:3.27 (3.7%) stddev-sans-first:2.99 05:32:20 INFO - PROCESS | 28973 | Values: 94.0 95.0 88.0 88.0 92.0 89.0 87.0 87.0 85.0 88.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:151.00 stddev:17.42 (11.5%) stddev-sans-first:18.41 05:32:20 INFO - PROCESS | 28973 | Values: 151.0 149.0 145.0 153.0 158.0 147.0 150.0 147.0 204.0 151.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:184.00 stddev:2.47 (1.3%) stddev-sans-first:2.59 05:32:20 INFO - PROCESS | 28973 | Values: 184.0 181.0 180.0 180.0 184.0 186.0 186.0 180.0 183.0 185.0 05:32:20 INFO - PROCESS | 28973 | 05:32:20 INFO - PROCESS | 28973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:1.66 05:32:20 INFO - PROCESS | 28973 | Values: 74.0 75.0 71.0 71.0 70.0 70.0 71.0 71.0 73.0 70.0 05:32:20 INFO - PROCESS | 28973 | -------- Summary: end -------- 05:32:20 INFO - PROCESS | 28973 | 05:32:21 INFO - TEST-INFO | 28973: exit 0 05:32:22 INFO - TEST-OK | kraken | took 65496ms 05:32:22 INFO - SUITE-END | took 1186s 05:32:22 INFO - Completed test suite (00:19:46) 05:32:22 INFO - javascript benchmark 05:32:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6227.472724760319, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.5687611544095, 2618.5941179117244, 2636.3277364272108, 2640.313518485194, 2659.2819938616576, 4530.682852200347, 4701.388819453475, 4718.811247550098, 4743.8814029649275, 4753.500882407349, 4581.770911454422, 4677.76611169441, 4710.057988402325, 4712.0575884823, 4791.161546729317, 4269.274223382017, 4346.500152482474, 4356.0, 4445.0443154721725, 4460.754658493782, 4002.3996400540004, 4409.426774519324, 4414.050979039506, 4443.46678398591, 4447.132809102226, 4148.004478925066, 4325.718828276184, 4339.696221264513, 4378.0, 4425.822967081329, 4187.183499217654, 4276.422682937795, 4326.805293761789, 4368.803403846835, 4430.224710675619, 4314.525402205755, 4343.5656434356315, 4346.76092814895, 4355.150745604608, 4385.254506733863, 4693.272542755878, 4694.953050469486, 4709.71741695496, 4718.787654555519, 4724.952750472486, 4817.397825271841, 4863.756812159378, 4864.513548645143, 4929.309896614441, 4938.654294199408, 4948.035133149037, 4958.87602809929, 4961.082199793013, 4962.057209130254, 5016.247562865563, 4694.2254528002495, 4709.270063140219, 4719.716816990923, 4753.382060332135, 4754.168020596382, 5136.357955255593, 5136.614753893473, 5142.485751424828, 5155.381354237516, 5182.844514664566, 4699.694519856198, 4741.454732705714, 4791.257355109963, 4897.41231052276, 4957.281194226817, 4826.469088400273, 4892.926606100911, 4937.1606826839525, 4999.575036121898, 5015.297858299841, 4813.711177329372, 4870.318155458239, 4888.291197776302, 4914.140025495524, 4947.505249475095, 4894.975525122423, 4895.0, 4919.385076865392, 4939.997323300659, 4957.107720610325, 4017.015831121394, 4050.6556942659613, 4137.338025915839, 4163.0, 4215.494140703074, 3612.440071788877, 3624.7462677612316, 3657.4330978698345, 3696.611855755161, 3699.7595156314756, 4366.0, 4367.301231802896, 4378.8029538670835, 4405.955940440619, 4418.8453404130705, 5067.391912970394, 5070.6957582545165, 5070.923936140961, 5081.18701007837, 5082.872928176751, 4203.285441474956, 4235.745855248695, 4237.597428244312, 4279.358096285582, 4373.234683930299, 4413.823447062082, 4419.911601768011, 4432.024954510002, 4437.911241775147, 4466.4640243171025, 4735.597474214593, 4749.738764367855, 4756.6908150970075, 4789.4971028042255, 4798.7840547175465, 5050.217216331474, 5052.873678158076, 5053.494650534917, 5080.517350851663, 5086.720230387216, 4493.056458143827, 4505.32420136969, 4550.908981820279, 4752.2158843790385, 4758.034138894914, 4882.194437917704, 4907.362042934538, 4950.282209079735, 4956.925646115384, 5005.1241032819835, 5020.899582008266, 5032.245163225399, 5034.546890779701, 5037.0, 5086.21163719624, 4687.554682305175, 4877.292792545132, 4883.0, 4893.045856058035, 4930.926036109389, 4718.268668356411, 4762.52374762521, 4806.639502037291, 4810.11012962603, 4811.941372897957, 4706.435227772552, 4810.95189048105, 4818.084563932842, 4869.537393947569, 4931.13705101613, 4970.726610036482, 4983.476734942778, 4989.052080104769, 4989.625778066732, 4997.900041999067, 4805.3512775774825, 4823.927641085316, 4835.661503694708, 4857.368542089505, 4893.0], "value": 4587.023897288432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8694469854885, 549.072068204734, 549.4231057389742, 554.3015800091883, 562.0894151474612, 37301.25397492052, 38525.22949541011, 38615.61384386155, 43131.3530297045, 43148.35277470833, 38252.61747382525, 38401.807990960006, 38508.0, 38862.0, 38917.41623875644, 7481.326680598759, 7670.923290767105, 7698.730544430946, 9540.093691099335, 9908.157806586449, 9634.181094606933, 9708.75728106796, 9720.659776907809, 9729.464879431629, 9735.269854760885, 9671.854922176173, 9740.951295243514, 9765.876924153707, 9812.754681132958, 9833.0, 9730.56212470437, 9764.658236961708, 9779.755506112333, 9790.21678265737, 9791.216702663769, 9837.90162098377, 9883.901160988442, 9904.851427228597, 9909.454979976099, 9910.10809027191, 37073.443898341546, 37222.0, 37274.52705675309, 37287.254254915024, 37625.435618465744, 2834.319763256824, 2917.6061231733656, 3051.5727798108283, 3080.3531258435755, 3258.9837050814594, 28031.0, 28267.0, 28311.0, 28755.85622071897, 29817.701822981708, 3401.523786669868, 3433.6909678129086, 3438.7249020078334, 3439.8624055038017, 3447.844846981867, 241786.0, 241998.0, 243432.0, 245442.0, 246709.0, 51297.487025129274, 51717.0, 51956.22065669018, 52212.21681674778, 52230.21654675183, 54219.0, 54325.72837135789, 54401.0, 54504.0, 54527.72736136294, 13488.39302231402, 13866.029377943447, 14051.297435128203, 14067.577972660836, 14080.577582672537, 9771.560279787427, 9979.251556133318, 10649.574017039387, 10775.6228532001, 10946.890531094747, 17086.40197593078, 17154.485365439057, 17217.139143042798, 17281.740773888403, 17358.479245622653, 6783.525153239325, 6824.0, 6920.653967301615, 6957.373836354753, 7037.4018208451835, 765.7894079128284, 773.1456740301998, 869.3219288954499, 912.2929729459589, 968.2399316536626, 25342.493150136896, 26955.191344259703, 26958.460830783275, 27096.72903270942, 27362.0, 895.713371721043, 915.9862602060974, 919.6781126605634, 954.355809828363, 996.2229461020415, 14540.437592789835, 14566.4901728439, 14617.634559136106, 14728.852711472962, 14802.851971480362, 326150.0, 326239.0, 326507.0, 327618.0, 329725.0, 47520.7623961878, 47977.76011119992, 48217.517824822, 48237.517624824, 48305.75847120742, 1162.0587324267372, 1186.489809381974, 1190.214458457414, 1198.0774803401332, 1201.585453018707, 25166.748332517174, 26098.0, 26897.865510673106, 27253.0, 27417.45165096727, 40410.595894040685, 40721.1855762889, 40806.0, 40856.38715419212, 40898.59101408948, 287555.8066403081, 288655.0, 289167.0, 289417.0, 289918.0, 21766.89116554407, 22312.77687223172, 22853.771462285164, 24251.757482425655, 24318.27045188647, 39873.20253594854, 39931.80034099811, 39951.600483994785, 40138.598614013485, 40837.0, 34075.65924340725, 34268.31463370768, 34410.0, 34705.65294347125, 34876.47685284672, 33565.83217083997, 33900.66099339074, 34098.829505852314, 34517.0, 34782.47826282557, 33762.15594610154, 34392.0, 34665.48001779925, 34679.0, 34851.12872178216, 30531.0, 31463.842680787366, 31969.360612788078, 32122.357552848345, 32209.51685724763, 23544.29367118989, 24214.75785242125, 24394.634080488453, 24901.377465563506, 24920.501589968462], "value": 17410.366670068375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8273771745268, 358.2244440785699, 367.7756568493219, 369.98890033298994, 387.03627966363746, 15157.696846063085, 16401.83598164018, 16600.833991660078, 16661.83338166618, 16719.414820481285, 15278.312475938581, 16387.42644007457, 16448.75326870098, 16532.66934661306, 16547.751783723255, 4932.580730637891, 5173.637845350827, 5206.114960456732, 5209.1404918188455, 5215.973920130394, 3720.4047352423618, 3886.689064874817, 5022.59819214462, 5124.231365295198, 5402.486763757456, 3911.823967921436, 3947.5262968443685, 6198.194234749476, 6202.131701561785, 6226.782062627809, 5889.440503152194, 6104.481119104881, 6128.877422451548, 6176.752929882799, 6199.907001394983, 5412.56699464042, 5420.403755586883, 5424.511793938565, 5429.864253393696, 5434.0, 16504.917475412545, 18658.90670546652, 20545.075471603814, 21094.894525527427, 21335.146594136215, 1829.4511646506128, 1857.6563335782923, 1859.3956963986623, 1870.9158087885942, 1941.3302410668439, 12870.549530766471, 12916.547920822726, 13082.542111026163, 13201.73596528064, 13586.38861251246, 1688.4343744845369, 1700.104027344333, 1711.1102226842097, 1736.722124460093, 1741.112032863249, 65963.67018164927, 66209.33790662128, 67750.66124669394, 69829.25426864318, 71356.64321678359, 9220.170184683411, 9263.583138758771, 9329.11373419524, 9443.811123777487, 9658.71023869285, 13344.666383340495, 13400.597982060553, 13423.328833558284, 13443.193408395528, 13474.258915759532, 7320.267973202637, 7361.227071157558, 7515.6242187891485, 7573.0, 7581.886271705929, 6933.861322773516, 6943.6875340609795, 6976.0, 7095.503314767917, 7243.311885370881, 6105.419985101408, 6189.164462797555, 6191.0, 6193.907091393633, 6227.346128656426, 1700.7108791505473, 1803.2877013579562, 1817.8909265443851, 1826.6711991841596, 1827.2690923630655, 882.2104216726123, 892.9732108036769, 900.2348004196381, 914.6844338703137, 920.3695468604028, 16917.49247522576, 17042.219350494608, 17534.210960506807, 18058.09709514519, 18460.538486537946, 843.9367047471342, 846.7417437681567, 857.6012154348258, 875.4090988582681, 912.5710915869531, 9101.908980910106, 9796.755081122887, 10127.594896204217, 10189.694309170736, 10299.0, 370951.0, 371593.0, 372609.0, 381214.0, 385941.0, 79564.0, 79859.0, 81600.0, 82742.0, 84557.57721211477, 871.7210492642421, 894.9239314658327, 933.5658918602746, 933.8879334479906, 933.9346245762868, 15430.5370838875, 15567.455139070078, 15718.607034824221, 16051.518454446385, 16191.514254572381, 35611.82194089117, 37183.0, 37975.430368543944, 38463.423048653734, 39011.41482877702, 52336.0, 52564.0, 53013.204801928776, 53209.46790532045, 53418.73290633522, 7323.890141647986, 7339.339459448462, 7384.52000619958, 7419.0, 7763.184865589258, 10835.837462437912, 11092.0, 11145.609903653332, 11336.0, 11485.19603627738, 9951.950240248752, 10257.897421025993, 10304.587816487257, 10598.25812193139, 10886.61896833607, 10169.338992965433, 10211.0, 10403.94798026005, 10474.633387831695, 10563.207759418228, 10248.077673009466, 10597.364158150536, 10616.0, 10674.146068314361, 10722.303050301705, 7272.8909066362985, 7344.522606030805, 7382.593957332183, 7532.359749421361, 7544.509606875536, 9395.624175032923, 9455.24358051368, 10187.541560629641, 10221.284510084222, 10335.0], "value": 8334.329049401296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.2393747532644, 1389.798479220513, 1443.667956370035, 1620.0676775037177, 1665.2589597629053, 6146.262448506174, 6254.718537665804, 6938.618375989318, 7392.630368481575, 7425.36884364829, 6928.510370270404, 7179.246179151192, 7183.640817959107, 7361.5583065016135, 7380.335769780719, 2075.616011037955, 2096.2348742708955, 2117.068489864462, 2118.7881211878844, 2122.246602456129, 2069.0, 2110.261408507018, 2126.5853158634072, 2147.2591955775233, 2148.8388370872167, 2096.6540520814046, 2099.580083983202, 2113.953592971481, 2116.91532338707, 2135.8184554312825, 2087.530305681217, 2113.059688438653, 2114.9577008459746, 2115.5663089066707, 2117.68234764785, 2005.1678553400322, 2094.068139677844, 2098.7586427560873, 2100.7689154193026, 2106.9262575809926, 7292.45306602007, 7323.304286092813, 7375.852482950365, 7386.0, 7403.37071348936, 4277.230098582254, 4412.536683648235, 4415.690901636886, 4428.380026796219, 4435.246008178618, 2718.0894400375896, 2790.511660459432, 2833.164216556121, 2882.164172390025, 2904.6804851466322, 845.750503601439, 880.5421180985916, 892.0455113029061, 901.7430032440723, 907.2424525521131, 9908.157806586449, 9938.602455901828, 9959.103680668775, 9966.850497242547, 9968.601255949754, 3780.4707340972286, 4039.6768258539246, 4043.353063509824, 4134.710570260113, 4140.3375459926265, 8249.29880960113, 8249.628766705513, 8265.256126948603, 8265.297449716722, 8267.917320826835, 4397.1205758848355, 4398.142362239332, 4401.735895846259, 4455.799489023002, 4464.464264288306, 3445.8277086145595, 3522.4011917974008, 3908.5309762828074, 4013.5986401360215, 4022.6379625833815, 3323.0, 3328.417526932777, 3439.8108104054018, 3450.0, 3460.723142148622, 1114.7491814341709, 1138.5047504335475, 1151.125144889873, 1151.861776586815, 1156.109795457493, 813.259933460548, 816.8856360109589, 817.3134566963779, 826.8304997475503, 841.5876220651836, 4908.288298196741, 4965.652404331734, 4975.90048199034, 5025.899482010339, 5092.6180536459915, 366.87892995311483, 371.86798686466454, 382.36909099985246, 385.76853887667176, 390.16310015017626, 3355.2282974915906, 3358.7984720916825, 3359.412102881986, 3393.7963722176746, 3477.669621385964, 8367.581620918929, 8906.688265910661, 8911.0, 8919.910800892038, 8926.973398059177, 8860.86708699357, 8863.936327640724, 8866.33502487316, 8866.911330886609, 8906.910930890737, 6869.862602747917, 6890.621015844176, 6995.300469952964, 7020.333068358498, 7056.929430705627, 4877.926831097466, 4903.950960490492, 5027.271045698426, 5028.296038554532, 5212.348456442945, 8114.472559283628, 8135.837283254184, 8211.95894020526, 8233.46482478637, 8322.126176751353, 8338.166183381856, 8339.45793523419, 8351.665933362598, 8411.789705257417, 8478.703245386629, 6110.663913484801, 6291.653959032297, 6297.0, 6360.586561873463, 6379.649119298483, 7019.3682568569075, 7075.292470752884, 7108.964455177691, 7112.182099058675, 7122.109736282965, 6336.239651241881, 6435.967820160869, 6449.161608990801, 6469.223693156851, 6590.373914478117, 6346.079818426395, 6364.077208804605, 6371.585846919936, 6494.0, 6551.574147680385, 5939.346671866005, 6016.338202797601, 6049.364816694184, 6049.66726830011, 6052.334243233329, 4385.627221686193, 4412.933805992977, 4511.1654343946475, 4515.9774201128785, 4536.140182525149, 4398.648108151404, 4411.933820992624, 4532.388127602731, 4555.293929440942, 4657.67396282257], "value": 3849.2574915025584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.6422728498517, 295.6599910103381, 298.66400299662877, 302.9394121175765, 303.4916514837647, 4970.875728106795, 5023.070731914599, 5026.567428282931, 5042.949570504298, 5072.264521644369, 4906.681065730725, 4913.3612630358, 4936.407631084266, 4937.80248790048, 4946.851594452172, 3667.2482141161063, 3759.4360845873202, 3784.545854497464, 3883.0486530799994, 3891.6886649068006, 3870.9032274193087, 3879.398693202544, 3886.9399218414146, 3895.4156876468473, 3905.863294784683, 3861.6717579005817, 3862.2082473093087, 3877.1696661437168, 3883.8834834954855, 3884.9028774280587, 3587.0, 3766.190269092131, 3845.5193100862393, 3861.768293902375, 3887.5918028607157, 3283.670113603994, 3298.752593555493, 3301.966980330214, 3312.5031245313153, 3314.751393645462, 4758.357621721093, 4826.975865120687, 4855.5387238212315, 4865.82969596066, 4866.902661946741, 4320.481542214923, 4323.351497275403, 4329.631981281595, 4332.610065094157, 4344.174606824725, 5012.77442515084, 5069.366329208849, 5093.18509038552, 5093.974530127362, 5128.153854613985, 3454.809985450799, 3469.5663042119736, 3477.95661301611, 3478.3217272631846, 3484.52958850557, 5312.814051508179, 5320.201969704536, 5336.4930331618825, 5339.172428273624, 5366.973165134149, 3562.6259242779133, 3594.8202589870402, 3624.8006359649944, 3645.781253124821, 3651.507046548682, 3639.7816131032223, 3653.2510835278704, 3660.158163622382, 3682.116292089933, 3686.635944700478, 4216.427978932848, 4238.788060596958, 4242.830286788494, 4247.214265360918, 4273.380359847867, 4944.909431605247, 5076.147206269685, 5099.521138869761, 5127.256547800548, 5156.561692256125, 1227.2268470863298, 1244.3280628460711, 1247.9937600311941, 1251.7997120460682, 1254.3289340202948, 839.1482645115213, 854.4318028511095, 864.2524216552637, 873.746613482083, 879.6261588824724, 4246.384274280212, 4373.0, 4413.602775750198, 4500.189965806187, 4501.7974191161475, 5291.232771248147, 5309.973450132725, 5310.522053015247, 5338.626296159309, 5339.0, 4537.137943790735, 4541.364209010741, 4541.772911354419, 4548.295014272793, 4571.291449825282, 2597.935051623687, 2711.3086163028697, 2725.38678797273, 2726.6142125640067, 2729.7543221110195, 4734.455537613149, 4752.881177970578, 4778.737169455713, 4784.593309568726, 4789.568938795455, 4995.550400463976, 5252.343457067866, 5259.21111833228, 5274.630775845654, 5298.947010529922, 4679.906401872012, 4718.834840780625, 4761.857144285677, 4776.928346074812, 4787.257975013808, 5020.849374518771, 5118.617973147155, 5145.3568303962, 5148.639595228448, 5178.249153872743, 4763.69036012658, 4981.452040275494, 4984.077945580079, 4988.251762235694, 5014.398272207359, 4752.833650822205, 4762.475887779482, 4786.832460863853, 4786.994731106507, 4788.353572267699, 3533.3816582098543, 3534.550834157983, 3537.557805274341, 3542.557180352456, 3560.7151427885187, 5134.149387959031, 5141.38303403594, 5143.588512918883, 5176.249443830548, 5253.159494480865, 4876.731779752147, 5125.846224613268, 5131.10205714006, 5152.510511501551, 5184.403793563789, 5115.907274180715, 5166.354205724285, 5168.2169651470185, 5182.1190397631735, 5208.635395522277, 4870.95129048705, 5057.519535644108, 5089.618278629044, 5095.592352611856, 5102.719350435762, 5047.747612619428, 5130.743462826918, 5167.689938603696, 5172.612054096033, 5195.81814636501, 5102.413222479314, 5105.693658380509, 5118.594260697466, 5123.513266239701, 5163.4578369270685], "value": 3813.4769295481456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.0313476494255, 715.1239731329123, 720.837811492414, 737.7122922060397, 740.551966060533, 11776.470058847352, 12287.569935052275, 12366.258024518513, 12797.744045119103, 12834.358282085894, 11796.823047654292, 12104.12386080159, 12106.636800895965, 12130.636080917564, 12140.69648258794, 616.7193926763312, 742.2948199210758, 760.8288135169598, 762.8321769210793, 763.2825144364308, 631.5200447659789, 741.7292688168834, 752.8795392737163, 757.795395243284, 758.0600055930662, 784.9921500785005, 788.9013873265842, 791.3748138970207, 796.9322607578363, 797.3939805747644, 789.6920201121567, 789.7196495244192, 789.873620220762, 793.2662287384176, 793.3811626931004, 580.6719203649966, 580.7125472890904, 580.7967211475992, 581.3198557687516, 582.3826743651742, 12091.697707557381, 12163.331016794073, 12169.452374643162, 12170.0, 12205.755884882341, 10632.840507392395, 10658.680239592824, 10733.248672592921, 11138.164637652128, 11467.36929468879, 10898.509567069501, 10976.506057227443, 11035.39305338206, 11255.81813909536, 11332.320060796379, 4026.8993275168064, 4055.3105971984537, 4077.7757223352705, 4089.5705950875326, 4199.748015119103, 41664.79167604142, 43344.34983475282, 47354.0, 47364.579062628174, 47406.0, 9708.0, 10080.546375412978, 10192.898071019343, 10358.792824143475, 10612.681619551426, 17935.37226197077, 18140.90929545344, 18157.818421815613, 18163.0, 18169.0, 6616.735330586819, 6665.566738162004, 6822.761203357859, 6909.239983601799, 7008.159020917523, 3465.4108801503803, 3520.0847779577493, 3533.9293214135573, 3600.765950213228, 3636.4363523653874, 2611.7257687942874, 2701.081632245007, 2813.08574713219, 2938.6326709161353, 2940.955885661717, 482.2043628013735, 498.9675671081368, 508.45595213122346, 510.364596077878, 514.362190883302, 534.8128155145668, 551.5973339462215, 588.7792077970761, 613.310026220502, 620.3300435529708, 7820.385972276385, 7891.053073631087, 8037.598120093972, 8042.798930026796, 8209.38429617781, 588.9617174883618, 602.9336772954971, 607.5807692692028, 625.8028720952885, 639.0, 3878.069263376826, 3958.7426817256787, 3962.4848769660334, 4032.9798351008058, 4125.628693417607, 40032.0, 61976.69011654913, 62528.0, 68216.65891670609, 68312.0, 52442.47557524452, 54967.725161373935, 56208.43791562032, 56934.7153264231, 61504.0, 48720.269195962086, 50134.49865501371, 51345.0, 51763.74118129385, 52197.0, 7882.842343153219, 8129.837403251783, 8248.422610417454, 8310.501369917823, 8542.957285213533, 30475.0, 34345.48481772726, 36104.63895361013, 36961.0, 39034.41448378334, 30262.243443914078, 30553.847230763702, 31081.222969425944, 31974.52038219382, 46556.7672161637, 9415.826708191871, 9668.85496717564, 9681.322307438411, 9995.500224988577, 10025.598976040877, 10646.73383165427, 11449.885501145216, 11497.827532587185, 11905.880941190824, 12209.738199619658, 10245.180385569285, 10556.419396933243, 10632.096271816983, 10718.785624287626, 11073.446327683745, 11144.387058711849, 11328.433578321215, 11661.825072623747, 11786.823197652213, 11790.94104529472, 11285.943570282096, 11562.479688413874, 11665.650030499099, 12155.939220303842, 12174.208676436003, 8832.072632373765, 9106.838816001884, 9437.373878643883, 9666.709998700051, 9726.076022777825, 7689.154193038873, 8110.188981101843, 8287.875681864898, 8342.124076972073, 8550.187732165434], "value": 5969.124018342862, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 117.0, 114.0, 116.0, 115.0, 117.0, 115.0, 115.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 137.0, 131.0, 165.0, 136.0, 135.0, 131.0, 133.0, 152.0, 135.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 165.0, 163.0, 165.0, 163.0, 166.0, 165.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 107.0, 79.0, 80.0, 76.0, 76.0, 97.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 105.0, 84.0, 84.0, 84.0, 94.0, 84.0, 84.0, 98.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 119.0, 120.0, 120.0, 118.0, 118.0, 118.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 150.0, 147.0, 148.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 67.0, 65.0, 65.0, 68.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 88.0, 88.0, 92.0, 89.0, 87.0, 87.0, 85.0, 88.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 145.0, 153.0, 158.0, 147.0, 150.0, 147.0, 204.0, 151.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 180.0, 180.0, 184.0, 186.0, 186.0, 180.0, 183.0, 185.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 71.0, 71.0, 70.0, 70.0, 71.0, 71.0, 73.0, 70.0], "value": 71.6, "unit": "score"}]}]} 05:32:22 INFO - Return code: 0 05:32:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:22 ERROR - # TBPL SUCCESS # 05:32:22 INFO - Running post-action listener: _resource_record_post_action 05:32:22 INFO - [mozharness: 2016-11-23 13:32:22.515920Z] Finished run-tests step (success) 05:32:22 INFO - Running post-run listener: _resource_record_post_run 05:32:22 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 396914688; Read time: 316; Write time: 399488 05:32:22 INFO - TinderboxPrint: CPU usage
13.5% 05:32:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 316 05:32:22 INFO - TinderboxPrint: I/O write bytes / time
396,914,688 / 399,488 05:32:22 INFO - TinderboxPrint: CPU idle
8,298.4 (86.5%) 05:32:22 INFO - TinderboxPrint: CPU user
1,230.7 (12.8%) 05:32:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:32:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106692608; Read time: 0; Write time: 124060 05:32:22 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290217984; Read time: 296; Write time: 275428 05:32:23 INFO - Running post-run listener: _upload_blobber_files 05:32:23 INFO - Blob upload gear active. 05:32:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:23 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 05:32:23 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:32:23 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:32:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:24 INFO - (blobuploader) - INFO - Done attempting. 05:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:25 INFO - (blobuploader) - INFO - Done attempting. 05:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:28 INFO - (blobuploader) - INFO - Done attempting. 05:32:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:28 INFO - Return code: 0 05:32:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/9146c71c4509e04f0fc27fb1361405b70babc469e56f467f64f2a89debbc4a64de0c69786f058ba54e5f2412868898ebfdbe4c661427ce6cdfe308b96af8e368", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c2aef498d04ff094775110ac6a258d54d57fc175f852f003e4176b6553a7e57a452e06a1aebab7cca0a6bd9b90638be651defea56f78930a5fbe248ccb5c9c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/12e5fc471e8eebfec5e3775de7ecdafef5de595e770a7b0b2f41834daf921dbd93f683adc452d5d1e80fa9d8bc8ce82e3ee6fa032e270d8e5415a9595e291887"} 05:32:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:28 INFO - Contents: 05:32:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/9146c71c4509e04f0fc27fb1361405b70babc469e56f467f64f2a89debbc4a64de0c69786f058ba54e5f2412868898ebfdbe4c661427ce6cdfe308b96af8e368", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c2aef498d04ff094775110ac6a258d54d57fc175f852f003e4176b6553a7e57a452e06a1aebab7cca0a6bd9b90638be651defea56f78930a5fbe248ccb5c9c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/12e5fc471e8eebfec5e3775de7ecdafef5de595e770a7b0b2f41834daf921dbd93f683adc452d5d1e80fa9d8bc8ce82e3ee6fa032e270d8e5415a9595e291887"} 05:32:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:28 INFO - Copying logs to upload dir... 05:32:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.710819 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-23 05:32:27.989676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:27.992663) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 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/Cedar/sha512/9146c71c4509e04f0fc27fb1361405b70babc469e56f467f64f2a89debbc4a64de0c69786f058ba54e5f2412868898ebfdbe4c661427ce6cdfe308b96af8e368", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c2aef498d04ff094775110ac6a258d54d57fc175f852f003e4176b6553a7e57a452e06a1aebab7cca0a6bd9b90638be651defea56f78930a5fbe248ccb5c9c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/12e5fc471e8eebfec5e3775de7ecdafef5de595e770a7b0b2f41834daf921dbd93f683adc452d5d1e80fa9d8bc8ce82e3ee6fa032e270d8e5415a9595e291887"} build_url:https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011732 build_url: 'https://queue.taskcluster.net/v1/task/LV8fJLIkQoqa6CPrubxFBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/9146c71c4509e04f0fc27fb1361405b70babc469e56f467f64f2a89debbc4a64de0c69786f058ba54e5f2412868898ebfdbe4c661427ce6cdfe308b96af8e368", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c2aef498d04ff094775110ac6a258d54d57fc175f852f003e4176b6553a7e57a452e06a1aebab7cca0a6bd9b90638be651defea56f78930a5fbe248ccb5c9c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/12e5fc471e8eebfec5e3775de7ecdafef5de595e770a7b0b2f41834daf921dbd93f683adc452d5d1e80fa9d8bc8ce82e3ee6fa032e270d8e5415a9595e291887"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:28.017870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:28.018203) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1479906700.560007-1952408811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 05:32:28.101160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 05:32:28.101482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 05:32:28.101767) ========= ========= Total master_lag: 0.16 =========