builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1502792879.26 results: success (0) revision: 564e82f0f289af976da01c2d50507017bbc152b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.259377) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.261264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.261581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.302146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.302457) ========= 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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 03:27:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-08-15 03:27:59 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118013 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.448925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.449263) ========= 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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014367 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:27:59.517613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-15 03:27:59.517979) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 564e82f0f289af976da01c2d50507017bbc152b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 564e82f0f289af976da01c2d50507017bbc152b5 --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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 03:27:59,854 truncating revision to first 12 chars 2017-08-15 03:27:59,854 Setting DEBUG logging. 2017-08-15 03:27:59,854 attempt 1/10 2017-08-15 03:27:59,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/564e82f0f289?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 03:28:00,444 attempt 1/10 2017-08-15 03:28:01,292 current task status: no status available at this point. state: STARTED 2017-08-15 03:28:01,292 sleeping for 10.00s (attempt 1/10) 2017-08-15 03:28:11,303 attempt 2/10 2017-08-15 03:28:11,641 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-15 03:28:11,995 unpacking tar archive at: mozilla-central-564e82f0f289/testing/mozharness/ program finished with exit code 0 elapsedTime=12.531919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-15 03:28:12.064639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:28:12.064957) ========= script_repo_revision: 564e82f0f289af976da01c2d50507017bbc152b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:28:12.065364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:28:12.065667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:28:12.078029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-15 03:28:12.078349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:12 INFO - MultiFileLogger online at 20170815 03:28:12 in /builds/slave/test 03:28:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:28:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:12 INFO - {'append_to_log': False, 03:28:12 INFO - 'base_work_dir': '/builds/slave/test', 03:28:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:28:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:12 INFO - 'branch': 'Firefox-Non-PGO', 03:28:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:12 INFO - 'code_coverage': False, 03:28:12 INFO - 'config_files': ('talos/linux_config.py',), 03:28:12 INFO - 'default_actions': ('clobber', 03:28:12 INFO - 'read-buildbot-config', 03:28:12 INFO - 'download-and-extract', 03:28:12 INFO - 'populate-webroot', 03:28:12 INFO - 'create-virtualenv', 03:28:12 INFO - 'install', 03:28:12 INFO - 'setup-mitmproxy', 03:28:12 INFO - 'run-tests'), 03:28:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:12 INFO - 'disable_ccov_upload': False, 03:28:12 INFO - 'download_minidump_stackwalk': True, 03:28:12 INFO - 'download_symbols': 'ondemand', 03:28:12 INFO - 'enable_stylo': False, 03:28:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:12 INFO - 'gecko_profile': False, 03:28:12 INFO - 'gecko_profile_interval': 0, 03:28:12 INFO - 'installer_path': 'installer.exe', 03:28:12 INFO - 'log_level': 'info', 03:28:12 INFO - 'log_name': 'talos', 03:28:12 INFO - 'log_to_console': True, 03:28:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:12 INFO - 'opt_config_files': (), 03:28:12 INFO - 'pip_index': False, 03:28:12 INFO - 'suite': 'dromaeojs-e10s', 03:28:12 INFO - 'system_bits': '32', 03:28:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:12 INFO - 'title': 'talos-linux64-ix-045', 03:28:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:12 INFO - 'use_talos_json': True, 03:28:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:12 INFO - 'work_dir': 'build'} 03:28:12 INFO - [mozharness: 2017-08-15 10:28:12.518692Z] Running clobber step. 03:28:12 INFO - Running pre-action listener: _resource_record_pre_action 03:28:12 INFO - Running main action method: clobber 03:28:12 INFO - rmtree: /builds/slave/test/build 03:28:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:13 INFO - Running post-action listener: _resource_record_post_action 03:28:13 INFO - [mozharness: 2017-08-15 10:28:13.548986Z] Finished clobber step (success) 03:28:13 INFO - [mozharness: 2017-08-15 10:28:13.549089Z] Running read-buildbot-config step. 03:28:13 INFO - Running pre-action listener: _resource_record_pre_action 03:28:13 INFO - Running main action method: read_buildbot_config 03:28:13 INFO - Using buildbot properties: 03:28:13 INFO - { 03:28:13 INFO - "project": "", 03:28:13 INFO - "product": "firefox", 03:28:13 INFO - "who": "cbook@mozilla.com", 03:28:13 INFO - "installer_path": "public/build/target.tar.bz2", 03:28:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:28:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:28:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:28:13 INFO - "stage_platform": "linux64", 03:28:13 INFO - "basedir": "/builds/slave/test", 03:28:13 INFO - "buildnumber": 1078, 03:28:13 INFO - "platform": "ubuntu64_hw", 03:28:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:28:13 INFO - "slavebuilddir": "test", 03:28:13 INFO - "taskId": "HWnkCW4kSUKL4BenSwBX0g", 03:28:13 INFO - "branch": "mozilla-central", 03:28:13 INFO - "script_repo_revision": "production", 03:28:13 INFO - "revision": "564e82f0f289af976da01c2d50507017bbc152b5", 03:28:13 INFO - "slavename": "talos-linux64-ix-045", 03:28:13 INFO - "repo_path": "mozilla-central" 03:28:13 INFO - } 03:28:13 INFO - Finding installer, test and symbols from parent task. 03:28:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HWnkCW4kSUKL4BenSwBX0g'}, attempt #1 03:28:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HWnkCW4kSUKL4BenSwBX0g'}, attempt #1 03:28:14 INFO - Task dependencies: HOHrldjzS5yKCO4vsvinCw 03:28:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw'}, attempt #1 03:28:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 03:28:14 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.test_packages.json 03:28:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.crashreporter-symbols.zip 03:28:14 INFO - Running post-action listener: _resource_record_post_action 03:28:14 INFO - [mozharness: 2017-08-15 10:28:14.891154Z] Finished read-buildbot-config step (success) 03:28:14 INFO - [mozharness: 2017-08-15 10:28:14.891377Z] Running download-and-extract step. 03:28:14 INFO - Running pre-action listener: _resource_record_pre_action 03:28:14 INFO - Running main action method: download_and_extract 03:28:14 INFO - mkdir: /builds/slave/test/build/tests 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:14 INFO - trying https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.test_packages.json 03:28:14 INFO - Downloading https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:28:15 INFO - Downloaded 989 bytes. 03:28:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:28:15 INFO - Using the following test package requirements: 03:28:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:28:15 INFO - u'common': [u'target.common.tests.zip'], 03:28:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:28:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:28:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:28:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:28:15 INFO - u'mozbase': [u'target.common.tests.zip'], 03:28:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:28:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:28:15 INFO - u'web-platform': [u'target.common.tests.zip', 03:28:15 INFO - u'target.web-platform.tests.tar.gz'], 03:28:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:28:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:28:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip 03:28:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip into memory 03:28:16 INFO - Content-Length response header: 54002443 03:28:16 INFO - Bytes received: 54002443 03:28:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip 03:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:27 INFO - Fetch https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.common.tests.zip into memory 03:28:28 INFO - Content-Length response header: 54002443 03:28:28 INFO - Bytes received: 54002443 03:28:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.talos.tests.zip 03:28:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:28:40 INFO - Fetch https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.talos.tests.zip into memory 03:28:41 INFO - Content-Length response header: 14496050 03:28:41 INFO - Bytes received: 14496050 03:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:41 INFO - trying https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 03:28:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:28:42 INFO - Downloaded 61923946 bytes. 03:28:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 03:28:42 INFO - mkdir: /builds/slave/test/properties 03:28:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:42 INFO - Contents: 03:28:42 INFO - build_url:https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 03:28:42 INFO - Running post-action listener: _resource_record_post_action 03:28:42 INFO - Running post-action listener: set_extra_try_arguments 03:28:42 INFO - [mozharness: 2017-08-15 10:28:42.722825Z] Finished download-and-extract step (success) 03:28:42 INFO - [mozharness: 2017-08-15 10:28:42.722924Z] Running populate-webroot step. 03:28:42 INFO - Running pre-action listener: _resource_record_pre_action 03:28:42 INFO - Running main action method: populate_webroot 03:28:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:42 INFO - 'tests': ['damp', 'tps']}, 03:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:28:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:28:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:28:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:42 INFO - 'ts_paint', 03:28:42 INFO - 'tpaint', 03:28:42 INFO - 'sessionrestore', 03:28:42 INFO - 'sessionrestore_many_windows', 03:28:42 INFO - 'sessionrestore_no_auto_restore', 03:28:42 INFO - 'tabpaint']}, 03:28:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:28:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:28:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:42 INFO - 'tsvgr_opacity', 03:28:42 INFO - 'tart', 03:28:42 INFO - 'tscrollx', 03:28:42 INFO - 'tsvg_static']}, 03:28:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:42 INFO - 'talos_options': ['--mitmproxy', 03:28:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:42 INFO - '--firstNonBlankPaint'], 03:28:42 INFO - 'tests': ['tp6_google', 03:28:42 INFO - 'tp6_youtube', 03:28:42 INFO - 'tp6_amazon', 03:28:42 INFO - 'tp6_facebook']}, 03:28:42 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:42 INFO - 'talos_options': ['--stylo', 03:28:42 INFO - '--mitmproxy', 03:28:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:42 INFO - '--firstNonBlankPaint'], 03:28:42 INFO - 'tests': ['tp6_google', 03:28:42 INFO - 'tp6_youtube', 03:28:42 INFO - 'tp6_amazon', 03:28:42 INFO - 'tp6_facebook']}, 03:28:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:42 INFO - 'talos_options': ['--stylo', 03:28:42 INFO - '--stylo-threads=1', 03:28:42 INFO - '--mitmproxy', 03:28:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:42 INFO - '--firstNonBlankPaint'], 03:28:42 INFO - 'tests': ['tp6_google', 03:28:42 INFO - 'tp6_youtube', 03:28:42 INFO - 'tp6_amazon', 03:28:42 INFO - 'tp6_facebook']}, 03:28:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:42 INFO - 'talos_options': ['--xperf_path', 03:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:42 INFO - 'tests': ['tp5n']}}} 03:28:42 INFO - Running post-action listener: _resource_record_post_action 03:28:42 INFO - [mozharness: 2017-08-15 10:28:42.731392Z] Finished populate-webroot step (success) 03:28:42 INFO - [mozharness: 2017-08-15 10:28:42.731483Z] Running create-virtualenv step. 03:28:42 INFO - Running pre-action listener: _resource_record_pre_action 03:28:42 INFO - Running main action method: create_virtualenv 03:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:42 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 03:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:42 INFO - Using real prefix '/usr' 03:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:45 INFO - Installing pip.................done. 03:28:45 INFO - Return code: 0 03:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:45 INFO - Reading from file tmpfile_stdout 03:28:45 INFO - Output received: 03:28:45 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) 03:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:45 INFO - Using env: {'DISPLAY': ':0', 03:28:45 INFO - 'HOME': '/home/cltbld', 03:28:45 INFO - 'LANG': 'en_US.UTF-8', 03:28:45 INFO - 'LANGUAGE': 'en_US:en', 03:28:45 INFO - 'LOGNAME': 'cltbld', 03:28:45 INFO - 'MAIL': '/var/mail/cltbld', 03:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:45 INFO - 'MOZ_NO_REMOTE': '1', 03:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:45 INFO - 'NO_EM_RESTART': '1', 03:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:45 INFO - 'PWD': '/builds/slave/test', 03:28:45 INFO - 'SHELL': '/bin/bash', 03:28:45 INFO - 'SHLVL': '1', 03:28:45 INFO - 'TERM': 'linux', 03:28:45 INFO - 'TMOUT': '86400', 03:28:45 INFO - 'USER': 'cltbld', 03:28:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:45 INFO - '_': '/tools/buildbot/bin/python'} 03:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:45 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 03:28:45 INFO - Cleaning up... 03:28:45 INFO - Return code: 0 03:28:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:45 INFO - Using env: {'DISPLAY': ':0', 03:28:45 INFO - 'HOME': '/home/cltbld', 03:28:45 INFO - 'LANG': 'en_US.UTF-8', 03:28:45 INFO - 'LANGUAGE': 'en_US:en', 03:28:45 INFO - 'LOGNAME': 'cltbld', 03:28:45 INFO - 'MAIL': '/var/mail/cltbld', 03:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:45 INFO - 'MOZ_NO_REMOTE': '1', 03:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:45 INFO - 'NO_EM_RESTART': '1', 03:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:45 INFO - 'PWD': '/builds/slave/test', 03:28:45 INFO - 'SHELL': '/bin/bash', 03:28:45 INFO - 'SHLVL': '1', 03:28:45 INFO - 'TERM': 'linux', 03:28:45 INFO - 'TMOUT': '86400', 03:28:45 INFO - 'USER': 'cltbld', 03:28:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:45 INFO - '_': '/tools/buildbot/bin/python'} 03:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:45 INFO - Downloading/unpacking psutil>=3.1.1 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:47 INFO - Installing collected packages: psutil 03:28:47 INFO - Running setup.py install for psutil 03:28:47 INFO - building 'psutil._psutil_linux' extension 03:28:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:47 INFO - building 'psutil._psutil_posix' extension 03:28:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:47 INFO - Successfully installed psutil 03:28:47 INFO - Cleaning up... 03:28:47 INFO - Return code: 0 03:28:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:28:47 INFO - Using env: {'DISPLAY': ':0', 03:28:47 INFO - 'HOME': '/home/cltbld', 03:28:47 INFO - 'LANG': 'en_US.UTF-8', 03:28:47 INFO - 'LANGUAGE': 'en_US:en', 03:28:47 INFO - 'LOGNAME': 'cltbld', 03:28:47 INFO - 'MAIL': '/var/mail/cltbld', 03:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:47 INFO - 'MOZ_NO_REMOTE': '1', 03:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:47 INFO - 'NO_EM_RESTART': '1', 03:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:47 INFO - 'PWD': '/builds/slave/test', 03:28:47 INFO - 'SHELL': '/bin/bash', 03:28:47 INFO - 'SHLVL': '1', 03:28:47 INFO - 'TERM': 'linux', 03:28:47 INFO - 'TMOUT': '86400', 03:28:47 INFO - 'USER': 'cltbld', 03:28:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:47 INFO - '_': '/tools/buildbot/bin/python'} 03:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:49 INFO - Installing collected packages: mozsystemmonitor 03:28:49 INFO - Running setup.py install for mozsystemmonitor 03:28:49 INFO - Successfully installed mozsystemmonitor 03:28:49 INFO - Cleaning up... 03:28:49 INFO - Return code: 0 03:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:49 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/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:49 INFO - Using env: {'DISPLAY': ':0', 03:28:49 INFO - 'HOME': '/home/cltbld', 03:28:49 INFO - 'LANG': 'en_US.UTF-8', 03:28:49 INFO - 'LANGUAGE': 'en_US:en', 03:28:49 INFO - 'LOGNAME': 'cltbld', 03:28:49 INFO - 'MAIL': '/var/mail/cltbld', 03:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:49 INFO - 'MOZ_NO_REMOTE': '1', 03:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:49 INFO - 'NO_EM_RESTART': '1', 03:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:49 INFO - 'PWD': '/builds/slave/test', 03:28:49 INFO - 'SHELL': '/bin/bash', 03:28:49 INFO - 'SHLVL': '1', 03:28:49 INFO - 'TERM': 'linux', 03:28:49 INFO - 'TMOUT': '86400', 03:28:49 INFO - 'USER': 'cltbld', 03:28:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:49 INFO - '_': '/tools/buildbot/bin/python'} 03:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:49 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 03:28:49 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 03:28:49 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 03:28:49 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 03:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:50 INFO - warning: no files found matching '*.txt' 03:28:50 INFO - no previously-included directories found matching 'build' 03:28:50 INFO - no previously-included directories found matching 'dist' 03:28:50 INFO - no previously-included directories found matching '.git*' 03:28:50 INFO - Installing collected packages: jsonschema, functools32 03:28:50 INFO - Running setup.py install for functools32 03:28:50 INFO - warning: no files found matching '*.txt' 03:28:50 INFO - no previously-included directories found matching 'build' 03:28:50 INFO - no previously-included directories found matching 'dist' 03:28:50 INFO - no previously-included directories found matching '.git*' 03:28:50 INFO - Successfully installed jsonschema functools32 03:28:50 INFO - Cleaning up... 03:28:50 INFO - Return code: 0 03:28:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:50 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/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:50 INFO - Using env: {'DISPLAY': ':0', 03:28:50 INFO - 'HOME': '/home/cltbld', 03:28:50 INFO - 'LANG': 'en_US.UTF-8', 03:28:50 INFO - 'LANGUAGE': 'en_US:en', 03:28:50 INFO - 'LOGNAME': 'cltbld', 03:28:50 INFO - 'MAIL': '/var/mail/cltbld', 03:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:50 INFO - 'MOZ_NO_REMOTE': '1', 03:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:50 INFO - 'NO_EM_RESTART': '1', 03:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:50 INFO - 'PWD': '/builds/slave/test', 03:28:50 INFO - 'SHELL': '/bin/bash', 03:28:50 INFO - 'SHLVL': '1', 03:28:50 INFO - 'TERM': 'linux', 03:28:50 INFO - 'TMOUT': '86400', 03:28:50 INFO - 'USER': 'cltbld', 03:28:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:50 INFO - '_': '/tools/buildbot/bin/python'} 03:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:51 INFO - Cleaning up... 03:28:51 INFO - Return code: 0 03:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:51 INFO - Using env: {'DISPLAY': ':0', 03:28:51 INFO - 'HOME': '/home/cltbld', 03:28:51 INFO - 'LANG': 'en_US.UTF-8', 03:28:51 INFO - 'LANGUAGE': 'en_US:en', 03:28:51 INFO - 'LOGNAME': 'cltbld', 03:28:51 INFO - 'MAIL': '/var/mail/cltbld', 03:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:51 INFO - 'MOZ_NO_REMOTE': '1', 03:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:51 INFO - 'NO_EM_RESTART': '1', 03:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:51 INFO - 'PWD': '/builds/slave/test', 03:28:51 INFO - 'SHELL': '/bin/bash', 03:28:51 INFO - 'SHLVL': '1', 03:28:51 INFO - 'TERM': 'linux', 03:28:51 INFO - 'TMOUT': '86400', 03:28:51 INFO - 'USER': 'cltbld', 03:28:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:51 INFO - '_': '/tools/buildbot/bin/python'} 03:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 INFO - Downloading docopt-0.6.1.tar.gz 03:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:53 INFO - Running setup.py install for blobuploader 03:28:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:53 INFO - Running setup.py install for requests 03:28:53 INFO - Running setup.py install for docopt 03:28:53 INFO - Successfully installed blobuploader requests docopt 03:28:53 INFO - Cleaning up... 03:28:53 INFO - Return code: 0 03:28:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:53 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/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:53 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:53 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:53 INFO - Using env: {'DISPLAY': ':0', 03:28:53 INFO - 'HOME': '/home/cltbld', 03:28:53 INFO - 'LANG': 'en_US.UTF-8', 03:28:53 INFO - 'LANGUAGE': 'en_US:en', 03:28:53 INFO - 'LOGNAME': 'cltbld', 03:28:53 INFO - 'MAIL': '/var/mail/cltbld', 03:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:53 INFO - 'MOZ_NO_REMOTE': '1', 03:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:53 INFO - 'NO_EM_RESTART': '1', 03:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:53 INFO - 'PWD': '/builds/slave/test', 03:28:53 INFO - 'SHELL': '/bin/bash', 03:28:53 INFO - 'SHLVL': '1', 03:28:53 INFO - 'TERM': 'linux', 03:28:53 INFO - 'TMOUT': '86400', 03:28:53 INFO - 'USER': 'cltbld', 03:28:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:53 INFO - '_': '/tools/buildbot/bin/python'} 03:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:53 INFO - Running setup.py (path:/tmp/pip-wWjfcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:53 INFO - Running setup.py (path:/tmp/pip-1reVUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:54 INFO - Running setup.py (path:/tmp/pip-OhHBXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:54 INFO - Running setup.py (path:/tmp/pip-l3JpyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:54 INFO - Running setup.py (path:/tmp/pip-hwL77f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:54 INFO - Running setup.py (path:/tmp/pip-GJJYoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:54 INFO - Running setup.py (path:/tmp/pip-qseE7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:54 INFO - Running setup.py (path:/tmp/pip-igpE2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:54 INFO - Running setup.py (path:/tmp/pip-huMd8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:54 INFO - Running setup.py (path:/tmp/pip-CSk535-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:54 INFO - Running setup.py (path:/tmp/pip-hYrHOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:54 INFO - Running setup.py (path:/tmp/pip-DZbCYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:54 INFO - Running setup.py (path:/tmp/pip-hG90u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:54 INFO - Running setup.py (path:/tmp/pip-KlXn35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:54 INFO - Running setup.py (path:/tmp/pip-oVFH9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:54 INFO - Running setup.py (path:/tmp/pip-FZ0zmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:55 INFO - Running setup.py (path:/tmp/pip-G1qTz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:55 INFO - Running setup.py install for manifestparser 03:28:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Running setup.py install for mozcrash 03:28:55 INFO - Running setup.py install for mozdebug 03:28:55 INFO - Running setup.py install for mozdevice 03:28:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Running setup.py install for mozfile 03:28:55 INFO - Running setup.py install for mozhttpd 03:28:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Running setup.py install for mozinfo 03:28:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Running setup.py install for mozInstall 03:28:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:55 INFO - Running setup.py install for mozleak 03:28:56 INFO - Running setup.py install for mozlog 03:28:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for moznetwork 03:28:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozprocess 03:28:56 INFO - Running setup.py install for mozprofile 03:28:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozrunner 03:28:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozscreenshot 03:28:56 INFO - Running setup.py install for moztest 03:28:56 INFO - Running setup.py install for mozversion 03:28:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:56 INFO - Cleaning up... 03:28:56 INFO - Return code: 0 03:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:56 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/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:56 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:56 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:56 INFO - Using env: {'DISPLAY': ':0', 03:28:56 INFO - 'HOME': '/home/cltbld', 03:28:56 INFO - 'LANG': 'en_US.UTF-8', 03:28:56 INFO - 'LANGUAGE': 'en_US:en', 03:28:56 INFO - 'LOGNAME': 'cltbld', 03:28:56 INFO - 'MAIL': '/var/mail/cltbld', 03:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:56 INFO - 'MOZ_NO_REMOTE': '1', 03:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:56 INFO - 'NO_EM_RESTART': '1', 03:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:56 INFO - 'PWD': '/builds/slave/test', 03:28:56 INFO - 'SHELL': '/bin/bash', 03:28:56 INFO - 'SHLVL': '1', 03:28:56 INFO - 'TERM': 'linux', 03:28:56 INFO - 'TMOUT': '86400', 03:28:56 INFO - 'USER': 'cltbld', 03:28:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:56 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:57 INFO - Running setup.py (path:/tmp/pip-xJBLWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:57 INFO - Running setup.py (path:/tmp/pip-hyxLIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:57 INFO - Running setup.py (path:/tmp/pip-DSuHxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:57 INFO - Running setup.py (path:/tmp/pip-dLHu4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:57 INFO - Running setup.py (path:/tmp/pip-PucPrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:57 INFO - Running setup.py (path:/tmp/pip-5HbcOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:57 INFO - Running setup.py (path:/tmp/pip-iFdKwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:57 INFO - Running setup.py (path:/tmp/pip-WNh4B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:57 INFO - Running setup.py (path:/tmp/pip-MhTW5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:57 INFO - Running setup.py (path:/tmp/pip-RESS7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:57 INFO - Running setup.py (path:/tmp/pip-_MYwH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:57 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:57 INFO - Running setup.py (path:/tmp/pip-SNzIvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:57 INFO - Running setup.py (path:/tmp/pip-flGu__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:58 INFO - Running setup.py (path:/tmp/pip-k8bD4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:58 INFO - Running setup.py (path:/tmp/pip-1yQixl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:58 INFO - Running setup.py (path:/tmp/pip-QnQ1am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:58 INFO - Running setup.py (path:/tmp/pip-6OSLIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:58 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)) 03:28:58 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)) 03:28:58 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)) 03:28:58 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)) 03:28:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - Downloading blessings-1.6.tar.gz 03:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:59 INFO - Installing collected packages: blessings 03:28:59 INFO - Running setup.py install for blessings 03:28:59 INFO - Successfully installed blessings 03:28:59 INFO - Cleaning up... 03:28:59 INFO - Return code: 0 03:28:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:59 INFO - Reading from file tmpfile_stdout 03:28:59 INFO - Current package versions: 03:28:59 INFO - argparse == 1.2.1 03:28:59 INFO - blessings == 1.6 03:28:59 INFO - blobuploader == 1.2.4 03:28:59 INFO - docopt == 0.6.1 03:28:59 INFO - functools32 == 3.2.3-2 03:28:59 INFO - jsonschema == 2.5.1 03:28:59 INFO - manifestparser == 1.1 03:28:59 INFO - mozInstall == 1.13 03:28:59 INFO - mozcrash == 1.0 03:28:59 INFO - mozdebug == 0.1 03:28:59 INFO - mozdevice == 0.51 03:28:59 INFO - mozfile == 1.2 03:28:59 INFO - mozhttpd == 0.7 03:28:59 INFO - mozinfo == 0.10 03:28:59 INFO - mozleak == 0.1 03:28:59 INFO - mozlog == 3.5 03:28:59 INFO - moznetwork == 0.27 03:28:59 INFO - mozprocess == 0.25 03:28:59 INFO - mozprofile == 0.28 03:28:59 INFO - mozrunner == 6.13 03:28:59 INFO - mozscreenshot == 0.1 03:28:59 INFO - mozsystemmonitor == 0.3 03:28:59 INFO - moztest == 0.8 03:28:59 INFO - mozversion == 1.4 03:28:59 INFO - psutil == 3.1.1 03:28:59 INFO - requests == 1.2.3 03:28:59 INFO - wsgiref == 0.1.2 03:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:59 INFO - Using env: {'DISPLAY': ':0', 03:28:59 INFO - 'HOME': '/home/cltbld', 03:28:59 INFO - 'LANG': 'en_US.UTF-8', 03:28:59 INFO - 'LANGUAGE': 'en_US:en', 03:28:59 INFO - 'LOGNAME': 'cltbld', 03:28:59 INFO - 'MAIL': '/var/mail/cltbld', 03:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:59 INFO - 'MOZ_NO_REMOTE': '1', 03:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:59 INFO - 'NO_EM_RESTART': '1', 03:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:59 INFO - 'PWD': '/builds/slave/test', 03:28:59 INFO - 'SHELL': '/bin/bash', 03:28:59 INFO - 'SHLVL': '1', 03:28:59 INFO - 'TERM': 'linux', 03:28:59 INFO - 'TMOUT': '86400', 03:28:59 INFO - 'USER': 'cltbld', 03:28:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:59 INFO - '_': '/tools/buildbot/bin/python'} 03:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 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)) 03:29:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29: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 03:29: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 03:29: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 03:29: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 03:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:29:01 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)) 03:29:01 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)) 03:29:01 INFO - Installing collected packages: simplejson 03:29:01 INFO - Running setup.py install for simplejson 03:29:01 INFO - building 'simplejson._speedups' extension 03:29:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:29:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:29:02 INFO - Successfully installed simplejson 03:29:02 INFO - Cleaning up... 03:29:02 INFO - Return code: 0 03:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29: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/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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, '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': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', '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 03:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:02 INFO - Using env: {'DISPLAY': ':0', 03:29:02 INFO - 'HOME': '/home/cltbld', 03:29:02 INFO - 'LANG': 'en_US.UTF-8', 03:29:02 INFO - 'LANGUAGE': 'en_US:en', 03:29:02 INFO - 'LOGNAME': 'cltbld', 03:29:02 INFO - 'MAIL': '/var/mail/cltbld', 03:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:02 INFO - 'MOZ_NO_REMOTE': '1', 03:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:02 INFO - 'NO_EM_RESTART': '1', 03:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:02 INFO - 'PWD': '/builds/slave/test', 03:29:02 INFO - 'SHELL': '/bin/bash', 03:29:02 INFO - 'SHLVL': '1', 03:29:02 INFO - 'TERM': 'linux', 03:29:02 INFO - 'TMOUT': '86400', 03:29:02 INFO - 'USER': 'cltbld', 03:29:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:02 INFO - '_': '/tools/buildbot/bin/python'} 03:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:02 INFO - Cleaning up... 03:29:02 INFO - Return code: 0 03:29:02 INFO - Running post-action listener: _resource_record_post_action 03:29:02 INFO - Running post-action listener: _start_resource_monitoring 03:29:02 INFO - Starting resource monitoring. 03:29:02 INFO - [mozharness: 2017-08-15 10:29:02.609858Z] Finished create-virtualenv step (success) 03:29:02 INFO - [mozharness: 2017-08-15 10:29:02.610380Z] Running install step. 03:29:02 INFO - Running pre-action listener: _resource_record_pre_action 03:29:02 INFO - Running main action method: install 03:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:02 INFO - Reading from file tmpfile_stdout 03:29:02 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:02 INFO - Reading from file tmpfile_stdout 03:29:02 INFO - Output received: 03:29:02 INFO - Usage: mozinstall [options] installer 03:29:02 INFO - Options: 03:29:02 INFO - -h, --help show this help message and exit 03:29:02 INFO - -d DEST, --destination=DEST 03:29:02 INFO - Directory to install application into. [default: 03:29:02 INFO - "/builds/slave/test"] 03:29:02 INFO - --app=APP Application being installed. [default: firefox] 03:29:02 INFO - mkdir: /builds/slave/test/build/application 03:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:29:20 INFO - Reading from file tmpfile_stdout 03:29:20 INFO - Output received: 03:29:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:20 INFO - Running post-action listener: _resource_record_post_action 03:29:20 INFO - [mozharness: 2017-08-15 10:29:20.935574Z] Finished install step (success) 03:29:20 INFO - [mozharness: 2017-08-15 10:29:20.935861Z] Running setup-mitmproxy step. 03:29:20 INFO - Running pre-action listener: _resource_record_pre_action 03:29:20 INFO - Running main action method: setup_mitmproxy 03:29:20 INFO - Skipping: mitmproxy is not required 03:29:20 INFO - Running post-action listener: _resource_record_post_action 03:29:20 INFO - [mozharness: 2017-08-15 10:29:20.937017Z] Finished setup-mitmproxy step (success) 03:29:20 INFO - [mozharness: 2017-08-15 10:29:20.937304Z] Running run-tests step. 03:29:20 INFO - Running pre-action listener: _resource_record_pre_action 03:29:20 INFO - Running pre-action listener: _set_gcov_prefix 03:29:20 INFO - Running main action method: run_tests 03:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:20 INFO - Python 2.7.3 03:29:20 INFO - Return code: 0 03:29:20 INFO - grabbing minidump binary from tooltool 03:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:29:20 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 0x1fe8f00>, '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 0x1fe3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:20 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 03:29:20 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 03:29:20 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 03:29:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:21 INFO - Return code: 0 03:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: RUST_BACKTRACE is now full 03:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:29:21 INFO - Using env: {'DISPLAY': ':0', 03:29:21 INFO - 'HOME': '/home/cltbld', 03:29:21 INFO - 'LANG': 'en_US.UTF-8', 03:29:21 INFO - 'LANGUAGE': 'en_US:en', 03:29:21 INFO - 'LOGNAME': 'cltbld', 03:29:21 INFO - 'MAIL': '/var/mail/cltbld', 03:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:21 INFO - 'MOZ_NO_REMOTE': '1', 03:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:21 INFO - 'NO_EM_RESTART': '1', 03:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:21 INFO - 'PWD': '/builds/slave/test', 03:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:21 INFO - 'RUST_BACKTRACE': 'full', 03:29:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:21 INFO - 'SHELL': '/bin/bash', 03:29:21 INFO - 'SHLVL': '1', 03:29:21 INFO - 'TERM': 'linux', 03:29:21 INFO - 'TMOUT': '86400', 03:29:21 INFO - 'USER': 'cltbld', 03:29:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502788465.853303-1907411612', 03:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:21 INFO - '_': '/tools/buildbot/bin/python'} 03:29:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:29:21 INFO - mozversion application_buildid: 20170815094231 03:29:21 INFO - mozversion application_changeset: 564e82f0f289af976da01c2d50507017bbc152b5 03:29:21 INFO - mozversion application_display_name: Nightly 03:29:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:21 INFO - mozversion application_name: Firefox 03:29:21 INFO - mozversion application_remotingname: firefox 03:29:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:21 INFO - mozversion application_vendor: Mozilla 03:29:21 INFO - mozversion application_version: 57.0a1 03:29:21 INFO - mozversion platform_buildid: 20170815094231 03:29:21 INFO - mozversion platform_changeset: 564e82f0f289af976da01c2d50507017bbc152b5 03:29:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:21 INFO - mozversion platform_version: 57.0a1 03:29:21 INFO - using testdate: 1502792961 03:29:21 INFO - actual date: 1502792961 03:29:21 INFO - starting webserver on 'localhost:53656' 03:29:21 INFO - SUITE-START | Running 2 tests 03:29:21 INFO - TEST-START | dromaeo_css 03:29:21 INFO - Initialising browser for dromaeo_css test... 03:29:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53656/getInfo.html -profile /tmp/tmpb384lh/profile 03:29:21 INFO - TEST-INFO | started process 25525 (/builds/slave/test/build/application/firefox/firefox http://localhost:53656/getInfo.html) 03:29:27 INFO - TEST-INFO | 25525: exit 0 03:29:27 INFO - Browser initialized. 03:29:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:27 INFO - TEST-INFO | started process 25738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb384lh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:28 INFO - PID 25738 | 03:29:28 INFO - PID 25738 | (/builds/slave/test/build/application/firefox/firefox:25787): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:28 INFO - PID 25738 | 03:29:38 INFO - PID 25738 | RSS: Main: 164433920 03:29:38 INFO - PID 25738 | 03:32:37 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53656/tests/dromaeo/cssquery-ext.html) 03:32:38 INFO - PID 25738 | RSS: Main: 172331008 03:32:38 INFO - PID 25738 | 03:35:40 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-ext.html (next: http://localhost:53656/tests/dromaeo/cssquery-jquery.html) 03:35:41 INFO - PID 25738 | RSS: Main: 167428096 03:35:41 INFO - PID 25738 | 03:38:42 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53656/tests/dromaeo/cssquery-mootools.html) 03:38:43 INFO - PID 25738 | RSS: Main: 171261952 03:38:43 INFO - PID 25738 | 03:41:45 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53656/tests/dromaeo/cssquery-prototype.html) 03:41:45 INFO - PID 25738 | RSS: Main: 169906176 03:41:45 INFO - PID 25738 | 03:44:49 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53656/tests/dromaeo/cssquery-yui.html) 03:44:50 INFO - PID 25738 | RSS: Main: 173473792 03:44:50 INFO - PID 25738 | 03:47:51 INFO - PID 25738 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-yui.html (next: http://localhost:53656/tests/dromaeo/cssquery-dojo.html) 03:47:52 INFO - PID 25738 | RSS: Main: 173936640 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | __start_tp_report 03:47:52 INFO - PID 25738 | _x_x_mozilla_page_load 03:47:52 INFO - PID 25738 | _x_x_mozilla_page_load_details 03:47:52 INFO - PID 25738 | |i|pagename|runs| 03:47:52 INFO - PID 25738 | |0;dojo.html;3154.227214332489;3171.8414079296035;3197.504386820043;3206.919827004326;3215.581974343335;6073.696315184246;6221.533384996126;6249.812505624838;6270.341614130513;6274.56078074535;6009.969950150254;6066.484348830344;6078.118672792442;6080.543959203055;6124.203853499039;5552.77788888444;5566.165075238706;5576.358718747335;5584.441555844423;5586.748596313176;5600.467955544217;5612.887742245152;5623.746931388097;5638.238837756912;5772.971135144339;5717.085266357383;5753.798617048405;5782.421757824226;5783.855403614902;5789.942100579004;5633.0987042073075;5662.122371032497;5743.9712801435935;5757.596968212227;5772.913406298909;5449.01917654822;5483;5571.9721401393135;5662.6036177467595;5682.857928551778;6016.308124565688;6105.8168254952425;6148.1392605035335;6183.041628547582;6186.164867742842;6479.514036447285;6507.251666058417;6604.669766511655;6616.86766264672;6617.900731489031;6501.219853617549;6545.476361891037;6602.9669851650915;6705.329467053304;6711.194656641185;6180.072989051633;6193.0091185410565;6194.566380353423;6205.503559715212;6210.254769427697;6818.761343352959;6910.48171387148;6913.723451061901;6914.0666010088;6935.098437203132;6507.934920650828;6514.283428822826;6554.180727409074;6586.604803711793;6622.86754264912;6443.065755465431;6522.967385163139;6523.249826269945;6545.312742162099;6587.341265873471;6460.095586617877;6471.288158302583;6488.643124628096;6491.837704057436;6492.09110724499;6439.710213040425;6542.149520562297;6561.2782593914635;6635.701393437307;6643.003549467522;5373.677579345252;5430.456954304538;5438.75525601341;5440.265564148868;5443.727813609304;4570.337301091389;4653.906921861611;4658.208104622222;4670.346151538787;4671.813127474863;5584.664920104807;5658.009848276535;5664.518515926193;5769.221155144086;5829.358770535237;6584.30864759203;6607.339266073354;6613.4709223262025;6616.172978377703;6620.966895165493;5623.550115990711;5669.177969194526;5690.260266165372;5693;5697.686627235542;5850.795222167204;5931.555133365015;5941.257342832146;5946.821595352147;5952.583319167703;6450.225972883284;6462.450691691259;6479.481641468671;6571.474282057424;6573.80278591643;6504.544681872413;6601.801945941629;6650.600963941985;6748.493862960396;6771.119754431892;6421.775237866652;6430.131932189094;6450.225972883096;6461;6467.191601049869;6546.639934803631;6556.377144171296;6563.540552161494;6572.8356791080605;6573.375529324707;6567.211934567882;6641.468682505485;6711.731530738716;6723.125993620798;6732.528722989344;6235.594686345373;6320.146780184617;6402.455791257609;6409.230892292955;6498.285188629342;6469.5794773339585;6474.352564743676;6480.287168411565;6489.902651460137;6502.544821862424;6356.11014457967;6406.871862562816;6453.193350831146;6477.902831457626;6491.707873145625;6438.935610643834;6473.449756770538;6564.4420224281475;6573.882439985309;6589.439897608565;6055.091736239599;6172.907406388818;6298.275698294755;6346.492280617632;6369.617822930639 03:47:52 INFO - PID 25738 | |1;ext.html;811.4563242627439;850.8638617821148;870.2124577257582;874.8337815814995;1146.4267866066966;31428.214294642617;43281.35077973829;44349;44373.11253774923;44535.77732111343;44190.33714494285;44516;44644.553554464444;44662.77668611652;44677.77661111698;7201.9557164211155;7700.383969282458;7810.76567702967;7813.062432508107;7823.960880195591;7645.120811106738;7728.111267204287;7756.3794896408435;7758.495697779655;7761.262680045386;7716.2669546393;7768.184340644236;7779.105402878657;7781.922180778176;7783.260590243946;7728.304452599265;7738.342240909529;7744.49660772048;7767.8058048548955;7770.106437759673;7593.81015474612;7656.923430765677;7661.578613176273;7662.693492260303;7667.309942105181;39961.400578991335;40139.19721605581;40157.39763903544;40195.59804401977;40318;3589.892303230907;3626.528551288342;3627.6735093841417;3634.509341238925;3635.291118231946;32405.189870253198;32667.6733232667;32673.346533069205;32752.6724732752;32791.344173116406;5097.464766199532;5097.8215762448135;5120.667156634807;5135.35808023997;5136.743162841843;184946;184965;184983;185629;185695;51238.743806281476;51267.48732512702;51286;51318.74340628273;51391.7430412853;53325.73337133289;53418;53581.46418535765;53663.463365365846;53685.731571341894;15713;15913.522594322189;15922.442714504938;15951.122688252257;15964.441244556385;11667.533298668128;12035.638930832089;12760.80858787119;12811.679708007374;12850;15106.848931510543;15251.389944402099;15340.386384544494;15409.84590154084;15410.691786164214;5833.854153646108;5998.340182579913;6132.816015519542;6137.140800287963;6151.446369826737;1008.8385858262643;1022.8619136416637;1026.7022563456662;1034.0331789776583;1036.896310368957;22925.88537057304;23673.171438999896;23779.286621401385;23782.405439864142;23811.730009514933;1055.6938487838595;1079.8014204233295;1098.8296813993684;1105.160078340467;1130.0451118804597;12118.878811211951;12458.75082498345;12651.683707907376;12858.357082145856;12896.032797540034;249229;250295;252850;253105;253422;55788.72105639446;56256.15615765767;56360.71819640876;56416.15375769367;56491.43508564862;1446.5732608880405;1459.0953608762422;1478.2830327291256;1486.1528928510645;1515.0606623893036;23363.299101026998;23408;23429.648555271342;23528.647070293617;23665.40836479102;39427.60572394239;39596.802015989735;39798.403023955245;39848.40227396534;39861.20277594374;221044;221323;222020;222676;224112;31186.532202017443;33426.83286583552;34939;35097;35148.82425587856;44885;45332.773336133105;45615.08769824651;45849.08301834011;45997;34076.31847363088;34343.141421464665;34432.31135377228;34464;34917.650823491436;33127.83436082804;33811.3237735239;33841;34305.656943430244;34796.13009674779;36519.81740091283;36529;36901.44647830231;37030.8148459256;37116.25767484689;32402.189945251557;32875.67124328822;34288.65711342855;35923.92228233157;36104.458433123;25186.24441266765;25391.15375427977;25942.740572594786;26088.478230435663;26656.733432666202 03:47:52 INFO - PID 25738 | |2;jquery.html;559.9916001259979;561.571204540363;573.5325709546719;578.7106446776613;592.576307939823;22174.88912555439;22509.212177573787;23163.420914477127;23226;23227.187048453306;27340.45319093617;27969.860150699216;27974.860125699393;28005.439891202164;28132.156035318923;6946.895796563043;7110.928890711104;7111.928880711204;7114.608696521689;7120.145582530104;6860.382565569098;6935.826604334881;7173.6771845267085;7207.207207207203;7220.205777364486;7226.060612120444;7231.240719724432;7231.276872312779;7232.746853860116;7237.240089790575;7188.568685878811;7188.568685878838;7188.892166617505;7211.963940180318;7212.567245965232;7054.788356349318;7065.43476521877;7066.364027237521;7072.08062951813;7079.89380159298;30790.53814192789;31713.365732685448;32530.18674533132;32677.18307042319;32744.508832367534;1964.3419454482766;1992.8804271743597;1993.950151246216;1995.630808300469;1998.1707591349573;21122.788772112388;21741;21770.238041668625;21797;21840.453988650253;2311.2603966730653;2494.052260141153;2502.862342571158;2524.5329614021466;2526.6715327007555;140673;143716;144312.2784386082;144645;144970.27514862464;15158.772618410732;15159.848401516065;15341.923290383476;15529.378824847106;15862.682746345008;24246;24394.39014024628;24418.633720494207;24450;24491.510169796504;10044.799104017879;10200.846987295197;10482.161427085815;10545.630902918361;10724.356538607708;8450.577471126418;8855.690050848189;9443.763905902408;9558.330916835894;9656.613735450503;9107.863382049274;9362.62549498026;9479.857802132974;9618.374805637612;9773.511324433892;2662.613920981447;2696.5146273670534;2774.195483309858;2797.59434881941;2804.9158525244275;949.9477528735848;952.6522819170953;964.71058682395;968.8352979993418;969.7381706939087;19966.60066798656;19978.800211997986;20248.804018299415;20492.897535512227;20776.06507707157;1004.6031817432073;1007.1439276614818;1017.5675337981328;1019.0980981831133;1023.4831410137981;11177.72055698614;11342.546298148147;11407.600733974272;11495.770084598262;11557.364344961108;459363;496234;537005;538385;547448;116864;121215;123421.76578234103;124796;127827;1255.453877563263;1261.224347026572;1294.695746499572;1304.6868751499762;1305.549585393038;20850.270240542115;21173.682394763782;21322.78677213208;21607.135714571243;21670;59270.110948336674;59685.40314596798;60037.39962600493;60429.0935635957;61832;78216;78305.60847195728;78460;78757;78796;14641.633959151106;15036.120484939383;15108.640222380038;15115.093094414371;15116;23589.174378896656;24070.157544485857;24177.75822241755;24186.758132419156;24240.63639045451;18373.356932507297;18401.63196736031;18429.170687318834;18496;18593.90703046476;16890.239939203013;17195;17730.202140903948;17829;17909.910450447664;17477.12614369251;17576.648467030842;17616.471505854333;17806.46580602584;19197.232110715973;14708.852911471176;14868.107913525224;14883.627909302355;15043;15080.170590617183;18040.909795450938;18251.634967300844;18397.72403413923;19224.423267302005;19374.903125484845 03:47:52 INFO - PID 25738 | |3;mootools.html;1334.1728128560292;1401.201315250307;1407.7958695989082;1419.7870319452074;1425.0405692173258;12334.814977775319;13323.866761332396;14108.576742697709;14129.57611271661;14158.221297828615;12448.875511244885;14231.501897433565;14623.488177913776;14625.195614241213;14671.559853204395;2618.882150303241;2667.146513115804;2668.159529748123;2676.4245687177254;2676.892924283036;2565.422779874523;2582.548054090536;2666.799990000748;2670.4659068186343;2684.476527077221;2725.6592925884265;2745.766609838166;2751.5184842652557;2753.5869619557025;2756.75189232969;2565.691497336353;2674.277944954861;2693.2593536777445;2700.297922540144;2702.094798242591;2560.129555950967;2566.114690431798;2579.019972410472;2655.495455863399;2706.2557796605893;14316.284185790773;14424.71150576993;14494.782578261334;14527.128372297697;14532.564023079325;7639.6944122235045;7938.960305198495;7940.404469664741;7942.245486678757;7948.523088614644;5147.768350424202;5181.81863634771;5293.153095504739;5360.391882435254;5360.731963401853;1864.2170288478735;1869.8971556564384;1905.4188472515877;1924.0764433072063;1928.5371510837438;23502.882485587463;23609.645855312185;23682.289531313916;23726.169584064646;23762.762372376226;6322.304546499881;6372.088373487935;6480.416762491398;6545.541812073205;6677.165354330708;16309.266083026292;16463.259153338127;16486.939132608422;16487.422940197277;16487.67024659524;7456.40348772097;7606.657700403495;7609.847803043908;7610.961945190239;7625;6727.495437842182;6993.055937448379;7042.084529011196;7113.89329160063;7154.785356439315;5046.21783623539;5187.610929180327;5193.662411943212;5193.92209116856;5276.314079169761;1386.1198139181693;1412.6821465170256;1467.4057006912217;1485.89598728088;1528.8318284988643;932.9067093290753;955.81361634482;956.5695437053354;958.8945216026232;966.5070813884829;8021.719239826578;8202.753917382488;8336.166383361615;8366.916330836613;8387.580620968927;975.1564896364594;1000.1049061090283;1027.8304079826744;1038.3977293169944;1043.4417586591137;5242.370915490165;5253.212018197224;5259.60552958522;5312;5358.517733404013;19505.31731389423;19774;20488.590228195353;20593.89703051505;20613.07241174151;19738;20100.597988040157;20215.393538193584;20355.491112722302;20378.490537736674;10152.593896244067;10836.729081773019;10852;10872.130229581615;10882.510287037103;8396.370272229486;8598.441101328393;8625.87061194095;8936.28509719234;9200.401973871676;17599.85600935935;17603.11984400749;17761.911190444484;17782.822171778633;17941.372051978116;17675.469735907944;18067.728984065514;18235.635287294444;18303.17635706423;18787.530311742317;11540.422978851191;11679.591214307458;11905.940470297593;11917.463714132711;11918.165728398928;13140.934295328461;13412.664683382993;13423;13431.664208394868;13441.126326788728;10937.398443085707;10990.780184396428;11172.832407513732;11199.832002520132;11448.599299024494;10403.94798026005;10677.359358438518;10711.196660250356;10805;10928.562857485611;9511.191548718436;9548.57031433601;9745.610175593181;9850.064243896819;9852.310338276251;7270.418366530559;7329.596872171868;7340.449466290156;7374.410047196104;7374.705011799468;7379.889301660587;7450.739224127129;7465.701371945279;7529.247075292427;7536.171021187774 03:47:52 INFO - PID 25738 | |4;prototype.html;489.4695787831512;499.66838375728685;519.2237604780853;524.6773234460805;526.8050821196157;6187.783427580036;6197.845053873644;6206.410391012852;6234.283057448395;6285.811425657238;6018.307894592123;6123.550579768095;6145.293291271505;6191.5356348273945;6194.349593292707;4943.604511639061;4957.206846904496;4958.776855041514;4963.553280204781;5000.949990500085;4870.43989941156;4907.82822601209;4940.308356830046;4982.487346420783;4993.475685053071;4868.221084626461;4954.182559877616;4976.950230497685;4993.550580447759;4998.175301075318;4960.107180707471;4977.626677999165;4995.6003519718515;5006.499350065001;5021.121303771862;4482.731036137842;4483.461984561841;4486.237339652267;4487.506374298824;4492.7528985905765;6153.476954458876;6171.9691401542705;6174.382561743834;6182.474489668339;6208.540992866673;5693;5723.399043100456;5737.827865164052;5776.508996735282;5799.681017544033;6583.341665833426;6613.404793568602;6622;6692.393825481898;6717.899231511531;4825.20384136617;4863.562279394836;4864.464908860023;4869.220924652074;4876.122297986361;6955.1653801544135;6977.860442791167;6991.265917078685;7042.929570704278;7061.823454413578;4967.428745694219;4968.22992436173;4970.627202959792;4984.800607975713;5042.42012168598;5027.773750181177;5048.545630893163;5049.495050494995;5068.797248110108;5084.694918304914;5713.74288157034;5746.13807928814;5767.5581104723815;5781.942180578225;5785.50823180026;6534.836629084216;6702.899456508157;6735.6968936397;6813.148356455443;6817.113775209191;1696.6850690714796;1739.2347367158409;1745.5723347779876;1758.34062226665;1761.3923196497187;1181.8050021746315;1185.2177562808506;1204.4820727087435;1206.8612109607507;1218.7264308797328;5786.1974561114175;5801.3908539602735;5812.128180772918;5844.6785426801935;5879.3826648202175;6686.1642294713165;6794.218664853506;6802.285759995129;6843.520953533304;6858.6570671466225;5751.539876809845;5769.221155144086;5786.3056433228285;5839.883202335929;5859.1797148399255;3565.839537220779;3589.94615080774;3639.8544058237903;3647.4164133738473;3654.8172591370326;6424.072778166625;6510.739570417225;6592.538522303393;6625.602463852184;6631.701573429207;6998.545094568837;7016.333448322402;7018.473614478935;7069.434445244368;7084.858302833914;6466.741330346734;6544.967275163689;6559.180102487189;6593.406593406617;6594.340565943463;6850.9314906850295;6859.759908403182;6891.104946139852;6930.792076237721;6941.722331106901;6765.1395866135235;6789.219239787488;6829.248782634006;6862.348076932683;6879.793606191823;6542.803715888531;6640.908113944092;6647;6681.558997116586;6682.431993280431;4929.778159982738;4934.383202099738;4945.307656927961;4946.406431228275;4954.058728841508;6847.349501797321;6854.931450685429;6880.58716477013;6915.619640919797;6926.168859736864;6615.386922165814;6616.371444712745;6617.66911654425;6648.445814617003;6664.700088496126;6650.96909978954;6655.201375834931;6656.2345330287635;6667.699953502201;6670.599764014175;6241.937580624136;6462.644554549545;6465.353464653497;6559.442447392025;6572.882609956415;6500.869982600227;6574.901376479261;6644.767433139817;6677.165354330708;6734.191896972395;6289.352175737969;6339.619622822645;6354.586951848115;6410;6434.45573062471 03:47:52 INFO - PID 25738 | |5;yui.html;907.8502047162223;917.3074328881694;923.5890028937117;931.4504442378995;934.7242563443785;19195.616087678238;20002.799972000277;20111.59776804463;20133.094010769513;20190.798092019075;20527.79472205281;21926.561468770615;22012.889935550338;22070.448238794037;22240.888795556;1047.5024363427349;1054.8048611006989;1055.145332280851;1055.762453447972;1055.8099542082423;1053.5522402978704;1058.6929790360787;1059.2161800267786;1059.6926891201542;1060.204846365226;1113.7104352868273;1116.5087361560886;1117.944102794861;1128.5260190719875;1128.6331942118802;1108.933463992159;1109.173665619115;1109.672646569264;1110.0897264243283;1121.8373335866254;818.4189225649795;818.5743413425046;818.7011740714656;819.0212695828487;819.2544784246307;19556.511087222792;19820.108095135754;19980.500487487785;20834.166633334647;20951.895240523852;21548.569028619495;21625.567488650297;21675.891620541955;21982.34052978413;22283.777162228493;15690.137042462775;15800.683986320324;16177.35290588375;16299.429519966863;16429.424970126107;3618.8371523281517;3652.214773823641;3653.5798383185743;3653.725970552193;3654.397024490956;126510;127068;128227.35886320508;128815.35592322072;129449;16956;16959.830401696072;17836.643267134845;18354.449366519028;18467.81532184661;32947.67052329494;33391.33217335639;33447.163820904185;33758.32483350319;33853.32293354168;7530.43521735872;7618.504797188165;8653.480791152551;8928.285737141014;8932.19610235082;4118.361653943643;4210.831566737296;4234.894127646833;4243.724157929724;4245.915081698348;5188.948110518922;5213.973930130325;5263.210518422191;5309.548688361455;5374.758135883894;1031.3296357367772;1038.3510306058713;1051.7055224537141;1056.1392465140887;1058.9788204236027;678.0744284052233;692.5567636712508;696.571608460793;705.3757424679093;711.6121713666064;11346.773064538664;11756.23584467007;12137.21108127969;12627.305498197687;12655.746885062246;643.3180828321994;647.2976820150095;650.677914432359;652.9085927970089;656.4289068510332;5518.475744804237;5531.640443371168;6029.638221706711;6141.692915354214;6211.720472578745;111708;111897;114545;115264;116927;95229;96307.51846240724;99621;102176.48911755542;105565;84535.577322113;84660;84873.87815304667;86976;88713.11286887177;12936.90036346921;13274.203547787163;13279.336033198495;13414.396352164371;13479.056466047283;39467.605323946394;39860.80069599633;40019.79990100031;40181.79909100436;40551.391729124676;72339.27660723536;72487.63756181185;73439.63280183564;73917;74812;18844.717329239797;20431;20488;20522.79477205209;20545.48636284105;18536.165872535497;19455.70816437726;21470.14119435205;22134;22161;18634.534136646693;18750.53123671919;18863.24547018104;19200.8079919199;19628.411147665593;19654.312099076462;19739.013049347763;19862.50343741418;19883.30408435698;20283.188672453525;17378.913105434392;18534.25862965466;19164.616707666046;19353.70969435488;19543.21827126899;13037.869621303666;13996.16023038621;14048.578542643738;14660.70678586401;14707.558773236393;14184.432622695389;14560.927195363955;14668.339924703627;14931.850681493046;15439.228038597801 03:47:52 INFO - PID 25738 | __end_tp_report 03:47:52 INFO - PID 25738 | __start_cc_report 03:47:52 INFO - PID 25738 | _x_x_mozilla_cycle_collect,371 03:47:52 INFO - PID 25738 | __end_cc_report 03:47:52 INFO - PID 25738 | __startTimestamp1502794072131__endTimestamp 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | ------- Summary: start ------- 03:47:52 INFO - PID 25738 | Number of tests: 6 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#0] dojo.html Cycles:165 Average:6096.23 Median:6369.62 stddev:706.56 (11.1%) stddev-sans-first:669.97 03:47:52 INFO - PID 25738 | Values: 3154.2 3171.8 3197.5 3206.9 3215.6 6073.7 6221.5 6249.8 6270.3 6274.6 6010.0 6066.5 6078.1 6080.5 6124.2 5552.8 5566.2 5576.4 5584.4 5586.7 5600.5 5612.9 5623.7 5638.2 5773.0 5717.1 5753.8 5782.4 5783.9 5789.9 5633.1 5662.1 5744.0 5757.6 5772.9 5449.0 5483.0 5572.0 5662.6 5682.9 6016.3 6105.8 6148.1 6183.0 6186.2 6479.5 6507.3 6604.7 6616.9 6617.9 6501.2 6545.5 6603.0 6705.3 6711.2 6180.1 6193.0 6194.6 6205.5 6210.3 6818.8 6910.5 6913.7 6914.1 6935.1 6507.9 6514.3 6554.2 6586.6 6622.9 6443.1 6523.0 6523.2 6545.3 6587.3 6460.1 6471.3 6488.6 6491.8 6492.1 6439.7 6542.1 6561.3 6635.7 6643.0 5373.7 5430.5 5438.8 5440.3 5443.7 4570.3 4653.9 4658.2 4670.3 4671.8 5584.7 5658.0 5664.5 5769.2 5829.4 6584.3 6607.3 6613.5 6616.2 6621.0 5623.6 5669.2 5690.3 5693.0 5697.7 5850.8 5931.6 5941.3 5946.8 5952.6 6450.2 6462.5 6479.5 6571.5 6573.8 6504.5 6601.8 6650.6 6748.5 6771.1 6421.8 6430.1 6450.2 6461.0 6467.2 6546.6 6556.4 6563.5 6572.8 6573.4 6567.2 6641.5 6711.7 6723.1 6732.5 6235.6 6320.1 6402.5 6409.2 6498.3 6469.6 6474.4 6480.3 6489.9 6502.5 6356.1 6406.9 6453.2 6477.9 6491.7 6438.9 6473.4 6564.4 6573.9 6589.4 6055.1 6172.9 6298.3 6346.5 6369.6 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#1] ext.html Cycles:180 Average:39585.34 Median:19756.91 stddev:57511.18 (291.1%) stddev-sans-first:57598.82 03:47:52 INFO - PID 25738 | Values: 811.5 850.9 870.2 874.8 1146.4 31428.2 43281.4 44349.0 44373.1 44535.8 44190.3 44516.0 44644.6 44662.8 44677.8 7202.0 7700.4 7810.8 7813.1 7824.0 7645.1 7728.1 7756.4 7758.5 7761.3 7716.3 7768.2 7779.1 7781.9 7783.3 7728.3 7738.3 7744.5 7767.8 7770.1 7593.8 7656.9 7661.6 7662.7 7667.3 39961.4 40139.2 40157.4 40195.6 40318.0 3589.9 3626.5 3627.7 3634.5 3635.3 32405.2 32667.7 32673.3 32752.7 32791.3 5097.5 5097.8 5120.7 5135.4 5136.7 184946.0 184965.0 184983.0 185629.0 185695.0 51238.7 51267.5 51286.0 51318.7 51391.7 53325.7 53418.0 53581.5 53663.5 53685.7 15713.0 15913.5 15922.4 15951.1 15964.4 11667.5 12035.6 12760.8 12811.7 12850.0 15106.8 15251.4 15340.4 15409.8 15410.7 5833.9 5998.3 6132.8 6137.1 6151.4 1008.8 1022.9 1026.7 1034.0 1036.9 22925.9 23673.2 23779.3 23782.4 23811.7 1055.7 1079.8 1098.8 1105.2 1130.0 12118.9 12458.8 12651.7 12858.4 12896.0 249229.0 250295.0 252850.0 253105.0 253422.0 55788.7 56256.2 56360.7 56416.2 56491.4 1446.6 1459.1 1478.3 1486.2 1515.1 23363.3 23408.0 23429.6 23528.6 23665.4 39427.6 39596.8 39798.4 39848.4 39861.2 221044.0 221323.0 222020.0 222676.0 224112.0 31186.5 33426.8 34939.0 35097.0 35148.8 44885.0 45332.8 45615.1 45849.1 45997.0 34076.3 34343.1 34432.3 34464.0 34917.7 33127.8 33811.3 33841.0 34305.7 34796.1 36519.8 36529.0 36901.4 37030.8 37116.3 32402.2 32875.7 34288.7 35923.9 36104.5 25186.2 25391.2 25942.7 26088.5 26656.7 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#2] jquery.html Cycles:180 Average:36681.74 Median:23408.18 stddev:87111.71 (372.1%) stddev-sans-first:87313.86 03:47:52 INFO - PID 25738 | Values: 560.0 561.6 573.5 578.7 592.6 22174.9 22509.2 23163.4 23226.0 23227.2 27340.5 27969.9 27974.9 28005.4 28132.2 6946.9 7110.9 7111.9 7114.6 7120.1 6860.4 6935.8 7173.7 7207.2 7220.2 7226.1 7231.2 7231.3 7232.7 7237.2 7188.6 7188.6 7188.9 7212.0 7212.6 7054.8 7065.4 7066.4 7072.1 7079.9 30790.5 31713.4 32530.2 32677.2 32744.5 1964.3 1992.9 1994.0 1995.6 1998.2 21122.8 21741.0 21770.2 21797.0 21840.5 2311.3 2494.1 2502.9 2524.5 2526.7 140673.0 143716.0 144312.3 144645.0 144970.3 15158.8 15159.8 15341.9 15529.4 15862.7 24246.0 24394.4 24418.6 24450.0 24491.5 10044.8 10200.8 10482.2 10545.6 10724.4 8450.6 8855.7 9443.8 9558.3 9656.6 9107.9 9362.6 9479.9 9618.4 9773.5 2662.6 2696.5 2774.2 2797.6 2804.9 949.9 952.7 964.7 968.8 969.7 19966.6 19978.8 20248.8 20492.9 20776.1 1004.6 1007.1 1017.6 1019.1 1023.5 11177.7 11342.5 11407.6 11495.8 11557.4 459363.0 496234.0 537005.0 538385.0 547448.0 116864.0 121215.0 123421.8 124796.0 127827.0 1255.5 1261.2 1294.7 1304.7 1305.5 20850.3 21173.7 21322.8 21607.1 21670.0 59270.1 59685.4 60037.4 60429.1 61832.0 78216.0 78305.6 78460.0 78757.0 78796.0 14641.6 15036.1 15108.6 15115.1 15116.0 23589.2 24070.2 24177.8 24186.8 24240.6 18373.4 18401.6 18429.2 18496.0 18593.9 16890.2 17195.0 17730.2 17829.0 17909.9 17477.1 17576.6 17616.5 17806.5 19197.2 14708.9 14868.1 14883.6 15043.0 15080.2 18040.9 18251.6 18397.7 19224.4 19374.9 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#3] mootools.html Cycles:180 Average:8960.83 Median:2565.56 stddev:6150.81 (239.7%) stddev-sans-first:6141.37 03:47:52 INFO - PID 25738 | Values: 1334.2 1401.2 1407.8 1419.8 1425.0 12334.8 13323.9 14108.6 14129.6 14158.2 12448.9 14231.5 14623.5 14625.2 14671.6 2618.9 2667.1 2668.2 2676.4 2676.9 2565.4 2582.5 2666.8 2670.5 2684.5 2725.7 2745.8 2751.5 2753.6 2756.8 2565.7 2674.3 2693.3 2700.3 2702.1 2560.1 2566.1 2579.0 2655.5 2706.3 14316.3 14424.7 14494.8 14527.1 14532.6 7639.7 7939.0 7940.4 7942.2 7948.5 5147.8 5181.8 5293.2 5360.4 5360.7 1864.2 1869.9 1905.4 1924.1 1928.5 23502.9 23609.6 23682.3 23726.2 23762.8 6322.3 6372.1 6480.4 6545.5 6677.2 16309.3 16463.3 16486.9 16487.4 16487.7 7456.4 7606.7 7609.8 7611.0 7625.0 6727.5 6993.1 7042.1 7113.9 7154.8 5046.2 5187.6 5193.7 5193.9 5276.3 1386.1 1412.7 1467.4 1485.9 1528.8 932.9 955.8 956.6 958.9 966.5 8021.7 8202.8 8336.2 8366.9 8387.6 975.2 1000.1 1027.8 1038.4 1043.4 5242.4 5253.2 5259.6 5312.0 5358.5 19505.3 19774.0 20488.6 20593.9 20613.1 19738.0 20100.6 20215.4 20355.5 20378.5 10152.6 10836.7 10852.0 10872.1 10882.5 8396.4 8598.4 8625.9 8936.3 9200.4 17599.9 17603.1 17761.9 17782.8 17941.4 17675.5 18067.7 18235.6 18303.2 18787.5 11540.4 11679.6 11905.9 11917.5 11918.2 13140.9 13412.7 13423.0 13431.7 13441.1 10937.4 10990.8 11172.8 11199.8 11448.6 10403.9 10677.4 10711.2 10805.0 10928.6 9511.2 9548.6 9745.6 9850.1 9852.3 7270.4 7329.6 7340.4 7374.4 7374.7 7379.9 7450.7 7465.7 7529.2 7536.2 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#4] prototype.html Cycles:180 Average:5561.86 Median:6178.43 stddev:1584.52 (25.6%) stddev-sans-first:1542.55 03:47:52 INFO - PID 25738 | Values: 489.5 499.7 519.2 524.7 526.8 6187.8 6197.8 6206.4 6234.3 6285.8 6018.3 6123.6 6145.3 6191.5 6194.3 4943.6 4957.2 4958.8 4963.6 5000.9 4870.4 4907.8 4940.3 4982.5 4993.5 4868.2 4954.2 4977.0 4993.6 4998.2 4960.1 4977.6 4995.6 5006.5 5021.1 4482.7 4483.5 4486.2 4487.5 4492.8 6153.5 6172.0 6174.4 6182.5 6208.5 5693.0 5723.4 5737.8 5776.5 5799.7 6583.3 6613.4 6622.0 6692.4 6717.9 4825.2 4863.6 4864.5 4869.2 4876.1 6955.2 6977.9 6991.3 7042.9 7061.8 4967.4 4968.2 4970.6 4984.8 5042.4 5027.8 5048.5 5049.5 5068.8 5084.7 5713.7 5746.1 5767.6 5781.9 5785.5 6534.8 6702.9 6735.7 6813.1 6817.1 1696.7 1739.2 1745.6 1758.3 1761.4 1181.8 1185.2 1204.5 1206.9 1218.7 5786.2 5801.4 5812.1 5844.7 5879.4 6686.2 6794.2 6802.3 6843.5 6858.7 5751.5 5769.2 5786.3 5839.9 5859.2 3565.8 3589.9 3639.9 3647.4 3654.8 6424.1 6510.7 6592.5 6625.6 6631.7 6998.5 7016.3 7018.5 7069.4 7084.9 6466.7 6545.0 6559.2 6593.4 6594.3 6850.9 6859.8 6891.1 6930.8 6941.7 6765.1 6789.2 6829.2 6862.3 6879.8 6542.8 6640.9 6647.0 6681.6 6682.4 4929.8 4934.4 4945.3 4946.4 4954.1 6847.3 6854.9 6880.6 6915.6 6926.2 6615.4 6616.4 6617.7 6648.4 6664.7 6651.0 6655.2 6656.2 6667.7 6670.6 6241.9 6462.6 6465.4 6559.4 6572.9 6500.9 6574.9 6644.8 6677.2 6734.2 6289.4 6339.6 6354.6 6410.0 6434.5 03:47:52 INFO - PID 25738 | 03:47:52 INFO - PID 25738 | [#5] yui.html Cycles:180 Average:24469.62 Median:20161.95 stddev:32798.92 (162.7%) stddev-sans-first:32843.21 03:47:52 INFO - PID 25738 | Values: 907.9 917.3 923.6 931.5 934.7 19195.6 20002.8 20111.6 20133.1 20190.8 20527.8 21926.6 22012.9 22070.4 22240.9 1047.5 1054.8 1055.1 1055.8 1055.8 1053.6 1058.7 1059.2 1059.7 1060.2 1113.7 1116.5 1117.9 1128.5 1128.6 1108.9 1109.2 1109.7 1110.1 1121.8 818.4 818.6 818.7 819.0 819.3 19556.5 19820.1 19980.5 20834.2 20951.9 21548.6 21625.6 21675.9 21982.3 22283.8 15690.1 15800.7 16177.4 16299.4 16429.4 3618.8 3652.2 3653.6 3653.7 3654.4 126510.0 127068.0 128227.4 128815.4 129449.0 16956.0 16959.8 17836.6 18354.4 18467.8 32947.7 33391.3 33447.2 33758.3 33853.3 7530.4 7618.5 8653.5 8928.3 8932.2 4118.4 4210.8 4234.9 4243.7 4245.9 5188.9 5214.0 5263.2 5309.5 5374.8 1031.3 1038.4 1051.7 1056.1 1059.0 678.1 692.6 696.6 705.4 711.6 11346.8 11756.2 12137.2 12627.3 12655.7 643.3 647.3 650.7 652.9 656.4 5518.5 5531.6 6029.6 6141.7 6211.7 111708.0 111897.0 114545.0 115264.0 116927.0 95229.0 96307.5 99621.0 102176.5 105565.0 84535.6 84660.0 84873.9 86976.0 88713.1 12936.9 13274.2 13279.3 13414.4 13479.1 39467.6 39860.8 40019.8 40181.8 40551.4 72339.3 72487.6 73439.6 73917.0 74812.0 18844.7 20431.0 20488.0 20522.8 20545.5 18536.2 19455.7 21470.1 22134.0 22161.0 18634.5 18750.5 18863.2 19200.8 19628.4 19654.3 19739.0 19862.5 19883.3 20283.2 17378.9 18534.3 19164.6 19353.7 19543.2 13037.9 13996.2 14048.6 14660.7 14707.6 14184.4 14560.9 14668.3 14931.9 15439.2 03:47:52 INFO - PID 25738 | -------- Summary: end -------- 03:47:52 INFO - PID 25738 | 03:47:52 INFO - TEST-INFO | 25738: exit 0 03:47:52 INFO - TEST-OK | dromaeo_css | took 1111638ms 03:47:52 INFO - TEST-START | kraken 03:47:52 INFO - Initialising browser for kraken test... 03:47:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53656/getInfo.html -profile /tmp/tmpUL5aNB/profile 03:47:52 INFO - TEST-INFO | started process 26105 (/builds/slave/test/build/application/firefox/firefox http://localhost:53656/getInfo.html) 03:47:59 INFO - TEST-INFO | 26105: exit 0 03:47:59 INFO - Browser initialized. 03:47:59 INFO - Running cycle 1/1 for kraken test... 03:47:59 INFO - TEST-INFO | started process 26318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUL5aNB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:00 INFO - PID 26318 | 03:48:00 INFO - PID 26318 | (/builds/slave/test/build/application/firefox/firefox:26366): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:00 INFO - PID 26318 | 03:48:10 INFO - PID 26318 | RSS: Main: 164282368 03:48:10 INFO - PID 26318 | 03:48:13 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:14 INFO - PID 26318 | RSS: Main: 171458560 03:48:14 INFO - PID 26318 | 03:48:16 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-dft) 03:48:17 INFO - PID 26318 | RSS: Main: 171593728 03:48:17 INFO - PID 26318 | 03:48:20 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-fft) 03:48:20 INFO - PID 26318 | RSS: Main: 166039552 03:48:20 INFO - PID 26318 | 03:48:23 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-oscillator) 03:48:23 INFO - PID 26318 | RSS: Main: 166506496 03:48:23 INFO - PID 26318 | 03:48:25 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:26 INFO - PID 26318 | RSS: Main: 166600704 03:48:26 INFO - PID 26318 | 03:48:29 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:30 INFO - PID 26318 | RSS: Main: 168505344 03:48:30 INFO - PID 26318 | 03:48:33 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:34 INFO - PID 26318 | RSS: Main: 169451520 03:48:34 INFO - PID 26318 | 03:48:37 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53656/tests/kraken/driver.html?testName=json-parse-financial) 03:48:37 INFO - PID 26318 | RSS: Main: 170467328 03:48:37 INFO - PID 26318 | 03:48:39 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:40 INFO - PID 26318 | RSS: Main: 170237952 03:48:40 INFO - PID 26318 | 03:48:41 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:42 INFO - PID 26318 | RSS: Main: 169848832 03:48:42 INFO - PID 26318 | 03:48:44 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:45 INFO - PID 26318 | RSS: Main: 170172416 03:48:45 INFO - PID 26318 | 03:48:47 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:48 INFO - PID 26318 | RSS: Main: 170291200 03:48:48 INFO - PID 26318 | 03:48:51 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:52 INFO - PID 26318 | RSS: Main: 170717184 03:48:52 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53656/tests/kraken/driver.html?testName=ai-astar) 03:48:54 INFO - PID 26318 | RSS: Main: 171991040 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | __start_tp_report 03:48:54 INFO - PID 26318 | _x_x_mozilla_page_load 03:48:54 INFO - PID 26318 | _x_x_mozilla_page_load_details 03:48:54 INFO - PID 26318 | |i|pagename|runs| 03:48:54 INFO - PID 26318 | |0;ai-astar;101;107;104;108;112;108;109;101;108;108 03:48:54 INFO - PID 26318 | |1;audio-beat-detection;150;120;146;171;117;148;147;119;172;119 03:48:54 INFO - PID 26318 | |2;audio-dft;163;163;162;163;164;165;167;164;164;166 03:48:54 INFO - PID 26318 | |3;audio-fft;76;77;76;180;76;74;75;74;155;76 03:48:54 INFO - PID 26318 | |4;audio-oscillator;79;79;135;79;79;79;133;79;79;126 03:48:54 INFO - PID 26318 | |5;imaging-gaussian-blur;114;113;113;113;114;116;113;114;113;113 03:48:54 INFO - PID 26318 | |6;imaging-darkroom;151;150;150;152;152;152;151;151;151;150 03:48:54 INFO - PID 26318 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;94;94 03:48:54 INFO - PID 26318 | |8;json-parse-financial;54;54;53;54;54;55;53;53;53;54 03:48:54 INFO - PID 26318 | |9;json-stringify-tinderbox;55;56;56;55;55;56;55;55;55;55 03:48:54 INFO - PID 26318 | |10;stanford-crypto-aes;78;85;77;78;79;80;78;77;80;79 03:48:54 INFO - PID 26318 | |11;stanford-crypto-ccm;124;123;125;122;131;123;123;132;125;161 03:48:54 INFO - PID 26318 | |12;stanford-crypto-pbkdf2;180;181;182;196;183;185;188;178;187;189 03:48:54 INFO - PID 26318 | |13;stanford-crypto-sha256-iterative;70;68;79;70;68;67;70;71;67;69 03:48:54 INFO - PID 26318 | __end_tp_report 03:48:54 INFO - PID 26318 | __start_cc_report 03:48:54 INFO - PID 26318 | _x_x_mozilla_cycle_collect,970 03:48:54 INFO - PID 26318 | __end_cc_report 03:48:54 INFO - PID 26318 | __startTimestamp1502794134397__endTimestamp 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | ------- Summary: start ------- 03:48:54 INFO - PID 26318 | Number of tests: 14 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#0] ai-astar Cycles:10 Average:106.60 Median:108.00 stddev:3.53 (3.3%) stddev-sans-first:3.11 03:48:54 INFO - PID 26318 | Values: 101.0 107.0 104.0 108.0 112.0 108.0 109.0 101.0 108.0 108.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.50 stddev:21.18 (14.4%) stddev-sans-first:22.21 03:48:54 INFO - PID 26318 | Values: 150.0 120.0 146.0 171.0 117.0 148.0 147.0 119.0 172.0 119.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 03:48:54 INFO - PID 26318 | Values: 163.0 163.0 162.0 163.0 164.0 165.0 167.0 164.0 164.0 166.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:39.25 (51.6%) stddev-sans-first:41.09 03:48:54 INFO - PID 26318 | Values: 76.0 77.0 76.0 180.0 76.0 74.0 75.0 74.0 155.0 76.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.38 (32.1%) stddev-sans-first:26.27 03:48:54 INFO - PID 26318 | Values: 79.0 79.0 135.0 79.0 79.0 79.0 133.0 79.0 79.0 126.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 03:48:54 INFO - PID 26318 | Values: 114.0 113.0 113.0 113.0 114.0 116.0 113.0 114.0 113.0 113.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:48:54 INFO - PID 26318 | Values: 151.0 150.0 150.0 152.0 152.0 152.0 151.0 151.0 151.0 150.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:48:54 INFO - PID 26318 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 03:48:54 INFO - PID 26318 | Values: 54.0 54.0 53.0 54.0 54.0 55.0 53.0 53.0 53.0 54.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 03:48:54 INFO - PID 26318 | Values: 55.0 56.0 56.0 55.0 55.0 56.0 55.0 55.0 55.0 55.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:2.33 (3.0%) stddev-sans-first:2.44 03:48:54 INFO - PID 26318 | Values: 78.0 85.0 77.0 78.0 79.0 80.0 78.0 77.0 80.0 79.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:125.00 stddev:11.79 (9.4%) stddev-sans-first:12.37 03:48:54 INFO - PID 26318 | Values: 124.0 123.0 125.0 122.0 131.0 123.0 123.0 132.0 125.0 161.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:186.00 stddev:5.30 (2.8%) stddev-sans-first:5.32 03:48:54 INFO - PID 26318 | Values: 180.0 181.0 182.0 196.0 183.0 185.0 188.0 178.0 187.0 189.0 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:3.48 (5.0%) stddev-sans-first:3.69 03:48:54 INFO - PID 26318 | Values: 70.0 68.0 79.0 70.0 68.0 67.0 70.0 71.0 67.0 69.0 03:48:54 INFO - PID 26318 | -------- Summary: end -------- 03:48:54 INFO - PID 26318 | 03:48:54 INFO - PID 26318 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:48:55 INFO - TEST-INFO | 26318: exit 0 03:48:55 INFO - TEST-OK | kraken | took 62168ms 03:48:55 INFO - SUITE-END | took 1173s 03:48:55 INFO - Completed test suite (00:19:34) 03:48:55 INFO - javascript benchmark 03:48:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8661.186129196712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.227214332489, 3171.8414079296035, 3197.504386820043, 3206.919827004326, 3215.581974343335, 6073.696315184246, 6221.533384996126, 6249.812505624838, 6270.341614130513, 6274.56078074535, 6009.969950150254, 6066.484348830344, 6078.118672792442, 6080.543959203055, 6124.203853499039, 5552.77788888444, 5566.165075238706, 5576.358718747335, 5584.441555844423, 5586.748596313176, 5600.467955544217, 5612.887742245152, 5623.746931388097, 5638.238837756912, 5772.971135144339, 5717.085266357383, 5753.798617048405, 5782.421757824226, 5783.855403614902, 5789.942100579004, 5633.0987042073075, 5662.122371032497, 5743.9712801435935, 5757.596968212227, 5772.913406298909, 5449.01917654822, 5483.0, 5571.9721401393135, 5662.6036177467595, 5682.857928551778, 6016.308124565688, 6105.8168254952425, 6148.1392605035335, 6183.041628547582, 6186.164867742842, 6479.514036447285, 6507.251666058417, 6604.669766511655, 6616.86766264672, 6617.900731489031, 6501.219853617549, 6545.476361891037, 6602.9669851650915, 6705.329467053304, 6711.194656641185, 6180.072989051633, 6193.0091185410565, 6194.566380353423, 6205.503559715212, 6210.254769427697, 6818.761343352959, 6910.48171387148, 6913.723451061901, 6914.0666010088, 6935.098437203132, 6507.934920650828, 6514.283428822826, 6554.180727409074, 6586.604803711793, 6622.86754264912, 6443.065755465431, 6522.967385163139, 6523.249826269945, 6545.312742162099, 6587.341265873471, 6460.095586617877, 6471.288158302583, 6488.643124628096, 6491.837704057436, 6492.09110724499, 6439.710213040425, 6542.149520562297, 6561.2782593914635, 6635.701393437307, 6643.003549467522, 5373.677579345252, 5430.456954304538, 5438.75525601341, 5440.265564148868, 5443.727813609304, 4570.337301091389, 4653.906921861611, 4658.208104622222, 4670.346151538787, 4671.813127474863, 5584.664920104807, 5658.009848276535, 5664.518515926193, 5769.221155144086, 5829.358770535237, 6584.30864759203, 6607.339266073354, 6613.4709223262025, 6616.172978377703, 6620.966895165493, 5623.550115990711, 5669.177969194526, 5690.260266165372, 5693.0, 5697.686627235542, 5850.795222167204, 5931.555133365015, 5941.257342832146, 5946.821595352147, 5952.583319167703, 6450.225972883284, 6462.450691691259, 6479.481641468671, 6571.474282057424, 6573.80278591643, 6504.544681872413, 6601.801945941629, 6650.600963941985, 6748.493862960396, 6771.119754431892, 6421.775237866652, 6430.131932189094, 6450.225972883096, 6461.0, 6467.191601049869, 6546.639934803631, 6556.377144171296, 6563.540552161494, 6572.8356791080605, 6573.375529324707, 6567.211934567882, 6641.468682505485, 6711.731530738716, 6723.125993620798, 6732.528722989344, 6235.594686345373, 6320.146780184617, 6402.455791257609, 6409.230892292955, 6498.285188629342, 6469.5794773339585, 6474.352564743676, 6480.287168411565, 6489.902651460137, 6502.544821862424, 6356.11014457967, 6406.871862562816, 6453.193350831146, 6477.902831457626, 6491.707873145625, 6438.935610643834, 6473.449756770538, 6564.4420224281475, 6573.882439985309, 6589.439897608565, 6055.091736239599, 6172.907406388818, 6298.275698294755, 6346.492280617632, 6369.617822930639], "value": 6044.6659569661715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.4563242627439, 850.8638617821148, 870.2124577257582, 874.8337815814995, 1146.4267866066966, 31428.214294642617, 43281.35077973829, 44349.0, 44373.11253774923, 44535.77732111343, 44190.33714494285, 44516.0, 44644.553554464444, 44662.77668611652, 44677.77661111698, 7201.9557164211155, 7700.383969282458, 7810.76567702967, 7813.062432508107, 7823.960880195591, 7645.120811106738, 7728.111267204287, 7756.3794896408435, 7758.495697779655, 7761.262680045386, 7716.2669546393, 7768.184340644236, 7779.105402878657, 7781.922180778176, 7783.260590243946, 7728.304452599265, 7738.342240909529, 7744.49660772048, 7767.8058048548955, 7770.106437759673, 7593.81015474612, 7656.923430765677, 7661.578613176273, 7662.693492260303, 7667.309942105181, 39961.400578991335, 40139.19721605581, 40157.39763903544, 40195.59804401977, 40318.0, 3589.892303230907, 3626.528551288342, 3627.6735093841417, 3634.509341238925, 3635.291118231946, 32405.189870253198, 32667.6733232667, 32673.346533069205, 32752.6724732752, 32791.344173116406, 5097.464766199532, 5097.8215762448135, 5120.667156634807, 5135.35808023997, 5136.743162841843, 184946.0, 184965.0, 184983.0, 185629.0, 185695.0, 51238.743806281476, 51267.48732512702, 51286.0, 51318.74340628273, 51391.7430412853, 53325.73337133289, 53418.0, 53581.46418535765, 53663.463365365846, 53685.731571341894, 15713.0, 15913.522594322189, 15922.442714504938, 15951.122688252257, 15964.441244556385, 11667.533298668128, 12035.638930832089, 12760.80858787119, 12811.679708007374, 12850.0, 15106.848931510543, 15251.389944402099, 15340.386384544494, 15409.84590154084, 15410.691786164214, 5833.854153646108, 5998.340182579913, 6132.816015519542, 6137.140800287963, 6151.446369826737, 1008.8385858262643, 1022.8619136416637, 1026.7022563456662, 1034.0331789776583, 1036.896310368957, 22925.88537057304, 23673.171438999896, 23779.286621401385, 23782.405439864142, 23811.730009514933, 1055.6938487838595, 1079.8014204233295, 1098.8296813993684, 1105.160078340467, 1130.0451118804597, 12118.878811211951, 12458.75082498345, 12651.683707907376, 12858.357082145856, 12896.032797540034, 249229.0, 250295.0, 252850.0, 253105.0, 253422.0, 55788.72105639446, 56256.15615765767, 56360.71819640876, 56416.15375769367, 56491.43508564862, 1446.5732608880405, 1459.0953608762422, 1478.2830327291256, 1486.1528928510645, 1515.0606623893036, 23363.299101026998, 23408.0, 23429.648555271342, 23528.647070293617, 23665.40836479102, 39427.60572394239, 39596.802015989735, 39798.403023955245, 39848.40227396534, 39861.20277594374, 221044.0, 221323.0, 222020.0, 222676.0, 224112.0, 31186.532202017443, 33426.83286583552, 34939.0, 35097.0, 35148.82425587856, 44885.0, 45332.773336133105, 45615.08769824651, 45849.08301834011, 45997.0, 34076.31847363088, 34343.141421464665, 34432.31135377228, 34464.0, 34917.650823491436, 33127.83436082804, 33811.3237735239, 33841.0, 34305.656943430244, 34796.13009674779, 36519.81740091283, 36529.0, 36901.44647830231, 37030.8148459256, 37116.25767484689, 32402.189945251557, 32875.67124328822, 34288.65711342855, 35923.92228233157, 36104.458433123, 25186.24441266765, 25391.15375427977, 25942.740572594786, 26088.478230435663, 26656.733432666202], "value": 17727.282435141307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9916001259979, 561.571204540363, 573.5325709546719, 578.7106446776613, 592.576307939823, 22174.88912555439, 22509.212177573787, 23163.420914477127, 23226.0, 23227.187048453306, 27340.45319093617, 27969.860150699216, 27974.860125699393, 28005.439891202164, 28132.156035318923, 6946.895796563043, 7110.928890711104, 7111.928880711204, 7114.608696521689, 7120.145582530104, 6860.382565569098, 6935.826604334881, 7173.6771845267085, 7207.207207207203, 7220.205777364486, 7226.060612120444, 7231.240719724432, 7231.276872312779, 7232.746853860116, 7237.240089790575, 7188.568685878811, 7188.568685878838, 7188.892166617505, 7211.963940180318, 7212.567245965232, 7054.788356349318, 7065.43476521877, 7066.364027237521, 7072.08062951813, 7079.89380159298, 30790.53814192789, 31713.365732685448, 32530.18674533132, 32677.18307042319, 32744.508832367534, 1964.3419454482766, 1992.8804271743597, 1993.950151246216, 1995.630808300469, 1998.1707591349573, 21122.788772112388, 21741.0, 21770.238041668625, 21797.0, 21840.453988650253, 2311.2603966730653, 2494.052260141153, 2502.862342571158, 2524.5329614021466, 2526.6715327007555, 140673.0, 143716.0, 144312.2784386082, 144645.0, 144970.27514862464, 15158.772618410732, 15159.848401516065, 15341.923290383476, 15529.378824847106, 15862.682746345008, 24246.0, 24394.39014024628, 24418.633720494207, 24450.0, 24491.510169796504, 10044.799104017879, 10200.846987295197, 10482.161427085815, 10545.630902918361, 10724.356538607708, 8450.577471126418, 8855.690050848189, 9443.763905902408, 9558.330916835894, 9656.613735450503, 9107.863382049274, 9362.62549498026, 9479.857802132974, 9618.374805637612, 9773.511324433892, 2662.613920981447, 2696.5146273670534, 2774.195483309858, 2797.59434881941, 2804.9158525244275, 949.9477528735848, 952.6522819170953, 964.71058682395, 968.8352979993418, 969.7381706939087, 19966.60066798656, 19978.800211997986, 20248.804018299415, 20492.897535512227, 20776.06507707157, 1004.6031817432073, 1007.1439276614818, 1017.5675337981328, 1019.0980981831133, 1023.4831410137981, 11177.72055698614, 11342.546298148147, 11407.600733974272, 11495.770084598262, 11557.364344961108, 459363.0, 496234.0, 537005.0, 538385.0, 547448.0, 116864.0, 121215.0, 123421.76578234103, 124796.0, 127827.0, 1255.453877563263, 1261.224347026572, 1294.695746499572, 1304.6868751499762, 1305.549585393038, 20850.270240542115, 21173.682394763782, 21322.78677213208, 21607.135714571243, 21670.0, 59270.110948336674, 59685.40314596798, 60037.39962600493, 60429.0935635957, 61832.0, 78216.0, 78305.60847195728, 78460.0, 78757.0, 78796.0, 14641.633959151106, 15036.120484939383, 15108.640222380038, 15115.093094414371, 15116.0, 23589.174378896656, 24070.157544485857, 24177.75822241755, 24186.758132419156, 24240.63639045451, 18373.356932507297, 18401.63196736031, 18429.170687318834, 18496.0, 18593.90703046476, 16890.239939203013, 17195.0, 17730.202140903948, 17829.0, 17909.910450447664, 17477.12614369251, 17576.648467030842, 17616.471505854333, 17806.46580602584, 19197.232110715973, 14708.852911471176, 14868.107913525224, 14883.627909302355, 15043.0, 15080.170590617183, 18040.909795450938, 18251.634967300844, 18397.72403413923, 19224.423267302005, 19374.903125484845], "value": 12528.86885287596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.1728128560292, 1401.201315250307, 1407.7958695989082, 1419.7870319452074, 1425.0405692173258, 12334.814977775319, 13323.866761332396, 14108.576742697709, 14129.57611271661, 14158.221297828615, 12448.875511244885, 14231.501897433565, 14623.488177913776, 14625.195614241213, 14671.559853204395, 2618.882150303241, 2667.146513115804, 2668.159529748123, 2676.4245687177254, 2676.892924283036, 2565.422779874523, 2582.548054090536, 2666.799990000748, 2670.4659068186343, 2684.476527077221, 2725.6592925884265, 2745.766609838166, 2751.5184842652557, 2753.5869619557025, 2756.75189232969, 2565.691497336353, 2674.277944954861, 2693.2593536777445, 2700.297922540144, 2702.094798242591, 2560.129555950967, 2566.114690431798, 2579.019972410472, 2655.495455863399, 2706.2557796605893, 14316.284185790773, 14424.71150576993, 14494.782578261334, 14527.128372297697, 14532.564023079325, 7639.6944122235045, 7938.960305198495, 7940.404469664741, 7942.245486678757, 7948.523088614644, 5147.768350424202, 5181.81863634771, 5293.153095504739, 5360.391882435254, 5360.731963401853, 1864.2170288478735, 1869.8971556564384, 1905.4188472515877, 1924.0764433072063, 1928.5371510837438, 23502.882485587463, 23609.645855312185, 23682.289531313916, 23726.169584064646, 23762.762372376226, 6322.304546499881, 6372.088373487935, 6480.416762491398, 6545.541812073205, 6677.165354330708, 16309.266083026292, 16463.259153338127, 16486.939132608422, 16487.422940197277, 16487.67024659524, 7456.40348772097, 7606.657700403495, 7609.847803043908, 7610.961945190239, 7625.0, 6727.495437842182, 6993.055937448379, 7042.084529011196, 7113.89329160063, 7154.785356439315, 5046.21783623539, 5187.610929180327, 5193.662411943212, 5193.92209116856, 5276.314079169761, 1386.1198139181693, 1412.6821465170256, 1467.4057006912217, 1485.89598728088, 1528.8318284988643, 932.9067093290753, 955.81361634482, 956.5695437053354, 958.8945216026232, 966.5070813884829, 8021.719239826578, 8202.753917382488, 8336.166383361615, 8366.916330836613, 8387.580620968927, 975.1564896364594, 1000.1049061090283, 1027.8304079826744, 1038.3977293169944, 1043.4417586591137, 5242.370915490165, 5253.212018197224, 5259.60552958522, 5312.0, 5358.517733404013, 19505.31731389423, 19774.0, 20488.590228195353, 20593.89703051505, 20613.07241174151, 19738.0, 20100.597988040157, 20215.393538193584, 20355.491112722302, 20378.490537736674, 10152.593896244067, 10836.729081773019, 10852.0, 10872.130229581615, 10882.510287037103, 8396.370272229486, 8598.441101328393, 8625.87061194095, 8936.28509719234, 9200.401973871676, 17599.85600935935, 17603.11984400749, 17761.911190444484, 17782.822171778633, 17941.372051978116, 17675.469735907944, 18067.728984065514, 18235.635287294444, 18303.17635706423, 18787.530311742317, 11540.422978851191, 11679.591214307458, 11905.940470297593, 11917.463714132711, 11918.165728398928, 13140.934295328461, 13412.664683382993, 13423.0, 13431.664208394868, 13441.126326788728, 10937.398443085707, 10990.780184396428, 11172.832407513732, 11199.832002520132, 11448.599299024494, 10403.94798026005, 10677.359358438518, 10711.196660250356, 10805.0, 10928.562857485611, 9511.191548718436, 9548.57031433601, 9745.610175593181, 9850.064243896819, 9852.310338276251, 7270.418366530559, 7329.596872171868, 7340.449466290156, 7374.410047196104, 7374.705011799468, 7379.889301660587, 7450.739224127129, 7465.701371945279, 7529.247075292427, 7536.171021187774], "value": 6530.575465672201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.4695787831512, 499.66838375728685, 519.2237604780853, 524.6773234460805, 526.8050821196157, 6187.783427580036, 6197.845053873644, 6206.410391012852, 6234.283057448395, 6285.811425657238, 6018.307894592123, 6123.550579768095, 6145.293291271505, 6191.5356348273945, 6194.349593292707, 4943.604511639061, 4957.206846904496, 4958.776855041514, 4963.553280204781, 5000.949990500085, 4870.43989941156, 4907.82822601209, 4940.308356830046, 4982.487346420783, 4993.475685053071, 4868.221084626461, 4954.182559877616, 4976.950230497685, 4993.550580447759, 4998.175301075318, 4960.107180707471, 4977.626677999165, 4995.6003519718515, 5006.499350065001, 5021.121303771862, 4482.731036137842, 4483.461984561841, 4486.237339652267, 4487.506374298824, 4492.7528985905765, 6153.476954458876, 6171.9691401542705, 6174.382561743834, 6182.474489668339, 6208.540992866673, 5693.0, 5723.399043100456, 5737.827865164052, 5776.508996735282, 5799.681017544033, 6583.341665833426, 6613.404793568602, 6622.0, 6692.393825481898, 6717.899231511531, 4825.20384136617, 4863.562279394836, 4864.464908860023, 4869.220924652074, 4876.122297986361, 6955.1653801544135, 6977.860442791167, 6991.265917078685, 7042.929570704278, 7061.823454413578, 4967.428745694219, 4968.22992436173, 4970.627202959792, 4984.800607975713, 5042.42012168598, 5027.773750181177, 5048.545630893163, 5049.495050494995, 5068.797248110108, 5084.694918304914, 5713.74288157034, 5746.13807928814, 5767.5581104723815, 5781.942180578225, 5785.50823180026, 6534.836629084216, 6702.899456508157, 6735.6968936397, 6813.148356455443, 6817.113775209191, 1696.6850690714796, 1739.2347367158409, 1745.5723347779876, 1758.34062226665, 1761.3923196497187, 1181.8050021746315, 1185.2177562808506, 1204.4820727087435, 1206.8612109607507, 1218.7264308797328, 5786.1974561114175, 5801.3908539602735, 5812.128180772918, 5844.6785426801935, 5879.3826648202175, 6686.1642294713165, 6794.218664853506, 6802.285759995129, 6843.520953533304, 6858.6570671466225, 5751.539876809845, 5769.221155144086, 5786.3056433228285, 5839.883202335929, 5859.1797148399255, 3565.839537220779, 3589.94615080774, 3639.8544058237903, 3647.4164133738473, 3654.8172591370326, 6424.072778166625, 6510.739570417225, 6592.538522303393, 6625.602463852184, 6631.701573429207, 6998.545094568837, 7016.333448322402, 7018.473614478935, 7069.434445244368, 7084.858302833914, 6466.741330346734, 6544.967275163689, 6559.180102487189, 6593.406593406617, 6594.340565943463, 6850.9314906850295, 6859.759908403182, 6891.104946139852, 6930.792076237721, 6941.722331106901, 6765.1395866135235, 6789.219239787488, 6829.248782634006, 6862.348076932683, 6879.793606191823, 6542.803715888531, 6640.908113944092, 6647.0, 6681.558997116586, 6682.431993280431, 4929.778159982738, 4934.383202099738, 4945.307656927961, 4946.406431228275, 4954.058728841508, 6847.349501797321, 6854.931450685429, 6880.58716477013, 6915.619640919797, 6926.168859736864, 6615.386922165814, 6616.371444712745, 6617.66911654425, 6648.445814617003, 6664.700088496126, 6650.96909978954, 6655.201375834931, 6656.2345330287635, 6667.699953502201, 6670.599764014175, 6241.937580624136, 6462.644554549545, 6465.353464653497, 6559.442447392025, 6572.882609956415, 6500.869982600227, 6574.901376479261, 6644.767433139817, 6677.165354330708, 6734.191896972395, 6289.352175737969, 6339.619622822645, 6354.586951848115, 6410.0, 6434.45573062471], "value": 5092.016154109328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.8502047162223, 917.3074328881694, 923.5890028937117, 931.4504442378995, 934.7242563443785, 19195.616087678238, 20002.799972000277, 20111.59776804463, 20133.094010769513, 20190.798092019075, 20527.79472205281, 21926.561468770615, 22012.889935550338, 22070.448238794037, 22240.888795556, 1047.5024363427349, 1054.8048611006989, 1055.145332280851, 1055.762453447972, 1055.8099542082423, 1053.5522402978704, 1058.6929790360787, 1059.2161800267786, 1059.6926891201542, 1060.204846365226, 1113.7104352868273, 1116.5087361560886, 1117.944102794861, 1128.5260190719875, 1128.6331942118802, 1108.933463992159, 1109.173665619115, 1109.672646569264, 1110.0897264243283, 1121.8373335866254, 818.4189225649795, 818.5743413425046, 818.7011740714656, 819.0212695828487, 819.2544784246307, 19556.511087222792, 19820.108095135754, 19980.500487487785, 20834.166633334647, 20951.895240523852, 21548.569028619495, 21625.567488650297, 21675.891620541955, 21982.34052978413, 22283.777162228493, 15690.137042462775, 15800.683986320324, 16177.35290588375, 16299.429519966863, 16429.424970126107, 3618.8371523281517, 3652.214773823641, 3653.5798383185743, 3653.725970552193, 3654.397024490956, 126510.0, 127068.0, 128227.35886320508, 128815.35592322072, 129449.0, 16956.0, 16959.830401696072, 17836.643267134845, 18354.449366519028, 18467.81532184661, 32947.67052329494, 33391.33217335639, 33447.163820904185, 33758.32483350319, 33853.32293354168, 7530.43521735872, 7618.504797188165, 8653.480791152551, 8928.285737141014, 8932.19610235082, 4118.361653943643, 4210.831566737296, 4234.894127646833, 4243.724157929724, 4245.915081698348, 5188.948110518922, 5213.973930130325, 5263.210518422191, 5309.548688361455, 5374.758135883894, 1031.3296357367772, 1038.3510306058713, 1051.7055224537141, 1056.1392465140887, 1058.9788204236027, 678.0744284052233, 692.5567636712508, 696.571608460793, 705.3757424679093, 711.6121713666064, 11346.773064538664, 11756.23584467007, 12137.21108127969, 12627.305498197687, 12655.746885062246, 643.3180828321994, 647.2976820150095, 650.677914432359, 652.9085927970089, 656.4289068510332, 5518.475744804237, 5531.640443371168, 6029.638221706711, 6141.692915354214, 6211.720472578745, 111708.0, 111897.0, 114545.0, 115264.0, 116927.0, 95229.0, 96307.51846240724, 99621.0, 102176.48911755542, 105565.0, 84535.577322113, 84660.0, 84873.87815304667, 86976.0, 88713.11286887177, 12936.90036346921, 13274.203547787163, 13279.336033198495, 13414.396352164371, 13479.056466047283, 39467.605323946394, 39860.80069599633, 40019.79990100031, 40181.79909100436, 40551.391729124676, 72339.27660723536, 72487.63756181185, 73439.63280183564, 73917.0, 74812.0, 18844.717329239797, 20431.0, 20488.0, 20522.79477205209, 20545.48636284105, 18536.165872535497, 19455.70816437726, 21470.14119435205, 22134.0, 22161.0, 18634.534136646693, 18750.53123671919, 18863.24547018104, 19200.8079919199, 19628.411147665593, 19654.312099076462, 19739.013049347763, 19862.50343741418, 19883.30408435698, 20283.188672453525, 17378.913105434392, 18534.25862965466, 19164.616707666046, 19353.70969435488, 19543.21827126899, 13037.869621303666, 13996.16023038621, 14048.578542643738, 14660.70678586401, 14707.558773236393, 14184.432622695389, 14560.927195363955, 14668.339924703627, 14931.850681493046, 15439.228038597801], "value": 9455.158240752242, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 104.0, 108.0, 112.0, 108.0, 109.0, 101.0, 108.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 146.0, 171.0, 117.0, 148.0, 147.0, 119.0, 172.0, 119.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 164.0, 165.0, 167.0, 164.0, 164.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 180.0, 76.0, 74.0, 75.0, 74.0, 155.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 79.0, 79.0, 79.0, 133.0, 79.0, 79.0, 126.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 116.0, 113.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 152.0, 152.0, 152.0, 151.0, 151.0, 151.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 53.0, 53.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 85.0, 77.0, 78.0, 79.0, 80.0, 78.0, 77.0, 80.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 125.0, 122.0, 131.0, 123.0, 123.0, 132.0, 125.0, 161.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 182.0, 196.0, 183.0, 185.0, 188.0, 178.0, 187.0, 189.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 79.0, 70.0, 68.0, 67.0, 70.0, 71.0, 67.0, 69.0], "value": 69.9, "unit": "score"}]}]} 03:48:55 INFO - Return code: 0 03:48:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:55 INFO - # TBPL SUCCESS # 03:48:55 INFO - Running post-action listener: _package_coverage_data 03:48:55 INFO - Running post-action listener: _resource_record_post_action 03:48:55 INFO - [mozharness: 2017-08-15 10:48:55.675233Z] Finished run-tests step (success) 03:48:55 INFO - Running post-run listener: _resource_record_post_run 03:48:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435822592; Read time: 20; Write time: 312572 03:48:55 INFO - TinderboxPrint: CPU usage
13.1% 03:48:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:48:55 INFO - TinderboxPrint: I/O write bytes / time
435,822,592 / 312,572 03:48:55 INFO - TinderboxPrint: CPU idle
8,263.5 (86.9%) 03:48:55 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 03:48:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112254976; Read time: 0; Write time: 115868 03:48:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:48:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 323567616; Read time: 0; Write time: 196704 03:48:56 INFO - Running post-run listener: _upload_blobber_files 03:48:56 INFO - Blob upload gear active. 03:48:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:57 INFO - (blobuploader) - INFO - Done attempting. 03:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:04 INFO - (blobuploader) - INFO - Done attempting. 03:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:05 INFO - (blobuploader) - INFO - Done attempting. 03:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:06 INFO - (blobuploader) - INFO - Done attempting. 03:49:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:06 INFO - Return code: 0 03:49:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/168db7430ba8bd0062b4b91661990fdebaaedefe3fd6f113a37bc864d27361f925f313a1ffc680d8ccdfecf9accfb39be424b42db446bcb29908bd9f24aced24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f512c022a9bb54748e6e9f597abe6f3c3e68a0fbc85525909378239bf6d58452965acebbf6d2ed8456bff3829f4f42f4e3af43749b1debf3bbe80b59c798ee30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132f231c7dc36dcbea752e169cc8123f7beb96e2e4eb4d034107f3e510df8b4542fd94c3f237859859e38455534919a50f0c95fd62f7f8a01400f878ffdf94c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9289ead20270f29f01af4e76473f173057dc419bb51cf4458e35d6d812b15692aa2424d8048ac06adf298470d6ad61bfd45f9b428b5d9332a90287bd21b668c2"} 03:49:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:06 INFO - Contents: 03:49:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/168db7430ba8bd0062b4b91661990fdebaaedefe3fd6f113a37bc864d27361f925f313a1ffc680d8ccdfecf9accfb39be424b42db446bcb29908bd9f24aced24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f512c022a9bb54748e6e9f597abe6f3c3e68a0fbc85525909378239bf6d58452965acebbf6d2ed8456bff3829f4f42f4e3af43749b1debf3bbe80b59c798ee30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132f231c7dc36dcbea752e169cc8123f7beb96e2e4eb4d034107f3e510df8b4542fd94c3f237859859e38455534919a50f0c95fd62f7f8a01400f878ffdf94c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9289ead20270f29f01af4e76473f173057dc419bb51cf4458e35d6d812b15692aa2424d8048ac06adf298470d6ad61bfd45f9b428b5d9332a90287bd21b668c2"} 03:49:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:06 INFO - Copying logs to upload dir... 03:49:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.725448 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-15 03:49:05.828818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:05.832515) ========= 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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 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/Firefox-Non-PGO/sha512/168db7430ba8bd0062b4b91661990fdebaaedefe3fd6f113a37bc864d27361f925f313a1ffc680d8ccdfecf9accfb39be424b42db446bcb29908bd9f24aced24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f512c022a9bb54748e6e9f597abe6f3c3e68a0fbc85525909378239bf6d58452965acebbf6d2ed8456bff3829f4f42f4e3af43749b1debf3bbe80b59c798ee30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132f231c7dc36dcbea752e169cc8123f7beb96e2e4eb4d034107f3e510df8b4542fd94c3f237859859e38455534919a50f0c95fd62f7f8a01400f878ffdf94c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9289ead20270f29f01af4e76473f173057dc419bb51cf4458e35d6d812b15692aa2424d8048ac06adf298470d6ad61bfd45f9b428b5d9332a90287bd21b668c2"} build_url:https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/HOHrldjzS5yKCO4vsvinCw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/168db7430ba8bd0062b4b91661990fdebaaedefe3fd6f113a37bc864d27361f925f313a1ffc680d8ccdfecf9accfb39be424b42db446bcb29908bd9f24aced24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f512c022a9bb54748e6e9f597abe6f3c3e68a0fbc85525909378239bf6d58452965acebbf6d2ed8456bff3829f4f42f4e3af43749b1debf3bbe80b59c798ee30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132f231c7dc36dcbea752e169cc8123f7beb96e2e4eb4d034107f3e510df8b4542fd94c3f237859859e38455534919a50f0c95fd62f7f8a01400f878ffdf94c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9289ead20270f29f01af4e76473f173057dc419bb51cf4458e35d6d812b15692aa2424d8048ac06adf298470d6ad61bfd45f9b428b5d9332a90287bd21b668c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:05.862227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:05.862660) ========= 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=4300f881736b422476174874000001bc-1502788465.853303-1907411612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:05.950067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 03:49:05.950826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 03:49:05.951457) ========= ========= Total master_lag: 0.22 =========