builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1500947286.93 results: success (0) revision: dcfb58fcb6dd8f6474eed6520ba6272dedded393 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:06.925902) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:06.926278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:06.926567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:06.948654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:06.948942) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 18:48:07-- 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% 42.5M=0s 2017-07-24 18:48:07 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.072814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.073126) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.125501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.125788) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dcfb58fcb6dd8f6474eed6520ba6272dedded393 --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 dcfb58fcb6dd8f6474eed6520ba6272dedded393 --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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 18:48:07,306 truncating revision to first 12 chars 2017-07-24 18:48:07,306 Setting DEBUG logging. 2017-07-24 18:48:07,306 attempt 1/10 2017-07-24 18:48:07,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dcfb58fcb6dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 18:48:07,610 unpacking tar archive at: mozilla-central-dcfb58fcb6dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.752027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.752318) ========= script_repo_revision: dcfb58fcb6dd8f6474eed6520ba6272dedded393 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.752677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.752957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:48:07.772250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-24 18:48:07.772540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:08 INFO - MultiFileLogger online at 20170724 18:48:08 in /builds/slave/test 18:48:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:48:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:48:08 INFO - {'append_to_log': False, 18:48:08 INFO - 'base_work_dir': '/builds/slave/test', 18:48:08 INFO - 'blob_upload_branch': 'Firefox', 18:48:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:48:08 INFO - 'branch': 'Firefox', 18:48:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:08 INFO - 'code_coverage': False, 18:48:08 INFO - 'config_files': ('talos/linux_config.py',), 18:48:08 INFO - 'default_actions': ('clobber', 18:48:08 INFO - 'read-buildbot-config', 18:48:08 INFO - 'download-and-extract', 18:48:08 INFO - 'populate-webroot', 18:48:08 INFO - 'create-virtualenv', 18:48:08 INFO - 'install', 18:48:08 INFO - 'setup-mitmproxy', 18:48:08 INFO - 'run-tests'), 18:48:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:08 INFO - 'disable_ccov_upload': False, 18:48:08 INFO - 'download_minidump_stackwalk': True, 18:48:08 INFO - 'download_symbols': 'ondemand', 18:48:08 INFO - 'enable_stylo': False, 18:48:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:08 INFO - 'gecko_profile': False, 18:48:08 INFO - 'gecko_profile_interval': 0, 18:48:08 INFO - 'installer_path': 'installer.exe', 18:48:08 INFO - 'log_level': 'info', 18:48:08 INFO - 'log_name': 'talos', 18:48:08 INFO - 'log_to_console': True, 18:48:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:08 INFO - 'opt_config_files': (), 18:48:08 INFO - 'pip_index': False, 18:48:08 INFO - 'suite': 'dromaeojs-e10s', 18:48:08 INFO - 'system_bits': '32', 18:48:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:08 INFO - 'title': 'talos-linux64-ix-015', 18:48:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:08 INFO - 'use_talos_json': True, 18:48:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:48:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:08 INFO - 'work_dir': 'build'} 18:48:08 INFO - [mozharness: 2017-07-25 01:48:08.062910Z] Running clobber step. 18:48:08 INFO - Running pre-action listener: _resource_record_pre_action 18:48:08 INFO - Running main action method: clobber 18:48:08 INFO - rmtree: /builds/slave/test/build 18:48:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:48:09 INFO - Running post-action listener: _resource_record_post_action 18:48:09 INFO - [mozharness: 2017-07-25 01:48:09.117961Z] Finished clobber step (success) 18:48:09 INFO - [mozharness: 2017-07-25 01:48:09.118064Z] Running read-buildbot-config step. 18:48:09 INFO - Running pre-action listener: _resource_record_pre_action 18:48:09 INFO - Running main action method: read_buildbot_config 18:48:09 INFO - Using buildbot properties: 18:48:09 INFO - { 18:48:09 INFO - "project": "", 18:48:09 INFO - "product": "firefox", 18:48:09 INFO - "who": "kwierso@gmail.com", 18:48:09 INFO - "installer_path": "public/build/target.tar.bz2", 18:48:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:48:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:48:09 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:48:09 INFO - "stage_platform": "linux64-stylo", 18:48:09 INFO - "basedir": "/builds/slave/test", 18:48:09 INFO - "buildnumber": 48, 18:48:09 INFO - "platform": "ubuntu64_hw_stylo", 18:48:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:48:09 INFO - "slavebuilddir": "test", 18:48:09 INFO - "taskId": "HNCF-Wd-Sw2O8HKgQnQX_Q", 18:48:09 INFO - "branch": "mozilla-central", 18:48:09 INFO - "script_repo_revision": "production", 18:48:09 INFO - "revision": "dcfb58fcb6dd8f6474eed6520ba6272dedded393", 18:48:09 INFO - "slavename": "talos-linux64-ix-015", 18:48:09 INFO - "repo_path": "mozilla-central" 18:48:09 INFO - } 18:48:09 INFO - Finding installer, test and symbols from parent task. 18:48:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNCF-Wd-Sw2O8HKgQnQX_Q'}, attempt #1 18:48:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNCF-Wd-Sw2O8HKgQnQX_Q'}, attempt #1 18:48:10 INFO - Task dependencies: ULAcXr-fTM-J89OT06qGYA 18:48:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA'}, attempt #1 18:48:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/test_packages.json 18:48:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip 18:48:10 INFO - Running post-action listener: _resource_record_post_action 18:48:10 INFO - [mozharness: 2017-07-25 01:48:10.505102Z] Finished read-buildbot-config step (success) 18:48:10 INFO - [mozharness: 2017-07-25 01:48:10.505416Z] Running download-and-extract step. 18:48:10 INFO - Running pre-action listener: _resource_record_pre_action 18:48:10 INFO - Running main action method: download_and_extract 18:48:10 INFO - mkdir: /builds/slave/test/build/tests 18:48:10 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')]} 18:48:10 INFO - trying https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.test_packages.json 18:48:10 INFO - Downloading https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:48:11 INFO - Downloaded 989 bytes. 18:48:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:48:11 INFO - Using the following test package requirements: 18:48:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:48:11 INFO - u'common': [u'target.common.tests.zip'], 18:48:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:48:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:48:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:48:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:48:11 INFO - u'mozbase': [u'target.common.tests.zip'], 18:48:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:48:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:48:11 INFO - u'web-platform': [u'target.common.tests.zip', 18:48:11 INFO - u'target.web-platform.tests.tar.gz'], 18:48:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:48:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:48:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip 18:48:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:48:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip into memory 18:48:12 INFO - Content-Length response header: 72761504 18:48:12 INFO - Bytes received: 72761504 18:48:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:48:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip 18:48:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:48:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip into memory 18:48:24 INFO - Content-Length response header: 72761504 18:48:24 INFO - Bytes received: 72761504 18:48:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.talos.tests.zip 18:48:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:48:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.talos.tests.zip into memory 18:48:37 INFO - Content-Length response header: 14498976 18:48:37 INFO - Bytes received: 14498976 18:48:37 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')]} 18:48:37 INFO - trying https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:48:38 INFO - Downloaded 61950688 bytes. 18:48:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:38 INFO - mkdir: /builds/slave/test/properties 18:48:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:48:38 INFO - Writing to file /builds/slave/test/properties/build_url 18:48:38 INFO - Contents: 18:48:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:38 INFO - Running post-action listener: _resource_record_post_action 18:48:38 INFO - Running post-action listener: set_extra_try_arguments 18:48:38 INFO - [mozharness: 2017-07-25 01:48:38.855189Z] Finished download-and-extract step (success) 18:48:38 INFO - [mozharness: 2017-07-25 01:48:38.855286Z] Running populate-webroot step. 18:48:38 INFO - Running pre-action listener: _resource_record_pre_action 18:48:38 INFO - Running main action method: populate_webroot 18:48:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:48:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:48:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:48:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:48:38 INFO - 'tests': ['damp', 'tps']}, 18:48:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:48:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:48:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:48:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:48:38 INFO - 'ts_paint', 18:48:38 INFO - 'tpaint', 18:48:38 INFO - 'sessionrestore', 18:48:38 INFO - 'sessionrestore_many_windows', 18:48:38 INFO - 'sessionrestore_no_auto_restore', 18:48:38 INFO - 'tabpaint']}, 18:48:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:48:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:48:38 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:48:38 INFO - 'talos_options': ['--mitmproxy', 18:48:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:48:38 INFO - '--firstNonBlankPaint'], 18:48:38 INFO - 'tests': ['quantum_pageload_google', 18:48:38 INFO - 'quantum_pageload_youtube', 18:48:38 INFO - 'quantum_pageload_amazon', 18:48:38 INFO - 'quantum_pageload_facebook']}, 18:48:38 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:48:38 INFO - 'talos_options': ['--stylo', 18:48:38 INFO - '--mitmproxy', 18:48:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:48:38 INFO - '--firstNonBlankPaint'], 18:48:38 INFO - 'tests': ['quantum_pageload_google', 18:48:38 INFO - 'quantum_pageload_youtube', 18:48:38 INFO - 'quantum_pageload_amazon', 18:48:38 INFO - 'quantum_pageload_facebook']}, 18:48:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:48:38 INFO - 'tsvgr_opacity', 18:48:38 INFO - 'tart', 18:48:38 INFO - 'tscrollx', 18:48:38 INFO - 'cart', 18:48:38 INFO - 'tsvg_static']}, 18:48:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:48:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:48:38 INFO - 'talos_options': ['--xperf_path', 18:48:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:38 INFO - 'tests': ['tp5n']}}} 18:48:38 INFO - Running post-action listener: _resource_record_post_action 18:48:38 INFO - [mozharness: 2017-07-25 01:48:38.862617Z] Finished populate-webroot step (success) 18:48:38 INFO - [mozharness: 2017-07-25 01:48:38.862708Z] Running create-virtualenv step. 18:48:38 INFO - Running pre-action listener: _resource_record_pre_action 18:48:38 INFO - Running main action method: create_virtualenv 18:48:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:48:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:48:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:48:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:48:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:38 INFO - Using real prefix '/usr' 18:48:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:48:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:41 INFO - Installing pip.................done. 18:48:41 INFO - Return code: 0 18:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:48:41 INFO - Reading from file tmpfile_stdout 18:48:41 INFO - Output received: 18:48:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:48:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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')]} 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:41 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 18:48:41 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 18:48:41 INFO - Using env: {'DISPLAY': ':0', 18:48:41 INFO - 'HOME': '/home/cltbld', 18:48:41 INFO - 'LANG': 'en_US.UTF-8', 18:48:41 INFO - 'LANGUAGE': 'en_US:en', 18:48:41 INFO - 'LOGNAME': 'cltbld', 18:48:41 INFO - 'MAIL': '/var/mail/cltbld', 18:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:41 INFO - 'MOZ_NO_REMOTE': '1', 18:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:41 INFO - 'NO_EM_RESTART': '1', 18:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:41 INFO - 'PWD': '/builds/slave/test', 18:48:41 INFO - 'SHELL': '/bin/bash', 18:48:41 INFO - 'SHLVL': '1', 18:48:41 INFO - 'TERM': 'linux', 18:48:41 INFO - 'TMOUT': '86400', 18:48:41 INFO - 'USER': 'cltbld', 18:48:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:41 INFO - '_': '/tools/buildbot/bin/python'} 18:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:48:41 INFO - Cleaning up... 18:48:41 INFO - Return code: 0 18:48:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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')]} 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:41 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 18:48:41 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 18:48:41 INFO - Using env: {'DISPLAY': ':0', 18:48:41 INFO - 'HOME': '/home/cltbld', 18:48:41 INFO - 'LANG': 'en_US.UTF-8', 18:48:41 INFO - 'LANGUAGE': 'en_US:en', 18:48:41 INFO - 'LOGNAME': 'cltbld', 18:48:41 INFO - 'MAIL': '/var/mail/cltbld', 18:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:41 INFO - 'MOZ_NO_REMOTE': '1', 18:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:41 INFO - 'NO_EM_RESTART': '1', 18:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:41 INFO - 'PWD': '/builds/slave/test', 18:48:41 INFO - 'SHELL': '/bin/bash', 18:48:41 INFO - 'SHLVL': '1', 18:48:41 INFO - 'TERM': 'linux', 18:48:41 INFO - 'TMOUT': '86400', 18:48:41 INFO - 'USER': 'cltbld', 18:48:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:41 INFO - '_': '/tools/buildbot/bin/python'} 18:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:42 INFO - Downloading/unpacking psutil>=3.1.1 18:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:43 INFO - Installing collected packages: psutil 18:48:43 INFO - Running setup.py install for psutil 18:48:43 INFO - building 'psutil._psutil_linux' extension 18:48:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:48:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:48:43 INFO - building 'psutil._psutil_posix' extension 18:48:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:48:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:48:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:43 INFO - Successfully installed psutil 18:48:43 INFO - Cleaning up... 18:48:43 INFO - Return code: 0 18:48:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:48:43 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')]} 18:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:43 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')]} 18:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:43 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:43 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 18:48:43 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 18:48:43 INFO - Using env: {'DISPLAY': ':0', 18:48:43 INFO - 'HOME': '/home/cltbld', 18:48:43 INFO - 'LANG': 'en_US.UTF-8', 18:48:43 INFO - 'LANGUAGE': 'en_US:en', 18:48:43 INFO - 'LOGNAME': 'cltbld', 18:48:43 INFO - 'MAIL': '/var/mail/cltbld', 18:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:43 INFO - 'MOZ_NO_REMOTE': '1', 18:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:43 INFO - 'NO_EM_RESTART': '1', 18:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:43 INFO - 'PWD': '/builds/slave/test', 18:48:43 INFO - 'SHELL': '/bin/bash', 18:48:43 INFO - 'SHLVL': '1', 18:48:43 INFO - 'TERM': 'linux', 18:48:43 INFO - 'TMOUT': '86400', 18:48:43 INFO - 'USER': 'cltbld', 18:48:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:43 INFO - '_': '/tools/buildbot/bin/python'} 18:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:48:45 INFO - Installing collected packages: mozsystemmonitor 18:48:45 INFO - Running setup.py install for mozsystemmonitor 18:48:45 INFO - Successfully installed mozsystemmonitor 18:48:45 INFO - Cleaning up... 18:48:45 INFO - Return code: 0 18:48:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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')]} 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48: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', '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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:48: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 jsonschema==2.5.1 18:48:45 INFO - Using env: {'DISPLAY': ':0', 18:48:45 INFO - 'HOME': '/home/cltbld', 18:48:45 INFO - 'LANG': 'en_US.UTF-8', 18:48:45 INFO - 'LANGUAGE': 'en_US:en', 18:48:45 INFO - 'LOGNAME': 'cltbld', 18:48:45 INFO - 'MAIL': '/var/mail/cltbld', 18:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:45 INFO - 'MOZ_NO_REMOTE': '1', 18:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:45 INFO - 'NO_EM_RESTART': '1', 18:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:45 INFO - 'PWD': '/builds/slave/test', 18:48:45 INFO - 'SHELL': '/bin/bash', 18:48:45 INFO - 'SHLVL': '1', 18:48:45 INFO - 'TERM': 'linux', 18:48:45 INFO - 'TMOUT': '86400', 18:48:45 INFO - 'USER': 'cltbld', 18:48:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:45 INFO - '_': '/tools/buildbot/bin/python'} 18:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:48:46 INFO - warning: no files found matching '*.txt' 18:48:46 INFO - no previously-included directories found matching 'build' 18:48:46 INFO - no previously-included directories found matching 'dist' 18:48:46 INFO - no previously-included directories found matching '.git*' 18:48:46 INFO - Installing collected packages: jsonschema, functools32 18:48:46 INFO - Running setup.py install for functools32 18:48:46 INFO - warning: no files found matching '*.txt' 18:48:46 INFO - no previously-included directories found matching 'build' 18:48:46 INFO - no previously-included directories found matching 'dist' 18:48:46 INFO - no previously-included directories found matching '.git*' 18:48:46 INFO - Successfully installed jsonschema functools32 18:48:46 INFO - Cleaning up... 18:48:46 INFO - Return code: 0 18:48:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:48:46 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')]} 18:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:46 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')]} 18:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:46 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:46 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 18:48:46 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 18:48:46 INFO - Using env: {'DISPLAY': ':0', 18:48:46 INFO - 'HOME': '/home/cltbld', 18:48:46 INFO - 'LANG': 'en_US.UTF-8', 18:48:46 INFO - 'LANGUAGE': 'en_US:en', 18:48:46 INFO - 'LOGNAME': 'cltbld', 18:48:46 INFO - 'MAIL': '/var/mail/cltbld', 18:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:46 INFO - 'MOZ_NO_REMOTE': '1', 18:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:46 INFO - 'NO_EM_RESTART': '1', 18:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:46 INFO - 'PWD': '/builds/slave/test', 18:48:46 INFO - 'SHELL': '/bin/bash', 18:48:46 INFO - 'SHLVL': '1', 18:48:46 INFO - 'TERM': 'linux', 18:48:46 INFO - 'TMOUT': '86400', 18:48:46 INFO - 'USER': 'cltbld', 18:48:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:46 INFO - '_': '/tools/buildbot/bin/python'} 18:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:48:47 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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')]} 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48: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', '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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:48: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 blobuploader==1.2.4 18:48:47 INFO - Using env: {'DISPLAY': ':0', 18:48:47 INFO - 'HOME': '/home/cltbld', 18:48:47 INFO - 'LANG': 'en_US.UTF-8', 18:48:47 INFO - 'LANGUAGE': 'en_US:en', 18:48:47 INFO - 'LOGNAME': 'cltbld', 18:48:47 INFO - 'MAIL': '/var/mail/cltbld', 18:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:47 INFO - 'MOZ_NO_REMOTE': '1', 18:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:47 INFO - 'NO_EM_RESTART': '1', 18:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:47 INFO - 'PWD': '/builds/slave/test', 18:48:47 INFO - 'SHELL': '/bin/bash', 18:48:47 INFO - 'SHLVL': '1', 18:48:47 INFO - 'TERM': 'linux', 18:48:47 INFO - 'TMOUT': '86400', 18:48:47 INFO - 'USER': 'cltbld', 18:48:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:47 INFO - '_': '/tools/buildbot/bin/python'} 18:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:48:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:49 INFO - Downloading docopt-0.6.1.tar.gz 18:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:49 INFO - Running setup.py install for blobuploader 18:48:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:48:49 INFO - Running setup.py install for requests 18:48:49 INFO - Running setup.py install for docopt 18:48:49 INFO - Successfully installed blobuploader requests docopt 18:48:49 INFO - Cleaning up... 18:48:49 INFO - Return code: 0 18:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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')]} 18:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:49 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:49 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 18:48:49 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 18:48:49 INFO - Using env: {'DISPLAY': ':0', 18:48:49 INFO - 'HOME': '/home/cltbld', 18:48:49 INFO - 'LANG': 'en_US.UTF-8', 18:48:49 INFO - 'LANGUAGE': 'en_US:en', 18:48:49 INFO - 'LOGNAME': 'cltbld', 18:48:49 INFO - 'MAIL': '/var/mail/cltbld', 18:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:49 INFO - 'MOZ_NO_REMOTE': '1', 18:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:49 INFO - 'NO_EM_RESTART': '1', 18:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:49 INFO - 'PWD': '/builds/slave/test', 18:48:49 INFO - 'SHELL': '/bin/bash', 18:48:49 INFO - 'SHLVL': '1', 18:48:49 INFO - 'TERM': 'linux', 18:48:49 INFO - 'TMOUT': '86400', 18:48:49 INFO - 'USER': 'cltbld', 18:48:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:49 INFO - '_': '/tools/buildbot/bin/python'} 18:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:49 INFO - Running setup.py (path:/tmp/pip-SehQH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:50 INFO - Running setup.py (path:/tmp/pip-YpHmyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:50 INFO - Running setup.py (path:/tmp/pip-4AmPE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:50 INFO - Running setup.py (path:/tmp/pip-6Vagps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:50 INFO - Running setup.py (path:/tmp/pip-msb8Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:50 INFO - Running setup.py (path:/tmp/pip-c3dfZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:50 INFO - Running setup.py (path:/tmp/pip-t5EPoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:50 INFO - Running setup.py (path:/tmp/pip-qHHz7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:50 INFO - Running setup.py (path:/tmp/pip-j972Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:50 INFO - Running setup.py (path:/tmp/pip-d8NqHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:50 INFO - Running setup.py (path:/tmp/pip-tnjck_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:50 INFO - Running setup.py (path:/tmp/pip-fNTyjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:50 INFO - Running setup.py (path:/tmp/pip-yMBnZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:50 INFO - Running setup.py (path:/tmp/pip-rekHv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:50 INFO - Running setup.py (path:/tmp/pip-9mb1FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:51 INFO - Running setup.py (path:/tmp/pip-kWSYEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:51 INFO - Running setup.py (path:/tmp/pip-9OVXvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:51 INFO - Running setup.py install for manifestparser 18:48:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Running setup.py install for mozcrash 18:48:51 INFO - Running setup.py install for mozdebug 18:48:51 INFO - Running setup.py install for mozdevice 18:48:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Running setup.py install for mozfile 18:48:51 INFO - Running setup.py install for mozhttpd 18:48:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Running setup.py install for mozinfo 18:48:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Running setup.py install for mozInstall 18:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:48:51 INFO - Running setup.py install for mozleak 18:48:52 INFO - Running setup.py install for mozlog 18:48:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Running setup.py install for moznetwork 18:48:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Running setup.py install for mozprocess 18:48:52 INFO - Running setup.py install for mozprofile 18:48:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Running setup.py install for mozrunner 18:48:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Running setup.py install for mozscreenshot 18:48:52 INFO - Running setup.py install for moztest 18:48:52 INFO - Running setup.py install for mozversion 18:48:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:48:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:52 INFO - Cleaning up... 18:48:52 INFO - Return code: 0 18:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:52 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')]} 18:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:52 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')]} 18:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:52 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:52 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 18:48:52 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 18:48:52 INFO - Using env: {'DISPLAY': ':0', 18:48:52 INFO - 'HOME': '/home/cltbld', 18:48:52 INFO - 'LANG': 'en_US.UTF-8', 18:48:52 INFO - 'LANGUAGE': 'en_US:en', 18:48:52 INFO - 'LOGNAME': 'cltbld', 18:48:52 INFO - 'MAIL': '/var/mail/cltbld', 18:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:52 INFO - 'MOZ_NO_REMOTE': '1', 18:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:52 INFO - 'NO_EM_RESTART': '1', 18:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:52 INFO - 'PWD': '/builds/slave/test', 18:48:52 INFO - 'SHELL': '/bin/bash', 18:48:52 INFO - 'SHLVL': '1', 18:48:52 INFO - 'TERM': 'linux', 18:48:52 INFO - 'TMOUT': '86400', 18:48:52 INFO - 'USER': 'cltbld', 18:48:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:52 INFO - '_': '/tools/buildbot/bin/python'} 18:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Running setup.py (path:/tmp/pip-lPn48v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Running setup.py (path:/tmp/pip-d8yPbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Running setup.py (path:/tmp/pip-JayppP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 INFO - Running setup.py (path:/tmp/pip-8IDQKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 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)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Running setup.py (path:/tmp/pip-7G2FhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Running setup.py (path:/tmp/pip-TlXVbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:53 INFO - Running setup.py (path:/tmp/pip-dW_lF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:53 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)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:53 INFO - Running setup.py (path:/tmp/pip-SnS0xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:53 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)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:53 INFO - Running setup.py (path:/tmp/pip-KjIsOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:53 INFO - Running setup.py (path:/tmp/pip-5aGMBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:53 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)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:53 INFO - Running setup.py (path:/tmp/pip-LYbJuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:53 INFO - Running setup.py (path:/tmp/pip-J_vz3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:54 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)) 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:54 INFO - Running setup.py (path:/tmp/pip-IRX_9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:54 INFO - Running setup.py (path:/tmp/pip-rpbun0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:54 INFO - Running setup.py (path:/tmp/pip-ARQBTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Running setup.py (path:/tmp/pip-uw8B6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Running setup.py (path:/tmp/pip-WhA3Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:48:54 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)) 18:48:54 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)) 18:48:54 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)) 18:48:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:55 INFO - Downloading blessings-1.6.tar.gz 18:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:55 INFO - Installing collected packages: blessings 18:48:55 INFO - Running setup.py install for blessings 18:48:55 INFO - Successfully installed blessings 18:48:55 INFO - Cleaning up... 18:48:55 INFO - Return code: 0 18:48:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:55 INFO - Reading from file tmpfile_stdout 18:48:55 INFO - Current package versions: 18:48:55 INFO - argparse == 1.2.1 18:48:55 INFO - blessings == 1.6 18:48:55 INFO - blobuploader == 1.2.4 18:48:55 INFO - docopt == 0.6.1 18:48:55 INFO - functools32 == 3.2.3-2 18:48:55 INFO - jsonschema == 2.5.1 18:48:55 INFO - manifestparser == 1.1 18:48:55 INFO - mozInstall == 1.13 18:48:55 INFO - mozcrash == 1.0 18:48:55 INFO - mozdebug == 0.1 18:48:55 INFO - mozdevice == 0.51 18:48:55 INFO - mozfile == 1.2 18:48:55 INFO - mozhttpd == 0.7 18:48:55 INFO - mozinfo == 0.10 18:48:55 INFO - mozleak == 0.1 18:48:55 INFO - mozlog == 3.5 18:48:55 INFO - moznetwork == 0.27 18:48:55 INFO - mozprocess == 0.25 18:48:55 INFO - mozprofile == 0.28 18:48:55 INFO - mozrunner == 6.13 18:48:55 INFO - mozscreenshot == 0.1 18:48:55 INFO - mozsystemmonitor == 0.3 18:48:55 INFO - moztest == 0.8 18:48:55 INFO - mozversion == 1.4 18:48:55 INFO - psutil == 3.1.1 18:48:55 INFO - requests == 1.2.3 18:48:55 INFO - wsgiref == 0.1.2 18:48:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:55 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')]} 18:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:55 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')]} 18:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:55 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:55 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 18:48:55 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 18:48:55 INFO - Using env: {'DISPLAY': ':0', 18:48:55 INFO - 'HOME': '/home/cltbld', 18:48:55 INFO - 'LANG': 'en_US.UTF-8', 18:48:55 INFO - 'LANGUAGE': 'en_US:en', 18:48:55 INFO - 'LOGNAME': 'cltbld', 18:48:55 INFO - 'MAIL': '/var/mail/cltbld', 18:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:55 INFO - 'MOZ_NO_REMOTE': '1', 18:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:55 INFO - 'NO_EM_RESTART': '1', 18:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:55 INFO - 'PWD': '/builds/slave/test', 18:48:55 INFO - 'SHELL': '/bin/bash', 18:48:55 INFO - 'SHLVL': '1', 18:48:55 INFO - 'TERM': 'linux', 18:48:55 INFO - 'TMOUT': '86400', 18:48:55 INFO - 'USER': 'cltbld', 18:48:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:55 INFO - '_': '/tools/buildbot/bin/python'} 18:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:48:56 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:57 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:48:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:48:57 INFO - Installing collected packages: marionette-driver, simplejson 18:48:57 INFO - Running setup.py install for marionette-driver 18:48:57 INFO - Running setup.py install for simplejson 18:48:57 INFO - building 'simplejson._speedups' extension 18:48:57 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 18:48:58 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 18:48:58 INFO - Successfully installed marionette-driver simplejson 18:48:58 INFO - Cleaning up... 18:48:58 INFO - Return code: 0 18:48:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:48:58 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')]} 18:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:58 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')]} 18:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:58 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 0xbe11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf50d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, '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': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:58 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 18:48:58 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 18:48:58 INFO - Using env: {'DISPLAY': ':0', 18:48:58 INFO - 'HOME': '/home/cltbld', 18:48:58 INFO - 'LANG': 'en_US.UTF-8', 18:48:58 INFO - 'LANGUAGE': 'en_US:en', 18:48:58 INFO - 'LOGNAME': 'cltbld', 18:48:58 INFO - 'MAIL': '/var/mail/cltbld', 18:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:58 INFO - 'MOZ_NO_REMOTE': '1', 18:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:58 INFO - 'NO_EM_RESTART': '1', 18:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:58 INFO - 'PWD': '/builds/slave/test', 18:48:58 INFO - 'SHELL': '/bin/bash', 18:48:58 INFO - 'SHLVL': '1', 18:48:58 INFO - 'TERM': 'linux', 18:48:58 INFO - 'TMOUT': '86400', 18:48:58 INFO - 'USER': 'cltbld', 18:48:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:58 INFO - '_': '/tools/buildbot/bin/python'} 18:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:48:58 INFO - Cleaning up... 18:48:58 INFO - Return code: 0 18:48:58 INFO - Running post-action listener: _resource_record_post_action 18:48:58 INFO - Running post-action listener: _start_resource_monitoring 18:48:59 INFO - Starting resource monitoring. 18:48:59 INFO - [mozharness: 2017-07-25 01:48:59.024003Z] Finished create-virtualenv step (success) 18:48:59 INFO - [mozharness: 2017-07-25 01:48:59.024474Z] Running install step. 18:48:59 INFO - Running pre-action listener: _resource_record_pre_action 18:48:59 INFO - Running main action method: install 18:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:59 INFO - Reading from file tmpfile_stdout 18:48:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:48:59 INFO - Reading from file tmpfile_stdout 18:48:59 INFO - Output received: 18:48:59 INFO - Usage: mozinstall [options] installer 18:48:59 INFO - Options: 18:48:59 INFO - -h, --help show this help message and exit 18:48:59 INFO - -d DEST, --destination=DEST 18:48:59 INFO - Directory to install application into. [default: 18:48:59 INFO - "/builds/slave/test"] 18:48:59 INFO - --app=APP Application being installed. [default: firefox] 18:48:59 INFO - mkdir: /builds/slave/test/build/application 18:48:59 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'] 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:49:17 INFO - Reading from file tmpfile_stdout 18:49:17 INFO - Output received: 18:49:17 INFO - /builds/slave/test/build/application/firefox/firefox 18:49:17 INFO - Running post-action listener: _resource_record_post_action 18:49:17 INFO - [mozharness: 2017-07-25 01:49:17.352547Z] Finished install step (success) 18:49:17 INFO - [mozharness: 2017-07-25 01:49:17.352803Z] Running setup-mitmproxy step. 18:49:17 INFO - Running pre-action listener: _resource_record_pre_action 18:49:17 INFO - Running main action method: setup_mitmproxy 18:49:17 INFO - Skipping: mitmproxy is not required 18:49:17 INFO - Running post-action listener: _resource_record_post_action 18:49:17 INFO - [mozharness: 2017-07-25 01:49:17.354013Z] Finished setup-mitmproxy step (success) 18:49:17 INFO - [mozharness: 2017-07-25 01:49:17.354236Z] Running run-tests step. 18:49:17 INFO - Running pre-action listener: _resource_record_pre_action 18:49:17 INFO - Running pre-action listener: _set_gcov_prefix 18:49:17 INFO - Running main action method: run_tests 18:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:49:17 INFO - Python 2.7.3 18:49:17 INFO - Return code: 0 18:49:17 INFO - grabbing minidump binary from tooltool 18:49:17 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')]} 18:49:17 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 0xf4deb0>, '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 0xf4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4f240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:49:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:49:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:49:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:49:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:17 INFO - Return code: 0 18:49:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:49:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:49:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:49:17 INFO - ENV: RUST_BACKTRACE is now 1 18:49:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:49:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:49:17 INFO - Using env: {'DISPLAY': ':0', 18:49:17 INFO - 'HOME': '/home/cltbld', 18:49:17 INFO - 'LANG': 'en_US.UTF-8', 18:49:17 INFO - 'LANGUAGE': 'en_US:en', 18:49:17 INFO - 'LOGNAME': 'cltbld', 18:49:17 INFO - 'MAIL': '/var/mail/cltbld', 18:49:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:49:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:17 INFO - 'MOZ_NO_REMOTE': '1', 18:49:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:17 INFO - 'NO_EM_RESTART': '1', 18:49:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:17 INFO - 'PWD': '/builds/slave/test', 18:49:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:49:17 INFO - 'RUST_BACKTRACE': '1', 18:49:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:49:17 INFO - 'SHELL': '/bin/bash', 18:49:17 INFO - 'SHLVL': '1', 18:49:17 INFO - 'STYLO_FORCE_ENABLED': '1', 18:49:17 INFO - 'TERM': 'linux', 18:49:17 INFO - 'TMOUT': '86400', 18:49:17 INFO - 'USER': 'cltbld', 18:49:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864', 18:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:17 INFO - '_': '/tools/buildbot/bin/python'} 18:49:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:49:17 INFO - mozversion application_buildid: 20170725010649 18:49:17 INFO - mozversion application_changeset: dcfb58fcb6dd8f6474eed6520ba6272dedded393 18:49:17 INFO - mozversion application_display_name: Nightly 18:49:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:17 INFO - mozversion application_name: Firefox 18:49:17 INFO - mozversion application_remotingname: firefox 18:49:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:49:17 INFO - mozversion application_vendor: Mozilla 18:49:17 INFO - mozversion application_version: 56.0a1 18:49:17 INFO - mozversion platform_buildid: 20170725010649 18:49:17 INFO - mozversion platform_changeset: dcfb58fcb6dd8f6474eed6520ba6272dedded393 18:49:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:49:17 INFO - mozversion platform_version: 56.0a1 18:49:17 INFO - using testdate: 1500947357 18:49:17 INFO - actual date: 1500947357 18:49:17 INFO - starting webserver on 'localhost:55556' 18:49:17 INFO - SUITE-START | Running 2 tests 18:49:17 INFO - TEST-START | dromaeo_css 18:49:17 INFO - Initialising browser for dromaeo_css test... 18:49:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55556/getInfo.html -profile /tmp/tmpfaK3ny/profile 18:49:17 INFO - TEST-INFO | started process 25071 (/builds/slave/test/build/application/firefox/firefox http://localhost:55556/getInfo.html) 18:49:23 INFO - TEST-INFO | 25071: exit 0 18:49:23 INFO - Browser initialized. 18:49:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:23 INFO - TEST-INFO | started process 25298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaK3ny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:35 INFO - PID 25298 | RSS: Main: 174690304 18:49:35 INFO - PID 25298 | 18:52:34 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55556/tests/dromaeo/cssquery-ext.html) 18:52:36 INFO - PID 25298 | RSS: Main: 175214592 18:52:36 INFO - PID 25298 | 18:55:38 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-ext.html (next: http://localhost:55556/tests/dromaeo/cssquery-jquery.html) 18:55:39 INFO - PID 25298 | RSS: Main: 175792128 18:55:39 INFO - PID 25298 | 18:58:40 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55556/tests/dromaeo/cssquery-mootools.html) 18:58:41 INFO - PID 25298 | RSS: Main: 177459200 18:58:41 INFO - PID 25298 | 19:01:43 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55556/tests/dromaeo/cssquery-prototype.html) 19:01:44 INFO - PID 25298 | RSS: Main: 175710208 19:01:44 INFO - PID 25298 | 19:04:48 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55556/tests/dromaeo/cssquery-yui.html) 19:04:48 INFO - PID 25298 | RSS: Main: 177733632 19:04:48 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | Cycle 1(1): loaded http://localhost:55556/tests/dromaeo/cssquery-yui.html (next: http://localhost:55556/tests/dromaeo/cssquery-dojo.html) 19:07:50 INFO - PID 25298 | RSS: Main: 179900416 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | __start_tp_report 19:07:50 INFO - PID 25298 | _x_x_mozilla_page_load 19:07:50 INFO - PID 25298 | _x_x_mozilla_page_load_details 19:07:50 INFO - PID 25298 | |i|pagename|runs| 19:07:50 INFO - PID 25298 | |0;dojo.html;3090.8563831382407;3146.181992681902;3171.9207019824503;3180.0777774445414;3205.6794320567933;6141.263048434189;6220.9377906220925;6253.937460625404;6256.155419018437;6268.4671802896755;5925.85185370366;5986.760529578812;5989.580729348936;6032.819015429544;6042.607230530023;5580.748866301006;5593.133064375028;5598.916016259759;5635.380108188096;5708.828735137952;5716.742746576393;5719.59962802604;5765.4522820332;5786.56600754943;5795.3335366432975;5426.565874730012;5655.3779084300695;5692.829215123532;5753.5684823638185;5775.133729940521;5507.421720719347;5638.971805140989;5677.290338707661;5706.572007099443;5723.9141412878425;5585.273914391144;5617.494425501724;5661.2357331760095;5665.065264231397;5695.658260504383;5892.23400957877;5942.762289508458;6128;6134.478569321613;6152.261728592553;6562.475001999828;6619.073329733841;6619.834504137387;6632.436242919358;6634.270230274666;6641.169853768279;6656.93343066568;6703.765368212138;6723.260441351447;6739.427148692367;6147.077938309245;6169.352218017133;6222.657753823538;6254.093156492283;6265.718042687999;6576.572522786004;6668;6761.154855643044;6846.178458585002;6861.039454476378;6234.719437625317;6299.5275354348605;6314.336994615591;6318.178636777281;6434.034894765822;6632.2704502504685;6637.86724265512;6658.600483970978;6664.266930637626;6672.566283191577;6588.143541339595;6656.467482601381;6665.666716664147;6674.933250667431;6680.966595166993;6599.274079851212;6609.173853268341;6668.83327916806;6699.832504187337;6704.96647516769;5194.4805519447755;5288.9735551322765;5296.814611488579;5387.272718182995;5443.482869127427;4629.629629629621;4659.767011649472;4681.391419115561;4684.297355396718;4703.2004559225015;5726;5742.425757424307;5798.594098413155;5798.855028624318;5809.535237181015;6420.390062944013;6544.770933017321;6596.967015164893;6646.900296495556;6732.023856540872;5705.828825135252;5754.1944127822135;5769.07694768835;5809.912851307234;5816.592838501264;5865.563434208747;5867.090600956859;5923.526117910643;5940.851478713067;5954.49386802118;6212.875742485216;6322.304546499973;6431.099646049557;6498.967505162444;6535.607863528204;6534.4772418205475;6641.867162656623;6678.3989440950545;6708.027336036345;6711.395974362331;6370.777022804365;6443.194600674916;6443.96778016107;6544.901826472512;6546.934530654633;6504.252011018793;6504.869902602016;6518.054882042172;6567.2447668518735;6624;6445.097686324012;6549.96725016391;6638.336166383323;6734.326567343226;6734.865302693821;6400.743970241325;6434.324395938546;6472.093906852951;6487.578307410004;6488.513361498001;6219.253689557282;6379.6810159490915;6387.201599800025;6392.680365981775;6478.805635830932;6263.029230469285;6272.874542509033;6297.937020629735;6301.96849015752;6308.369163083655;6315.842103947438;6380.138681277968;6391.6804159792755;6404.615723056445;6418.261899881573;6147.907781383194;6189.690515474298;6204.472619827366;6206.937930620817;6218.595791273553 19:07:50 INFO - PID 25298 | |1;ext.html;776.8096816280013;824.0523398092197;857.4041041476173;877.171073335698;880.9955950220248;39692;40107.59892401079;40509.18981620366;40536.189276214456;40550.39174412386;36854;37027.44458833113;37031.44452833203;37078.44382334267;37211.62788372116;6673.766418175364;6792.728290868359;6823.044773731682;6830.00964860095;6856.862862742742;6772.390484856362;6859.862802743942;6892.620905850176;6912.101426814507;6915.827104322407;7449.21783212763;7617.352525035379;7619.771406857803;7644.6559904804135;7646.847063058735;7450.441216908726;7496.8125796854965;7501;7542.886856697154;7564.092308922909;7270.491065625409;7445.590492522909;7451;7457.552546847152;7472.103347598269;39471.60528394737;39739.403908941385;39821.402678959836;39833;39898.60101399007;3510.1751088494184;3542.752007359486;3554.253606742587;3567.4470457079196;3567.554055743032;31548.053558393283;31678.36643267145;31725.682743172503;31810.36379272425;31873.203169920707;4829.3721816164025;4862.659613827033;4870.172070747982;4881.682690625098;4944.802207911679;183404;184945;186648;186967;192917;49293.75353123283;49839.50160498349;49855;49881.75059124681;49891.25163122556;51343;51349.74325128425;51427.74286128546;51444;51557.48442515602;15290.235488225544;15377.923110384376;15385.53843384678;15409.537713868602;15608.063516188839;12570.685732856751;12577.93711031439;12585.24488530691;12586.68533286657;12604.369781510888;14462.05996610217;14586.927065364605;14663.266836658124;14728.263586820616;14749.926250368893;5856.795012174553;5926.199963005025;5935.970320148372;5979.402059794073;5996.340402555716;950.6625148072335;968.1673760565908;975.8487434447673;988.4859872866069;1024.9897501025043;27804.16587502378;28925.7107428923;29841.850790745906;30188.396232075236;30484.390312194075;1077.1606748382328;1084.810158222308;1100.8073587122221;1116.603605719974;1117.9888201118047;12184.695382615328;12583.93708031454;12666.303353315656;12725.55460558876;12793.29636869981;236422;238936;238956;239125;240181;53013;53611.463885360645;53662;53739.73130134324;53969;1452.1359790924382;1469.1552357394755;1487.5611694550134;1497.094257973932;1509.6603264265452;22702;23036.193733219257;23693.407664808517;27387;27774.027909023087;52088.47911520836;52739;52751.73624132008;52774;52797.999999998465;219247;223777;224151;224752;224861;35435.46846797249;37491.250174996894;38322.233555329294;38352.6164738349;38353.42469862899;45970.28927289944;47184;47427.525724742314;48007.279890800964;48007.279890800964;32287.35425291434;33037.33925321528;33235.667643324225;33492;33937.15157121092;31017.224569385948;31045.844770776002;32663.510047348835;33079;33399;36486;37752.05619859525;37926.24147517089;38258.234835303694;38447.80776096102;32517.837410812794;32804.67195328112;32808.83595582007;32869.34261314713;33400.66599334073;23656.52686946217;24890.377740555905;25297;25628.615570766826;25784 19:07:50 INFO - PID 25298 | |2;jquery.html;573.5583600627514;575.5050656435467;575.7409165875357;585.9472647461728;602.4517688903097;21415.785842141595;22446.663300050513;22470.213542525995;22539.436514087156;22937.541249175007;25041.49917001659;25335.493290134233;25561.10536131236;25616.359591010234;25621.103261385855;6331.398517140888;6518.608883467007;6518.706658200369;6521.217453905538;6522.086907832907;3844.5770965193806;3995.540512841017;6099.085137229406;6490.643014634194;6496.967515162418;6433.131527243832;6464;6473.1261279727105;6488.805335839932;6499.285078641369;6422.26143993442;6470.547061705683;6471.967640161793;6477.384648458389;6497.025446183063;5988.341282458926;6020.488258498033;6039.245094363205;6040.214772079646;6070.757169713206;28534.143975680763;29818.85090574555;29891.25271868199;30099.247518811986;30244.69755302441;1881.9529511762178;1934.7775005874223;1938.6122775444967;1939.5442071113418;1941.7864034956144;18560.164792584364;18968.810311896843;18999.620007599908;19122.33071842479;19145.425637230906;2238.641817309239;2275.8748268845206;2292.7363353214428;2301.022065622104;2400.699912510936;136051;143664;143797;143836;144262.27868860692;14285.857141428452;14935.850641493445;15198.240087995557;15264.847351526565;15369.462068827761;22855.428614284443;22864.885675571848;22869;22893.313200604007;23006.539869202523;10060.899391006142;10099.596016159272;10197.694069177936;10276.229282803819;10344.5344959477;9323.580438880266;9326.487043212688;9354.298427617956;9381.390209636353;9505.619775209052;9070.81858362829;9128.81742365149;9260.39807412516;9300.813983720287;9318.161365477139;2806.3032044948786;2883.7692984561186;2897.768178545711;2940.941181176407;3013.2918764090423;947.6304241345881;951.6526467839188;978.280963491833;998.201438848918;1002.6691191906654;19653.312134075524;20067.799322006595;20209.797902021084;20683.689744653842;23754.881225593763;1002.6240159940022;1006.942710154335;1021.1677482851452;1048.491481631408;1053.899879511445;11336.773264534662;11543.88456115428;11599.594014209462;11667.88332116685;11711.472983715754;536942;552516;557397;559709;568624;125364.37317813536;126160;128106;129846;130653;1231.7105480212142;1268.6067319131098;1300.2913412190378;1301.2452777389092;1306.1510018487868;17191.914040429718;18891.338803141825;19153.52116197106;19225.903870480557;20950;58349.12476312774;59288;60514;61044.38955610387;61500;67579.32420675927;68204;68279.65860170667;68458.65770671115;69047.65476172588;14593.635159121108;14734.557963261119;14754.188519631523;14792.926035369754;14844;23553.646695299925;23652.645210322204;23854.16510422127;23938.64092038586;24069.51860962806;18184.09079545991;18239.726404104214;18324.541886452946;18356.724649130007;18379.72430413518;16104;16804.495865124067;16900;17007.48977530676;17042;18475.983820889982;18725.719114213025;18873;18902.338418155297;18982.24071037198;14020.439182432588;14151.292435377984;14184.432622695389;14188.503402380868;14191.929040354733;17948.923064616163;18240.45278641643;19214.903925480285;19256.326028588934;19395.418137455898 19:07:50 INFO - PID 25298 | |3;mootools.html;1371.6776557508983;1383.418964035105;1410.8377536583282;1416.3980308368941;1464.026422429085;13823.170609763409;13961.93019034906;14487.565373038813;14527.92736036321;14528.709425811478;14446.711065778678;14816.11103333798;14893.92553037236;14901;14919.32863021164;2554.795616350697;2599.285196570939;2622.9868850655816;2626.120249716347;2636.6967798703204;2539.6825396825398;2634.143903231448;2694.703582605912;2699.5140874642557;2703.6079768433565;2653.31013936376;2673.2782148819806;2686.986565067182;2688.8386696798157;2691.1791903469434;2464.383904023994;2608.100205429124;2655.0441840937247;2675.063727695291;2680.5041067402494;2506.1228570000535;2517.735637758027;2557.4373637799654;2569.4347243606376;2573.6654234949337;13742.106763060368;13821.516246931309;13923.860761392358;13929.303534823219;13932.442702291997;7230.313120253568;7542.434317426215;7545.849083018364;7554.848903021909;7560.357369623589;4690.413698287714;4838.6371022173125;4976.253561965698;5009.398872135331;5037.974810125963;1826.8264514871066;1837.3936600921663;1881.0876724788466;1890.5368184794677;1899.7815251246145;22481.100755969743;22761.31716048521;22834;23027.309180724606;23068;5885.588008839341;5978.880422391615;6153.661548614779;6159.692015399301;6196.566240363221;14636.926815365856;14721.337539810735;14723.779143312859;14737.926310368379;14739.705205896036;6914.446844252448;7007.054047703495;7041.683124259421;7065.0815393998455;7072.186698529632;6419.101325814389;6429.260635027032;6510.609363438209;6556.901646475307;6607.80176594703;4415.977920110379;4531.071130418256;4763.833265835679;4903.092927808367;4942.901141977212;1293.2563775828935;1301.4208677138772;1318.5912367166209;1333.8466076401337;1342.1074985134776;858.914108589136;881.4667126388571;882.3250213586612;909.6816114360054;925.121134921827;7795.415343849234;8581.914180858112;8846.380753347332;8891.333150013776;8940.955295223483;954.61815273891;959.3092973059386;972.6595691507915;973.73709098543;997.3766396002499;4919.458859525449;5063.417706963746;5214.40206257681;5289.312389389354;5431.995080910045;17484.388046418313;18265.45203643893;18338.08309584542;18344;18359.90820045891;19348.8065119347;19412.22351105968;19542.31601893927;19564.902175489315;19651.705224421647;10433.895661043443;10921.290116142425;10974.725631859268;11029.779404412027;11073.280236784743;7695;7977.48146370484;8478.957605211934;8489.915100848912;8493.87259191125;16357.34570617162;16663.250153743353;17152.313907443564;17491.737623935398;17497.737533936746;16976.660466790843;17393.391231306843;17417.39039133624;17662.20520076574;17731.64536709233;11426.771464570496;11771.646850594496;11787.646370608896;11788.174827761974;11789.587364442203;11114.16643751738;11461.598844040418;11768.823467648162;12857.292848893401;13005.284709340698;10444.791104178026;10936.562537498728;10978.780424391627;11208.55165793359;11369.886301136883;10098.747531311776;10486;10624.787504250025;10719.249652524248;10736.89263107359;9652.90347096548;9703.07820757027;9753.9024609753;9786.608535658494;9796.608135674778;6749.392554670103;6862.519623626298;6896.448284137357;6914.965425172842;7032.156141263081;7179.461540384387;7218.314260145278;7266.418686505172;7328.853422931618;7376.815579610553 19:07:50 INFO - PID 25298 | |4;prototype.html;487.6074759818347;500.14724894055627;521.2025600830731;521.9269302297678;528.1312241362958;6216.813495595128;6239.6256224626495;6242.469390101835;6251.374862513752;6267.4045965633195;5900.380460051697;5927.88144237115;5977.581569290141;6013.969930150354;6096.481799047076;4803.351547541072;4904.730239836807;4909.165441874872;4919.655624106314;4920.163572192718;4756;4891.828785992491;4929.876753081166;4936.950630493703;4977.377827771528;4757.215059515176;4810.484697320333;4837.105135549935;4901.485344038878;4942.703437793743;4852.199387101124;4861.611071114302;4864.367632207825;4865.245886887538;4894.800773810439;4392.2752745797225;4406.713563618355;4422.6682998774895;4450.554944505556;4455.287154055368;5952.761889524414;6002.189704389939;6023.849403764897;6052.4552790248645;6063.483654283511;5581.888362232733;5625;5661.2923384576925;5690.971545142289;5726.656400615976;6410.102585638015;6461.709223084926;6462.353764623547;6478.7084581193485;6479.222493300834;4803.039392121555;4831.396075490564;4845.297431872359;4870.172070747982;4878.780454879539;6663.300353462865;6757.526973111884;6772.764987554096;6843.589384636888;6882.483813713991;4917.844306587949;4935;4939.876503087452;4956.182229932093;5003.924941125886;5000.524950129732;5062.620303477254;5069.366329208849;5083.491650834961;5092;5498.615096943256;5523.447655234525;5688.402717714663;5694.7323725554525;5698.458646428583;6356.77751278703;6469.967650161719;6480.2547707013355;6493.967530162414;6575.243846957565;1645.317193364764;1721.5093698295925;1726.1369315342329;1750.474857542732;1767.3637490503409;990.6285143071349;1195.9940200298943;1216.3492531495608;1217.4278089298016;1235.6293112066344;5512.310961129859;5610.579206559524;5671.51792097668;5697.572682048863;5697.857553561112;6572.638504882278;6621.3047629998155;6641.306466850922;6656.800295991031;6686.130802995676;5633.647979452219;5692.573057020657;5699.658020518782;5733.569982251348;5749.568782341257;3547.5742910850345;3551.4672799079826;3566.4293713006314;3570.393033184313;3619.4027985382645;6366.427021568081;6431.228252609717;6451.483881289486;6493.772717954849;6512.34876512345;6788.422984046411;6802.217744959294;6837.62393068386;6853.7943861684225;6869.179667388146;6399.968000159969;6427.517936154807;6467.997460393646;6472.935270647327;6500.382463665944;6632.801015969529;6685.298043705341;6685.598864067977;6701.363370479797;6705.765298214539;6607.834804129935;6610.3720146586;6622;6659.134312539339;6678.165229346332;6359.332270111757;6369.407648087978;6373.840653983688;6390.360963903572;6505.8698826024165;4822.987172693774;4890.902181956412;4900.803967841246;4914.287428322802;4937.950620493749;6581.703823327866;6654.866902662016;6750.143710479658;6783.219929708147;6809.89785153233;6400.1679781629955;6473.385028422293;6501.414872661483;6515.837104072436;6548.639824809681;6425.518086143465;6459.935400646122;6478.643674597943;6480.837979050561;6496.148597649647;6349.238091429058;6432.807015789534;6437.452816510649;6457.321981191907;6515.73937042513;6485.805425837232;6552.180977377828;6582.703778330082;6625.244310257882;6633.6019838809825;5844.766209351748;6300.716467759054;6301.180846489927;6374.4900407966325;6408.839779005562 19:07:50 INFO - PID 25298 | |5;yui.html;881.8148188880335;899.4063917814244;908.8318661047707;916.9174774270316;921.3688623293043;18022.639547209063;19137.138828752722;19164.71252931207;19196;21583.67624485634;20594.1762329507;20852.68720969183;21572;21771.129154833827;21786.455338616543;1034.6792494326746;1063.7872425514888;1063.8776540697802;1064.2177999170603;1064.2231171244996;1016.207358260558;1065.0201814330835;1066.7493139112303;1067.066316972649;1068.732816795801;1107.070061148635;1116;1117.60883690708;1117.809972304706;1118.1613789657756;1105.4141305108305;1108.7727015961748;1108.8392183133442;1110.0065441429956;1112.8608923884515;808.2241048593357;808.5795386399099;809.0210844877705;812.553095797315;813.1502579804119;19278.903605481883;19836.702449463126;19892.303769368147;20117.094730737153;20411.387658370273;20305.695414568792;20314.79685203144;20662.07020684073;20732.274370396965;20835.687464688042;15864.206789660586;16019.519414417586;16179.595510112342;16185.838141618551;16555;3512.5082488451635;3516.7362447816517;3541.6635419635095;3541.8052007139595;3565.6790888819874;115513;119090;121407.3929630355;122893.38553307176;125019;14171.433142674177;14223.64440888986;14381.64045898861;14495.275236238145;14544.200068996306;28393.57409638857;30315.69684303173;30334.393312134074;30514.77940882384;30548.69451305503;7780.533168009937;8014.438989270695;8427.32581393487;8594.699185528476;8717.782055448664;4218.282891908383;4295.033617436052;4316.050468896838;4318.978405107954;4327.394164816928;4934.087193869145;4957.454679985199;5079.31429257053;5085.898282034339;5121.795128194905;996.7308826616772;1018.7367664096467;1025.108155904353;1034.2915103154364;1037.025196315461;663.4559661077966;672.1900110366996;691.2051141187574;692.7021380806201;698.4761428928304;10534.947325263325;12642.936785316015;12771.233725976472;12865.549705760253;13501.66245843842;652.6345246661884;689.3106893106893;691.0532570378614;692.5083190934392;696.8571442854203;5040.31955685985;5192.299039629677;5263.157894736823;5295.338082739658;5349.144136938149;107889;107945.04034031123;112391.43804280926;113090;113647;93784;94985.52507237557;95236.52381738185;97783.0221697774;97806.5109674447;77919.2208077912;81874;83881.58059209665;84014;85612;10011.799764004825;10308.433036182782;10534.631287904887;11873.228240164362;12908.548200812926;39115;39648.40527392149;40469.797651011555;42839.35740963826;43190.352144717224;63924.68037659782;66125.33874661192;70258.64870675614;70454.94317585138;71379.64310178623;18283.634327313113;18386.356477523223;18756.96836673996;18903.90548047306;19020.714689279393;17047.23287452043;18099.54751131232;19577.412677619694;21167;21553.461163471038;17031.744523831905;17144.571385715455;17309.740353894955;17417.912910435873;17541.298348066444;17980.730289045936;18027.2789088435;18057;18132.909335453238;18269.08654567293;17599.82400175982;17637.02996335214;17788.733169002215;18033.639327213645;18072;12580.559680411141;12976.416061277454;13520.86479135196;13534.932325338705;13839.30803459843;12785.232886026868;14092.36584353686;14342.569722908329;14398.352074156897;14566.198859062853 19:07:50 INFO - PID 25298 | __end_tp_report 19:07:50 INFO - PID 25298 | __start_cc_report 19:07:50 INFO - PID 25298 | _x_x_mozilla_cycle_collect,353 19:07:50 INFO - PID 25298 | __end_cc_report 19:07:50 INFO - PID 25298 | __startTimestamp1500948470822__endTimestamp 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | ------- Summary: start ------- 19:07:50 INFO - PID 25298 | Number of tests: 6 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#0] dojo.html Cycles:165 Average:6082.83 Median:6265.72 stddev:703.35 (11.2%) stddev-sans-first:665.19 19:07:50 INFO - PID 25298 | Values: 3090.9 3146.2 3171.9 3180.1 3205.7 6141.3 6220.9 6253.9 6256.2 6268.5 5925.9 5986.8 5989.6 6032.8 6042.6 5580.7 5593.1 5598.9 5635.4 5708.8 5716.7 5719.6 5765.5 5786.6 5795.3 5426.6 5655.4 5692.8 5753.6 5775.1 5507.4 5639.0 5677.3 5706.6 5723.9 5585.3 5617.5 5661.2 5665.1 5695.7 5892.2 5942.8 6128.0 6134.5 6152.3 6562.5 6619.1 6619.8 6632.4 6634.3 6641.2 6656.9 6703.8 6723.3 6739.4 6147.1 6169.4 6222.7 6254.1 6265.7 6576.6 6668.0 6761.2 6846.2 6861.0 6234.7 6299.5 6314.3 6318.2 6434.0 6632.3 6637.9 6658.6 6664.3 6672.6 6588.1 6656.5 6665.7 6674.9 6681.0 6599.3 6609.2 6668.8 6699.8 6705.0 5194.5 5289.0 5296.8 5387.3 5443.5 4629.6 4659.8 4681.4 4684.3 4703.2 5726.0 5742.4 5798.6 5798.9 5809.5 6420.4 6544.8 6597.0 6646.9 6732.0 5705.8 5754.2 5769.1 5809.9 5816.6 5865.6 5867.1 5923.5 5940.9 5954.5 6212.9 6322.3 6431.1 6499.0 6535.6 6534.5 6641.9 6678.4 6708.0 6711.4 6370.8 6443.2 6444.0 6544.9 6546.9 6504.3 6504.9 6518.1 6567.2 6624.0 6445.1 6550.0 6638.3 6734.3 6734.9 6400.7 6434.3 6472.1 6487.6 6488.5 6219.3 6379.7 6387.2 6392.7 6478.8 6263.0 6272.9 6297.9 6302.0 6308.4 6315.8 6380.1 6391.7 6404.6 6418.3 6147.9 6189.7 6204.5 6206.9 6218.6 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#1] ext.html Cycles:180 Average:39329.94 Median:37054.94 stddev:56441.95 (152.3%) stddev-sans-first:56526.05 19:07:50 INFO - PID 25298 | Values: 776.8 824.1 857.4 877.2 881.0 39692.0 40107.6 40509.2 40536.2 40550.4 36854.0 37027.4 37031.4 37078.4 37211.6 6673.8 6792.7 6823.0 6830.0 6856.9 6772.4 6859.9 6892.6 6912.1 6915.8 7449.2 7617.4 7619.8 7644.7 7646.8 7450.4 7496.8 7501.0 7542.9 7564.1 7270.5 7445.6 7451.0 7457.6 7472.1 39471.6 39739.4 39821.4 39833.0 39898.6 3510.2 3542.8 3554.3 3567.4 3567.6 31548.1 31678.4 31725.7 31810.4 31873.2 4829.4 4862.7 4870.2 4881.7 4944.8 183404.0 184945.0 186648.0 186967.0 192917.0 49293.8 49839.5 49855.0 49881.8 49891.3 51343.0 51349.7 51427.7 51444.0 51557.5 15290.2 15377.9 15385.5 15409.5 15608.1 12570.7 12577.9 12585.2 12586.7 12604.4 14462.1 14586.9 14663.3 14728.3 14749.9 5856.8 5926.2 5936.0 5979.4 5996.3 950.7 968.2 975.8 988.5 1025.0 27804.2 28925.7 29841.9 30188.4 30484.4 1077.2 1084.8 1100.8 1116.6 1118.0 12184.7 12583.9 12666.3 12725.6 12793.3 236422.0 238936.0 238956.0 239125.0 240181.0 53013.0 53611.5 53662.0 53739.7 53969.0 1452.1 1469.2 1487.6 1497.1 1509.7 22702.0 23036.2 23693.4 27387.0 27774.0 52088.5 52739.0 52751.7 52774.0 52798.0 219247.0 223777.0 224151.0 224752.0 224861.0 35435.5 37491.3 38322.2 38352.6 38353.4 45970.3 47184.0 47427.5 48007.3 48007.3 32287.4 33037.3 33235.7 33492.0 33937.2 31017.2 31045.8 32663.5 33079.0 33399.0 36486.0 37752.1 37926.2 38258.2 38447.8 32517.8 32804.7 32808.8 32869.3 33400.7 23656.5 24890.4 25297.0 25628.6 25784.0 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#2] jquery.html Cycles:180 Average:37104.42 Median:12565.65 stddev:93120.23 (741.1%) stddev-sans-first:93341.06 19:07:50 INFO - PID 25298 | Values: 573.6 575.5 575.7 585.9 602.5 21415.8 22446.7 22470.2 22539.4 22937.5 25041.5 25335.5 25561.1 25616.4 25621.1 6331.4 6518.6 6518.7 6521.2 6522.1 3844.6 3995.5 6099.1 6490.6 6497.0 6433.1 6464.0 6473.1 6488.8 6499.3 6422.3 6470.5 6472.0 6477.4 6497.0 5988.3 6020.5 6039.2 6040.2 6070.8 28534.1 29818.9 29891.3 30099.2 30244.7 1882.0 1934.8 1938.6 1939.5 1941.8 18560.2 18968.8 18999.6 19122.3 19145.4 2238.6 2275.9 2292.7 2301.0 2400.7 136051.0 143664.0 143797.0 143836.0 144262.3 14285.9 14935.9 15198.2 15264.8 15369.5 22855.4 22864.9 22869.0 22893.3 23006.5 10060.9 10099.6 10197.7 10276.2 10344.5 9323.6 9326.5 9354.3 9381.4 9505.6 9070.8 9128.8 9260.4 9300.8 9318.2 2806.3 2883.8 2897.8 2940.9 3013.3 947.6 951.7 978.3 998.2 1002.7 19653.3 20067.8 20209.8 20683.7 23754.9 1002.6 1006.9 1021.2 1048.5 1053.9 11336.8 11543.9 11599.6 11667.9 11711.5 536942.0 552516.0 557397.0 559709.0 568624.0 125364.4 126160.0 128106.0 129846.0 130653.0 1231.7 1268.6 1300.3 1301.2 1306.2 17191.9 18891.3 19153.5 19225.9 20950.0 58349.1 59288.0 60514.0 61044.4 61500.0 67579.3 68204.0 68279.7 68458.7 69047.7 14593.6 14734.6 14754.2 14792.9 14844.0 23553.6 23652.6 23854.2 23938.6 24069.5 18184.1 18239.7 18324.5 18356.7 18379.7 16104.0 16804.5 16900.0 17007.5 17042.0 18476.0 18725.7 18873.0 18902.3 18982.2 14020.4 14151.3 14184.4 14188.5 14191.9 17948.9 18240.5 19214.9 19256.3 19395.4 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#3] mootools.html Cycles:180 Average:8637.89 Median:2563.44 stddev:5892.77 (229.9%) stddev-sans-first:5884.00 19:07:50 INFO - PID 25298 | Values: 1371.7 1383.4 1410.8 1416.4 1464.0 13823.2 13961.9 14487.6 14527.9 14528.7 14446.7 14816.1 14893.9 14901.0 14919.3 2554.8 2599.3 2623.0 2626.1 2636.7 2539.7 2634.1 2694.7 2699.5 2703.6 2653.3 2673.3 2687.0 2688.8 2691.2 2464.4 2608.1 2655.0 2675.1 2680.5 2506.1 2517.7 2557.4 2569.4 2573.7 13742.1 13821.5 13923.9 13929.3 13932.4 7230.3 7542.4 7545.8 7554.8 7560.4 4690.4 4838.6 4976.3 5009.4 5038.0 1826.8 1837.4 1881.1 1890.5 1899.8 22481.1 22761.3 22834.0 23027.3 23068.0 5885.6 5978.9 6153.7 6159.7 6196.6 14636.9 14721.3 14723.8 14737.9 14739.7 6914.4 7007.1 7041.7 7065.1 7072.2 6419.1 6429.3 6510.6 6556.9 6607.8 4416.0 4531.1 4763.8 4903.1 4942.9 1293.3 1301.4 1318.6 1333.8 1342.1 858.9 881.5 882.3 909.7 925.1 7795.4 8581.9 8846.4 8891.3 8941.0 954.6 959.3 972.7 973.7 997.4 4919.5 5063.4 5214.4 5289.3 5432.0 17484.4 18265.5 18338.1 18344.0 18359.9 19348.8 19412.2 19542.3 19564.9 19651.7 10433.9 10921.3 10974.7 11029.8 11073.3 7695.0 7977.5 8479.0 8489.9 8493.9 16357.3 16663.3 17152.3 17491.7 17497.7 16976.7 17393.4 17417.4 17662.2 17731.6 11426.8 11771.6 11787.6 11788.2 11789.6 11114.2 11461.6 11768.8 12857.3 13005.3 10444.8 10936.6 10978.8 11208.6 11369.9 10098.7 10486.0 10624.8 10719.2 10736.9 9652.9 9703.1 9753.9 9786.6 9796.6 6749.4 6862.5 6896.4 6915.0 7032.2 7179.5 7218.3 7266.4 7328.9 7376.8 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#4] prototype.html Cycles:180 Average:5451.72 Median:6018.91 stddev:1538.07 (25.6%) stddev-sans-first:1496.57 19:07:50 INFO - PID 25298 | Values: 487.6 500.1 521.2 521.9 528.1 6216.8 6239.6 6242.5 6251.4 6267.4 5900.4 5927.9 5977.6 6014.0 6096.5 4803.4 4904.7 4909.2 4919.7 4920.2 4756.0 4891.8 4929.9 4937.0 4977.4 4757.2 4810.5 4837.1 4901.5 4942.7 4852.2 4861.6 4864.4 4865.2 4894.8 4392.3 4406.7 4422.7 4450.6 4455.3 5952.8 6002.2 6023.8 6052.5 6063.5 5581.9 5625.0 5661.3 5691.0 5726.7 6410.1 6461.7 6462.4 6478.7 6479.2 4803.0 4831.4 4845.3 4870.2 4878.8 6663.3 6757.5 6772.8 6843.6 6882.5 4917.8 4935.0 4939.9 4956.2 5003.9 5000.5 5062.6 5069.4 5083.5 5092.0 5498.6 5523.4 5688.4 5694.7 5698.5 6356.8 6470.0 6480.3 6494.0 6575.2 1645.3 1721.5 1726.1 1750.5 1767.4 990.6 1196.0 1216.3 1217.4 1235.6 5512.3 5610.6 5671.5 5697.6 5697.9 6572.6 6621.3 6641.3 6656.8 6686.1 5633.6 5692.6 5699.7 5733.6 5749.6 3547.6 3551.5 3566.4 3570.4 3619.4 6366.4 6431.2 6451.5 6493.8 6512.3 6788.4 6802.2 6837.6 6853.8 6869.2 6400.0 6427.5 6468.0 6472.9 6500.4 6632.8 6685.3 6685.6 6701.4 6705.8 6607.8 6610.4 6622.0 6659.1 6678.2 6359.3 6369.4 6373.8 6390.4 6505.9 4823.0 4890.9 4900.8 4914.3 4938.0 6581.7 6654.9 6750.1 6783.2 6809.9 6400.2 6473.4 6501.4 6515.8 6548.6 6425.5 6459.9 6478.6 6480.8 6496.1 6349.2 6432.8 6437.5 6457.3 6515.7 6485.8 6552.2 6582.7 6625.2 6633.6 5844.8 6300.7 6301.2 6374.5 6408.8 19:07:50 INFO - PID 25298 | 19:07:50 INFO - PID 25298 | [#5] yui.html Cycles:180 Average:23298.05 Median:19428.16 stddev:31410.42 (161.7%) stddev-sans-first:31453.44 19:07:50 INFO - PID 25298 | Values: 881.8 899.4 908.8 916.9 921.4 18022.6 19137.1 19164.7 19196.0 21583.7 20594.2 20852.7 21572.0 21771.1 21786.5 1034.7 1063.8 1063.9 1064.2 1064.2 1016.2 1065.0 1066.7 1067.1 1068.7 1107.1 1116.0 1117.6 1117.8 1118.2 1105.4 1108.8 1108.8 1110.0 1112.9 808.2 808.6 809.0 812.6 813.2 19278.9 19836.7 19892.3 20117.1 20411.4 20305.7 20314.8 20662.1 20732.3 20835.7 15864.2 16019.5 16179.6 16185.8 16555.0 3512.5 3516.7 3541.7 3541.8 3565.7 115513.0 119090.0 121407.4 122893.4 125019.0 14171.4 14223.6 14381.6 14495.3 14544.2 28393.6 30315.7 30334.4 30514.8 30548.7 7780.5 8014.4 8427.3 8594.7 8717.8 4218.3 4295.0 4316.1 4319.0 4327.4 4934.1 4957.5 5079.3 5085.9 5121.8 996.7 1018.7 1025.1 1034.3 1037.0 663.5 672.2 691.2 692.7 698.5 10534.9 12642.9 12771.2 12865.5 13501.7 652.6 689.3 691.1 692.5 696.9 5040.3 5192.3 5263.2 5295.3 5349.1 107889.0 107945.0 112391.4 113090.0 113647.0 93784.0 94985.5 95236.5 97783.0 97806.5 77919.2 81874.0 83881.6 84014.0 85612.0 10011.8 10308.4 10534.6 11873.2 12908.5 39115.0 39648.4 40469.8 42839.4 43190.4 63924.7 66125.3 70258.6 70454.9 71379.6 18283.6 18386.4 18757.0 18903.9 19020.7 17047.2 18099.5 19577.4 21167.0 21553.5 17031.7 17144.6 17309.7 17417.9 17541.3 17980.7 18027.3 18057.0 18132.9 18269.1 17599.8 17637.0 17788.7 18033.6 18072.0 12580.6 12976.4 13520.9 13534.9 13839.3 12785.2 14092.4 14342.6 14398.4 14566.2 19:07:50 INFO - PID 25298 | -------- Summary: end -------- 19:07:50 INFO - PID 25298 | 19:07:51 INFO - TEST-INFO | 25298: exit 0 19:07:51 INFO - TEST-OK | dromaeo_css | took 1113872ms 19:07:51 INFO - TEST-START | kraken 19:07:51 INFO - Initialising browser for kraken test... 19:07:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55556/getInfo.html -profile /tmp/tmp_Yxg8Z/profile 19:07:51 INFO - TEST-INFO | started process 25668 (/builds/slave/test/build/application/firefox/firefox http://localhost:55556/getInfo.html) 19:07:57 INFO - TEST-INFO | 25668: exit 0 19:07:57 INFO - Browser initialized. 19:07:57 INFO - Running cycle 1/1 for kraken test... 19:07:57 INFO - TEST-INFO | started process 25894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Yxg8Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:09 INFO - PID 25894 | RSS: Main: 174493696 19:08:09 INFO - PID 25894 | 19:08:11 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55556/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:12 INFO - PID 25894 | RSS: Main: 179404800 19:08:12 INFO - PID 25894 | 19:08:15 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55556/tests/kraken/driver.html?testName=audio-dft) 19:08:15 INFO - PID 25894 | RSS: Main: 180301824 19:08:15 INFO - PID 25894 | 19:08:18 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55556/tests/kraken/driver.html?testName=audio-fft) 19:08:19 INFO - PID 25894 | RSS: Main: 173654016 19:08:19 INFO - PID 25894 | 19:08:21 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55556/tests/kraken/driver.html?testName=audio-oscillator) 19:08:22 INFO - PID 25894 | RSS: Main: 174276608 19:08:22 INFO - PID 25894 | 19:08:24 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:25 INFO - PID 25894 | RSS: Main: 174440448 19:08:25 INFO - PID 25894 | 19:08:28 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55556/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:28 INFO - PID 25894 | RSS: Main: 176730112 19:08:28 INFO - PID 25894 | 19:08:32 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55556/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:33 INFO - PID 25894 | RSS: Main: 176668672 19:08:33 INFO - PID 25894 | 19:08:35 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55556/tests/kraken/driver.html?testName=json-parse-financial) 19:08:36 INFO - PID 25894 | RSS: Main: 177340416 19:08:36 INFO - PID 25894 | 19:08:38 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:38 INFO - PID 25894 | RSS: Main: 177397760 19:08:38 INFO - PID 25894 | 19:08:40 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:41 INFO - PID 25894 | RSS: Main: 177430528 19:08:41 INFO - PID 25894 | 19:08:43 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:43 INFO - PID 25894 | RSS: Main: 177659904 19:08:44 INFO - PID 25894 | 19:08:46 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:47 INFO - PID 25894 | RSS: Main: 178245632 19:08:47 INFO - PID 25894 | 19:08:50 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:51 INFO - PID 25894 | RSS: Main: 177950720 19:08:51 INFO - PID 25894 | 19:08:52 INFO - PID 25894 | Cycle 1(1): loaded http://localhost:55556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55556/tests/kraken/driver.html?testName=ai-astar) 19:08:53 INFO - PID 25894 | RSS: Main: 179671040 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | __start_tp_report 19:08:53 INFO - PID 25894 | _x_x_mozilla_page_load 19:08:53 INFO - PID 25894 | _x_x_mozilla_page_load_details 19:08:53 INFO - PID 25894 | |i|pagename|runs| 19:08:53 INFO - PID 25894 | |0;ai-astar;101;111;104;109;112;112;114;103;110;112 19:08:53 INFO - PID 25894 | |1;audio-beat-detection;152;118;151;182;117;146;143;125;175;127 19:08:53 INFO - PID 25894 | |2;audio-dft;165;163;164;162;163;164;166;163;167;164 19:08:53 INFO - PID 25894 | |3;audio-fft;76;76;76;174;77;76;76;89;99;76 19:08:53 INFO - PID 25894 | |4;audio-oscillator;81;82;131;82;81;81;129;80;81;141 19:08:53 INFO - PID 25894 | |5;imaging-gaussian-blur;115;114;116;113;116;114;114;114;115;123 19:08:53 INFO - PID 25894 | |6;imaging-darkroom;150;150;149;152;151;152;150;152;152;152 19:08:53 INFO - PID 25894 | |7;imaging-desaturate;95;95;94;94;93;99;100;94;94;94 19:08:53 INFO - PID 25894 | |8;json-parse-financial;53;53;53;53;53;52;53;53;53;53 19:08:53 INFO - PID 25894 | |9;json-stringify-tinderbox;55;54;54;55;54;55;57;54;54;54 19:08:53 INFO - PID 25894 | |10;stanford-crypto-aes;89;77;79;88;78;78;78;76;77;86 19:08:53 INFO - PID 25894 | |11;stanford-crypto-ccm;139;124;135;124;127;130;126;128;135;169 19:08:53 INFO - PID 25894 | |12;stanford-crypto-pbkdf2;176;176;184;182;175;171;179;173;173;190 19:08:53 INFO - PID 25894 | |13;stanford-crypto-sha256-iterative;68;71;68;71;73;66;68;73;68;70 19:08:53 INFO - PID 25894 | __end_tp_report 19:08:53 INFO - PID 25894 | __start_cc_report 19:08:53 INFO - PID 25894 | _x_x_mozilla_cycle_collect,953 19:08:53 INFO - PID 25894 | __end_cc_report 19:08:53 INFO - PID 25894 | __startTimestamp1500948533124__endTimestamp 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | ------- Summary: start ------- 19:08:53 INFO - PID 25894 | Number of tests: 14 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.49 (4.0%) stddev-sans-first:3.77 19:08:53 INFO - PID 25894 | Values: 101.0 111.0 104.0 109.0 112.0 112.0 114.0 103.0 110.0 112.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:148.50 stddev:22.55 (15.2%) stddev-sans-first:23.71 19:08:53 INFO - PID 25894 | Values: 152.0 118.0 151.0 182.0 117.0 146.0 143.0 125.0 175.0 127.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 19:08:53 INFO - PID 25894 | Values: 165.0 163.0 164.0 162.0 163.0 164.0 166.0 163.0 167.0 164.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#3] audio-fft Cycles:10 Average:89.50 Median:76.00 stddev:30.70 (40.4%) stddev-sans-first:32.17 19:08:53 INFO - PID 25894 | Values: 76.0 76.0 76.0 174.0 77.0 76.0 76.0 89.0 99.0 76.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:81.00 stddev:25.56 (31.6%) stddev-sans-first:26.45 19:08:53 INFO - PID 25894 | Values: 81.0 82.0 131.0 82.0 81.0 81.0 129.0 80.0 81.0 141.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:2.84 (2.5%) stddev-sans-first:3.00 19:08:53 INFO - PID 25894 | Values: 115.0 114.0 116.0 113.0 116.0 114.0 114.0 114.0 115.0 123.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:152.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 19:08:53 INFO - PID 25894 | Values: 150.0 150.0 149.0 152.0 151.0 152.0 150.0 152.0 152.0 152.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.35 (2.5%) stddev-sans-first:2.49 19:08:53 INFO - PID 25894 | Values: 95.0 95.0 94.0 94.0 93.0 99.0 100.0 94.0 94.0 94.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 19:08:53 INFO - PID 25894 | Values: 53.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 53.0 53.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:1.01 19:08:53 INFO - PID 25894 | Values: 55.0 54.0 54.0 55.0 54.0 55.0 57.0 54.0 54.0 54.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:78.50 stddev:4.99 (6.4%) stddev-sans-first:4.27 19:08:53 INFO - PID 25894 | Values: 89.0 77.0 79.0 88.0 78.0 78.0 78.0 76.0 77.0 86.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:132.50 stddev:13.40 (10.1%) stddev-sans-first:14.08 19:08:53 INFO - PID 25894 | Values: 139.0 124.0 135.0 124.0 127.0 130.0 126.0 128.0 135.0 169.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:177.50 stddev:5.90 (3.3%) stddev-sans-first:6.21 19:08:53 INFO - PID 25894 | Values: 176.0 176.0 184.0 182.0 175.0 171.0 179.0 173.0 173.0 190.0 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.50 stddev:2.37 (3.4%) stddev-sans-first:2.44 19:08:53 INFO - PID 25894 | Values: 68.0 71.0 68.0 71.0 73.0 66.0 68.0 73.0 68.0 70.0 19:08:53 INFO - PID 25894 | -------- Summary: end -------- 19:08:53 INFO - PID 25894 | 19:08:53 INFO - PID 25894 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:08:53 INFO - TEST-INFO | 25894: exit 0 19:08:53 INFO - TEST-OK | kraken | took 62208ms 19:08:53 INFO - SUITE-END | took 1176s 19:08:54 INFO - Completed test suite (00:19:36) 19:08:54 INFO - javascript benchmark 19:08:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8449.506400945082, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.8563831382407, 3146.181992681902, 3171.9207019824503, 3180.0777774445414, 3205.6794320567933, 6141.263048434189, 6220.9377906220925, 6253.937460625404, 6256.155419018437, 6268.4671802896755, 5925.85185370366, 5986.760529578812, 5989.580729348936, 6032.819015429544, 6042.607230530023, 5580.748866301006, 5593.133064375028, 5598.916016259759, 5635.380108188096, 5708.828735137952, 5716.742746576393, 5719.59962802604, 5765.4522820332, 5786.56600754943, 5795.3335366432975, 5426.565874730012, 5655.3779084300695, 5692.829215123532, 5753.5684823638185, 5775.133729940521, 5507.421720719347, 5638.971805140989, 5677.290338707661, 5706.572007099443, 5723.9141412878425, 5585.273914391144, 5617.494425501724, 5661.2357331760095, 5665.065264231397, 5695.658260504383, 5892.23400957877, 5942.762289508458, 6128.0, 6134.478569321613, 6152.261728592553, 6562.475001999828, 6619.073329733841, 6619.834504137387, 6632.436242919358, 6634.270230274666, 6641.169853768279, 6656.93343066568, 6703.765368212138, 6723.260441351447, 6739.427148692367, 6147.077938309245, 6169.352218017133, 6222.657753823538, 6254.093156492283, 6265.718042687999, 6576.572522786004, 6668.0, 6761.154855643044, 6846.178458585002, 6861.039454476378, 6234.719437625317, 6299.5275354348605, 6314.336994615591, 6318.178636777281, 6434.034894765822, 6632.2704502504685, 6637.86724265512, 6658.600483970978, 6664.266930637626, 6672.566283191577, 6588.143541339595, 6656.467482601381, 6665.666716664147, 6674.933250667431, 6680.966595166993, 6599.274079851212, 6609.173853268341, 6668.83327916806, 6699.832504187337, 6704.96647516769, 5194.4805519447755, 5288.9735551322765, 5296.814611488579, 5387.272718182995, 5443.482869127427, 4629.629629629621, 4659.767011649472, 4681.391419115561, 4684.297355396718, 4703.2004559225015, 5726.0, 5742.425757424307, 5798.594098413155, 5798.855028624318, 5809.535237181015, 6420.390062944013, 6544.770933017321, 6596.967015164893, 6646.900296495556, 6732.023856540872, 5705.828825135252, 5754.1944127822135, 5769.07694768835, 5809.912851307234, 5816.592838501264, 5865.563434208747, 5867.090600956859, 5923.526117910643, 5940.851478713067, 5954.49386802118, 6212.875742485216, 6322.304546499973, 6431.099646049557, 6498.967505162444, 6535.607863528204, 6534.4772418205475, 6641.867162656623, 6678.3989440950545, 6708.027336036345, 6711.395974362331, 6370.777022804365, 6443.194600674916, 6443.96778016107, 6544.901826472512, 6546.934530654633, 6504.252011018793, 6504.869902602016, 6518.054882042172, 6567.2447668518735, 6624.0, 6445.097686324012, 6549.96725016391, 6638.336166383323, 6734.326567343226, 6734.865302693821, 6400.743970241325, 6434.324395938546, 6472.093906852951, 6487.578307410004, 6488.513361498001, 6219.253689557282, 6379.6810159490915, 6387.201599800025, 6392.680365981775, 6478.805635830932, 6263.029230469285, 6272.874542509033, 6297.937020629735, 6301.96849015752, 6308.369163083655, 6315.842103947438, 6380.138681277968, 6391.6804159792755, 6404.615723056445, 6418.261899881573, 6147.907781383194, 6189.690515474298, 6204.472619827366, 6206.937930620817, 6218.595791273553], "value": 6031.431472007984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.8096816280013, 824.0523398092197, 857.4041041476173, 877.171073335698, 880.9955950220248, 39692.0, 40107.59892401079, 40509.18981620366, 40536.189276214456, 40550.39174412386, 36854.0, 37027.44458833113, 37031.44452833203, 37078.44382334267, 37211.62788372116, 6673.766418175364, 6792.728290868359, 6823.044773731682, 6830.00964860095, 6856.862862742742, 6772.390484856362, 6859.862802743942, 6892.620905850176, 6912.101426814507, 6915.827104322407, 7449.21783212763, 7617.352525035379, 7619.771406857803, 7644.6559904804135, 7646.847063058735, 7450.441216908726, 7496.8125796854965, 7501.0, 7542.886856697154, 7564.092308922909, 7270.491065625409, 7445.590492522909, 7451.0, 7457.552546847152, 7472.103347598269, 39471.60528394737, 39739.403908941385, 39821.402678959836, 39833.0, 39898.60101399007, 3510.1751088494184, 3542.752007359486, 3554.253606742587, 3567.4470457079196, 3567.554055743032, 31548.053558393283, 31678.36643267145, 31725.682743172503, 31810.36379272425, 31873.203169920707, 4829.3721816164025, 4862.659613827033, 4870.172070747982, 4881.682690625098, 4944.802207911679, 183404.0, 184945.0, 186648.0, 186967.0, 192917.0, 49293.75353123283, 49839.50160498349, 49855.0, 49881.75059124681, 49891.25163122556, 51343.0, 51349.74325128425, 51427.74286128546, 51444.0, 51557.48442515602, 15290.235488225544, 15377.923110384376, 15385.53843384678, 15409.537713868602, 15608.063516188839, 12570.685732856751, 12577.93711031439, 12585.24488530691, 12586.68533286657, 12604.369781510888, 14462.05996610217, 14586.927065364605, 14663.266836658124, 14728.263586820616, 14749.926250368893, 5856.795012174553, 5926.199963005025, 5935.970320148372, 5979.402059794073, 5996.340402555716, 950.6625148072335, 968.1673760565908, 975.8487434447673, 988.4859872866069, 1024.9897501025043, 27804.16587502378, 28925.7107428923, 29841.850790745906, 30188.396232075236, 30484.390312194075, 1077.1606748382328, 1084.810158222308, 1100.8073587122221, 1116.603605719974, 1117.9888201118047, 12184.695382615328, 12583.93708031454, 12666.303353315656, 12725.55460558876, 12793.29636869981, 236422.0, 238936.0, 238956.0, 239125.0, 240181.0, 53013.0, 53611.463885360645, 53662.0, 53739.73130134324, 53969.0, 1452.1359790924382, 1469.1552357394755, 1487.5611694550134, 1497.094257973932, 1509.6603264265452, 22702.0, 23036.193733219257, 23693.407664808517, 27387.0, 27774.027909023087, 52088.47911520836, 52739.0, 52751.73624132008, 52774.0, 52797.999999998465, 219247.0, 223777.0, 224151.0, 224752.0, 224861.0, 35435.46846797249, 37491.250174996894, 38322.233555329294, 38352.6164738349, 38353.42469862899, 45970.28927289944, 47184.0, 47427.525724742314, 48007.279890800964, 48007.279890800964, 32287.35425291434, 33037.33925321528, 33235.667643324225, 33492.0, 33937.15157121092, 31017.224569385948, 31045.844770776002, 32663.510047348835, 33079.0, 33399.0, 36486.0, 37752.05619859525, 37926.24147517089, 38258.234835303694, 38447.80776096102, 32517.837410812794, 32804.67195328112, 32808.83595582007, 32869.34261314713, 33400.66599334073, 23656.52686946217, 24890.377740555905, 25297.0, 25628.615570766826, 25784.0], "value": 17515.110547090786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5583600627514, 575.5050656435467, 575.7409165875357, 585.9472647461728, 602.4517688903097, 21415.785842141595, 22446.663300050513, 22470.213542525995, 22539.436514087156, 22937.541249175007, 25041.49917001659, 25335.493290134233, 25561.10536131236, 25616.359591010234, 25621.103261385855, 6331.398517140888, 6518.608883467007, 6518.706658200369, 6521.217453905538, 6522.086907832907, 3844.5770965193806, 3995.540512841017, 6099.085137229406, 6490.643014634194, 6496.967515162418, 6433.131527243832, 6464.0, 6473.1261279727105, 6488.805335839932, 6499.285078641369, 6422.26143993442, 6470.547061705683, 6471.967640161793, 6477.384648458389, 6497.025446183063, 5988.341282458926, 6020.488258498033, 6039.245094363205, 6040.214772079646, 6070.757169713206, 28534.143975680763, 29818.85090574555, 29891.25271868199, 30099.247518811986, 30244.69755302441, 1881.9529511762178, 1934.7775005874223, 1938.6122775444967, 1939.5442071113418, 1941.7864034956144, 18560.164792584364, 18968.810311896843, 18999.620007599908, 19122.33071842479, 19145.425637230906, 2238.641817309239, 2275.8748268845206, 2292.7363353214428, 2301.022065622104, 2400.699912510936, 136051.0, 143664.0, 143797.0, 143836.0, 144262.27868860692, 14285.857141428452, 14935.850641493445, 15198.240087995557, 15264.847351526565, 15369.462068827761, 22855.428614284443, 22864.885675571848, 22869.0, 22893.313200604007, 23006.539869202523, 10060.899391006142, 10099.596016159272, 10197.694069177936, 10276.229282803819, 10344.5344959477, 9323.580438880266, 9326.487043212688, 9354.298427617956, 9381.390209636353, 9505.619775209052, 9070.81858362829, 9128.81742365149, 9260.39807412516, 9300.813983720287, 9318.161365477139, 2806.3032044948786, 2883.7692984561186, 2897.768178545711, 2940.941181176407, 3013.2918764090423, 947.6304241345881, 951.6526467839188, 978.280963491833, 998.201438848918, 1002.6691191906654, 19653.312134075524, 20067.799322006595, 20209.797902021084, 20683.689744653842, 23754.881225593763, 1002.6240159940022, 1006.942710154335, 1021.1677482851452, 1048.491481631408, 1053.899879511445, 11336.773264534662, 11543.88456115428, 11599.594014209462, 11667.88332116685, 11711.472983715754, 536942.0, 552516.0, 557397.0, 559709.0, 568624.0, 125364.37317813536, 126160.0, 128106.0, 129846.0, 130653.0, 1231.7105480212142, 1268.6067319131098, 1300.2913412190378, 1301.2452777389092, 1306.1510018487868, 17191.914040429718, 18891.338803141825, 19153.52116197106, 19225.903870480557, 20950.0, 58349.12476312774, 59288.0, 60514.0, 61044.38955610387, 61500.0, 67579.32420675927, 68204.0, 68279.65860170667, 68458.65770671115, 69047.65476172588, 14593.635159121108, 14734.557963261119, 14754.188519631523, 14792.926035369754, 14844.0, 23553.646695299925, 23652.645210322204, 23854.16510422127, 23938.64092038586, 24069.51860962806, 18184.09079545991, 18239.726404104214, 18324.541886452946, 18356.724649130007, 18379.72430413518, 16104.0, 16804.495865124067, 16900.0, 17007.48977530676, 17042.0, 18475.983820889982, 18725.719114213025, 18873.0, 18902.338418155297, 18982.24071037198, 14020.439182432588, 14151.292435377984, 14184.432622695389, 14188.503402380868, 14191.929040354733, 17948.923064616163, 18240.45278641643, 19214.903925480285, 19256.326028588934, 19395.418137455898], "value": 12063.120246017863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.6776557508983, 1383.418964035105, 1410.8377536583282, 1416.3980308368941, 1464.026422429085, 13823.170609763409, 13961.93019034906, 14487.565373038813, 14527.92736036321, 14528.709425811478, 14446.711065778678, 14816.11103333798, 14893.92553037236, 14901.0, 14919.32863021164, 2554.795616350697, 2599.285196570939, 2622.9868850655816, 2626.120249716347, 2636.6967798703204, 2539.6825396825398, 2634.143903231448, 2694.703582605912, 2699.5140874642557, 2703.6079768433565, 2653.31013936376, 2673.2782148819806, 2686.986565067182, 2688.8386696798157, 2691.1791903469434, 2464.383904023994, 2608.100205429124, 2655.0441840937247, 2675.063727695291, 2680.5041067402494, 2506.1228570000535, 2517.735637758027, 2557.4373637799654, 2569.4347243606376, 2573.6654234949337, 13742.106763060368, 13821.516246931309, 13923.860761392358, 13929.303534823219, 13932.442702291997, 7230.313120253568, 7542.434317426215, 7545.849083018364, 7554.848903021909, 7560.357369623589, 4690.413698287714, 4838.6371022173125, 4976.253561965698, 5009.398872135331, 5037.974810125963, 1826.8264514871066, 1837.3936600921663, 1881.0876724788466, 1890.5368184794677, 1899.7815251246145, 22481.100755969743, 22761.31716048521, 22834.0, 23027.309180724606, 23068.0, 5885.588008839341, 5978.880422391615, 6153.661548614779, 6159.692015399301, 6196.566240363221, 14636.926815365856, 14721.337539810735, 14723.779143312859, 14737.926310368379, 14739.705205896036, 6914.446844252448, 7007.054047703495, 7041.683124259421, 7065.0815393998455, 7072.186698529632, 6419.101325814389, 6429.260635027032, 6510.609363438209, 6556.901646475307, 6607.80176594703, 4415.977920110379, 4531.071130418256, 4763.833265835679, 4903.092927808367, 4942.901141977212, 1293.2563775828935, 1301.4208677138772, 1318.5912367166209, 1333.8466076401337, 1342.1074985134776, 858.914108589136, 881.4667126388571, 882.3250213586612, 909.6816114360054, 925.121134921827, 7795.415343849234, 8581.914180858112, 8846.380753347332, 8891.333150013776, 8940.955295223483, 954.61815273891, 959.3092973059386, 972.6595691507915, 973.73709098543, 997.3766396002499, 4919.458859525449, 5063.417706963746, 5214.40206257681, 5289.312389389354, 5431.995080910045, 17484.388046418313, 18265.45203643893, 18338.08309584542, 18344.0, 18359.90820045891, 19348.8065119347, 19412.22351105968, 19542.31601893927, 19564.902175489315, 19651.705224421647, 10433.895661043443, 10921.290116142425, 10974.725631859268, 11029.779404412027, 11073.280236784743, 7695.0, 7977.48146370484, 8478.957605211934, 8489.915100848912, 8493.87259191125, 16357.34570617162, 16663.250153743353, 17152.313907443564, 17491.737623935398, 17497.737533936746, 16976.660466790843, 17393.391231306843, 17417.39039133624, 17662.20520076574, 17731.64536709233, 11426.771464570496, 11771.646850594496, 11787.646370608896, 11788.174827761974, 11789.587364442203, 11114.16643751738, 11461.598844040418, 11768.823467648162, 12857.292848893401, 13005.284709340698, 10444.791104178026, 10936.562537498728, 10978.780424391627, 11208.55165793359, 11369.886301136883, 10098.747531311776, 10486.0, 10624.787504250025, 10719.249652524248, 10736.89263107359, 9652.90347096548, 9703.07820757027, 9753.9024609753, 9786.608535658494, 9796.608135674778, 6749.392554670103, 6862.519623626298, 6896.448284137357, 6914.965425172842, 7032.156141263081, 7179.461540384387, 7218.314260145278, 7266.418686505172, 7328.853422931618, 7376.815579610553], "value": 6297.538391199759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.6074759818347, 500.14724894055627, 521.2025600830731, 521.9269302297678, 528.1312241362958, 6216.813495595128, 6239.6256224626495, 6242.469390101835, 6251.374862513752, 6267.4045965633195, 5900.380460051697, 5927.88144237115, 5977.581569290141, 6013.969930150354, 6096.481799047076, 4803.351547541072, 4904.730239836807, 4909.165441874872, 4919.655624106314, 4920.163572192718, 4756.0, 4891.828785992491, 4929.876753081166, 4936.950630493703, 4977.377827771528, 4757.215059515176, 4810.484697320333, 4837.105135549935, 4901.485344038878, 4942.703437793743, 4852.199387101124, 4861.611071114302, 4864.367632207825, 4865.245886887538, 4894.800773810439, 4392.2752745797225, 4406.713563618355, 4422.6682998774895, 4450.554944505556, 4455.287154055368, 5952.761889524414, 6002.189704389939, 6023.849403764897, 6052.4552790248645, 6063.483654283511, 5581.888362232733, 5625.0, 5661.2923384576925, 5690.971545142289, 5726.656400615976, 6410.102585638015, 6461.709223084926, 6462.353764623547, 6478.7084581193485, 6479.222493300834, 4803.039392121555, 4831.396075490564, 4845.297431872359, 4870.172070747982, 4878.780454879539, 6663.300353462865, 6757.526973111884, 6772.764987554096, 6843.589384636888, 6882.483813713991, 4917.844306587949, 4935.0, 4939.876503087452, 4956.182229932093, 5003.924941125886, 5000.524950129732, 5062.620303477254, 5069.366329208849, 5083.491650834961, 5092.0, 5498.615096943256, 5523.447655234525, 5688.402717714663, 5694.7323725554525, 5698.458646428583, 6356.77751278703, 6469.967650161719, 6480.2547707013355, 6493.967530162414, 6575.243846957565, 1645.317193364764, 1721.5093698295925, 1726.1369315342329, 1750.474857542732, 1767.3637490503409, 990.6285143071349, 1195.9940200298943, 1216.3492531495608, 1217.4278089298016, 1235.6293112066344, 5512.310961129859, 5610.579206559524, 5671.51792097668, 5697.572682048863, 5697.857553561112, 6572.638504882278, 6621.3047629998155, 6641.306466850922, 6656.800295991031, 6686.130802995676, 5633.647979452219, 5692.573057020657, 5699.658020518782, 5733.569982251348, 5749.568782341257, 3547.5742910850345, 3551.4672799079826, 3566.4293713006314, 3570.393033184313, 3619.4027985382645, 6366.427021568081, 6431.228252609717, 6451.483881289486, 6493.772717954849, 6512.34876512345, 6788.422984046411, 6802.217744959294, 6837.62393068386, 6853.7943861684225, 6869.179667388146, 6399.968000159969, 6427.517936154807, 6467.997460393646, 6472.935270647327, 6500.382463665944, 6632.801015969529, 6685.298043705341, 6685.598864067977, 6701.363370479797, 6705.765298214539, 6607.834804129935, 6610.3720146586, 6622.0, 6659.134312539339, 6678.165229346332, 6359.332270111757, 6369.407648087978, 6373.840653983688, 6390.360963903572, 6505.8698826024165, 4822.987172693774, 4890.902181956412, 4900.803967841246, 4914.287428322802, 4937.950620493749, 6581.703823327866, 6654.866902662016, 6750.143710479658, 6783.219929708147, 6809.89785153233, 6400.1679781629955, 6473.385028422293, 6501.414872661483, 6515.837104072436, 6548.639824809681, 6425.518086143465, 6459.935400646122, 6478.643674597943, 6480.837979050561, 6496.148597649647, 6349.238091429058, 6432.807015789534, 6437.452816510649, 6457.321981191907, 6515.73937042513, 6485.805425837232, 6552.180977377828, 6582.703778330082, 6625.244310257882, 6633.6019838809825, 5844.766209351748, 6300.716467759054, 6301.180846489927, 6374.4900407966325, 6408.839779005562], "value": 4997.532240185001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.8148188880335, 899.4063917814244, 908.8318661047707, 916.9174774270316, 921.3688623293043, 18022.639547209063, 19137.138828752722, 19164.71252931207, 19196.0, 21583.67624485634, 20594.1762329507, 20852.68720969183, 21572.0, 21771.129154833827, 21786.455338616543, 1034.6792494326746, 1063.7872425514888, 1063.8776540697802, 1064.2177999170603, 1064.2231171244996, 1016.207358260558, 1065.0201814330835, 1066.7493139112303, 1067.066316972649, 1068.732816795801, 1107.070061148635, 1116.0, 1117.60883690708, 1117.809972304706, 1118.1613789657756, 1105.4141305108305, 1108.7727015961748, 1108.8392183133442, 1110.0065441429956, 1112.8608923884515, 808.2241048593357, 808.5795386399099, 809.0210844877705, 812.553095797315, 813.1502579804119, 19278.903605481883, 19836.702449463126, 19892.303769368147, 20117.094730737153, 20411.387658370273, 20305.695414568792, 20314.79685203144, 20662.07020684073, 20732.274370396965, 20835.687464688042, 15864.206789660586, 16019.519414417586, 16179.595510112342, 16185.838141618551, 16555.0, 3512.5082488451635, 3516.7362447816517, 3541.6635419635095, 3541.8052007139595, 3565.6790888819874, 115513.0, 119090.0, 121407.3929630355, 122893.38553307176, 125019.0, 14171.433142674177, 14223.64440888986, 14381.64045898861, 14495.275236238145, 14544.200068996306, 28393.57409638857, 30315.69684303173, 30334.393312134074, 30514.77940882384, 30548.69451305503, 7780.533168009937, 8014.438989270695, 8427.32581393487, 8594.699185528476, 8717.782055448664, 4218.282891908383, 4295.033617436052, 4316.050468896838, 4318.978405107954, 4327.394164816928, 4934.087193869145, 4957.454679985199, 5079.31429257053, 5085.898282034339, 5121.795128194905, 996.7308826616772, 1018.7367664096467, 1025.108155904353, 1034.2915103154364, 1037.025196315461, 663.4559661077966, 672.1900110366996, 691.2051141187574, 692.7021380806201, 698.4761428928304, 10534.947325263325, 12642.936785316015, 12771.233725976472, 12865.549705760253, 13501.66245843842, 652.6345246661884, 689.3106893106893, 691.0532570378614, 692.5083190934392, 696.8571442854203, 5040.31955685985, 5192.299039629677, 5263.157894736823, 5295.338082739658, 5349.144136938149, 107889.0, 107945.04034031123, 112391.43804280926, 113090.0, 113647.0, 93784.0, 94985.52507237557, 95236.52381738185, 97783.0221697774, 97806.5109674447, 77919.2208077912, 81874.0, 83881.58059209665, 84014.0, 85612.0, 10011.799764004825, 10308.433036182782, 10534.631287904887, 11873.228240164362, 12908.548200812926, 39115.0, 39648.40527392149, 40469.797651011555, 42839.35740963826, 43190.352144717224, 63924.68037659782, 66125.33874661192, 70258.64870675614, 70454.94317585138, 71379.64310178623, 18283.634327313113, 18386.356477523223, 18756.96836673996, 18903.90548047306, 19020.714689279393, 17047.23287452043, 18099.54751131232, 19577.412677619694, 21167.0, 21553.461163471038, 17031.744523831905, 17144.571385715455, 17309.740353894955, 17417.912910435873, 17541.298348066444, 17980.730289045936, 18027.2789088435, 18057.0, 18132.909335453238, 18269.08654567293, 17599.82400175982, 17637.02996335214, 17788.733169002215, 18033.639327213645, 18072.0, 12580.559680411141, 12976.416061277454, 13520.86479135196, 13534.932325338705, 13839.30803459843, 12785.232886026868, 14092.36584353686, 14342.569722908329, 14398.352074156897, 14566.198859062853], "value": 9072.783234140352, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 109.0, 112.0, 112.0, 114.0, 103.0, 110.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 151.0, 182.0, 117.0, 146.0, 143.0, 125.0, 175.0, 127.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 162.0, 163.0, 164.0, 166.0, 163.0, 167.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 174.0, 77.0, 76.0, 76.0, 89.0, 99.0, 76.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 131.0, 82.0, 81.0, 81.0, 129.0, 80.0, 81.0, 141.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 113.0, 116.0, 114.0, 114.0, 114.0, 115.0, 123.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 152.0, 151.0, 152.0, 150.0, 152.0, 152.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 93.0, 99.0, 100.0, 94.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 57.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 77.0, 79.0, 88.0, 78.0, 78.0, 78.0, 76.0, 77.0, 86.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 135.0, 124.0, 127.0, 130.0, 126.0, 128.0, 135.0, 169.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 184.0, 182.0, 175.0, 171.0, 179.0, 173.0, 173.0, 190.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 71.0, 73.0, 66.0, 68.0, 73.0, 68.0, 70.0], "value": 69.6, "unit": "score"}]}]} 19:08:54 INFO - Return code: 0 19:08:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:08:54 INFO - # TBPL SUCCESS # 19:08:54 INFO - Running post-action listener: _package_coverage_data 19:08:54 INFO - Running post-action listener: _resource_record_post_action 19:08:54 INFO - [mozharness: 2017-07-25 02:08:54.385091Z] Finished run-tests step (success) 19:08:54 INFO - Running post-run listener: _resource_record_post_run 19:08:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 61440; Write bytes: 438140928; Read time: 452; Write time: 291060 19:08:54 INFO - TinderboxPrint: CPU usage
13.2% 19:08:54 INFO - TinderboxPrint: I/O read bytes / time
61,440 / 452 19:08:54 INFO - TinderboxPrint: I/O write bytes / time
438,140,928 / 291,060 19:08:54 INFO - TinderboxPrint: CPU idle
8,273.4 (86.8%) 19:08:54 INFO - TinderboxPrint: CPU user
1,204.8 (12.6%) 19:08:54 INFO - TinderboxPrint: Swap in / out
0 / 0 19:08:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106815488; Read time: 180; Write time: 89960 19:08:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:08:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 53248; Write bytes: 330203136; Read time: 252; Write time: 201064 19:08:55 INFO - Running post-run listener: _upload_blobber_files 19:08:55 INFO - Blob upload gear active. 19:08:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:08:55 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 19:08:55 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:08:55 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:08:55 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:56 INFO - (blobuploader) - INFO - Done attempting. 19:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:59 INFO - (blobuploader) - INFO - Done attempting. 19:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:01 INFO - (blobuploader) - INFO - Done attempting. 19:09:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:09:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:01 INFO - (blobuploader) - INFO - Done attempting. 19:09:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:09:01 INFO - Return code: 0 19:09:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:09:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:09:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea72bf46ca6d7e949bf971af12f6018b4a594688e2bac521e5ea32343e22d44b5a2e1a0c529426f2da26d17d98e7f867cc42a1e0bb15f50ed60dd62d2dd22c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9005a86c8e4488cee3e4bc070a910c17586cb1c152ddaa6821ea87a566ef7ce3ef2b6ee1f2736121f035c046f7387870fce94f6c25a031f68c08f5ad12143d55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed9b046affafc6fc1576532dffcd163886851370a699c78729eb9f6a0b67fb3ee8e2ef9c9df678549db5df613174ceaa2797aba902eafb31da2c43ad68287b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b0de040d3e7f01ae8dbf7671ed21d6fb10ab9a333646846301fd224601c506f240c477a2fb25c312fc93b83b21cd6d26b0eb1d2d6687785d1f7fd3bbae3fba"} 19:09:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:09:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:09:01 INFO - Contents: 19:09:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea72bf46ca6d7e949bf971af12f6018b4a594688e2bac521e5ea32343e22d44b5a2e1a0c529426f2da26d17d98e7f867cc42a1e0bb15f50ed60dd62d2dd22c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9005a86c8e4488cee3e4bc070a910c17586cb1c152ddaa6821ea87a566ef7ce3ef2b6ee1f2736121f035c046f7387870fce94f6c25a031f68c08f5ad12143d55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed9b046affafc6fc1576532dffcd163886851370a699c78729eb9f6a0b67fb3ee8e2ef9c9df678549db5df613174ceaa2797aba902eafb31da2c43ad68287b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b0de040d3e7f01ae8dbf7671ed21d6fb10ab9a333646846301fd224601c506f240c477a2fb25c312fc93b83b21cd6d26b0eb1d2d6687785d1f7fd3bbae3fba"} 19:09:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:09:01 INFO - Copying logs to upload dir... 19:09:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:09:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.865189 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-24 19:09:01.679333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:09:01.682444) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea72bf46ca6d7e949bf971af12f6018b4a594688e2bac521e5ea32343e22d44b5a2e1a0c529426f2da26d17d98e7f867cc42a1e0bb15f50ed60dd62d2dd22c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9005a86c8e4488cee3e4bc070a910c17586cb1c152ddaa6821ea87a566ef7ce3ef2b6ee1f2736121f035c046f7387870fce94f6c25a031f68c08f5ad12143d55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed9b046affafc6fc1576532dffcd163886851370a699c78729eb9f6a0b67fb3ee8e2ef9c9df678549db5df613174ceaa2797aba902eafb31da2c43ad68287b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b0de040d3e7f01ae8dbf7671ed21d6fb10ab9a333646846301fd224601c506f240c477a2fb25c312fc93b83b21cd6d26b0eb1d2d6687785d1f7fd3bbae3fba"} build_url:https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea72bf46ca6d7e949bf971af12f6018b4a594688e2bac521e5ea32343e22d44b5a2e1a0c529426f2da26d17d98e7f867cc42a1e0bb15f50ed60dd62d2dd22c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9005a86c8e4488cee3e4bc070a910c17586cb1c152ddaa6821ea87a566ef7ce3ef2b6ee1f2736121f035c046f7387870fce94f6c25a031f68c08f5ad12143d55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed9b046affafc6fc1576532dffcd163886851370a699c78729eb9f6a0b67fb3ee8e2ef9c9df678549db5df613174ceaa2797aba902eafb31da2c43ad68287b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b0de040d3e7f01ae8dbf7671ed21d6fb10ab9a333646846301fd224601c506f240c477a2fb25c312fc93b83b21cd6d26b0eb1d2d6687785d1f7fd3bbae3fba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:09:01.709565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:09:01.709867) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500942149.874597-714837864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:09:01.788834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:09:01.792157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:09:01.792439) ========= ========= Total master_lag: 0.21 =========