builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1500947274.06 results: success (0) revision: dcfb58fcb6dd8f6474eed6520ba6272dedded393 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.059377) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.059831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.060117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.079928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.080216) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 18:47:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.4M=0s 2017-07-24 18:47:54 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.177498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.177806) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.226986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.230357) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 18:47:54,437 truncating revision to first 12 chars 2017-07-24 18:47:54,437 Setting DEBUG logging. 2017-07-24 18:47:54,437 attempt 1/10 2017-07-24 18:47:54,437 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:47:54,823 unpacking tar archive at: mozilla-central-dcfb58fcb6dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692791 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.938126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.938412) ========= script_repo_revision: dcfb58fcb6dd8f6474eed6520ba6272dedded393 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.938769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.939030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:47:54.947969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-24 18:47:54.948262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:55 INFO - MultiFileLogger online at 20170724 18:47:55 in /builds/slave/test 18:47:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:47:55 INFO - {'append_to_log': False, 18:47:55 INFO - 'base_work_dir': '/builds/slave/test', 18:47:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:47:55 INFO - 'branch': 'Firefox-Non-PGO', 18:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:55 INFO - 'code_coverage': False, 18:47:55 INFO - 'config_files': ('talos/linux_config.py',), 18:47:55 INFO - 'default_actions': ('clobber', 18:47:55 INFO - 'read-buildbot-config', 18:47:55 INFO - 'download-and-extract', 18:47:55 INFO - 'populate-webroot', 18:47:55 INFO - 'create-virtualenv', 18:47:55 INFO - 'install', 18:47:55 INFO - 'setup-mitmproxy', 18:47:55 INFO - 'run-tests'), 18:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:55 INFO - 'disable_ccov_upload': False, 18:47:55 INFO - 'download_minidump_stackwalk': True, 18:47:55 INFO - 'download_symbols': 'ondemand', 18:47:55 INFO - 'enable_stylo': False, 18:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:55 INFO - 'gecko_profile': False, 18:47:55 INFO - 'gecko_profile_interval': 0, 18:47:55 INFO - 'installer_path': 'installer.exe', 18:47:55 INFO - 'log_level': 'info', 18:47:55 INFO - 'log_name': 'talos', 18:47:55 INFO - 'log_to_console': True, 18:47:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:55 INFO - 'opt_config_files': (), 18:47:55 INFO - 'pip_index': False, 18:47:55 INFO - 'suite': 'dromaeojs-e10s', 18:47:55 INFO - 'system_bits': '32', 18:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:55 INFO - 'title': 'talos-linux64-ix-071', 18:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:55 INFO - 'use_talos_json': True, 18:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:55 INFO - 'work_dir': 'build'} 18:47:55 INFO - [mozharness: 2017-07-25 01:47:55.259050Z] Running clobber step. 18:47:55 INFO - Running pre-action listener: _resource_record_pre_action 18:47:55 INFO - Running main action method: clobber 18:47:55 INFO - rmtree: /builds/slave/test/build 18:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:47:56 INFO - Running post-action listener: _resource_record_post_action 18:47:56 INFO - [mozharness: 2017-07-25 01:47:56.287186Z] Finished clobber step (success) 18:47:56 INFO - [mozharness: 2017-07-25 01:47:56.287290Z] Running read-buildbot-config step. 18:47:56 INFO - Running pre-action listener: _resource_record_pre_action 18:47:56 INFO - Running main action method: read_buildbot_config 18:47:56 INFO - Using buildbot properties: 18:47:56 INFO - { 18:47:56 INFO - "project": "", 18:47:56 INFO - "product": "firefox", 18:47:56 INFO - "who": "kwierso@gmail.com", 18:47:56 INFO - "installer_path": "public/build/target.tar.bz2", 18:47:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:47:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:47:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:47:56 INFO - "stage_platform": "linux64", 18:47:56 INFO - "basedir": "/builds/slave/test", 18:47:56 INFO - "buildnumber": 740, 18:47:56 INFO - "platform": "ubuntu64_hw", 18:47:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:47:56 INFO - "slavebuilddir": "test", 18:47:56 INFO - "taskId": "X4zbmgYJRRWPs9wo216x0A", 18:47:56 INFO - "branch": "mozilla-central", 18:47:56 INFO - "script_repo_revision": "production", 18:47:56 INFO - "revision": "dcfb58fcb6dd8f6474eed6520ba6272dedded393", 18:47:56 INFO - "slavename": "talos-linux64-ix-071", 18:47:56 INFO - "repo_path": "mozilla-central" 18:47:56 INFO - } 18:47:56 INFO - Finding installer, test and symbols from parent task. 18:47:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4zbmgYJRRWPs9wo216x0A'}, attempt #1 18:47:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4zbmgYJRRWPs9wo216x0A'}, attempt #1 18:47:57 INFO - Task dependencies: ULAcXr-fTM-J89OT06qGYA 18:47:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA'}, attempt #1 18:47:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:47:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/test_packages.json 18:47:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip 18:47:57 INFO - Running post-action listener: _resource_record_post_action 18:47:57 INFO - [mozharness: 2017-07-25 01:47:57.623929Z] Finished read-buildbot-config step (success) 18:47:57 INFO - [mozharness: 2017-07-25 01:47:57.624152Z] Running download-and-extract step. 18:47:57 INFO - Running pre-action listener: _resource_record_pre_action 18:47:57 INFO - Running main action method: download_and_extract 18:47:57 INFO - mkdir: /builds/slave/test/build/tests 18:47:57 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:47:57 INFO - trying https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.test_packages.json 18:47:57 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:47:57 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:47:58 INFO - Downloaded 989 bytes. 18:47:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:47:58 INFO - Using the following test package requirements: 18:47:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:47:58 INFO - u'common': [u'target.common.tests.zip'], 18:47:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:47:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:47:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:47:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:47:58 INFO - u'mozbase': [u'target.common.tests.zip'], 18:47:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:47:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:47:58 INFO - u'web-platform': [u'target.common.tests.zip', 18:47:58 INFO - u'target.web-platform.tests.tar.gz'], 18:47:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:47:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:47:58 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:47:58 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:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip into memory 18:47:59 INFO - Content-Length response header: 72761504 18:47:59 INFO - Bytes received: 72761504 18:48:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:48:10 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:10 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:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.common.tests.zip into memory 18:48:11 INFO - Content-Length response header: 72761504 18:48:11 INFO - Bytes received: 72761504 18:48:25 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:25 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:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.talos.tests.zip into memory 18:48:25 INFO - Content-Length response header: 14498976 18:48:25 INFO - Bytes received: 14498976 18:48:26 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:26 INFO - trying https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:26 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:26 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:27 INFO - Downloaded 61950688 bytes. 18:48:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:27 INFO - mkdir: /builds/slave/test/properties 18:48:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:48:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:48:27 INFO - Contents: 18:48:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.tar.bz2 18:48:27 INFO - Running post-action listener: _resource_record_post_action 18:48:27 INFO - Running post-action listener: set_extra_try_arguments 18:48:27 INFO - [mozharness: 2017-07-25 01:48:27.822520Z] Finished download-and-extract step (success) 18:48:27 INFO - [mozharness: 2017-07-25 01:48:27.822618Z] Running populate-webroot step. 18:48:27 INFO - Running pre-action listener: _resource_record_pre_action 18:48:27 INFO - Running main action method: populate_webroot 18:48:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:48:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:48:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:48:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:48:27 INFO - 'tests': ['damp', 'tps']}, 18:48:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:48:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:48:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:48:27 INFO - 'other-e10s': {'tests': ['a11yr', 18:48:27 INFO - 'ts_paint', 18:48:27 INFO - 'tpaint', 18:48:27 INFO - 'sessionrestore', 18:48:27 INFO - 'sessionrestore_many_windows', 18:48:27 INFO - 'sessionrestore_no_auto_restore', 18:48:27 INFO - 'tabpaint']}, 18:48:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:48:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:48:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:48:27 INFO - 'talos_options': ['--mitmproxy', 18:48:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:48:27 INFO - '--firstNonBlankPaint'], 18:48:27 INFO - 'tests': ['quantum_pageload_google', 18:48:27 INFO - 'quantum_pageload_youtube', 18:48:27 INFO - 'quantum_pageload_amazon', 18:48:27 INFO - 'quantum_pageload_facebook']}, 18:48:27 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:48:27 INFO - 'talos_options': ['--stylo', 18:48:27 INFO - '--mitmproxy', 18:48:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:48:27 INFO - '--firstNonBlankPaint'], 18:48:27 INFO - 'tests': ['quantum_pageload_google', 18:48:27 INFO - 'quantum_pageload_youtube', 18:48:27 INFO - 'quantum_pageload_amazon', 18:48:27 INFO - 'quantum_pageload_facebook']}, 18:48:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:48:27 INFO - 'tsvgr_opacity', 18:48:27 INFO - 'tart', 18:48:27 INFO - 'tscrollx', 18:48:27 INFO - 'cart', 18:48:27 INFO - 'tsvg_static']}, 18:48:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:48:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:48:27 INFO - 'talos_options': ['--xperf_path', 18:48:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:27 INFO - 'tests': ['tp5n']}}} 18:48:27 INFO - Running post-action listener: _resource_record_post_action 18:48:27 INFO - [mozharness: 2017-07-25 01:48:27.829932Z] Finished populate-webroot step (success) 18:48:27 INFO - [mozharness: 2017-07-25 01:48:27.830023Z] Running create-virtualenv step. 18:48:27 INFO - Running pre-action listener: _resource_record_pre_action 18:48:27 INFO - Running main action method: create_virtualenv 18:48:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:48:27 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:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:48:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:48:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:27 INFO - Using real prefix '/usr' 18:48:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:30 INFO - Installing pip.................done. 18:48:30 INFO - Return code: 0 18:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:48:30 INFO - Reading from file tmpfile_stdout 18:48:30 INFO - Output received: 18:48:30 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:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:48:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:30 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 18:48:30 INFO - 'HOME': '/home/cltbld', 18:48:30 INFO - 'LANG': 'en_US.UTF-8', 18:48:30 INFO - 'LANGUAGE': 'en_US:en', 18:48:30 INFO - 'LOGNAME': 'cltbld', 18:48:30 INFO - 'MAIL': '/var/mail/cltbld', 18:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:30 INFO - 'MOZ_NO_REMOTE': '1', 18:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:30 INFO - 'NO_EM_RESTART': '1', 18:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:30 INFO - 'PWD': '/builds/slave/test', 18:48:30 INFO - 'SHELL': '/bin/bash', 18:48:30 INFO - 'SHLVL': '1', 18:48:30 INFO - 'TERM': 'linux', 18:48:30 INFO - 'TMOUT': '86400', 18:48:30 INFO - 'USER': 'cltbld', 18:48:30 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:30 INFO - '_': '/tools/buildbot/bin/python'} 18:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:30 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:30 INFO - Cleaning up... 18:48:30 INFO - Return code: 0 18:48:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:48:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:30 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 18:48:30 INFO - 'HOME': '/home/cltbld', 18:48:30 INFO - 'LANG': 'en_US.UTF-8', 18:48:30 INFO - 'LANGUAGE': 'en_US:en', 18:48:30 INFO - 'LOGNAME': 'cltbld', 18:48:30 INFO - 'MAIL': '/var/mail/cltbld', 18:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:30 INFO - 'MOZ_NO_REMOTE': '1', 18:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:30 INFO - 'NO_EM_RESTART': '1', 18:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:30 INFO - 'PWD': '/builds/slave/test', 18:48:30 INFO - 'SHELL': '/bin/bash', 18:48:30 INFO - 'SHLVL': '1', 18:48:30 INFO - 'TERM': 'linux', 18:48:30 INFO - 'TMOUT': '86400', 18:48:30 INFO - 'USER': 'cltbld', 18:48:30 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:30 INFO - '_': '/tools/buildbot/bin/python'} 18:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:31 INFO - Downloading/unpacking psutil>=3.1.1 18:48:31 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:31 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:31 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:31 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:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:32 INFO - Installing collected packages: psutil 18:48:32 INFO - Running setup.py install for psutil 18:48:32 INFO - building 'psutil._psutil_linux' extension 18:48:32 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:32 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:32 INFO - building 'psutil._psutil_posix' extension 18:48:32 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:32 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:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:32 INFO - Successfully installed psutil 18:48:32 INFO - Cleaning up... 18:48:32 INFO - Return code: 0 18:48:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:48:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:32 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 18:48:32 INFO - 'HOME': '/home/cltbld', 18:48:32 INFO - 'LANG': 'en_US.UTF-8', 18:48:32 INFO - 'LANGUAGE': 'en_US:en', 18:48:32 INFO - 'LOGNAME': 'cltbld', 18:48:32 INFO - 'MAIL': '/var/mail/cltbld', 18:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:32 INFO - 'MOZ_NO_REMOTE': '1', 18:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:32 INFO - 'NO_EM_RESTART': '1', 18:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:32 INFO - 'PWD': '/builds/slave/test', 18:48:32 INFO - 'SHELL': '/bin/bash', 18:48:32 INFO - 'SHLVL': '1', 18:48:32 INFO - 'TERM': 'linux', 18:48:32 INFO - 'TMOUT': '86400', 18:48:32 INFO - 'USER': 'cltbld', 18:48:32 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:32 INFO - '_': '/tools/buildbot/bin/python'} 18:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:48:32 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:32 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:32 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:32 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:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:34 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:34 INFO - Installing collected packages: mozsystemmonitor 18:48:34 INFO - Running setup.py install for mozsystemmonitor 18:48:34 INFO - Successfully installed mozsystemmonitor 18:48:34 INFO - Cleaning up... 18:48:34 INFO - Return code: 0 18:48:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:48:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:34 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 18:48:34 INFO - 'HOME': '/home/cltbld', 18:48:34 INFO - 'LANG': 'en_US.UTF-8', 18:48:34 INFO - 'LANGUAGE': 'en_US:en', 18:48:34 INFO - 'LOGNAME': 'cltbld', 18:48:34 INFO - 'MAIL': '/var/mail/cltbld', 18:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:34 INFO - 'MOZ_NO_REMOTE': '1', 18:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:34 INFO - 'NO_EM_RESTART': '1', 18:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:34 INFO - 'PWD': '/builds/slave/test', 18:48:34 INFO - 'SHELL': '/bin/bash', 18:48:34 INFO - 'SHLVL': '1', 18:48:34 INFO - 'TERM': 'linux', 18:48:34 INFO - 'TMOUT': '86400', 18:48:34 INFO - 'USER': 'cltbld', 18:48:34 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:34 INFO - '_': '/tools/buildbot/bin/python'} 18:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:48:34 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:34 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:34 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:34 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:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:48:35 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:35 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:35 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:35 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:35 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:48:35 INFO - warning: no files found matching '*.txt' 18:48:35 INFO - no previously-included directories found matching 'build' 18:48:35 INFO - no previously-included directories found matching 'dist' 18:48:35 INFO - no previously-included directories found matching '.git*' 18:48:35 INFO - Installing collected packages: jsonschema, functools32 18:48:35 INFO - Running setup.py install for functools32 18:48:35 INFO - warning: no files found matching '*.txt' 18:48:35 INFO - no previously-included directories found matching 'build' 18:48:35 INFO - no previously-included directories found matching 'dist' 18:48:35 INFO - no previously-included directories found matching '.git*' 18:48:35 INFO - Successfully installed jsonschema functools32 18:48:35 INFO - Cleaning up... 18:48:35 INFO - Return code: 0 18:48:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:48:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:35 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 18:48:35 INFO - 'HOME': '/home/cltbld', 18:48:35 INFO - 'LANG': 'en_US.UTF-8', 18:48:35 INFO - 'LANGUAGE': 'en_US:en', 18:48:35 INFO - 'LOGNAME': 'cltbld', 18:48:35 INFO - 'MAIL': '/var/mail/cltbld', 18:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:35 INFO - 'MOZ_NO_REMOTE': '1', 18:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:35 INFO - 'NO_EM_RESTART': '1', 18:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:35 INFO - 'PWD': '/builds/slave/test', 18:48:35 INFO - 'SHELL': '/bin/bash', 18:48:35 INFO - 'SHLVL': '1', 18:48:35 INFO - 'TERM': 'linux', 18:48:35 INFO - 'TMOUT': '86400', 18:48:35 INFO - 'USER': 'cltbld', 18:48:35 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:35 INFO - '_': '/tools/buildbot/bin/python'} 18:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:48:36 INFO - Cleaning up... 18:48:36 INFO - Return code: 0 18:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:48:36 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:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:36 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:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:36 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 18:48:36 INFO - 'HOME': '/home/cltbld', 18:48:36 INFO - 'LANG': 'en_US.UTF-8', 18:48:36 INFO - 'LANGUAGE': 'en_US:en', 18:48:36 INFO - 'LOGNAME': 'cltbld', 18:48:36 INFO - 'MAIL': '/var/mail/cltbld', 18:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:36 INFO - 'MOZ_NO_REMOTE': '1', 18:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:36 INFO - 'NO_EM_RESTART': '1', 18:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:36 INFO - 'PWD': '/builds/slave/test', 18:48:36 INFO - 'SHELL': '/bin/bash', 18:48:36 INFO - 'SHLVL': '1', 18:48:36 INFO - 'TERM': 'linux', 18:48:36 INFO - 'TMOUT': '86400', 18:48:36 INFO - 'USER': 'cltbld', 18:48:36 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:36 INFO - '_': '/tools/buildbot/bin/python'} 18:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:36 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:36 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:36 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:36 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:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:37 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:37 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:37 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:37 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:48:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:37 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:37 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:37 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:37 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:37 INFO - Downloading docopt-0.6.1.tar.gz 18:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:38 INFO - Running setup.py install for blobuploader 18:48:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:48:38 INFO - Running setup.py install for requests 18:48:38 INFO - Running setup.py install for docopt 18:48:38 INFO - Successfully installed blobuploader requests docopt 18:48:38 INFO - Cleaning up... 18:48:38 INFO - Return code: 0 18:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:38 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 18:48:38 INFO - 'HOME': '/home/cltbld', 18:48:38 INFO - 'LANG': 'en_US.UTF-8', 18:48:38 INFO - 'LANGUAGE': 'en_US:en', 18:48:38 INFO - 'LOGNAME': 'cltbld', 18:48:38 INFO - 'MAIL': '/var/mail/cltbld', 18:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:38 INFO - 'MOZ_NO_REMOTE': '1', 18:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:38 INFO - 'NO_EM_RESTART': '1', 18:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:38 INFO - 'PWD': '/builds/slave/test', 18:48:38 INFO - 'SHELL': '/bin/bash', 18:48:38 INFO - 'SHLVL': '1', 18:48:38 INFO - 'TERM': 'linux', 18:48:38 INFO - 'TMOUT': '86400', 18:48:38 INFO - 'USER': 'cltbld', 18:48:38 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:38 INFO - '_': '/tools/buildbot/bin/python'} 18:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:38 INFO - Running setup.py (path:/tmp/pip-k7mUJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:38 INFO - Running setup.py (path:/tmp/pip-GaGZ1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:38 INFO - Running setup.py (path:/tmp/pip-c4P02x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:39 INFO - Running setup.py (path:/tmp/pip-jmDu9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:39 INFO - Running setup.py (path:/tmp/pip-REKs4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:39 INFO - Running setup.py (path:/tmp/pip-b4hJJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:39 INFO - Running setup.py (path:/tmp/pip-Q9_eHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:39 INFO - Running setup.py (path:/tmp/pip-QixHqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:39 INFO - Running setup.py (path:/tmp/pip-7jGrxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:39 INFO - Running setup.py (path:/tmp/pip-sHzRAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:39 INFO - Running setup.py (path:/tmp/pip-0_C_UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:39 INFO - Running setup.py (path:/tmp/pip-EbTDKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:39 INFO - Running setup.py (path:/tmp/pip-joV5Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:39 INFO - Running setup.py (path:/tmp/pip-5tBEwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:39 INFO - Running setup.py (path:/tmp/pip-IIlifu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:39 INFO - Running setup.py (path:/tmp/pip-DA2cB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:39 INFO - Running setup.py (path:/tmp/pip-PmONeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:40 INFO - Running setup.py install for manifestparser 18:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Running setup.py install for mozcrash 18:48:40 INFO - Running setup.py install for mozdebug 18:48:40 INFO - Running setup.py install for mozdevice 18:48:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Running setup.py install for mozfile 18:48:40 INFO - Running setup.py install for mozhttpd 18:48:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Running setup.py install for mozinfo 18:48:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Running setup.py install for mozInstall 18:48:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:48:40 INFO - Running setup.py install for mozleak 18:48:40 INFO - Running setup.py install for mozlog 18:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Running setup.py install for moznetwork 18:48:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Running setup.py install for mozprocess 18:48:41 INFO - Running setup.py install for mozprofile 18:48:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Running setup.py install for mozrunner 18:48:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Running setup.py install for mozscreenshot 18:48:41 INFO - Running setup.py install for moztest 18:48:41 INFO - Running setup.py install for mozversion 18:48:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:48:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:41 INFO - Cleaning up... 18:48:41 INFO - Return code: 0 18:48:41 INFO - Installing None 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', '-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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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', '-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:41 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: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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:42 INFO - Running setup.py (path:/tmp/pip-SP6Puo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:42 INFO - Running setup.py (path:/tmp/pip-Jog_d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:42 INFO - Running setup.py (path:/tmp/pip-0sLxnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:42 INFO - Running setup.py (path:/tmp/pip-zBxqw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:42 INFO - Running setup.py (path:/tmp/pip-eCsxQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:42 INFO - Running setup.py (path:/tmp/pip-gdl9Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:42 INFO - Running setup.py (path:/tmp/pip-_5bNDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:42 INFO - Running setup.py (path:/tmp/pip-fYi0tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:42 INFO - Running setup.py (path:/tmp/pip-xez4eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:42 INFO - Running setup.py (path:/tmp/pip-EHU27_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:42 INFO - Running setup.py (path:/tmp/pip-HHofbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:42 INFO - Running setup.py (path:/tmp/pip-zHShc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:42 INFO - Running setup.py (path:/tmp/pip-oznPNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:43 INFO - Running setup.py (path:/tmp/pip-H36fgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:43 INFO - Running setup.py (path:/tmp/pip-wHQd9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:43 INFO - Running setup.py (path:/tmp/pip-L6KayJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:43 INFO - Running setup.py (path:/tmp/pip-GV83lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:44 INFO - Downloading blessings-1.6.tar.gz 18:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:44 INFO - Installing collected packages: blessings 18:48:44 INFO - Running setup.py install for blessings 18:48:44 INFO - Successfully installed blessings 18:48:44 INFO - Cleaning up... 18:48:44 INFO - Return code: 0 18:48:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:44 INFO - Reading from file tmpfile_stdout 18:48:44 INFO - Current package versions: 18:48:44 INFO - argparse == 1.2.1 18:48:44 INFO - blessings == 1.6 18:48:44 INFO - blobuploader == 1.2.4 18:48:44 INFO - docopt == 0.6.1 18:48:44 INFO - functools32 == 3.2.3-2 18:48:44 INFO - jsonschema == 2.5.1 18:48:44 INFO - manifestparser == 1.1 18:48:44 INFO - mozInstall == 1.13 18:48:44 INFO - mozcrash == 1.0 18:48:44 INFO - mozdebug == 0.1 18:48:44 INFO - mozdevice == 0.51 18:48:44 INFO - mozfile == 1.2 18:48:44 INFO - mozhttpd == 0.7 18:48:44 INFO - mozinfo == 0.10 18:48:44 INFO - mozleak == 0.1 18:48:44 INFO - mozlog == 3.5 18:48:44 INFO - moznetwork == 0.27 18:48:44 INFO - mozprocess == 0.25 18:48:44 INFO - mozprofile == 0.28 18:48:44 INFO - mozrunner == 6.13 18:48:44 INFO - mozscreenshot == 0.1 18:48:44 INFO - mozsystemmonitor == 0.3 18:48:44 INFO - moztest == 0.8 18:48:44 INFO - mozversion == 1.4 18:48:44 INFO - psutil == 3.1.1 18:48:44 INFO - requests == 1.2.3 18:48:44 INFO - wsgiref == 0.1.2 18:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:44 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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:44 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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:44 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 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 18:48:44 INFO - 'HOME': '/home/cltbld', 18:48:44 INFO - 'LANG': 'en_US.UTF-8', 18:48:44 INFO - 'LANGUAGE': 'en_US:en', 18:48:44 INFO - 'LOGNAME': 'cltbld', 18:48:44 INFO - 'MAIL': '/var/mail/cltbld', 18:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:44 INFO - 'MOZ_NO_REMOTE': '1', 18:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:44 INFO - 'NO_EM_RESTART': '1', 18:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:44 INFO - 'PWD': '/builds/slave/test', 18:48:44 INFO - 'SHELL': '/bin/bash', 18:48:44 INFO - 'SHLVL': '1', 18:48:44 INFO - 'TERM': 'linux', 18:48:44 INFO - 'TMOUT': '86400', 18:48:44 INFO - 'USER': 'cltbld', 18:48:44 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:44 INFO - '_': '/tools/buildbot/bin/python'} 18:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 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 marionette_driver-1.4.0.tar.gz 18:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:48:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:48:46 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:46 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:46 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:46 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:46 INFO - Installing collected packages: marionette-driver, simplejson 18:48:46 INFO - Running setup.py install for marionette-driver 18:48:46 INFO - Running setup.py install for simplejson 18:48:46 INFO - building 'simplejson._speedups' extension 18:48:46 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:47 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:47 INFO - Successfully installed marionette-driver simplejson 18:48:47 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', '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', 'jsonschema'] 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 jsonschema 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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 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 - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:48:47 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Running post-action listener: _resource_record_post_action 18:48:47 INFO - Running post-action listener: _start_resource_monitoring 18:48:47 INFO - Starting resource monitoring. 18:48:47 INFO - [mozharness: 2017-07-25 01:48:47.880220Z] Finished create-virtualenv step (success) 18:48:47 INFO - [mozharness: 2017-07-25 01:48:47.880728Z] Running install step. 18:48:47 INFO - Running pre-action listener: _resource_record_pre_action 18:48:47 INFO - Running main action method: install 18:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:48 INFO - Reading from file tmpfile_stdout 18:48:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:48:48 INFO - Reading from file tmpfile_stdout 18:48:48 INFO - Output received: 18:48:48 INFO - Usage: mozinstall [options] installer 18:48:48 INFO - Options: 18:48:48 INFO - -h, --help show this help message and exit 18:48:48 INFO - -d DEST, --destination=DEST 18:48:48 INFO - Directory to install application into. [default: 18:48:48 INFO - "/builds/slave/test"] 18:48:48 INFO - --app=APP Application being installed. [default: firefox] 18:48:48 INFO - mkdir: /builds/slave/test/build/application 18:48:48 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:48 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:06 INFO - Reading from file tmpfile_stdout 18:49:06 INFO - Output received: 18:49:06 INFO - /builds/slave/test/build/application/firefox/firefox 18:49:06 INFO - Running post-action listener: _resource_record_post_action 18:49:06 INFO - [mozharness: 2017-07-25 01:49:06.163317Z] Finished install step (success) 18:49:06 INFO - [mozharness: 2017-07-25 01:49:06.163661Z] Running setup-mitmproxy step. 18:49:06 INFO - Running pre-action listener: _resource_record_pre_action 18:49:06 INFO - Running main action method: setup_mitmproxy 18:49:06 INFO - Skipping: mitmproxy is not required 18:49:06 INFO - Running post-action listener: _resource_record_post_action 18:49:06 INFO - [mozharness: 2017-07-25 01:49:06.165277Z] Finished setup-mitmproxy step (success) 18:49:06 INFO - [mozharness: 2017-07-25 01:49:06.165671Z] Running run-tests step. 18:49:06 INFO - Running pre-action listener: _resource_record_pre_action 18:49:06 INFO - Running pre-action listener: _set_gcov_prefix 18:49:06 INFO - Running main action method: run_tests 18:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:49:06 INFO - Python 2.7.3 18:49:06 INFO - Return code: 0 18:49:06 INFO - grabbing minidump binary from tooltool 18:49:06 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:06 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 0xd96eb0>, '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 0xd97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd98240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:49:06 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:06 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:06 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:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:06 INFO - Return code: 0 18:49:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:49:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:49:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:49:06 INFO - ENV: RUST_BACKTRACE is now 1 18:49:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:49:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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:06 INFO - Using env: {'DISPLAY': ':0', 18:49:06 INFO - 'HOME': '/home/cltbld', 18:49:06 INFO - 'LANG': 'en_US.UTF-8', 18:49:06 INFO - 'LANGUAGE': 'en_US:en', 18:49:06 INFO - 'LOGNAME': 'cltbld', 18:49:06 INFO - 'MAIL': '/var/mail/cltbld', 18:49:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:49:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:06 INFO - 'MOZ_NO_REMOTE': '1', 18:49:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:06 INFO - 'NO_EM_RESTART': '1', 18:49:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:06 INFO - 'PWD': '/builds/slave/test', 18:49:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:49:06 INFO - 'RUST_BACKTRACE': '1', 18:49:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:49:06 INFO - 'SHELL': '/bin/bash', 18:49:06 INFO - 'SHLVL': '1', 18:49:06 INFO - 'TERM': 'linux', 18:49:06 INFO - 'TMOUT': '86400', 18:49:06 INFO - 'USER': 'cltbld', 18:49:06 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160', 18:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:06 INFO - '_': '/tools/buildbot/bin/python'} 18:49:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULAcXr-fTM-J89OT06qGYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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:06 INFO - mozversion application_buildid: 20170725010649 18:49:06 INFO - mozversion application_changeset: dcfb58fcb6dd8f6474eed6520ba6272dedded393 18:49:06 INFO - mozversion application_display_name: Nightly 18:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:06 INFO - mozversion application_name: Firefox 18:49:06 INFO - mozversion application_remotingname: firefox 18:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:49:06 INFO - mozversion application_vendor: Mozilla 18:49:06 INFO - mozversion application_version: 56.0a1 18:49:06 INFO - mozversion platform_buildid: 20170725010649 18:49:06 INFO - mozversion platform_changeset: dcfb58fcb6dd8f6474eed6520ba6272dedded393 18:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:49:06 INFO - mozversion platform_version: 56.0a1 18:49:06 INFO - using testdate: 1500947346 18:49:06 INFO - actual date: 1500947346 18:49:06 INFO - starting webserver on 'localhost:52412' 18:49:06 INFO - SUITE-START | Running 2 tests 18:49:06 INFO - TEST-START | dromaeo_css 18:49:06 INFO - Initialising browser for dromaeo_css test... 18:49:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52412/getInfo.html -profile /tmp/tmpXOexUp/profile 18:49:06 INFO - TEST-INFO | started process 4157 (/builds/slave/test/build/application/firefox/firefox http://localhost:52412/getInfo.html) 18:49:12 INFO - TEST-INFO | 4157: exit 0 18:49:12 INFO - Browser initialized. 18:49:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:12 INFO - TEST-INFO | started process 4366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOexUp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:23 INFO - PID 4366 | RSS: Main: 175288320 18:49:23 INFO - PID 4366 | 18:52:23 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52412/tests/dromaeo/cssquery-ext.html) 18:52:24 INFO - PID 4366 | RSS: Main: 175841280 18:52:24 INFO - PID 4366 | 18:55:26 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-ext.html (next: http://localhost:52412/tests/dromaeo/cssquery-jquery.html) 18:55:26 INFO - PID 4366 | RSS: Main: 172142592 18:55:26 INFO - PID 4366 | 18:58:28 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52412/tests/dromaeo/cssquery-mootools.html) 18:58:29 INFO - PID 4366 | RSS: Main: 174895104 18:58:29 INFO - PID 4366 | 19:01:31 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52412/tests/dromaeo/cssquery-prototype.html) 19:01:31 INFO - PID 4366 | RSS: Main: 174493696 19:01:31 INFO - PID 4366 | 19:04:35 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52412/tests/dromaeo/cssquery-yui.html) 19:04:36 INFO - PID 4366 | RSS: Main: 174944256 19:04:36 INFO - PID 4366 | 19:07:37 INFO - PID 4366 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-yui.html (next: http://localhost:52412/tests/dromaeo/cssquery-dojo.html) 19:07:38 INFO - PID 4366 | RSS: Main: 177541120 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | __start_tp_report 19:07:38 INFO - PID 4366 | _x_x_mozilla_page_load 19:07:38 INFO - PID 4366 | _x_x_mozilla_page_load_details 19:07:38 INFO - PID 4366 | |i|pagename|runs| 19:07:38 INFO - PID 4366 | |0;dojo.html;3113.7664675149354;3157.321175947171;3157.873685052598;3160.952585711214;3189.7926634768737;6023.909641355383;6157.846053848656;6169.2288463942;6176.660283684396;6231.5014798816155;5901.498372638331;6012.669303188323;6077.0884367344925;6117.204763380765;6198.845028874269;5642.943570564304;5657.717114144297;5702.515286200667;5720.8283751487525;5750.683712395817;5474.91787623186;5541.33503979523;5648.604597678164;5682.573806964473;5786.913196302038;5591.440855914417;5662.320521537421;5667.234923285345;5673.177389278531;5674.716264186794;5610.438956104398;5650.802221922254;5677.659340439587;5743.052396354638;5759.078547432391;5440.265564148868;5504.559635229172;5612.326520817487;5639.492445679867;5694.629849059798;6032.5173986081445;6078.422549857756;6142.324344322121;6163.506919446433;6172.105044768484;6507.934920650828;6521.967390163066;6634.104395906539;6643.800685979429;6644.136262285921;6454.290028096905;6557.278699343068;6583.572067815577;6617.569857959265;6635.8009259722285;6167.660778657217;6225.501959843202;6241.095041219043;6247.500199983991;6257.593256438271;6774.830629234309;6801.115854938926;6874.65626718662;6875.965620171867;6877.346652068046;6275;6304.65324407162;6400.423961843457;6509.576877502947;6602.042703807921;6569.441597464173;6576.638284894281;6601.570897891622;6603.966980165068;6604.801855944329;6522.771702990372;6556.409923106943;6572.572782769104;6590.835229119214;6675.299093595199;6535.8366040848405;6586.934130658728;6623.6688165592495;6665.166854143232;6689.431398331099;5365.409804921455;5423.132298832168;5443.319585051869;5449.509544140967;5456;4597.908041839144;4606.216943119678;4630.560096790799;4659.627229821606;4671.089137618132;5739.942600574024;5753.712314384264;5767.163761254678;5774.595778295479;5778.566607504454;6626.602403855688;6633.767818126343;6636.933630663631;6747.696353664097;6749.392554670103;5540.335159780771;5626.156076588462;5646;5793.478586927196;5798.797042103506;5823;5902.61632993854;5908.409159084057;5916.5858389913155;5929.169916211734;6391.360863913665;6396.648184349812;6448.387403196689;6489;6491.610503369813;6399.840003999937;6607.405333519814;6664.4668426524795;6680.098186744727;6704.865902681821;6233.314335423191;6392.20097487814;6443.226812782496;6455.903161452676;6504.674766261763;6488.935110649022;6498.837529061811;6569;6585;6593.109930159559;6564.5076619254705;6595.571287866273;6695.799126026227;6698.330166983263;6740.696668650021;6259.029850373199;6275.466585340298;6290.899092658675;6334.9366506334345;6367.840803979938;6460.353964603502;6460.676966151767;6517.478601711757;6542.34576542342;6554.770583029571;6340.904886426615;6349.0476428536085;6493.707783149675;6497.31778163305;6500.089987401862;6285.49716022708;6477.4494167996245;6491.578047426902;6516.413522782972;6592.538522303393;6261.96869015652;6332.176817013758;6352.491800655844;6364.904526432199;6413.615183089029 19:07:38 INFO - PID 4366 | |1;ext.html;815.48624366649;821.4824660463906;840.315143158326;867.137198487505;867.8524650809363;43243.35134972974;44257.114857702865;44554.33168502471;44639.10721785562;44649.553504465024;39005.60994390062;39172.412413813814;39245.8037709811;39398.606013939854;39739;6786.321367863224;6901.413379862693;6917.7578784742545;6923.965380173092;6926.757563485279;6854.21176564694;6944.375006249436;6944.444444444458;6949.270326615683;6955.339242771954;7629.732959346424;7786.26030527099;7786.260305271018;7788.376929845627;7823.687052517921;7645.655945482466;7673.923260767377;7678.846423071564;7731.729389471369;7738.7678369649;7598.468107232496;7653.425993050488;7670.194629563871;7671.654775535114;7674.309312161932;39918.800405998074;40081.39877901834;40345.79827100875;40355;40381;3646.179609587848;3650.634936506328;3680.061584296014;3694.852205911787;3696.149885526317;31960.520592191137;32045.359092818013;32103.51844722331;32172.356552868812;32308.35383292321;4949.257611358289;4951.133551628486;4960.702357858504;4988.326575912241;4991.625628077909;217338;218415;220499;220966.9999999984;221757;48956;48984.265236021485;49112.75443622759;49431;49579.75210123926;51137;51193;51381.22928156081;51581;51631;16486.505404837873;16911.408100716417;16963.915180424017;16972.575685607713;17080.316787328615;13966.86033139676;13973.16161030321;13985.3706583204;13998;14026.22855742944;14636.634084147769;14774.374818769928;14803;14870.776938345933;15027.398904043715;5894.469497745224;5897.675627840425;5907.852303692356;5954.910676339859;6016.789412370546;969.6266937229218;986.5018165826211;995.2684776689127;997.5511020040866;1017.97455063624;22410;22840.65739013916;23228.41928951756;23248.767512324997;23578.528429431317;1080.5191689698165;1095.1348434736628;1124.887511248885;1128.9322640641587;1130.0620484997432;11777.234479758788;11983.820242696367;12023.63929082129;12077;12412.146534357908;235212;238523;239351;239359;239448;52993.470065299625;53720;58062.129068064016;58915.11627325594;59191.40808591945;1498.572906721579;1503.2859391788813;1516.780066890317;1517.2944580769995;1520.2094910646401;26127;27773;27824;27989.580156298078;28009.719902800713;39469.40795888007;39831.402528962666;39841.40237896492;39874.40188397234;39881;215820;215844;216017;216112;217189;34671;35500.467492988144;35659.46510802288;35904.28191436105;35918.461223082195;44711.77644111889;44741.55258447374;44762.3285650722;45853;48087.5191248097;34415.31169376648;34807.651923480444;34957.82521087378;34983.82508087545;35568;32929.835350823094;34264.31471370609;34448.483272750425;34810.30379392449;34906.12734681552;38428.615713842504;38504.614953850105;38512.22975540417;38653.806730966164;38860.41709374305;28969;29158.666091931234;29571.85214073916;29738;29814;24010;24076;24151.275461736175;24365.147219847222;24663.260102196964 19:07:38 INFO - PID 4366 | |2;jquery.html;567.6792612174124;572.5963195946858;582.1180910919956;590.2150140313383;606.9180660610817;22579.54840903183;22839.77160228397;23495.177668781595;23579.646305305414;23602.409939751517;26439.20682379527;27114.1865744028;27140.864295678544;27142.18573442795;27265.182044538647;6712.697928593213;6875.243723190445;6879.208890977551;6879.793606191823;6884.139482564679;6293.842653933665;6573.868522629545;6604.867902641944;6685.632290224035;6700.497462690318;6551.410373066423;6558.409743123118;6560.540762146652;6560.7047682854145;6560.835979100513;6557.147570815811;6558.836029099263;6560.803175904731;6567.113439685629;6579.80260592183;6082.787102451393;6096;6096.390360963913;6121.081837724377;6126.969365153191;28198.295042624097;28874.27814304638;29466.41067178666;29499.262518436997;30114.24714382136;1812.0667856054142;1856.0905156473232;1856.9721454178198;1857.8049304822935;1862.757841480599;19174.233030678755;19786.307479238156;19796.901015494976;19805.306814261578;19869.20523179071;2284.851484653492;2297.127091705158;2301.0680674326923;2332.300309907038;2344.284993077111;131417.34291328577;132754.33622831825;135201;136562.31718841344;136607;14626.683598476187;15018.924905375403;15164.545063648107;15180.468683596022;15656.217189140498;23885.761142388354;23898;23913.402164946016;23992;24059.398515036915;10428.383600541929;10444.268901176996;10456.68629941103;10617.946910265398;10681.57273709043;8077.313428358538;9607.231421486264;9760.313092884924;9806.803863922823;9817.067378599022;8356.328734253173;9011.738356630078;9411.529423528933;9570.665026724031;9609.174256891169;2706.526357887362;2727.5363188258043;2799.566067259578;2802.341449759305;2902.3904979954023;905.3707673167086;948.2508818033814;957.3872721458272;965.1458459263462;984.084801134937;19195.32816351421;19512.121954511797;19808.40574782759;19847;20262.493437664176;982.5431174503747;1034.1054987435814;1051.9737006574896;1059.676798576426;1063.9414832184304;10523.52644131016;10547.947260263649;10595.193531481527;10944.562217511211;11142.442877856074;504913;513122;518273;519694;524933;118736.40631796786;120064;120744.39627801804;121976;125708;1261.2306493039239;1274.222724138275;1306.5427100514935;1311.7376524695098;1317.236003118189;19783.802161978198;20243.39269821908;20875.791242087384;20883.04476150985;21348.466288342916;56060;56293.43706562882;57718;58675;59200;71506;71895.64052179914;71899.64050179716;72083.63958180175;72277.6386118066;12171.81742273849;12665.240085594894;13694.65763355924;14313.642158945693;14814.25928703582;21809.454763631034;22231.555368892856;22275.220367287067;22311.88844055834;22355.888220558794;16798.328066877188;16829.747553786947;16838.747418788975;16889.493315200565;18293.17680704345;14237.572872813833;14733.484328048467;14746.262686865828;14838.851611484179;15336.846631533543;16994;17110.572235694206;18016.459506214833;18020.459386218434;18032;14911.403543858125;15113.697726045637;15121.39514419411;15194.316255768295;15253;16951.321947121978;17075.31698732037;17132;17833.375831845824;18979.145938432528 19:07:38 INFO - PID 4366 | |3;mootools.html;1356.6065840906138;1419.1130543410368;1421.374595178121;1431.155618185271;1431.3916585451186;13401.329933503323;13919.02566820323;13923.860761392409;13965.790513142298;13975.720485590282;13444.798328025063;14044.438222471088;14343.354549045293;14466.349014294356;14470.276486175675;2460.274219105364;2496.588062969608;2505.799536037113;2526.696796384427;2527.2039307618043;2523.7602427769334;2590.3265151060764;2597.2727636261875;2664.480426316869;2665.3869609989715;2701.5947607858784;2704.094128466956;2721.360480287141;2733.876975536096;2734.53512902806;2585.327814768155;2640.9867950660123;2647.6160956661274;2654.588538776493;2656.774174195196;2595.0268649256527;2600.2069368842494;2622.593498007812;2622.803289753276;2623.580227163645;13943.790843137362;13968.790468142986;14236.857631423656;14242.145471271757;14247.145171289756;7217.350438460564;7282.453815963824;7433.293837085468;7453.701851925916;7528.623568821592;4944.159492886218;5003.5997120230295;5150.4334523202415;5157.896842063175;5158.40678321994;1792.0069393448082;1810.5021119192195;1857.136431559318;1878.0797409269496;1894.7726272847208;22476.10095596174;22621.88689056544;22720.318390448312;22735.317940461813;22762.77237227623;6217;6699.6315202663345;6939.444844412435;6990.650467476606;6997.650117494105;15523.922380388025;15622.750179985575;15642.296096675676;15657.608559786097;15661.921690391475;7470.439717021137;7471.476996610185;7522.871569264545;7739.380849532024;7776.92223077762;6872.587644741331;6938.479614028867;6962.582245065312;6963.303669632996;7041.084658994298;4705.929411058837;4815.085133824562;4843.4430040545785;4859;4905.681130726492;1282.4805953588625;1308.0778051473687;1323.8742319479634;1327.336331834083;1330.255057167989;860.6084231674573;860.6213266162869;871.3551971541013;900.1358695652248;916.9816603667889;7990.720324788605;8035.598220088972;8196.877046844302;8211.137830527709;8217.95891020553;931.5839923316656;983.3902980152351;989.1048601016092;996.5017491254373;1006.8238058339762;4489.371487991683;5223.733878578175;5259.552938000236;5265.6840589564745;5322.760475778599;18198.727019094724;18903.716444253347;18999.240030398905;19175.808241917402;19348.903255483634;18569.628607428047;19009.14458849355;19198.712019319442;19322.130504127348;19375;10553.208509361828;10810.135189184846;10951.069159121405;10956.28784129029;10992.890071099346;7462;7970.960145199237;8005.639746211318;8112.75661730149;8147.348212142896;16351.672966540365;16448.259828307993;16764.664706705553;17409.303627854744;17652;16379.754303685693;16724.832751672813;17362.13189340553;17647.38234161798;17803.643927121127;10859.457027148768;11290.548378065114;11320.26418282842;11323.547058117583;11385.259958102697;11682.824757628812;13000.609981700563;13062;13125.60623181306;13170.341482926007;8813.823723525622;9771.609135634495;10083.495825208856;10885.673429797118;11138;9950.154236889655;10431.739206519898;10569.418681972258;10689.144868410664;10705.9464702676;9396.107369799858;9484.383515071499;9501.762455938657;9551.283653725859;9552.665656701982;6919.342662447059;6947.305269473012;7146.464015198985;7291.817704557428;7322.340989310987;7208.414872798435;7283.854322913406;7312;7340.339369456775;7436.59098749574 19:07:38 INFO - PID 4366 | |4;prototype.html;489.92338847411315;500.63075501872396;519.5531842615352;520.9192575150852;527.5621234375469;6117.327094019654;6122.000219892254;6143.385661433855;6159.322474527804;6173.228346456693;5795.739191736371;5939.703014849262;5965.224520812289;6038.849028774272;6049.183360246366;4876.097921884445;4880.656750126175;4910.508949105088;4963.726995015273;4969.826056088038;4819.807207711688;4863.465018847924;4890.77991490382;4930.285108659242;4947.431045429786;4824.758762061883;4887.218045112782;4929.4824043475455;4935.753212339387;4970.875728106808;4836.854894353175;4857.24712669535;4888.706677599355;4929.901401971941;4941.629377796662;4428.335749637548;4441.356003379492;4451.376807246988;4458.554144585548;4495.752733599651;5972.641641501524;5975.760969561213;6022.277326720821;6063;6074.96962515189;5604.271444712162;5631.324241091054;5664.830055098354;5699.829005129853;5702.971485142548;6387.520935929778;6428.067930150149;6432.195975503062;6442.742290308382;6476.514261430411;4775.14047471455;4800.807967681289;4842.757862106881;4879.829205977774;4891.461939186686;6828.214755303154;6829.6585170742255;6850.725970961205;6911.930880691179;6922.757703480354;4899.853004409873;4942.827001054946;4949.331840201598;4952.70283782967;4956.430010548761;4961.950380496149;4980.676256043345;5008.524190201925;5008.697738587994;5016.322796422509;5541.639793413416;5614.933162699074;5635.436456354414;5641.323041234996;5684.829455116271;6165.753369865245;6325.9051114233325;6407.935920640734;6531.902021469682;6538.542302038907;1626.2356692354574;1643.1866226218099;1715.8198389169206;1725.6289897672061;1761.4451447793904;1182.7279725663145;1219.9817002744967;1226.2274766896799;1228.950841966329;1235.8197920985438;5446.945530544723;5595.972020139955;5638.633488823213;5640.266765320564;5682.261306030272;6505.316941721146;6547.574407663486;6583.868322633521;6612.2726500084955;6622.2715501294815;5642.463965923231;5669.2346533218315;5676.631018983835;5699.857503562444;5729.169270455761;3486.75592708513;3543.2027793746715;3545.290941811648;3547.2728090741334;3570.8571657133425;6433.581817181868;6469.644169570624;6471.573160064976;6477.352264773485;6509.707063182168;6654.534182607171;6742.258351581322;6843.418309443753;6855.794326170223;6863.588184708933;6383.489320854414;6394.520410969103;6421.133147025092;6422.614643121427;6488.351164883474;6650.90023649636;6666.333366663489;6673.5328527004585;6700.430463410665;6731.225909020525;6537.967310163419;6546.869062618816;6594.868102637824;6605.768798092044;6635.668216589248;6235.251769787655;6398.936010639834;6415.262244841903;6425.357464253537;6439.935600643934;4889.951100489092;4932.82735104284;4944.283078953604;4993.575546078624;5018.949810501848;6309.053641953744;6433.356664333529;6584.4732421405215;6668.733250669919;6697.254125808395;6211.105612788143;6348.079528468254;6363.268224154282;6410;6420.229572451336;6329.272133704683;6448.419642232222;6454;6468.773592924225;6505.512086593619;6223.688815559294;6323.525735569759;6337.176167098432;6415.230172379344;6436.871262574628;6425.325340839331;6502.544821862424;6507.869842603216;6520.9347906520325;6534.901976470452;6243.250809902841;6291.591046581958;6318;6325.746970121328;6339.587926784744 19:07:38 INFO - PID 4366 | |5;yui.html;891.509669681675;905.1853332001202;912.6258234124008;917.6925729880489;922.3727865051762;18004.819951800477;19011.904940475295;19045;19067;20019.099140538674;20138;20815.895920520416;20884.582308353863;20896.686549701768;21029.474263143427;1038.7818558102808;1062.7927554126948;1065.5205157679036;1066.109798318401;1066.461436974327;1051.7370657335666;1052.252900440688;1055.166418529361;1056.9207309451783;1057.3919996002292;785.9056913170399;816.7059858450953;1065.275612583443;1123.1632433836762;1125.7861006408798;1121.8485504456876;1124.7750449910009;1127.7349822791637;1128.2215271462665;1128.2948157401624;807.8788181772723;811.4157806379397;811.7280710961776;812.0215140755435;815.6288888555753;19311.710324345146;19799.208031678714;19947.800521994886;20076.89961550183;20152.093155808023;20703.378898633066;20991.790082099134;21054.473638159016;21151;21215.78784212169;15519.068855868683;15909.602259943478;16024.278907449192;16065.196740163063;16269.674606507922;3417.094469965461;3425.2293234022395;3435.089701229176;3439.0198793343775;3444.9827750861086;116297;119293.40353298264;121484;126226;127623;16688.33246670144;17126.14369281556;17157;17297.827021729623;17326.220320085627;28567.42865142727;30211.848940755157;30423;30487.695123048485;30581;7088.149422069281;7488.663010164556;8419.621117049748;8915.687950921687;9146.679866204651;4171.5828417158045;4229.767362795076;4242.215190189825;4290.785460727014;4298.849540266076;5132.255822905658;5169;5266.34170728659;5324.760385782649;5359.705216213068;1080.173667144635;1086.9347839129678;1103.2994048778924;1104.3539529375246;1104.861892263467;649.2890285137767;657.3131078023476;669.5079116849112;685.0648864300194;699.4439420660588;10646.946765266124;12328.75342493145;12674.366281686063;13165.275909825052;13347.332633368293;668.058038166193;693.1820451866846;693.8542905989698;695.5930780493367;701.2601705201062;5080.923786143211;5131.666441681279;5185.196294574347;5311.840644780663;5412.107002344648;110378.44810776056;113607.43196283966;113801.4309928445;114153.42923285496;116623;85637.14362856292;90259;92716.53641731747;93119.5344023289;94142.58786118214;73531.26468735244;79179.60410197912;82547;82618.58690706629;84848.15151848402;11296.650789445957;11591.826122608;11688.766224675288;12151.149419540547;12370.195937264049;36738.8163059183;38420.807895960344;38592.2281554373;38663;39557.2088558233;47323.52676473191;47331.05337893292;47588.762056189495;65733;65874.67062664848;17716.468505944842;18395.08024598738;18438.723419148457;18646;18676.252949882397;18184.36354727578;20322.187112515334;20705.896470518153;21091.683624745336;21185.470363240427;16117.194140293173;16583.336666533687;16764.077975711454;17008.914955425145;17052.48842534726;17648.382306619205;18144.45566633003;18173.909130454264;18239.361622343153;18280.90859545694;16579.66840663204;16760.245788939283;16846.1576921151;16898.32406703718;17541;11099.334039957628;12065.577704780291;12245.938770306091;12722.554710585086;13490.52783152585;13428.597142085753;13791.586252412444;13892.444302227797;14095.506657266946;14112.36494357777 19:07:38 INFO - PID 4366 | __end_tp_report 19:07:38 INFO - PID 4366 | __start_cc_report 19:07:38 INFO - PID 4366 | _x_x_mozilla_cycle_collect,358 19:07:38 INFO - PID 4366 | __end_cc_report 19:07:38 INFO - PID 4366 | __startTimestamp1500948458167__endTimestamp 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | ------- Summary: start ------- 19:07:38 INFO - PID 4366 | Number of tests: 6 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#0] dojo.html Cycles:165 Average:6090.41 Median:6304.65 stddev:709.06 (11.2%) stddev-sans-first:671.68 19:07:38 INFO - PID 4366 | Values: 3113.8 3157.3 3157.9 3161.0 3189.8 6023.9 6157.8 6169.2 6176.7 6231.5 5901.5 6012.7 6077.1 6117.2 6198.8 5642.9 5657.7 5702.5 5720.8 5750.7 5474.9 5541.3 5648.6 5682.6 5786.9 5591.4 5662.3 5667.2 5673.2 5674.7 5610.4 5650.8 5677.7 5743.1 5759.1 5440.3 5504.6 5612.3 5639.5 5694.6 6032.5 6078.4 6142.3 6163.5 6172.1 6507.9 6522.0 6634.1 6643.8 6644.1 6454.3 6557.3 6583.6 6617.6 6635.8 6167.7 6225.5 6241.1 6247.5 6257.6 6774.8 6801.1 6874.7 6876.0 6877.3 6275.0 6304.7 6400.4 6509.6 6602.0 6569.4 6576.6 6601.6 6604.0 6604.8 6522.8 6556.4 6572.6 6590.8 6675.3 6535.8 6586.9 6623.7 6665.2 6689.4 5365.4 5423.1 5443.3 5449.5 5456.0 4597.9 4606.2 4630.6 4659.6 4671.1 5739.9 5753.7 5767.2 5774.6 5778.6 6626.6 6633.8 6636.9 6747.7 6749.4 5540.3 5626.2 5646.0 5793.5 5798.8 5823.0 5902.6 5908.4 5916.6 5929.2 6391.4 6396.6 6448.4 6489.0 6491.6 6399.8 6607.4 6664.5 6680.1 6704.9 6233.3 6392.2 6443.2 6455.9 6504.7 6488.9 6498.8 6569.0 6585.0 6593.1 6564.5 6595.6 6695.8 6698.3 6740.7 6259.0 6275.5 6290.9 6334.9 6367.8 6460.4 6460.7 6517.5 6542.3 6554.8 6340.9 6349.0 6493.7 6497.3 6500.1 6285.5 6477.4 6491.6 6516.4 6592.5 6262.0 6332.2 6352.5 6364.9 6413.6 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#1] ext.html Cycles:180 Average:39839.91 Median:21062.38 stddev:58358.73 (277.1%) stddev-sans-first:58448.87 19:07:38 INFO - PID 4366 | Values: 815.5 821.5 840.3 867.1 867.9 43243.4 44257.1 44554.3 44639.1 44649.6 39005.6 39172.4 39245.8 39398.6 39739.0 6786.3 6901.4 6917.8 6924.0 6926.8 6854.2 6944.4 6944.4 6949.3 6955.3 7629.7 7786.3 7786.3 7788.4 7823.7 7645.7 7673.9 7678.8 7731.7 7738.8 7598.5 7653.4 7670.2 7671.7 7674.3 39918.8 40081.4 40345.8 40355.0 40381.0 3646.2 3650.6 3680.1 3694.9 3696.1 31960.5 32045.4 32103.5 32172.4 32308.4 4949.3 4951.1 4960.7 4988.3 4991.6 217338.0 218415.0 220499.0 220967.0 221757.0 48956.0 48984.3 49112.8 49431.0 49579.8 51137.0 51193.0 51381.2 51581.0 51631.0 16486.5 16911.4 16963.9 16972.6 17080.3 13966.9 13973.2 13985.4 13998.0 14026.2 14636.6 14774.4 14803.0 14870.8 15027.4 5894.5 5897.7 5907.9 5954.9 6016.8 969.6 986.5 995.3 997.6 1018.0 22410.0 22840.7 23228.4 23248.8 23578.5 1080.5 1095.1 1124.9 1128.9 1130.1 11777.2 11983.8 12023.6 12077.0 12412.1 235212.0 238523.0 239351.0 239359.0 239448.0 52993.5 53720.0 58062.1 58915.1 59191.4 1498.6 1503.3 1516.8 1517.3 1520.2 26127.0 27773.0 27824.0 27989.6 28009.7 39469.4 39831.4 39841.4 39874.4 39881.0 215820.0 215844.0 216017.0 216112.0 217189.0 34671.0 35500.5 35659.5 35904.3 35918.5 44711.8 44741.6 44762.3 45853.0 48087.5 34415.3 34807.7 34957.8 34983.8 35568.0 32929.8 34264.3 34448.5 34810.3 34906.1 38428.6 38504.6 38512.2 38653.8 38860.4 28969.0 29158.7 29571.9 29738.0 29814.0 24010.0 24076.0 24151.3 24365.1 24663.3 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#2] jquery.html Cycles:180 Average:35599.46 Median:12562.31 stddev:86686.07 (690.0%) stddev-sans-first:86889.34 19:07:38 INFO - PID 4366 | Values: 567.7 572.6 582.1 590.2 606.9 22579.5 22839.8 23495.2 23579.6 23602.4 26439.2 27114.2 27140.9 27142.2 27265.2 6712.7 6875.2 6879.2 6879.8 6884.1 6293.8 6573.9 6604.9 6685.6 6700.5 6551.4 6558.4 6560.5 6560.7 6560.8 6557.1 6558.8 6560.8 6567.1 6579.8 6082.8 6096.0 6096.4 6121.1 6127.0 28198.3 28874.3 29466.4 29499.3 30114.2 1812.1 1856.1 1857.0 1857.8 1862.8 19174.2 19786.3 19796.9 19805.3 19869.2 2284.9 2297.1 2301.1 2332.3 2344.3 131417.3 132754.3 135201.0 136562.3 136607.0 14626.7 15018.9 15164.5 15180.5 15656.2 23885.8 23898.0 23913.4 23992.0 24059.4 10428.4 10444.3 10456.7 10617.9 10681.6 8077.3 9607.2 9760.3 9806.8 9817.1 8356.3 9011.7 9411.5 9570.7 9609.2 2706.5 2727.5 2799.6 2802.3 2902.4 905.4 948.3 957.4 965.1 984.1 19195.3 19512.1 19808.4 19847.0 20262.5 982.5 1034.1 1052.0 1059.7 1063.9 10523.5 10547.9 10595.2 10944.6 11142.4 504913.0 513122.0 518273.0 519694.0 524933.0 118736.4 120064.0 120744.4 121976.0 125708.0 1261.2 1274.2 1306.5 1311.7 1317.2 19783.8 20243.4 20875.8 20883.0 21348.5 56060.0 56293.4 57718.0 58675.0 59200.0 71506.0 71895.6 71899.6 72083.6 72277.6 12171.8 12665.2 13694.7 14313.6 14814.3 21809.5 22231.6 22275.2 22311.9 22355.9 16798.3 16829.7 16838.7 16889.5 18293.2 14237.6 14733.5 14746.3 14838.9 15336.8 16994.0 17110.6 18016.5 18020.5 18032.0 14911.4 15113.7 15121.4 15194.3 15253.0 16951.3 17075.3 17132.0 17833.4 18979.1 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#3] mootools.html Cycles:180 Average:8646.89 Median:2592.68 stddev:5869.47 (226.4%) stddev-sans-first:5860.37 19:07:38 INFO - PID 4366 | Values: 1356.6 1419.1 1421.4 1431.2 1431.4 13401.3 13919.0 13923.9 13965.8 13975.7 13444.8 14044.4 14343.4 14466.3 14470.3 2460.3 2496.6 2505.8 2526.7 2527.2 2523.8 2590.3 2597.3 2664.5 2665.4 2701.6 2704.1 2721.4 2733.9 2734.5 2585.3 2641.0 2647.6 2654.6 2656.8 2595.0 2600.2 2622.6 2622.8 2623.6 13943.8 13968.8 14236.9 14242.1 14247.1 7217.4 7282.5 7433.3 7453.7 7528.6 4944.2 5003.6 5150.4 5157.9 5158.4 1792.0 1810.5 1857.1 1878.1 1894.8 22476.1 22621.9 22720.3 22735.3 22762.8 6217.0 6699.6 6939.4 6990.7 6997.7 15523.9 15622.8 15642.3 15657.6 15661.9 7470.4 7471.5 7522.9 7739.4 7776.9 6872.6 6938.5 6962.6 6963.3 7041.1 4705.9 4815.1 4843.4 4859.0 4905.7 1282.5 1308.1 1323.9 1327.3 1330.3 860.6 860.6 871.4 900.1 917.0 7990.7 8035.6 8196.9 8211.1 8218.0 931.6 983.4 989.1 996.5 1006.8 4489.4 5223.7 5259.6 5265.7 5322.8 18198.7 18903.7 18999.2 19175.8 19348.9 18569.6 19009.1 19198.7 19322.1 19375.0 10553.2 10810.1 10951.1 10956.3 10992.9 7462.0 7971.0 8005.6 8112.8 8147.3 16351.7 16448.3 16764.7 17409.3 17652.0 16379.8 16724.8 17362.1 17647.4 17803.6 10859.5 11290.5 11320.3 11323.5 11385.3 11682.8 13000.6 13062.0 13125.6 13170.3 8813.8 9771.6 10083.5 10885.7 11138.0 9950.2 10431.7 10569.4 10689.1 10705.9 9396.1 9484.4 9501.8 9551.3 9552.7 6919.3 6947.3 7146.5 7291.8 7322.3 7208.4 7283.9 7312.0 7340.3 7436.6 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#4] prototype.html Cycles:180 Average:5431.61 Median:6030.56 stddev:1521.37 (25.2%) stddev-sans-first:1479.73 19:07:38 INFO - PID 4366 | Values: 489.9 500.6 519.6 520.9 527.6 6117.3 6122.0 6143.4 6159.3 6173.2 5795.7 5939.7 5965.2 6038.8 6049.2 4876.1 4880.7 4910.5 4963.7 4969.8 4819.8 4863.5 4890.8 4930.3 4947.4 4824.8 4887.2 4929.5 4935.8 4970.9 4836.9 4857.2 4888.7 4929.9 4941.6 4428.3 4441.4 4451.4 4458.6 4495.8 5972.6 5975.8 6022.3 6063.0 6075.0 5604.3 5631.3 5664.8 5699.8 5703.0 6387.5 6428.1 6432.2 6442.7 6476.5 4775.1 4800.8 4842.8 4879.8 4891.5 6828.2 6829.7 6850.7 6911.9 6922.8 4899.9 4942.8 4949.3 4952.7 4956.4 4962.0 4980.7 5008.5 5008.7 5016.3 5541.6 5614.9 5635.4 5641.3 5684.8 6165.8 6325.9 6407.9 6531.9 6538.5 1626.2 1643.2 1715.8 1725.6 1761.4 1182.7 1220.0 1226.2 1229.0 1235.8 5446.9 5596.0 5638.6 5640.3 5682.3 6505.3 6547.6 6583.9 6612.3 6622.3 5642.5 5669.2 5676.6 5699.9 5729.2 3486.8 3543.2 3545.3 3547.3 3570.9 6433.6 6469.6 6471.6 6477.4 6509.7 6654.5 6742.3 6843.4 6855.8 6863.6 6383.5 6394.5 6421.1 6422.6 6488.4 6650.9 6666.3 6673.5 6700.4 6731.2 6538.0 6546.9 6594.9 6605.8 6635.7 6235.3 6398.9 6415.3 6425.4 6439.9 4890.0 4932.8 4944.3 4993.6 5018.9 6309.1 6433.4 6584.5 6668.7 6697.3 6211.1 6348.1 6363.3 6410.0 6420.2 6329.3 6448.4 6454.0 6468.8 6505.5 6223.7 6323.5 6337.2 6415.2 6436.9 6425.3 6502.5 6507.9 6520.9 6534.9 6243.3 6291.6 6318.0 6325.7 6339.6 19:07:38 INFO - PID 4366 | 19:07:38 INFO - PID 4366 | [#5] yui.html Cycles:180 Average:22782.97 Median:19983.45 stddev:30864.21 (154.4%) stddev-sans-first:30907.02 19:07:38 INFO - PID 4366 | Values: 891.5 905.2 912.6 917.7 922.4 18004.8 19011.9 19045.0 19067.0 20019.1 20138.0 20815.9 20884.6 20896.7 21029.5 1038.8 1062.8 1065.5 1066.1 1066.5 1051.7 1052.3 1055.2 1056.9 1057.4 785.9 816.7 1065.3 1123.2 1125.8 1121.8 1124.8 1127.7 1128.2 1128.3 807.9 811.4 811.7 812.0 815.6 19311.7 19799.2 19947.8 20076.9 20152.1 20703.4 20991.8 21054.5 21151.0 21215.8 15519.1 15909.6 16024.3 16065.2 16269.7 3417.1 3425.2 3435.1 3439.0 3445.0 116297.0 119293.4 121484.0 126226.0 127623.0 16688.3 17126.1 17157.0 17297.8 17326.2 28567.4 30211.8 30423.0 30487.7 30581.0 7088.1 7488.7 8419.6 8915.7 9146.7 4171.6 4229.8 4242.2 4290.8 4298.8 5132.3 5169.0 5266.3 5324.8 5359.7 1080.2 1086.9 1103.3 1104.4 1104.9 649.3 657.3 669.5 685.1 699.4 10646.9 12328.8 12674.4 13165.3 13347.3 668.1 693.2 693.9 695.6 701.3 5080.9 5131.7 5185.2 5311.8 5412.1 110378.4 113607.4 113801.4 114153.4 116623.0 85637.1 90259.0 92716.5 93119.5 94142.6 73531.3 79179.6 82547.0 82618.6 84848.2 11296.7 11591.8 11688.8 12151.1 12370.2 36738.8 38420.8 38592.2 38663.0 39557.2 47323.5 47331.1 47588.8 65733.0 65874.7 17716.5 18395.1 18438.7 18646.0 18676.3 18184.4 20322.2 20705.9 21091.7 21185.5 16117.2 16583.3 16764.1 17008.9 17052.5 17648.4 18144.5 18173.9 18239.4 18280.9 16579.7 16760.2 16846.2 16898.3 17541.0 11099.3 12065.6 12245.9 12722.6 13490.5 13428.6 13791.6 13892.4 14095.5 14112.4 19:07:38 INFO - PID 4366 | -------- Summary: end -------- 19:07:38 INFO - PID 4366 | 19:07:38 INFO - TEST-INFO | 4366: exit 0 19:07:38 INFO - TEST-OK | dromaeo_css | took 1112393ms 19:07:38 INFO - TEST-START | kraken 19:07:38 INFO - Initialising browser for kraken test... 19:07:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52412/getInfo.html -profile /tmp/tmpcnv7q9/profile 19:07:38 INFO - TEST-INFO | started process 4726 (/builds/slave/test/build/application/firefox/firefox http://localhost:52412/getInfo.html) 19:07:44 INFO - TEST-INFO | 4726: exit 0 19:07:44 INFO - Browser initialized. 19:07:44 INFO - Running cycle 1/1 for kraken test... 19:07:44 INFO - TEST-INFO | started process 4934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnv7q9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:56 INFO - PID 4934 | RSS: Main: 174948352 19:07:56 INFO - PID 4934 | 19:07:58 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:59 INFO - PID 4934 | RSS: Main: 179728384 19:07:59 INFO - PID 4934 | 19:08:02 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-dft) 19:08:02 INFO - PID 4934 | RSS: Main: 179830784 19:08:02 INFO - PID 4934 | 19:08:05 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-fft) 19:08:06 INFO - PID 4934 | RSS: Main: 174206976 19:08:06 INFO - PID 4934 | 19:08:08 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator) 19:08:09 INFO - PID 4934 | RSS: Main: 174702592 19:08:09 INFO - PID 4934 | 19:08:11 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:12 INFO - PID 4934 | RSS: Main: 174919680 19:08:12 INFO - PID 4934 | 19:08:15 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:15 INFO - PID 4934 | RSS: Main: 177573888 19:08:15 INFO - PID 4934 | 19:08:19 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:19 INFO - PID 4934 | RSS: Main: 177401856 19:08:19 INFO - PID 4934 | 19:08:22 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial) 19:08:23 INFO - PID 4934 | RSS: Main: 177508352 19:08:23 INFO - PID 4934 | 19:08:25 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:25 INFO - PID 4934 | RSS: Main: 177463296 19:08:25 INFO - PID 4934 | 19:08:27 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:28 INFO - PID 4934 | RSS: Main: 175017984 19:08:28 INFO - PID 4934 | 19:08:30 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:30 INFO - PID 4934 | RSS: Main: 174600192 19:08:30 INFO - PID 4934 | 19:08:33 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:34 INFO - PID 4934 | RSS: Main: 175251456 19:08:34 INFO - PID 4934 | 19:08:37 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:37 INFO - PID 4934 | RSS: Main: 175235072 19:08:37 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52412/tests/kraken/driver.html?testName=ai-astar) 19:08:39 INFO - PID 4934 | RSS: Main: 176898048 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | __start_tp_report 19:08:39 INFO - PID 4934 | _x_x_mozilla_page_load 19:08:39 INFO - PID 4934 | _x_x_mozilla_page_load_details 19:08:39 INFO - PID 4934 | |i|pagename|runs| 19:08:39 INFO - PID 4934 | |0;ai-astar;101;109;102;109;112;121;112;105;111;114 19:08:39 INFO - PID 4934 | |1;audio-beat-detection;150;122;154;168;120;146;150;119;176;119 19:08:39 INFO - PID 4934 | |2;audio-dft;165;164;166;163;162;168;167;169;165;164 19:08:39 INFO - PID 4934 | |3;audio-fft;76;74;75;174;76;74;76;89;100;77 19:08:39 INFO - PID 4934 | |4;audio-oscillator;81;81;133;84;81;81;131;81;82;131 19:08:39 INFO - PID 4934 | |5;imaging-gaussian-blur;117;118;118;114;115;115;114;114;118;116 19:08:39 INFO - PID 4934 | |6;imaging-darkroom;153;151;149;156;151;150;149;155;151;151 19:08:39 INFO - PID 4934 | |7;imaging-desaturate;95;95;95;94;94;96;93;94;94;94 19:08:39 INFO - PID 4934 | |8;json-parse-financial;54;52;53;53;52;55;53;53;52;54 19:08:39 INFO - PID 4934 | |9;json-stringify-tinderbox;54;54;55;55;55;55;55;54;56;55 19:08:39 INFO - PID 4934 | |10;stanford-crypto-aes;78;89;77;77;79;78;77;77;78;78 19:08:39 INFO - PID 4934 | |11;stanford-crypto-ccm;135;131;124;128;125;127;128;122;130;157 19:08:39 INFO - PID 4934 | |12;stanford-crypto-pbkdf2;181;180;178;178;179;191;191;174;183;177 19:08:39 INFO - PID 4934 | |13;stanford-crypto-sha256-iterative;69;70;70;68;68;66;67;72;70;66 19:08:39 INFO - PID 4934 | __end_tp_report 19:08:39 INFO - PID 4934 | __start_cc_report 19:08:39 INFO - PID 4934 | _x_x_mozilla_cycle_collect,977 19:08:39 INFO - PID 4934 | __end_cc_report 19:08:39 INFO - PID 4934 | __startTimestamp1500948519985__endTimestamp 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | ------- Summary: start ------- 19:08:39 INFO - PID 4934 | Number of tests: 14 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:5.93 (5.3%) stddev-sans-first:5.41 19:08:39 INFO - PID 4934 | Values: 101.0 109.0 102.0 109.0 112.0 121.0 112.0 105.0 111.0 114.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:150.00 stddev:21.24 (14.2%) stddev-sans-first:22.35 19:08:39 INFO - PID 4934 | Values: 150.0 122.0 154.0 168.0 120.0 146.0 150.0 119.0 176.0 119.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.21 (1.3%) stddev-sans-first:2.35 19:08:39 INFO - PID 4934 | Values: 165.0 164.0 166.0 163.0 162.0 168.0 167.0 169.0 165.0 164.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.00 stddev:30.99 (40.8%) stddev-sans-first:32.50 19:08:39 INFO - PID 4934 | Values: 76.0 74.0 75.0 174.0 76.0 74.0 76.0 89.0 100.0 77.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:81.00 stddev:24.22 (29.9%) stddev-sans-first:25.02 19:08:39 INFO - PID 4934 | Values: 81.0 81.0 133.0 84.0 81.0 81.0 131.0 81.0 82.0 131.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.50 stddev:1.73 (1.5%) stddev-sans-first:1.79 19:08:39 INFO - PID 4934 | Values: 117.0 118.0 118.0 114.0 115.0 115.0 114.0 114.0 118.0 116.0 19:08:39 INFO - PID 4934 | 19:08:39 INFO - PID 4934 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:2.37 (1.6%) stddev-sans-first:2.46 19:08:39 INFO - PID 4934 | Values: 153.0 151.0 149.0 156.0 151.0 150.0 149.0 155.0 151.0 151.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 19:08:40 INFO - PID 4934 | Values: 95.0 95.0 95.0 94.0 94.0 96.0 93.0 94.0 94.0 94.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 19:08:40 INFO - PID 4934 | Values: 54.0 52.0 53.0 53.0 52.0 55.0 53.0 53.0 52.0 54.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 19:08:40 INFO - PID 4934 | Values: 54.0 54.0 55.0 55.0 55.0 55.0 55.0 54.0 56.0 55.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.65 (4.7%) stddev-sans-first:3.86 19:08:40 INFO - PID 4934 | Values: 78.0 89.0 77.0 77.0 79.0 78.0 77.0 77.0 78.0 78.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:129.00 stddev:9.96 (7.7%) stddev-sans-first:10.44 19:08:40 INFO - PID 4934 | Values: 135.0 131.0 124.0 128.0 125.0 127.0 128.0 122.0 130.0 157.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:180.50 stddev:5.69 (3.2%) stddev-sans-first:6.04 19:08:40 INFO - PID 4934 | Values: 181.0 180.0 178.0 178.0 179.0 191.0 191.0 174.0 183.0 177.0 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:1.96 (2.8%) stddev-sans-first:2.07 19:08:40 INFO - PID 4934 | Values: 69.0 70.0 70.0 68.0 68.0 66.0 67.0 72.0 70.0 66.0 19:08:40 INFO - PID 4934 | -------- Summary: end -------- 19:08:40 INFO - PID 4934 | 19:08:40 INFO - PID 4934 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:08:40 INFO - TEST-INFO | 4934: exit 0 19:08:40 INFO - TEST-OK | kraken | took 61957ms 19:08:40 INFO - SUITE-END | took 1174s 19:08:41 INFO - Completed test suite (00:19:34) 19:08:41 INFO - javascript benchmark 19:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8436.987819360722, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.7664675149354, 3157.321175947171, 3157.873685052598, 3160.952585711214, 3189.7926634768737, 6023.909641355383, 6157.846053848656, 6169.2288463942, 6176.660283684396, 6231.5014798816155, 5901.498372638331, 6012.669303188323, 6077.0884367344925, 6117.204763380765, 6198.845028874269, 5642.943570564304, 5657.717114144297, 5702.515286200667, 5720.8283751487525, 5750.683712395817, 5474.91787623186, 5541.33503979523, 5648.604597678164, 5682.573806964473, 5786.913196302038, 5591.440855914417, 5662.320521537421, 5667.234923285345, 5673.177389278531, 5674.716264186794, 5610.438956104398, 5650.802221922254, 5677.659340439587, 5743.052396354638, 5759.078547432391, 5440.265564148868, 5504.559635229172, 5612.326520817487, 5639.492445679867, 5694.629849059798, 6032.5173986081445, 6078.422549857756, 6142.324344322121, 6163.506919446433, 6172.105044768484, 6507.934920650828, 6521.967390163066, 6634.104395906539, 6643.800685979429, 6644.136262285921, 6454.290028096905, 6557.278699343068, 6583.572067815577, 6617.569857959265, 6635.8009259722285, 6167.660778657217, 6225.501959843202, 6241.095041219043, 6247.500199983991, 6257.593256438271, 6774.830629234309, 6801.115854938926, 6874.65626718662, 6875.965620171867, 6877.346652068046, 6275.0, 6304.65324407162, 6400.423961843457, 6509.576877502947, 6602.042703807921, 6569.441597464173, 6576.638284894281, 6601.570897891622, 6603.966980165068, 6604.801855944329, 6522.771702990372, 6556.409923106943, 6572.572782769104, 6590.835229119214, 6675.299093595199, 6535.8366040848405, 6586.934130658728, 6623.6688165592495, 6665.166854143232, 6689.431398331099, 5365.409804921455, 5423.132298832168, 5443.319585051869, 5449.509544140967, 5456.0, 4597.908041839144, 4606.216943119678, 4630.560096790799, 4659.627229821606, 4671.089137618132, 5739.942600574024, 5753.712314384264, 5767.163761254678, 5774.595778295479, 5778.566607504454, 6626.602403855688, 6633.767818126343, 6636.933630663631, 6747.696353664097, 6749.392554670103, 5540.335159780771, 5626.156076588462, 5646.0, 5793.478586927196, 5798.797042103506, 5823.0, 5902.61632993854, 5908.409159084057, 5916.5858389913155, 5929.169916211734, 6391.360863913665, 6396.648184349812, 6448.387403196689, 6489.0, 6491.610503369813, 6399.840003999937, 6607.405333519814, 6664.4668426524795, 6680.098186744727, 6704.865902681821, 6233.314335423191, 6392.20097487814, 6443.226812782496, 6455.903161452676, 6504.674766261763, 6488.935110649022, 6498.837529061811, 6569.0, 6585.0, 6593.109930159559, 6564.5076619254705, 6595.571287866273, 6695.799126026227, 6698.330166983263, 6740.696668650021, 6259.029850373199, 6275.466585340298, 6290.899092658675, 6334.9366506334345, 6367.840803979938, 6460.353964603502, 6460.676966151767, 6517.478601711757, 6542.34576542342, 6554.770583029571, 6340.904886426615, 6349.0476428536085, 6493.707783149675, 6497.31778163305, 6500.089987401862, 6285.49716022708, 6477.4494167996245, 6491.578047426902, 6516.413522782972, 6592.538522303393, 6261.96869015652, 6332.176817013758, 6352.491800655844, 6364.904526432199, 6413.615183089029], "value": 6038.22471256414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.48624366649, 821.4824660463906, 840.315143158326, 867.137198487505, 867.8524650809363, 43243.35134972974, 44257.114857702865, 44554.33168502471, 44639.10721785562, 44649.553504465024, 39005.60994390062, 39172.412413813814, 39245.8037709811, 39398.606013939854, 39739.0, 6786.321367863224, 6901.413379862693, 6917.7578784742545, 6923.965380173092, 6926.757563485279, 6854.21176564694, 6944.375006249436, 6944.444444444458, 6949.270326615683, 6955.339242771954, 7629.732959346424, 7786.26030527099, 7786.260305271018, 7788.376929845627, 7823.687052517921, 7645.655945482466, 7673.923260767377, 7678.846423071564, 7731.729389471369, 7738.7678369649, 7598.468107232496, 7653.425993050488, 7670.194629563871, 7671.654775535114, 7674.309312161932, 39918.800405998074, 40081.39877901834, 40345.79827100875, 40355.0, 40381.0, 3646.179609587848, 3650.634936506328, 3680.061584296014, 3694.852205911787, 3696.149885526317, 31960.520592191137, 32045.359092818013, 32103.51844722331, 32172.356552868812, 32308.35383292321, 4949.257611358289, 4951.133551628486, 4960.702357858504, 4988.326575912241, 4991.625628077909, 217338.0, 218415.0, 220499.0, 220966.9999999984, 221757.0, 48956.0, 48984.265236021485, 49112.75443622759, 49431.0, 49579.75210123926, 51137.0, 51193.0, 51381.22928156081, 51581.0, 51631.0, 16486.505404837873, 16911.408100716417, 16963.915180424017, 16972.575685607713, 17080.316787328615, 13966.86033139676, 13973.16161030321, 13985.3706583204, 13998.0, 14026.22855742944, 14636.634084147769, 14774.374818769928, 14803.0, 14870.776938345933, 15027.398904043715, 5894.469497745224, 5897.675627840425, 5907.852303692356, 5954.910676339859, 6016.789412370546, 969.6266937229218, 986.5018165826211, 995.2684776689127, 997.5511020040866, 1017.97455063624, 22410.0, 22840.65739013916, 23228.41928951756, 23248.767512324997, 23578.528429431317, 1080.5191689698165, 1095.1348434736628, 1124.887511248885, 1128.9322640641587, 1130.0620484997432, 11777.234479758788, 11983.820242696367, 12023.63929082129, 12077.0, 12412.146534357908, 235212.0, 238523.0, 239351.0, 239359.0, 239448.0, 52993.470065299625, 53720.0, 58062.129068064016, 58915.11627325594, 59191.40808591945, 1498.572906721579, 1503.2859391788813, 1516.780066890317, 1517.2944580769995, 1520.2094910646401, 26127.0, 27773.0, 27824.0, 27989.580156298078, 28009.719902800713, 39469.40795888007, 39831.402528962666, 39841.40237896492, 39874.40188397234, 39881.0, 215820.0, 215844.0, 216017.0, 216112.0, 217189.0, 34671.0, 35500.467492988144, 35659.46510802288, 35904.28191436105, 35918.461223082195, 44711.77644111889, 44741.55258447374, 44762.3285650722, 45853.0, 48087.5191248097, 34415.31169376648, 34807.651923480444, 34957.82521087378, 34983.82508087545, 35568.0, 32929.835350823094, 34264.31471370609, 34448.483272750425, 34810.30379392449, 34906.12734681552, 38428.615713842504, 38504.614953850105, 38512.22975540417, 38653.806730966164, 38860.41709374305, 28969.0, 29158.666091931234, 29571.85214073916, 29738.0, 29814.0, 24010.0, 24076.0, 24151.275461736175, 24365.147219847222, 24663.260102196964], "value": 17603.251902792465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6792612174124, 572.5963195946858, 582.1180910919956, 590.2150140313383, 606.9180660610817, 22579.54840903183, 22839.77160228397, 23495.177668781595, 23579.646305305414, 23602.409939751517, 26439.20682379527, 27114.1865744028, 27140.864295678544, 27142.18573442795, 27265.182044538647, 6712.697928593213, 6875.243723190445, 6879.208890977551, 6879.793606191823, 6884.139482564679, 6293.842653933665, 6573.868522629545, 6604.867902641944, 6685.632290224035, 6700.497462690318, 6551.410373066423, 6558.409743123118, 6560.540762146652, 6560.7047682854145, 6560.835979100513, 6557.147570815811, 6558.836029099263, 6560.803175904731, 6567.113439685629, 6579.80260592183, 6082.787102451393, 6096.0, 6096.390360963913, 6121.081837724377, 6126.969365153191, 28198.295042624097, 28874.27814304638, 29466.41067178666, 29499.262518436997, 30114.24714382136, 1812.0667856054142, 1856.0905156473232, 1856.9721454178198, 1857.8049304822935, 1862.757841480599, 19174.233030678755, 19786.307479238156, 19796.901015494976, 19805.306814261578, 19869.20523179071, 2284.851484653492, 2297.127091705158, 2301.0680674326923, 2332.300309907038, 2344.284993077111, 131417.34291328577, 132754.33622831825, 135201.0, 136562.31718841344, 136607.0, 14626.683598476187, 15018.924905375403, 15164.545063648107, 15180.468683596022, 15656.217189140498, 23885.761142388354, 23898.0, 23913.402164946016, 23992.0, 24059.398515036915, 10428.383600541929, 10444.268901176996, 10456.68629941103, 10617.946910265398, 10681.57273709043, 8077.313428358538, 9607.231421486264, 9760.313092884924, 9806.803863922823, 9817.067378599022, 8356.328734253173, 9011.738356630078, 9411.529423528933, 9570.665026724031, 9609.174256891169, 2706.526357887362, 2727.5363188258043, 2799.566067259578, 2802.341449759305, 2902.3904979954023, 905.3707673167086, 948.2508818033814, 957.3872721458272, 965.1458459263462, 984.084801134937, 19195.32816351421, 19512.121954511797, 19808.40574782759, 19847.0, 20262.493437664176, 982.5431174503747, 1034.1054987435814, 1051.9737006574896, 1059.676798576426, 1063.9414832184304, 10523.52644131016, 10547.947260263649, 10595.193531481527, 10944.562217511211, 11142.442877856074, 504913.0, 513122.0, 518273.0, 519694.0, 524933.0, 118736.40631796786, 120064.0, 120744.39627801804, 121976.0, 125708.0, 1261.2306493039239, 1274.222724138275, 1306.5427100514935, 1311.7376524695098, 1317.236003118189, 19783.802161978198, 20243.39269821908, 20875.791242087384, 20883.04476150985, 21348.466288342916, 56060.0, 56293.43706562882, 57718.0, 58675.0, 59200.0, 71506.0, 71895.64052179914, 71899.64050179716, 72083.63958180175, 72277.6386118066, 12171.81742273849, 12665.240085594894, 13694.65763355924, 14313.642158945693, 14814.25928703582, 21809.454763631034, 22231.555368892856, 22275.220367287067, 22311.88844055834, 22355.888220558794, 16798.328066877188, 16829.747553786947, 16838.747418788975, 16889.493315200565, 18293.17680704345, 14237.572872813833, 14733.484328048467, 14746.262686865828, 14838.851611484179, 15336.846631533543, 16994.0, 17110.572235694206, 18016.459506214833, 18020.459386218434, 18032.0, 14911.403543858125, 15113.697726045637, 15121.39514419411, 15194.316255768295, 15253.0, 16951.321947121978, 17075.31698732037, 17132.0, 17833.375831845824, 18979.145938432528], "value": 11989.587016810785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.6065840906138, 1419.1130543410368, 1421.374595178121, 1431.155618185271, 1431.3916585451186, 13401.329933503323, 13919.02566820323, 13923.860761392409, 13965.790513142298, 13975.720485590282, 13444.798328025063, 14044.438222471088, 14343.354549045293, 14466.349014294356, 14470.276486175675, 2460.274219105364, 2496.588062969608, 2505.799536037113, 2526.696796384427, 2527.2039307618043, 2523.7602427769334, 2590.3265151060764, 2597.2727636261875, 2664.480426316869, 2665.3869609989715, 2701.5947607858784, 2704.094128466956, 2721.360480287141, 2733.876975536096, 2734.53512902806, 2585.327814768155, 2640.9867950660123, 2647.6160956661274, 2654.588538776493, 2656.774174195196, 2595.0268649256527, 2600.2069368842494, 2622.593498007812, 2622.803289753276, 2623.580227163645, 13943.790843137362, 13968.790468142986, 14236.857631423656, 14242.145471271757, 14247.145171289756, 7217.350438460564, 7282.453815963824, 7433.293837085468, 7453.701851925916, 7528.623568821592, 4944.159492886218, 5003.5997120230295, 5150.4334523202415, 5157.896842063175, 5158.40678321994, 1792.0069393448082, 1810.5021119192195, 1857.136431559318, 1878.0797409269496, 1894.7726272847208, 22476.10095596174, 22621.88689056544, 22720.318390448312, 22735.317940461813, 22762.77237227623, 6217.0, 6699.6315202663345, 6939.444844412435, 6990.650467476606, 6997.650117494105, 15523.922380388025, 15622.750179985575, 15642.296096675676, 15657.608559786097, 15661.921690391475, 7470.439717021137, 7471.476996610185, 7522.871569264545, 7739.380849532024, 7776.92223077762, 6872.587644741331, 6938.479614028867, 6962.582245065312, 6963.303669632996, 7041.084658994298, 4705.929411058837, 4815.085133824562, 4843.4430040545785, 4859.0, 4905.681130726492, 1282.4805953588625, 1308.0778051473687, 1323.8742319479634, 1327.336331834083, 1330.255057167989, 860.6084231674573, 860.6213266162869, 871.3551971541013, 900.1358695652248, 916.9816603667889, 7990.720324788605, 8035.598220088972, 8196.877046844302, 8211.137830527709, 8217.95891020553, 931.5839923316656, 983.3902980152351, 989.1048601016092, 996.5017491254373, 1006.8238058339762, 4489.371487991683, 5223.733878578175, 5259.552938000236, 5265.6840589564745, 5322.760475778599, 18198.727019094724, 18903.716444253347, 18999.240030398905, 19175.808241917402, 19348.903255483634, 18569.628607428047, 19009.14458849355, 19198.712019319442, 19322.130504127348, 19375.0, 10553.208509361828, 10810.135189184846, 10951.069159121405, 10956.28784129029, 10992.890071099346, 7462.0, 7970.960145199237, 8005.639746211318, 8112.75661730149, 8147.348212142896, 16351.672966540365, 16448.259828307993, 16764.664706705553, 17409.303627854744, 17652.0, 16379.754303685693, 16724.832751672813, 17362.13189340553, 17647.38234161798, 17803.643927121127, 10859.457027148768, 11290.548378065114, 11320.26418282842, 11323.547058117583, 11385.259958102697, 11682.824757628812, 13000.609981700563, 13062.0, 13125.60623181306, 13170.341482926007, 8813.823723525622, 9771.609135634495, 10083.495825208856, 10885.673429797118, 11138.0, 9950.154236889655, 10431.739206519898, 10569.418681972258, 10689.144868410664, 10705.9464702676, 9396.107369799858, 9484.383515071499, 9501.762455938657, 9551.283653725859, 9552.665656701982, 6919.342662447059, 6947.305269473012, 7146.464015198985, 7291.817704557428, 7322.340989310987, 7208.414872798435, 7283.854322913406, 7312.0, 7340.339369456775, 7436.59098749574], "value": 6316.793838922603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.92338847411315, 500.63075501872396, 519.5531842615352, 520.9192575150852, 527.5621234375469, 6117.327094019654, 6122.000219892254, 6143.385661433855, 6159.322474527804, 6173.228346456693, 5795.739191736371, 5939.703014849262, 5965.224520812289, 6038.849028774272, 6049.183360246366, 4876.097921884445, 4880.656750126175, 4910.508949105088, 4963.726995015273, 4969.826056088038, 4819.807207711688, 4863.465018847924, 4890.77991490382, 4930.285108659242, 4947.431045429786, 4824.758762061883, 4887.218045112782, 4929.4824043475455, 4935.753212339387, 4970.875728106808, 4836.854894353175, 4857.24712669535, 4888.706677599355, 4929.901401971941, 4941.629377796662, 4428.335749637548, 4441.356003379492, 4451.376807246988, 4458.554144585548, 4495.752733599651, 5972.641641501524, 5975.760969561213, 6022.277326720821, 6063.0, 6074.96962515189, 5604.271444712162, 5631.324241091054, 5664.830055098354, 5699.829005129853, 5702.971485142548, 6387.520935929778, 6428.067930150149, 6432.195975503062, 6442.742290308382, 6476.514261430411, 4775.14047471455, 4800.807967681289, 4842.757862106881, 4879.829205977774, 4891.461939186686, 6828.214755303154, 6829.6585170742255, 6850.725970961205, 6911.930880691179, 6922.757703480354, 4899.853004409873, 4942.827001054946, 4949.331840201598, 4952.70283782967, 4956.430010548761, 4961.950380496149, 4980.676256043345, 5008.524190201925, 5008.697738587994, 5016.322796422509, 5541.639793413416, 5614.933162699074, 5635.436456354414, 5641.323041234996, 5684.829455116271, 6165.753369865245, 6325.9051114233325, 6407.935920640734, 6531.902021469682, 6538.542302038907, 1626.2356692354574, 1643.1866226218099, 1715.8198389169206, 1725.6289897672061, 1761.4451447793904, 1182.7279725663145, 1219.9817002744967, 1226.2274766896799, 1228.950841966329, 1235.8197920985438, 5446.945530544723, 5595.972020139955, 5638.633488823213, 5640.266765320564, 5682.261306030272, 6505.316941721146, 6547.574407663486, 6583.868322633521, 6612.2726500084955, 6622.2715501294815, 5642.463965923231, 5669.2346533218315, 5676.631018983835, 5699.857503562444, 5729.169270455761, 3486.75592708513, 3543.2027793746715, 3545.290941811648, 3547.2728090741334, 3570.8571657133425, 6433.581817181868, 6469.644169570624, 6471.573160064976, 6477.352264773485, 6509.707063182168, 6654.534182607171, 6742.258351581322, 6843.418309443753, 6855.794326170223, 6863.588184708933, 6383.489320854414, 6394.520410969103, 6421.133147025092, 6422.614643121427, 6488.351164883474, 6650.90023649636, 6666.333366663489, 6673.5328527004585, 6700.430463410665, 6731.225909020525, 6537.967310163419, 6546.869062618816, 6594.868102637824, 6605.768798092044, 6635.668216589248, 6235.251769787655, 6398.936010639834, 6415.262244841903, 6425.357464253537, 6439.935600643934, 4889.951100489092, 4932.82735104284, 4944.283078953604, 4993.575546078624, 5018.949810501848, 6309.053641953744, 6433.356664333529, 6584.4732421405215, 6668.733250669919, 6697.254125808395, 6211.105612788143, 6348.079528468254, 6363.268224154282, 6410.0, 6420.229572451336, 6329.272133704683, 6448.419642232222, 6454.0, 6468.773592924225, 6505.512086593619, 6223.688815559294, 6323.525735569759, 6337.176167098432, 6415.230172379344, 6436.871262574628, 6425.325340839331, 6502.544821862424, 6507.869842603216, 6520.9347906520325, 6534.901976470452, 6243.250809902841, 6291.591046581958, 6318.0, 6325.746970121328, 6339.587926784744], "value": 4984.950298044625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.509669681675, 905.1853332001202, 912.6258234124008, 917.6925729880489, 922.3727865051762, 18004.819951800477, 19011.904940475295, 19045.0, 19067.0, 20019.099140538674, 20138.0, 20815.895920520416, 20884.582308353863, 20896.686549701768, 21029.474263143427, 1038.7818558102808, 1062.7927554126948, 1065.5205157679036, 1066.109798318401, 1066.461436974327, 1051.7370657335666, 1052.252900440688, 1055.166418529361, 1056.9207309451783, 1057.3919996002292, 785.9056913170399, 816.7059858450953, 1065.275612583443, 1123.1632433836762, 1125.7861006408798, 1121.8485504456876, 1124.7750449910009, 1127.7349822791637, 1128.2215271462665, 1128.2948157401624, 807.8788181772723, 811.4157806379397, 811.7280710961776, 812.0215140755435, 815.6288888555753, 19311.710324345146, 19799.208031678714, 19947.800521994886, 20076.89961550183, 20152.093155808023, 20703.378898633066, 20991.790082099134, 21054.473638159016, 21151.0, 21215.78784212169, 15519.068855868683, 15909.602259943478, 16024.278907449192, 16065.196740163063, 16269.674606507922, 3417.094469965461, 3425.2293234022395, 3435.089701229176, 3439.0198793343775, 3444.9827750861086, 116297.0, 119293.40353298264, 121484.0, 126226.0, 127623.0, 16688.33246670144, 17126.14369281556, 17157.0, 17297.827021729623, 17326.220320085627, 28567.42865142727, 30211.848940755157, 30423.0, 30487.695123048485, 30581.0, 7088.149422069281, 7488.663010164556, 8419.621117049748, 8915.687950921687, 9146.679866204651, 4171.5828417158045, 4229.767362795076, 4242.215190189825, 4290.785460727014, 4298.849540266076, 5132.255822905658, 5169.0, 5266.34170728659, 5324.760385782649, 5359.705216213068, 1080.173667144635, 1086.9347839129678, 1103.2994048778924, 1104.3539529375246, 1104.861892263467, 649.2890285137767, 657.3131078023476, 669.5079116849112, 685.0648864300194, 699.4439420660588, 10646.946765266124, 12328.75342493145, 12674.366281686063, 13165.275909825052, 13347.332633368293, 668.058038166193, 693.1820451866846, 693.8542905989698, 695.5930780493367, 701.2601705201062, 5080.923786143211, 5131.666441681279, 5185.196294574347, 5311.840644780663, 5412.107002344648, 110378.44810776056, 113607.43196283966, 113801.4309928445, 114153.42923285496, 116623.0, 85637.14362856292, 90259.0, 92716.53641731747, 93119.5344023289, 94142.58786118214, 73531.26468735244, 79179.60410197912, 82547.0, 82618.58690706629, 84848.15151848402, 11296.650789445957, 11591.826122608, 11688.766224675288, 12151.149419540547, 12370.195937264049, 36738.8163059183, 38420.807895960344, 38592.2281554373, 38663.0, 39557.2088558233, 47323.52676473191, 47331.05337893292, 47588.762056189495, 65733.0, 65874.67062664848, 17716.468505944842, 18395.08024598738, 18438.723419148457, 18646.0, 18676.252949882397, 18184.36354727578, 20322.187112515334, 20705.896470518153, 21091.683624745336, 21185.470363240427, 16117.194140293173, 16583.336666533687, 16764.077975711454, 17008.914955425145, 17052.48842534726, 17648.382306619205, 18144.45566633003, 18173.909130454264, 18239.361622343153, 18280.90859545694, 16579.66840663204, 16760.245788939283, 16846.1576921151, 16898.32406703718, 17541.0, 11099.334039957628, 12065.577704780291, 12245.938770306091, 12722.554710585086, 13490.52783152585, 13428.597142085753, 13791.586252412444, 13892.444302227797, 14095.506657266946, 14112.36494357777], "value": 8987.366258937063, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 102.0, 109.0, 112.0, 121.0, 112.0, 105.0, 111.0, 114.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 154.0, 168.0, 120.0, 146.0, 150.0, 119.0, 176.0, 119.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 163.0, 162.0, 168.0, 167.0, 169.0, 165.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 174.0, 76.0, 74.0, 76.0, 89.0, 100.0, 77.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 133.0, 84.0, 81.0, 81.0, 131.0, 81.0, 82.0, 131.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 114.0, 115.0, 115.0, 114.0, 114.0, 118.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 149.0, 156.0, 151.0, 150.0, 149.0, 155.0, 151.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 93.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 52.0, 55.0, 53.0, 53.0, 52.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 56.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 89.0, 77.0, 77.0, 79.0, 78.0, 77.0, 77.0, 78.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 124.0, 128.0, 125.0, 127.0, 128.0, 122.0, 130.0, 157.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 178.0, 178.0, 179.0, 191.0, 191.0, 174.0, 183.0, 177.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 68.0, 66.0, 67.0, 72.0, 70.0, 66.0], "value": 68.6, "unit": "score"}]}]} 19:08:41 INFO - Return code: 0 19:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:08:41 INFO - # TBPL SUCCESS # 19:08:41 INFO - Running post-action listener: _package_coverage_data 19:08:41 INFO - Running post-action listener: _resource_record_post_action 19:08:41 INFO - [mozharness: 2017-07-25 02:08:41.249209Z] Finished run-tests step (success) 19:08:41 INFO - Running post-run listener: _resource_record_post_run 19:08:41 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 430080; Write bytes: 449613824; Read time: 200; Write time: 272036 19:08:41 INFO - TinderboxPrint: CPU usage
13.1% 19:08:41 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 200 19:08:41 INFO - TinderboxPrint: I/O write bytes / time
449,613,824 / 272,036 19:08:41 INFO - TinderboxPrint: CPU idle
8,262.2 (86.9%) 19:08:41 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 19:08:41 INFO - TinderboxPrint: Swap in / out
0 / 0 19:08:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118009856; Read time: 0; Write time: 97976 19:08:41 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:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 425984; Write bytes: 330481664; Read time: 184; Write time: 173904 19:08:41 INFO - Running post-run listener: _upload_blobber_files 19:08:41 INFO - Blob upload gear active. 19:08:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:08:41 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:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:08:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:43 INFO - (blobuploader) - INFO - Done attempting. 19:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:44 INFO - (blobuploader) - INFO - Done attempting. 19:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:47 INFO - (blobuploader) - INFO - Done attempting. 19:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:48 INFO - (blobuploader) - INFO - Done attempting. 19:08:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:08:48 INFO - Return code: 0 19:08:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:08:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:08:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83e32ab558eee845006568664f3afb2a6ff63642b24b2dc9fa4ce72553b515ab5e3a69138cb9a583557e0ea0c36f74721f675a013233e7c552ebf7575e69546c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971bb7e485e9b080dcee22df86e2a88c0c025a2e0b63449e8d98c4fab44f220f47d3b7a3734512f298e070e4a63db8234750b0e1929fb2521c35afcb4272098d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79cf5ca2e288b661f13d509937bd727a080e2aea76aa9502f3cd69500459b5a45bb34464f0a5bc20f1f53cf8015374da690419b14aa2e517c3f9b2bf2054b166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/324f6b3210fed29e63288095e019cdd597b109c915800a8519707329b542e1d9ec794e703b133ba8c4c7f523006028d6d0886d3fb0e6d4f4bdef81e2459ea61e"} 19:08:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:08:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:08:48 INFO - Contents: 19:08:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83e32ab558eee845006568664f3afb2a6ff63642b24b2dc9fa4ce72553b515ab5e3a69138cb9a583557e0ea0c36f74721f675a013233e7c552ebf7575e69546c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971bb7e485e9b080dcee22df86e2a88c0c025a2e0b63449e8d98c4fab44f220f47d3b7a3734512f298e070e4a63db8234750b0e1929fb2521c35afcb4272098d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79cf5ca2e288b661f13d509937bd727a080e2aea76aa9502f3cd69500459b5a45bb34464f0a5bc20f1f53cf8015374da690419b14aa2e517c3f9b2bf2054b166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/324f6b3210fed29e63288095e019cdd597b109c915800a8519707329b542e1d9ec794e703b133ba8c4c7f523006028d6d0886d3fb0e6d4f4bdef81e2459ea61e"} 19:08:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:08:48 INFO - Copying logs to upload dir... 19:08:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:08:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.233085 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-24 19:08:48.207603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:08:48.212468) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 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-Non-PGO/sha512/83e32ab558eee845006568664f3afb2a6ff63642b24b2dc9fa4ce72553b515ab5e3a69138cb9a583557e0ea0c36f74721f675a013233e7c552ebf7575e69546c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971bb7e485e9b080dcee22df86e2a88c0c025a2e0b63449e8d98c4fab44f220f47d3b7a3734512f298e070e4a63db8234750b0e1929fb2521c35afcb4272098d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79cf5ca2e288b661f13d509937bd727a080e2aea76aa9502f3cd69500459b5a45bb34464f0a5bc20f1f53cf8015374da690419b14aa2e517c3f9b2bf2054b166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/324f6b3210fed29e63288095e019cdd597b109c915800a8519707329b542e1d9ec794e703b133ba8c4c7f523006028d6d0886d3fb0e6d4f4bdef81e2459ea61e"} 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.011269 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-Non-PGO/sha512/83e32ab558eee845006568664f3afb2a6ff63642b24b2dc9fa4ce72553b515ab5e3a69138cb9a583557e0ea0c36f74721f675a013233e7c552ebf7575e69546c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971bb7e485e9b080dcee22df86e2a88c0c025a2e0b63449e8d98c4fab44f220f47d3b7a3734512f298e070e4a63db8234750b0e1929fb2521c35afcb4272098d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79cf5ca2e288b661f13d509937bd727a080e2aea76aa9502f3cd69500459b5a45bb34464f0a5bc20f1f53cf8015374da690419b14aa2e517c3f9b2bf2054b166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/324f6b3210fed29e63288095e019cdd597b109c915800a8519707329b542e1d9ec794e703b133ba8c4c7f523006028d6d0886d3fb0e6d4f4bdef81e2459ea61e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:08:48.239755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:08:48.240104) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500941259.276810-1019124160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:08:48.325066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:08:48.325385) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:08:48.325710) ========= ========= Total master_lag: 0.18 =========