builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1502228910.63 results: success (0) revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.629193) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.629932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.630201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.682156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.682417) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 14:48:30-- 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% 46.0M=0s 2017-08-08 14:48:30 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.219902 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.960010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.960298) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014623 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:31.023590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-08 14:48:31.023899) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 14:48:31,071 truncating revision to first 12 chars 2017-08-08 14:48:31,071 Setting DEBUG logging. 2017-08-08 14:48:31,071 attempt 1/10 2017-08-08 14:48:31,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40004a53d1d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 14:48:32,072 attempt 1/10 2017-08-08 14:48:33,018 current task status: no status available at this point. state: STARTED 2017-08-08 14:48:33,019 sleeping for 11.00s (attempt 1/10) 2017-08-08 14:48:44,030 attempt 2/10 2017-08-08 14:48:44,382 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-08 14:48:44,800 unpacking tar archive at: mozilla-central-40004a53d1d1/testing/mozharness/ program finished with exit code 0 elapsedTime=14.111801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-08 14:48:45.157551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.157883) ========= script_repo_revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.158243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.158509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.169201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-08 14:48:45.169488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:48:45 INFO - MultiFileLogger online at 20170808 14:48:45 in /builds/slave/test 14:48:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:48:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:45 INFO - {'append_to_log': False, 14:48:45 INFO - 'base_work_dir': '/builds/slave/test', 14:48:45 INFO - 'blob_upload_branch': 'Firefox', 14:48:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:45 INFO - 'branch': 'Firefox', 14:48:45 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:45 INFO - 'code_coverage': False, 14:48:45 INFO - 'config_files': ('talos/linux_config.py',), 14:48:45 INFO - 'default_actions': ('clobber', 14:48:45 INFO - 'read-buildbot-config', 14:48:45 INFO - 'download-and-extract', 14:48:45 INFO - 'populate-webroot', 14:48:45 INFO - 'create-virtualenv', 14:48:45 INFO - 'install', 14:48:45 INFO - 'setup-mitmproxy', 14:48:45 INFO - 'run-tests'), 14:48:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:45 INFO - 'disable_ccov_upload': False, 14:48:45 INFO - 'download_minidump_stackwalk': True, 14:48:45 INFO - 'download_symbols': 'ondemand', 14:48:45 INFO - 'enable_stylo': False, 14:48:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:48:45 INFO - 'tooltool.py': '/tools/tooltool.py', 14:48:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:48:45 INFO - '/tools/misc-python/virtualenv.py')}, 14:48:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:45 INFO - 'gecko_profile': False, 14:48:45 INFO - 'gecko_profile_interval': 0, 14:48:45 INFO - 'installer_path': 'installer.exe', 14:48:45 INFO - 'log_level': 'info', 14:48:45 INFO - 'log_name': 'talos', 14:48:45 INFO - 'log_to_console': True, 14:48:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:48:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:48:45 INFO - 'opt_config_files': (), 14:48:45 INFO - 'pip_index': False, 14:48:45 INFO - 'suite': 'dromaeojs-e10s', 14:48:45 INFO - 'system_bits': '32', 14:48:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:45 INFO - 'title': 'talos-linux64-ix-037', 14:48:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:45 INFO - 'use_talos_json': True, 14:48:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:45 INFO - 'work_dir': 'build'} 14:48:45 INFO - [mozharness: 2017-08-08 21:48:45.381438Z] Running clobber step. 14:48:45 INFO - Running pre-action listener: _resource_record_pre_action 14:48:45 INFO - Running main action method: clobber 14:48:45 INFO - rmtree: /builds/slave/test/build 14:48:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:46 INFO - Running post-action listener: _resource_record_post_action 14:48:46 INFO - [mozharness: 2017-08-08 21:48:46.381718Z] Finished clobber step (success) 14:48:46 INFO - [mozharness: 2017-08-08 21:48:46.381819Z] Running read-buildbot-config step. 14:48:46 INFO - Running pre-action listener: _resource_record_pre_action 14:48:46 INFO - Running main action method: read_buildbot_config 14:48:46 INFO - Using buildbot properties: 14:48:46 INFO - { 14:48:46 INFO - "project": "", 14:48:46 INFO - "product": "firefox", 14:48:46 INFO - "who": "kwierso@gmail.com", 14:48:46 INFO - "installer_path": "public/build/target.tar.bz2", 14:48:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 14:48:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:48:46 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 14:48:46 INFO - "stage_platform": "linux64-stylo", 14:48:46 INFO - "basedir": "/builds/slave/test", 14:48:46 INFO - "buildnumber": 69, 14:48:46 INFO - "platform": "ubuntu64_hw_stylo", 14:48:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:48:46 INFO - "slavebuilddir": "test", 14:48:46 INFO - "taskId": "e52-yv0kSU27RFcH7brVtA", 14:48:46 INFO - "branch": "mozilla-central", 14:48:46 INFO - "script_repo_revision": "production", 14:48:46 INFO - "revision": "40004a53d1d1a28b30f565ffc1329b1f28dfffd2", 14:48:46 INFO - "slavename": "talos-linux64-ix-037", 14:48:46 INFO - "repo_path": "mozilla-central" 14:48:46 INFO - } 14:48:46 INFO - Finding installer, test and symbols from parent task. 14:48:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e52-yv0kSU27RFcH7brVtA'}, attempt #1 14:48:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e52-yv0kSU27RFcH7brVtA'}, attempt #1 14:48:47 INFO - Task dependencies: ZRtnnw9hTj-zpiR_sx9VUw 14:48:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw'}, attempt #1 14:48:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:48:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:48:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip 14:48:47 INFO - Running post-action listener: _resource_record_post_action 14:48:47 INFO - [mozharness: 2017-08-08 21:48:47.802709Z] Finished read-buildbot-config step (success) 14:48:47 INFO - [mozharness: 2017-08-08 21:48:47.802929Z] Running download-and-extract step. 14:48:47 INFO - Running pre-action listener: _resource_record_pre_action 14:48:47 INFO - Running main action method: download_and_extract 14:48:47 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:48:47 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:48:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:48:48 INFO - Downloaded 989 bytes. 14:48:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:48:48 INFO - Using the following test package requirements: 14:48:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:48:48 INFO - u'common': [u'target.common.tests.zip'], 14:48:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:48:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:48:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:48:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:48:48 INFO - u'mozbase': [u'target.common.tests.zip'], 14:48:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:48:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:48:48 INFO - u'web-platform': [u'target.common.tests.zip', 14:48:48 INFO - u'target.web-platform.tests.tar.gz'], 14:48:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:48:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:48:49 INFO - Content-Length response header: 54284810 14:48:49 INFO - Bytes received: 54284810 14:49:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:49:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:49:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:49:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:49:02 INFO - Content-Length response header: 54284810 14:49:02 INFO - Bytes received: 54284810 14:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip 14:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip into memory 14:49:15 INFO - Content-Length response header: 14496008 14:49:15 INFO - Bytes received: 14496008 14:49:16 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')]} 14:49:16 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:16 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:49:18 INFO - Downloaded 61871458 bytes. 14:49:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:18 INFO - mkdir: /builds/slave/test/properties 14:49:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:49:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:49:18 INFO - Contents: 14:49:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:18 INFO - Running post-action listener: _resource_record_post_action 14:49:18 INFO - Running post-action listener: set_extra_try_arguments 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.349425Z] Finished download-and-extract step (success) 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.349523Z] Running populate-webroot step. 14:49:18 INFO - Running pre-action listener: _resource_record_pre_action 14:49:18 INFO - Running main action method: populate_webroot 14:49:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:49:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:49:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['damp', 'tps']}, 14:49:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:49:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:49:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:49:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:49:18 INFO - 'ts_paint', 14:49:18 INFO - 'tpaint', 14:49:18 INFO - 'sessionrestore', 14:49:18 INFO - 'sessionrestore_many_windows', 14:49:18 INFO - 'sessionrestore_no_auto_restore', 14:49:18 INFO - 'tabpaint']}, 14:49:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:49:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:49:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:49:18 INFO - 'tsvgr_opacity', 14:49:18 INFO - 'tart', 14:49:18 INFO - 'tscrollx', 14:49:18 INFO - 'tsvg_static']}, 14:49:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:49:18 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--stylo', 14:49:18 INFO - '--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--stylo', 14:49:18 INFO - '--stylo-threads=1', 14:49:18 INFO - '--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'talos_options': ['--xperf_path', 14:49:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:18 INFO - 'tests': ['tp5n']}}} 14:49:18 INFO - Running post-action listener: _resource_record_post_action 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.357920Z] Finished populate-webroot step (success) 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.358010Z] Running create-virtualenv step. 14:49:18 INFO - Running pre-action listener: _resource_record_pre_action 14:49:18 INFO - Running main action method: create_virtualenv 14:49:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:49:18 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 14:49:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:49:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:49:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:49:18 INFO - Using real prefix '/usr' 14:49:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:49:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:49:21 INFO - Installing pip.................done. 14:49:21 INFO - Return code: 0 14:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:49:21 INFO - Reading from file tmpfile_stdout 14:49:21 INFO - Output received: 14:49:21 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) 14:49:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:49:21 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')]} 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:21 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')]} 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:21 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:21 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 14:49:21 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 14:49:21 INFO - Using env: {'DISPLAY': ':0', 14:49:21 INFO - 'HOME': '/home/cltbld', 14:49:21 INFO - 'LANG': 'en_US.UTF-8', 14:49:21 INFO - 'LANGUAGE': 'en_US:en', 14:49:21 INFO - 'LOGNAME': 'cltbld', 14:49:21 INFO - 'MAIL': '/var/mail/cltbld', 14:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:21 INFO - 'MOZ_NO_REMOTE': '1', 14:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:21 INFO - 'NO_EM_RESTART': '1', 14:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:21 INFO - 'PWD': '/builds/slave/test', 14:49:21 INFO - 'SHELL': '/bin/bash', 14:49:21 INFO - 'SHLVL': '1', 14:49:21 INFO - 'TERM': 'linux', 14:49:21 INFO - 'TMOUT': '86400', 14:49:21 INFO - 'USER': 'cltbld', 14:49:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:21 INFO - '_': '/tools/buildbot/bin/python'} 14:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:21 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 14:49:21 INFO - Cleaning up... 14:49:21 INFO - Return code: 0 14:49:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:49:21 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')]} 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:21 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')]} 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:21 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:21 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 14:49:21 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 14:49:21 INFO - Using env: {'DISPLAY': ':0', 14:49:21 INFO - 'HOME': '/home/cltbld', 14:49:21 INFO - 'LANG': 'en_US.UTF-8', 14:49:21 INFO - 'LANGUAGE': 'en_US:en', 14:49:21 INFO - 'LOGNAME': 'cltbld', 14:49:21 INFO - 'MAIL': '/var/mail/cltbld', 14:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:21 INFO - 'MOZ_NO_REMOTE': '1', 14:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:21 INFO - 'NO_EM_RESTART': '1', 14:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:21 INFO - 'PWD': '/builds/slave/test', 14:49:21 INFO - 'SHELL': '/bin/bash', 14:49:21 INFO - 'SHLVL': '1', 14:49:21 INFO - 'TERM': 'linux', 14:49:21 INFO - 'TMOUT': '86400', 14:49:21 INFO - 'USER': 'cltbld', 14:49:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:21 INFO - '_': '/tools/buildbot/bin/python'} 14:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:21 INFO - Downloading/unpacking psutil>=3.1.1 14:49:21 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 14:49:21 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 14:49:21 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 14:49:21 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 14:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:23 INFO - Installing collected packages: psutil 14:49:23 INFO - Running setup.py install for psutil 14:49:23 INFO - building 'psutil._psutil_linux' extension 14:49:23 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 14:49:24 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 14:49:24 INFO - building 'psutil._psutil_posix' extension 14:49:24 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 14:49:24 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 14:49:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:24 INFO - Successfully installed psutil 14:49:24 INFO - Cleaning up... 14:49:24 INFO - Return code: 0 14:49:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:49:24 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')]} 14:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:24 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')]} 14:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:24 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:24 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 14:49:24 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 14:49:24 INFO - Using env: {'DISPLAY': ':0', 14:49:24 INFO - 'HOME': '/home/cltbld', 14:49:24 INFO - 'LANG': 'en_US.UTF-8', 14:49:24 INFO - 'LANGUAGE': 'en_US:en', 14:49:24 INFO - 'LOGNAME': 'cltbld', 14:49:24 INFO - 'MAIL': '/var/mail/cltbld', 14:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:24 INFO - 'MOZ_NO_REMOTE': '1', 14:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:24 INFO - 'NO_EM_RESTART': '1', 14:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:24 INFO - 'PWD': '/builds/slave/test', 14:49:24 INFO - 'SHELL': '/bin/bash', 14:49:24 INFO - 'SHLVL': '1', 14:49:24 INFO - 'TERM': 'linux', 14:49:24 INFO - 'TMOUT': '86400', 14:49:24 INFO - 'USER': 'cltbld', 14:49:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:24 INFO - '_': '/tools/buildbot/bin/python'} 14:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:49:24 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 14:49:24 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 14:49:24 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 14:49:24 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 14:49:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:49:25 INFO - Installing collected packages: mozsystemmonitor 14:49:25 INFO - Running setup.py install for mozsystemmonitor 14:49:25 INFO - Successfully installed mozsystemmonitor 14:49:25 INFO - Cleaning up... 14:49:26 INFO - Return code: 0 14:49:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:26 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:26 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 14:49:26 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 14:49:26 INFO - Using env: {'DISPLAY': ':0', 14:49:26 INFO - 'HOME': '/home/cltbld', 14:49:26 INFO - 'LANG': 'en_US.UTF-8', 14:49:26 INFO - 'LANGUAGE': 'en_US:en', 14:49:26 INFO - 'LOGNAME': 'cltbld', 14:49:26 INFO - 'MAIL': '/var/mail/cltbld', 14:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:26 INFO - 'MOZ_NO_REMOTE': '1', 14:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:26 INFO - 'NO_EM_RESTART': '1', 14:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:26 INFO - 'PWD': '/builds/slave/test', 14:49:26 INFO - 'SHELL': '/bin/bash', 14:49:26 INFO - 'SHLVL': '1', 14:49:26 INFO - 'TERM': 'linux', 14:49:26 INFO - 'TMOUT': '86400', 14:49:26 INFO - 'USER': 'cltbld', 14:49:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:26 INFO - '_': '/tools/buildbot/bin/python'} 14:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:49:26 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 14:49:26 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 14:49:26 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 14:49:26 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 14:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:27 INFO - warning: no files found matching '*.txt' 14:49:27 INFO - no previously-included directories found matching 'build' 14:49:27 INFO - no previously-included directories found matching 'dist' 14:49:27 INFO - no previously-included directories found matching '.git*' 14:49:27 INFO - Installing collected packages: jsonschema, functools32 14:49:27 INFO - Running setup.py install for functools32 14:49:27 INFO - warning: no files found matching '*.txt' 14:49:27 INFO - no previously-included directories found matching 'build' 14:49:27 INFO - no previously-included directories found matching 'dist' 14:49:27 INFO - no previously-included directories found matching '.git*' 14:49:27 INFO - Successfully installed jsonschema functools32 14:49:27 INFO - Cleaning up... 14:49:27 INFO - Return code: 0 14:49:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:49:27 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')]} 14:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:27 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')]} 14:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:27 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:27 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 14:49:27 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 14:49:27 INFO - Using env: {'DISPLAY': ':0', 14:49:27 INFO - 'HOME': '/home/cltbld', 14:49:27 INFO - 'LANG': 'en_US.UTF-8', 14:49:27 INFO - 'LANGUAGE': 'en_US:en', 14:49:27 INFO - 'LOGNAME': 'cltbld', 14:49:27 INFO - 'MAIL': '/var/mail/cltbld', 14:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:27 INFO - 'MOZ_NO_REMOTE': '1', 14:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:27 INFO - 'NO_EM_RESTART': '1', 14:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:27 INFO - 'PWD': '/builds/slave/test', 14:49:27 INFO - 'SHELL': '/bin/bash', 14:49:27 INFO - 'SHLVL': '1', 14:49:27 INFO - 'TERM': 'linux', 14:49:27 INFO - 'TMOUT': '86400', 14:49:27 INFO - 'USER': 'cltbld', 14:49:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:27 INFO - '_': '/tools/buildbot/bin/python'} 14:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:49:27 INFO - Cleaning up... 14:49:27 INFO - Return code: 0 14:49:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:49:27 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')]} 14:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:27 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')]} 14:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:27 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:27 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 14:49:27 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 14:49:27 INFO - Using env: {'DISPLAY': ':0', 14:49:27 INFO - 'HOME': '/home/cltbld', 14:49:27 INFO - 'LANG': 'en_US.UTF-8', 14:49:27 INFO - 'LANGUAGE': 'en_US:en', 14:49:27 INFO - 'LOGNAME': 'cltbld', 14:49:27 INFO - 'MAIL': '/var/mail/cltbld', 14:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:27 INFO - 'MOZ_NO_REMOTE': '1', 14:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:27 INFO - 'NO_EM_RESTART': '1', 14:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:27 INFO - 'PWD': '/builds/slave/test', 14:49:27 INFO - 'SHELL': '/bin/bash', 14:49:27 INFO - 'SHLVL': '1', 14:49:27 INFO - 'TERM': 'linux', 14:49:27 INFO - 'TMOUT': '86400', 14:49:27 INFO - 'USER': 'cltbld', 14:49:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:27 INFO - '_': '/tools/buildbot/bin/python'} 14:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:49:28 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 14:49:28 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 14:49:28 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 14:49:28 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 14:49:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:49:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:49:29 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 14:49:29 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 14:49:29 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 14:49:29 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 14:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:49:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:49:29 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 14:49:29 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 14:49:29 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 14:49:29 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 14:49:29 INFO - Downloading docopt-0.6.1.tar.gz 14:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:49:29 INFO - Installing collected packages: blobuploader, requests, docopt 14:49:29 INFO - Running setup.py install for blobuploader 14:49:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:49:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:49:29 INFO - Running setup.py install for requests 14:49:30 INFO - Running setup.py install for docopt 14:49:30 INFO - Successfully installed blobuploader requests docopt 14:49:30 INFO - Cleaning up... 14:49:30 INFO - Return code: 0 14:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:30 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:30 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 14:49:30 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 14:49:30 INFO - Using env: {'DISPLAY': ':0', 14:49:30 INFO - 'HOME': '/home/cltbld', 14:49:30 INFO - 'LANG': 'en_US.UTF-8', 14:49:30 INFO - 'LANGUAGE': 'en_US:en', 14:49:30 INFO - 'LOGNAME': 'cltbld', 14:49:30 INFO - 'MAIL': '/var/mail/cltbld', 14:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:30 INFO - 'MOZ_NO_REMOTE': '1', 14:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:30 INFO - 'NO_EM_RESTART': '1', 14:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:30 INFO - 'PWD': '/builds/slave/test', 14:49:30 INFO - 'SHELL': '/bin/bash', 14:49:30 INFO - 'SHLVL': '1', 14:49:30 INFO - 'TERM': 'linux', 14:49:30 INFO - 'TMOUT': '86400', 14:49:30 INFO - 'USER': 'cltbld', 14:49:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:30 INFO - '_': '/tools/buildbot/bin/python'} 14:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:30 INFO - Running setup.py (path:/tmp/pip-LYJCWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:30 INFO - Running setup.py (path:/tmp/pip-f4d7YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:30 INFO - Running setup.py (path:/tmp/pip-NI1bop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:30 INFO - Running setup.py (path:/tmp/pip-chZ5Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:30 INFO - Running setup.py (path:/tmp/pip-Q9Wwrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:31 INFO - Running setup.py (path:/tmp/pip-O6DC3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:31 INFO - Running setup.py (path:/tmp/pip-AXhG8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:31 INFO - Running setup.py (path:/tmp/pip-Ch3m6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:31 INFO - Running setup.py (path:/tmp/pip-iWBgP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:31 INFO - Running setup.py (path:/tmp/pip-A_8c4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:31 INFO - Running setup.py (path:/tmp/pip-qZSN4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:31 INFO - Running setup.py (path:/tmp/pip-pZ3EDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:31 INFO - Running setup.py (path:/tmp/pip-ItNN9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:31 INFO - Running setup.py (path:/tmp/pip-dye5vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:31 INFO - Running setup.py (path:/tmp/pip-jaUu8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:31 INFO - Running setup.py (path:/tmp/pip-rSiSLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:31 INFO - Running setup.py (path:/tmp/pip-4rqSmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:31 INFO - Running setup.py install for manifestparser 14:49:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozcrash 14:49:32 INFO - Running setup.py install for mozdebug 14:49:32 INFO - Running setup.py install for mozdevice 14:49:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozfile 14:49:32 INFO - Running setup.py install for mozhttpd 14:49:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozinfo 14:49:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozInstall 14:49:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozleak 14:49:32 INFO - Running setup.py install for mozlog 14:49:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for moznetwork 14:49:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Running setup.py install for mozprocess 14:49:33 INFO - Running setup.py install for mozprofile 14:49:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Running setup.py install for mozrunner 14:49:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Running setup.py install for mozscreenshot 14:49:33 INFO - Running setup.py install for moztest 14:49:33 INFO - Running setup.py install for mozversion 14:49:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:33 INFO - Cleaning up... 14:49:33 INFO - Return code: 0 14:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:33 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')]} 14:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:33 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')]} 14:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:33 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:33 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 14:49:33 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 14:49:33 INFO - Using env: {'DISPLAY': ':0', 14:49:33 INFO - 'HOME': '/home/cltbld', 14:49:33 INFO - 'LANG': 'en_US.UTF-8', 14:49:33 INFO - 'LANGUAGE': 'en_US:en', 14:49:33 INFO - 'LOGNAME': 'cltbld', 14:49:33 INFO - 'MAIL': '/var/mail/cltbld', 14:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:33 INFO - 'MOZ_NO_REMOTE': '1', 14:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:33 INFO - 'NO_EM_RESTART': '1', 14:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:33 INFO - 'PWD': '/builds/slave/test', 14:49:33 INFO - 'SHELL': '/bin/bash', 14:49:33 INFO - 'SHLVL': '1', 14:49:33 INFO - 'TERM': 'linux', 14:49:33 INFO - 'TMOUT': '86400', 14:49:33 INFO - 'USER': 'cltbld', 14:49:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:33 INFO - '_': '/tools/buildbot/bin/python'} 14:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:33 INFO - Running setup.py (path:/tmp/pip-3psPyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:33 INFO - Running setup.py (path:/tmp/pip-wMK2vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:34 INFO - Running setup.py (path:/tmp/pip-ul8WkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:34 INFO - Running setup.py (path:/tmp/pip-OcPoot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:34 INFO - Running setup.py (path:/tmp/pip-pVL7jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:34 INFO - Running setup.py (path:/tmp/pip-wCAxx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:34 INFO - Running setup.py (path:/tmp/pip-vVRLtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:34 INFO - Running setup.py (path:/tmp/pip-fcp84d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:34 INFO - Running setup.py (path:/tmp/pip-P8JahD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:34 INFO - Running setup.py (path:/tmp/pip-_8BS9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:34 INFO - Running setup.py (path:/tmp/pip-JuqH9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:34 INFO - Running setup.py (path:/tmp/pip-TVeThR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:34 INFO - Running setup.py (path:/tmp/pip-mUrfK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:34 INFO - Running setup.py (path:/tmp/pip-TPi6cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:34 INFO - Running setup.py (path:/tmp/pip-f5RPA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:34 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)) 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:34 INFO - Running setup.py (path:/tmp/pip-TySXhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:35 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)) 14:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:35 INFO - Running setup.py (path:/tmp/pip-YEUjxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:35 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)) 14:49:35 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)) 14:49:35 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)) 14:49:35 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)) 14:49:35 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)) 14:49:35 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)) 14:49:35 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)) 14:49:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49: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 14:49: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 14:49: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 14:49: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 14:49:36 INFO - Downloading blessings-1.6.tar.gz 14:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:36 INFO - Installing collected packages: blessings 14:49:36 INFO - Running setup.py install for blessings 14:49:36 INFO - Successfully installed blessings 14:49:36 INFO - Cleaning up... 14:49:36 INFO - Return code: 0 14:49:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:36 INFO - Reading from file tmpfile_stdout 14:49:36 INFO - Current package versions: 14:49:36 INFO - argparse == 1.2.1 14:49:36 INFO - blessings == 1.6 14:49:36 INFO - blobuploader == 1.2.4 14:49:36 INFO - docopt == 0.6.1 14:49:36 INFO - functools32 == 3.2.3-2 14:49:36 INFO - jsonschema == 2.5.1 14:49:36 INFO - manifestparser == 1.1 14:49:36 INFO - mozInstall == 1.13 14:49:36 INFO - mozcrash == 1.0 14:49:36 INFO - mozdebug == 0.1 14:49:36 INFO - mozdevice == 0.51 14:49:36 INFO - mozfile == 1.2 14:49:36 INFO - mozhttpd == 0.7 14:49:36 INFO - mozinfo == 0.10 14:49:36 INFO - mozleak == 0.1 14:49:36 INFO - mozlog == 3.5 14:49:36 INFO - moznetwork == 0.27 14:49:36 INFO - mozprocess == 0.25 14:49:36 INFO - mozprofile == 0.28 14:49:36 INFO - mozrunner == 6.13 14:49:36 INFO - mozscreenshot == 0.1 14:49:36 INFO - mozsystemmonitor == 0.3 14:49:36 INFO - moztest == 0.8 14:49:36 INFO - mozversion == 1.4 14:49:36 INFO - psutil == 3.1.1 14:49:36 INFO - requests == 1.2.3 14:49:36 INFO - wsgiref == 0.1.2 14:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:36 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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:36 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 14:49:36 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 14:49:36 INFO - Using env: {'DISPLAY': ':0', 14:49:36 INFO - 'HOME': '/home/cltbld', 14:49:36 INFO - 'LANG': 'en_US.UTF-8', 14:49:36 INFO - 'LANGUAGE': 'en_US:en', 14:49:36 INFO - 'LOGNAME': 'cltbld', 14:49:36 INFO - 'MAIL': '/var/mail/cltbld', 14:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:36 INFO - 'MOZ_NO_REMOTE': '1', 14:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:36 INFO - 'NO_EM_RESTART': '1', 14:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:36 INFO - 'PWD': '/builds/slave/test', 14:49:36 INFO - 'SHELL': '/bin/bash', 14:49:36 INFO - 'SHLVL': '1', 14:49:36 INFO - 'TERM': 'linux', 14:49:36 INFO - 'TMOUT': '86400', 14:49:36 INFO - 'USER': 'cltbld', 14:49:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:36 INFO - '_': '/tools/buildbot/bin/python'} 14:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 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)) 14:49:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:49: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 14:49: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 14:49: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 14:49: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 14:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:49:38 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)) 14:49:38 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)) 14:49:38 INFO - Installing collected packages: simplejson 14:49:38 INFO - Running setup.py install for simplejson 14:49:38 INFO - building 'simplejson._speedups' extension 14:49:38 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 14:49:38 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 14:49:39 INFO - Successfully installed simplejson 14:49:39 INFO - Cleaning up... 14:49:39 INFO - Return code: 0 14:49:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49:39 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')]} 14:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:39 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')]} 14:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x199c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', '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 14:49:39 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 14:49:39 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 14:49:39 INFO - Using env: {'DISPLAY': ':0', 14:49:39 INFO - 'HOME': '/home/cltbld', 14:49:39 INFO - 'LANG': 'en_US.UTF-8', 14:49:39 INFO - 'LANGUAGE': 'en_US:en', 14:49:39 INFO - 'LOGNAME': 'cltbld', 14:49:39 INFO - 'MAIL': '/var/mail/cltbld', 14:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:39 INFO - 'MOZ_NO_REMOTE': '1', 14:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:39 INFO - 'NO_EM_RESTART': '1', 14:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:39 INFO - 'PWD': '/builds/slave/test', 14:49:39 INFO - 'SHELL': '/bin/bash', 14:49:39 INFO - 'SHLVL': '1', 14:49:39 INFO - 'TERM': 'linux', 14:49:39 INFO - 'TMOUT': '86400', 14:49:39 INFO - 'USER': 'cltbld', 14:49:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:39 INFO - '_': '/tools/buildbot/bin/python'} 14:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:49:39 INFO - Cleaning up... 14:49:39 INFO - Return code: 0 14:49:39 INFO - Running post-action listener: _resource_record_post_action 14:49:39 INFO - Running post-action listener: _start_resource_monitoring 14:49:39 INFO - Starting resource monitoring. 14:49:39 INFO - [mozharness: 2017-08-08 21:49:39.408549Z] Finished create-virtualenv step (success) 14:49:39 INFO - [mozharness: 2017-08-08 21:49:39.409613Z] Running install step. 14:49:39 INFO - Running pre-action listener: _resource_record_pre_action 14:49:39 INFO - Running main action method: install 14:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:39 INFO - Reading from file tmpfile_stdout 14:49:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:39 INFO - Reading from file tmpfile_stdout 14:49:39 INFO - Output received: 14:49:39 INFO - Usage: mozinstall [options] installer 14:49:39 INFO - Options: 14:49:39 INFO - -h, --help show this help message and exit 14:49:39 INFO - -d DEST, --destination=DEST 14:49:39 INFO - Directory to install application into. [default: 14:49:39 INFO - "/builds/slave/test"] 14:49:39 INFO - --app=APP Application being installed. [default: firefox] 14:49:39 INFO - mkdir: /builds/slave/test/build/application 14:49:39 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'] 14:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:49:57 INFO - Reading from file tmpfile_stdout 14:49:57 INFO - Output received: 14:49:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:49:57 INFO - Running post-action listener: _resource_record_post_action 14:49:57 INFO - [mozharness: 2017-08-08 21:49:57.702437Z] Finished install step (success) 14:49:57 INFO - [mozharness: 2017-08-08 21:49:57.702716Z] Running setup-mitmproxy step. 14:49:57 INFO - Running pre-action listener: _resource_record_pre_action 14:49:57 INFO - Running main action method: setup_mitmproxy 14:49:57 INFO - Skipping: mitmproxy is not required 14:49:57 INFO - Running post-action listener: _resource_record_post_action 14:49:57 INFO - [mozharness: 2017-08-08 21:49:57.703857Z] Finished setup-mitmproxy step (success) 14:49:57 INFO - [mozharness: 2017-08-08 21:49:57.704076Z] Running run-tests step. 14:49:57 INFO - Running pre-action listener: _resource_record_pre_action 14:49:57 INFO - Running pre-action listener: _set_gcov_prefix 14:49:57 INFO - Running main action method: run_tests 14:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:57 INFO - Python 2.7.3 14:49:57 INFO - Return code: 0 14:49:57 INFO - grabbing minidump binary from tooltool 14:49: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')]} 14:49:57 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 0x1d08eb0>, '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 0x1d09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:57 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 14:49:57 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 14:49:57 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 14:49:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:57 INFO - Return code: 0 14:49:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:49:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:57 INFO - ENV: RUST_BACKTRACE is now 1 14:49:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:49:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 14:49:57 INFO - Using env: {'DISPLAY': ':0', 14:49:57 INFO - 'HOME': '/home/cltbld', 14:49:57 INFO - 'LANG': 'en_US.UTF-8', 14:49:57 INFO - 'LANGUAGE': 'en_US:en', 14:49:57 INFO - 'LOGNAME': 'cltbld', 14:49:57 INFO - 'MAIL': '/var/mail/cltbld', 14:49:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:57 INFO - 'MOZ_NO_REMOTE': '1', 14:49:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:57 INFO - 'NO_EM_RESTART': '1', 14:49:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:57 INFO - 'PWD': '/builds/slave/test', 14:49:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:57 INFO - 'RUST_BACKTRACE': '1', 14:49:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:49:57 INFO - 'SHELL': '/bin/bash', 14:49:57 INFO - 'SHLVL': '1', 14:49:57 INFO - 'STYLO_FORCE_ENABLED': '1', 14:49:57 INFO - 'TERM': 'linux', 14:49:57 INFO - 'TMOUT': '86400', 14:49:57 INFO - 'USER': 'cltbld', 14:49:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910', 14:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:57 INFO - '_': '/tools/buildbot/bin/python'} 14:49:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:49:58 INFO - mozversion application_buildid: 20170808210507 14:49:58 INFO - mozversion application_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:49:58 INFO - mozversion application_display_name: Nightly 14:49:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:58 INFO - mozversion application_name: Firefox 14:49:58 INFO - mozversion application_remotingname: firefox 14:49:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:49:58 INFO - mozversion application_vendor: Mozilla 14:49:58 INFO - mozversion application_version: 57.0a1 14:49:58 INFO - mozversion platform_buildid: 20170808210507 14:49:58 INFO - mozversion platform_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:49:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:49:58 INFO - mozversion platform_version: 57.0a1 14:49:58 INFO - using testdate: 1502228998 14:49:58 INFO - actual date: 1502228998 14:49:58 INFO - starting webserver on 'localhost:56134' 14:49:58 INFO - SUITE-START | Running 2 tests 14:49:58 INFO - TEST-START | dromaeo_css 14:49:58 INFO - Initialising browser for dromaeo_css test... 14:49:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56134/getInfo.html -profile /tmp/tmpNehiLi/profile 14:49:58 INFO - TEST-INFO | started process 3302 (/builds/slave/test/build/application/firefox/firefox http://localhost:56134/getInfo.html) 14:50:06 INFO - TEST-INFO | 3302: exit 0 14:50:06 INFO - Browser initialized. 14:50:06 INFO - Running cycle 1/1 for dromaeo_css test... 14:50:06 INFO - TEST-INFO | started process 3529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNehiLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:07 INFO - PID 3529 | 14:50:07 INFO - PID 3529 | (/builds/slave/test/build/application/firefox/firefox:3583): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:50:07 INFO - PID 3529 | 14:50:17 INFO - PID 3529 | RSS: Main: 173735936 14:50:17 INFO - PID 3529 | 14:53:17 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56134/tests/dromaeo/cssquery-ext.html) 14:53:18 INFO - PID 3529 | RSS: Main: 175116288 14:53:18 INFO - PID 3529 | 14:56:20 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-ext.html (next: http://localhost:56134/tests/dromaeo/cssquery-jquery.html) 14:56:21 INFO - PID 3529 | RSS: Main: 172916736 14:56:21 INFO - PID 3529 | 14:59:23 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56134/tests/dromaeo/cssquery-mootools.html) 14:59:23 INFO - PID 3529 | RSS: Main: 175026176 14:59:23 INFO - PID 3529 | 15:02:25 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56134/tests/dromaeo/cssquery-prototype.html) 15:02:26 INFO - PID 3529 | RSS: Main: 173527040 15:02:26 INFO - PID 3529 | 15:05:30 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56134/tests/dromaeo/cssquery-yui.html) 15:05:30 INFO - PID 3529 | RSS: Main: 177004544 15:05:30 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:56134/tests/dromaeo/cssquery-yui.html (next: http://localhost:56134/tests/dromaeo/cssquery-dojo.html) 15:08:32 INFO - PID 3529 | RSS: Main: 177418240 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | __start_tp_report 15:08:32 INFO - PID 3529 | _x_x_mozilla_page_load 15:08:32 INFO - PID 3529 | _x_x_mozilla_page_load_details 15:08:32 INFO - PID 3529 | |i|pagename|runs| 15:08:32 INFO - PID 3529 | |0;dojo.html;3117.1427857339213;3168.920776980574;3186.6813318668137;3193.089969358733;3224.290656055667;6139.907901381477;6141.662208578532;6147.569670123082;6228.128062071313;6304.432601065903;6162.969185154079;6242.594231374969;6259.593126446778;6285.308616052242;6296.212973378328;5666.235058267143;5689.6017278790505;5733.598648094635;5757.395473475288;5758;5481.725913704318;5570.136628822519;5615.9157612635845;5632.239647647556;5717.857053573653;5518.558515318785;5581.832545023656;5596.244506991545;5718.742656580423;5737.770489180428;5658.405867383948;5725.484706376405;5731.398203188689;5733.655980641175;5737.8565535861935;5590.2732644756325;5605.299337582802;5624.493795558419;5647.43525647436;5701.600887937846;5983.940160598426;6069.666168360738;6110.63336199825;6144.539159563051;6178.135061091451;6637.269900310962;6720.227173875018;6723.924172132435;6727.024581435713;6739.393454589062;6689;6691.899621505681;6719.496037797136;6794.048833163361;6813.591184528944;6109.694515274218;6180.072989051589;6213.502919766408;6269.62382257066;6300.464460520861;6910.896336554955;6930.514863959575;6935.133108361455;6937.791866244021;6954;6492.09110724499;6591.703373348211;6598.505112116611;6610.768623098168;6620.966895165493;6639.568428052161;6640.169978752656;6659.167604049494;6742.056112144303;6775.695093720795;6510.056041873901;6536.673166341664;6640.169978752656;6701.698423570951;6710.295418981034;6719.227288861745;6725.024871393621;6736.595804251662;6737.966310168418;6739.292374300726;5369.27514785499;5399;5411.972940135274;5444.50999410055;5446.972765136149;4622.791974361162;4663.417072865892;4675.602573781267;4678.8770695032945;4682.344471773954;5743.10981797822;5827.388124246978;5835.5915085944425;5910.586258961917;5918.674472904032;6677.3656502632175;6706.899396509057;6752.76365327221;6753.0208119822355;6761.695723692445;5800.941990580124;5887.381824908409;5895.115732640138;5904.0553511437965;5923.585349025613;5827.59206855516;5888.4700376966275;5906.852328691731;5924.851878703067;5941.31674857397;6473.2232132144445;6497.610143391317;6572.605643661395;6584.736610535525;6629.436497897733;6589.868202635825;6679.06493090958;6701.028350889192;6745.055692202997;6780.660966951534;6358.332375100548;6422.807315780347;6443.903341449788;6450.903236451551;6455.7740479083;6370.93629063722;6443.097966284818;6456.870862582816;6464.806055818333;6469.611823290617;6490.156279683611;6559.376859198369;6638.070670106093;6643.468522518284;6650.866982660223;6340.61956282606;6347.841303967438;6371.490280777434;6434.163558737334;6446.8388290293115;6471.805845824632;6495.967520162369;6550.312217217123;6551.115599394021;6569.047488114292;6481.805545833632;6489.513286503437;6547.770828020996;6549.672516374258;6550.967245163743;6564.868702625825;6605.273419923708;6631.403173714389;6682.465402767864;6708.362705542965;6249.406306400884;6345.8730825384155;6358.554901156875;6448.806535803933;6471.838204044937 15:08:32 INFO - PID 3529 | |1;ext.html;818.7339114787695;866.2333834556417;892.7768057985504;900.0594378874076;1087.2226358153919;29713.85143074284;40979.79510102449;41485.37771933423;41715.74852754414;41933.7903310483;42288.51990180344;42587.36118958218;42598.57401425985;42635.36046959298;42804.35793463093;7394.926050739505;7485.326320631142;7599.088109426876;7607.885881711779;7732.690692372326;7538.736144234953;7623.542587444771;7627.809304767397;7659.348955338775;7665.310122089011;7523.623818809037;7553.9622301888685;7603;7634.5037572557885;7649.502782319159;7561.659725312346;7664;7668.38652907766;7669.079710434784;7670.386369090459;7561.357284630813;7561.659725312375;7605.429592780563;7608.087029556488;7609.124950630638;38350.232995340215;38648.227035459415;38810.80594597037;38826.417603735965;38826.61173388258;3509.0700964244497;3553.1650062235353;3556.982215088908;3563.322968635977;3564.41187204111;30868.69131308703;31151.532727009115;31280.37439251225;31302.373952520822;31333.843330783428;4879.292502587141;4885.2916327132725;4950.653454258203;4962;4990.725510096943;189871.99999999863;190343;191085;191185.9999999986;192105;48341.274880876816;48724.26913596299;48749.75625121922;48930.5106948926;49001.75499122553;50938.23592646113;51065.74467127641;51066;51170.74414627977;51204;16058.197090145446;16320.591985200464;16348.264328105264;16423.42518011864;16438.424655137012;12055.457504412323;12064;12065.939670301592;12962.351882405843;12999.545015924397;14075.577732668036;14090.154590724589;14096.647583810487;14195.858041419453;14280.285985700673;5705.115707065412;5769;5798.478136967693;5844.415558444207;5872.823815285548;967.7435479597913;990.9058639429243;1004.5379125602304;1013.0477351289765;1025.0825511167463;23347.182848600216;23498.53002939966;23556;23615.88192059063;23729.762702372755;1098.3794156301665;1107.634480621393;1109.417555783204;1117.1509652664033;1119.6193294279983;12155.878441215475;12381.380930953417;12395.194312369667;12398.938005309916;12533.56132535375;237042;237243;238840;240350;240576;51729;52065.73967130216;52340.214896776575;54795.17807232895;54874.72562637161;1453.9927300363431;1456.5630310906686;1477.8965472417042;1477.9778303325459;1493.2608358862215;26375.20874373772;26981.865090674422;27174.456510870066;27354.726452735216;27649.03228386997;34803.303933921685;34879.302413951074;34885.65114348824;34892.12769680778;35029.824850875586;184037.07981460006;184197;184639;185388;186251;32492.350152997282;32803;32882.17794555155;32971.83514082414;33016.33967320688;41397.37903931383;41510;41521.584784151775;41594.1681166381;41987.7900610495;31266.53100203544;31587.84206078955;31916;32054.19864503406;32113.8394308027;30936.381272374878;31077.689223107478;31114.688853112086;31199.84400078076;34353.828230858686;37672.62327376691;37735.433968489946;38072;38084.80957595194;38095.619043810315;32471.350572987936;33081.17297067593;33613.66386336203;33760.15599609931;33888.49167262542;24166.87916560406;24508.430816466396;24686.382840428414;24734.752652473966;24758.50482990294 15:08:32 INFO - PID 3529 | |2;jquery.html;575.7783253447421;580.7734983356492;582.478681579986;584.6696616411728;599.9460048595625;20999.68500472492;21946.89026554867;22058;22073;22777.31668049957;25857.48285034298;26156.869215653944;26298.737012629867;26446.33884152897;26558.468830623377;6384.3934826191435;6549.57427767196;6549.869002619945;6550.836229094263;6562.507811914125;5801.622894511865;6117.113018612298;6182.536309776762;6192;6350.460210882057;6317.178766760315;6329.113924050636;6333.714982825761;6335.144755458024;6335.366463353651;6333.9683301583655;6342.175517182736;6343.365663433666;6344.7627712596295;6347.047942808569;5848.473637372615;5885.176075349455;5885.529157667419;5890.941090589082;5891.086881533369;29183.708162918523;29375.85312073426;29781.702182978326;29809;30106.54840177399;1894.9242030318771;1958.432054704134;1960.235508151822;1960.3530834824473;1960.8431325493925;19595.706064409045;19868.205271789113;19946.10242539089;19953.700694489595;19988.90005549963;2352.482453860148;2475.3811547113223;2499.825012249143;2507.3104896153523;2507.3731567108225;135366;141076;141146.29426852902;141642;141987;14745.967782255138;15015.663174303549;15126.697466050837;15206.619834504227;15435.228238588026;24174.274771756875;24228.636570451457;24239.39401514941;24257.757422425904;24276.271711848673;10337.896621033844;10403.323783954018;10495.580176792842;10532.526036328383;10741.40922249268;9742.07450292221;9757.365771224848;9774.609015639437;9894.208463322917;10091.192704583616;8640.827183456297;9297.488638124969;9350.812983740287;9406.482643454676;9531.618735250513;2636.275024368276;2694.986525067362;2800.215939536933;2808.1746864538213;2843.469591226321;924.6856068936594;936.5691781780457;963.0658261486348;970.5244430229278;986.9605215791431;19494.415167544998;19500.219991200476;19855.900720496305;20279.18883244683;20461.18155273802;1022.2282176956351;1029.1869423155624;1030.124394264869;1039.776448063655;1040.2250323509033;10871.728206794893;11037.282576632493;11106.61126860556;11252.943735281435;13628.727425451436;518450;524023;538671;553519;553975;121394.39302803429;123642;124250;126113.73886261204;126143;1259.1500737002486;1262.678017105632;1302.3032677517483;1302.7850404683122;1315.0137396952478;20783.896080519502;20828.791712082686;20848.37454876356;21425.250116245857;21440.356789296347;57487;57818.4218157813;59204;59311;59617.403825961184;68689.65655171692;68746.65626671835;68854.3114568848;68963.65518172376;69680.30319696738;12575.182613130117;14868.702625947637;15073.472428464951;15089.47186848455;15153.166575838435;18837.811621883604;23292.767072329738;23920.401989949693;24234;24311.878440607685;18769.71845422347;19023.619527609648;19090.618187635893;19131.13909874031;19180;17022.57443563921;17082.487525374258;17333.739993900355;17342.306307748055;17490;19433.51416214606;19660.50848728793;19721.70417443711;19870.701939471208;20002.799972000677;14688;14902.105873647615;14994.550163495112;15085.622859428602;15086;18419;18558.2576696936;18625.161867715713;18920.148593313057;18921.810781892003 15:08:32 INFO - PID 3529 | |3;mootools.html;1331.713681558465;1367.3846768953974;1396.0646366934157;1396.322783450026;1413.4063693248834;13172.275524846129;13674.247916364597;13996.090254133487;13996.930015349923;14011.159330440181;14268.429262829475;14487;14499.275036248171;14506.782398264035;14518.637034074154;2565.1919645311714;2607.1787386973137;2618.93452663684;2619.5808670612705;2621.5150197213575;2468.2225099093816;2505.1232068775967;2551.1453663022908;2551.63001364802;2552.553303171947;2509.9372515687073;2526.0401047601886;2583.987080064597;2632.1182403894622;2634.5916382960672;2488.228649118779;2494.962575561368;2496.2885577610386;2507.523570521595;2510.535550923085;2431.112643884987;2486.316263027664;2487.0424886418677;2497.7127630322566;2502.2868482482404;13532.59402217935;13643.317834108355;13783.104098233583;13806.65483362914;13815.309234538232;7308.378787803043;7607.239276072404;7612.885806712904;7620.123685776151;7622.923770762277;4934.235193545006;5097.5667068299235;5132.794688212504;5210.53105220532;5243.711595862226;1885.8774179678278;1889.8582606304444;1897.4971632517395;1912.741779859729;1947.3865732294423;22709.886450567807;22779.430514237112;22813.77186228133;22845.657315140284;22907.31278061661;6276.435120839146;6480.805575832733;6561.639109849004;6573.671316434159;6601.8349541260895;15489.457868974532;15582.610434739223;15605.141717205663;16056.518304450885;16066.839331606769;7510.5493670378855;7752.418568607377;7753.263439973193;7760.30157285847;7799.844003119906;7085.822854428578;7132.928670713331;7209.351158395664;7233.168185658611;7293.927060729325;5016.473270306566;5184.922226166535;5198.558122559625;5207.7916883325;5225.921611175835;1528.4039224702376;1539.2303848075962;1547.0794877048138;1548.341954669261;1558.688262347535;883.1212943121507;915.7527467583715;917.3257655623112;927.0729270729271;928.3084102343797;7366.77899663011;7367.4842761007285;7408.296211859864;7448.255174482509;7461.403087752967;705.6577559883452;731.4514114414189;731.498923237584;742.3244847189032;746;4428.734275943454;4467.865964021084;5618.988582055269;5734.6845923473775;5803.709814509342;19378.224871005;19476.8052319475;19786.70319945202;19852.60294794096;19904.402867913985;18487.53781155455;19507.902460487607;19526.804731952783;19783.208671652974;19855.60288794245;10772.353658780341;11012.284201526714;11031.944840275748;11040.668779936615;11054.944725276322;8150.4294699370475;8376.413651044611;8640.654373824977;8958.193762561401;8975.147361000694;16505.092219928018;16557.66884662324;16800;17139.571510712332;17203;16601.66796664084;17000.91499542544;17248.223829927432;17293.481195564153;17492.300307988047;12730;12929.353532323157;13062.934685326512;13070.80393794113;13355.399007044512;13274.07081504324;13383.059456378965;13391.598252052454;13409.128406653535;13425.462981480632;10923.344599324066;10927.617533386294;11078.501467434146;11090.722731931766;11219.326840389604;10420.68737937863;10468.162546996375;10559.78880422372;10828.566857325619;10898.291611045574;9415.717528473882;9458.810823783348;9521.571529281338;9541.904580954102;9550.283728720235;7207.9639601801655;7212.927870721435;7229.49393542447;7261.382782463338;7287.489875708861;7487.625618718933;7513.812154695957;7522.398208143445;7553.357964573072;7609.162992070978 15:08:32 INFO - PID 3529 | |4;prototype.html;501.52355262500635;514.3416426973475;529.8383992882169;530.0776648631381;534.7727215933228;6075.574709770318;6089;6097.871893699663;6140.662263575501;6187.9690601547045;5953.3451320354725;6020.939790602092;6033.517318614511;6055.9394406056035;6097.969510152454;4913.606911447076;4932.284818701286;5000.42495113063;5004.899902001957;5017;4837.951620483803;4932.432770231416;4949.307097006422;4971.900561988758;5021.59827213822;4926.989967056745;4927.44785392602;4941.160002799515;4957.256411538262;4979.900401991958;4919.409670839486;4964.478729733362;4980.12847751642;4999.3000979862845;5001.549860512571;4460.353248778942;4497.797599108048;4515.503294637587;4516.435445569304;4523.276275795857;6047.304559975615;6062.605270917963;6070.8785824283705;6079.300880398767;6111;5666.206731057655;5683.147527870811;5707.885842283131;5711.62874413166;5730.36965933747;6496.155499784998;6570.211574611029;6573.375529324707;6577.112089867855;6581.638009909453;4893.654245082631;4898.265260210961;4907.386576677915;4918;4919.827806026772;6749.190097188271;6876.965615171942;6889.380995466062;6894.759203258911;6952.652367381661;4909.705417674951;4992.929348450749;5005.724685142352;5009.699418034929;5025.47232540578;5032.521910418504;5102.9489705103215;5106.234064890296;5121.129408000575;5146.614003949719;5594.328680558359;5601.60788744784;5674.659520428788;5709.944420008794;5718.571107166979;6193.876122477615;6484.221893372825;6515.087887695727;6567.179102612174;6587.80236592903;1690.7717458142993;1725.568607848038;1893.479293194355;1940.796216397258;1949.171602069115;1433.7992681024664;1439.1437094928501;1456.6067161866238;1463.8975271730876;1468.6401831551339;5695.971520142372;5734.541236701054;5762.74067666956;5767.500449882977;5786.392428795;6602;6650.46796256308;6692.531522793358;6740.416002239568;6799.524033317719;5807.82576522705;5814.738336774855;5822.388649191858;5850.590458667937;5866.325372582122;3480.547528821237;3558.4840198171637;3580.0154957386408;3580.856765729394;3610.9097272568397;6546.639934803631;6602.636854972927;6621.437177839841;6700.195976482853;6746.730130794714;6975.558554505882;6992.2658120897595;6994.125734283215;6994.4404447644065;7029.753958611526;6455.419012288917;6515.7067931943175;6629.502787290972;6647.567908085959;6699.933000669931;6715.865682686416;6730.259671436236;6765.632028789884;6767.86464270702;6778.610694652673;6697.698603562949;6705;6709.295523970108;6709.496787741036;6714.563553369016;6492.675366231575;6503.1791098492495;6547.70535325921;6578.24350199714;6641.369069938348;5005.874853128701;5011.4487406386;5046.823361182488;5056.165732654071;5097.388313402415;6446.8388290293115;6701.296363881722;6717.899231511629;6751.291114432914;6808.276689324111;6396.264429590657;6539.444147247537;6539.901901471387;6548.901766473602;6585.934140658532;6394.936050639434;6522.315156908646;6522.478201743944;6544.149260596092;6552;6240.282367527792;6269.216347956505;6356.682165891594;6426.5218999629415;6461.57999730016;6284.340144284967;6414.807555773335;6416.903746443901;6496.220453545605;6504.38208370204;6237.906431403442;6269.905951410824;6270.874582508415;6371.74513019474;6407.967960160356 15:08:32 INFO - PID 3529 | |5;yui.html;900.113388312512;908.8182363527295;917.8164367126574;924.0251534630962;924.9445033298002;17406.129693515322;17920.910395448005;17955.371561995333;18027.09864506776;22652.207172748957;21528.677069843965;21616.243431479863;21969.23107691231;21971.34085977419;22026.4493387665;977.4623956823737;985.9992108010339;987.6493844685141;1000.4947501511763;1000.6197644894929;898.1871406377239;906.6690657909882;980.8921018687938;984.44378925907;986.3982970388057;1005.03516624041;1046.638909576195;1047.6228557719214;1047.7904419116169;1050.154625526451;995.6017592962836;1043.4156872151543;1045.9581616735322;1046.6284469013467;1049.0715716590835;745.0649434959091;757.8029712274794;776.2237762237762;777.2111307023375;777.4596655324551;20001;20234.291799786937;20425.795742042537;20429.284975025952;20561.177552897865;21442.249521266836;21566.568668626696;21933.451663708376;22086.337409877728;22116.88941555298;15135.697286054217;15404.922975385163;15652.452164174314;15661.92169039159;15711.135887526181;3594.1733401317842;3615.529981102466;3625.6011838697723;3627.9818600907092;3631.237440137574;126889.36555317257;127008;129496.35251823775;130159;131766.34116829452;16863.15684215784;16872.746908796376;17155.91422042882;17279.481615551555;17359.826401736074;30653.69346306553;31415.37169256602;31989.200269993435;31998.520022199686;32098.19754506109;7351.77944661661;7747.457677962489;8235.21765432283;8804.427712198687;9030.27757779376;4057.4928133983253;4198.097409057006;4203.894902627459;4236.152769446123;4247.681423893158;5333.466653334635;5437.728113594305;5461.890762184814;5485.917711234335;5500.22996780451;1067.2849191042021;1077.606673564159;1078.8166011778017;1082.7509672775307;1091.2034215023077;680.1498127340824;695.1345574759457;702.4380495603497;710.3500297227979;718.7879575525233;10839.615284637368;12211.633650990485;12335;12504.312262825631;12767.808482872764;690.6650274616807;691.4192078653955;704.3907020427396;707.2785758526275;713.4363852556526;5614.157876318503;5655.773769049274;5657.490825825613;5721.141828725725;5747.109198074305;102612.48693756484;102875;103891;105163;108948.91051089547;88254.55872720724;89444;89525;89800.5509972446;95287.52356238312;80982;81363;82635;83746.58126709328;85547.57226213954;11716.004139648225;11777.411129443664;11884.34636095023;12008.579699710468;12391.318477483825;33092.1726956828;33156.50265245975;33517.66482335243;34698.826505867306;35490.64509354976;43038.56961430346;44721;44721.10557788761;45275;62036.37963620487;18557.72163417523;18885;18981.810181898556;19083.236670533024;19607.509812254808;19477.220911163397;21781;21875.890620546794;21894;22262.44343891351;18264;18748.81251187471;18856.622867542847;18870.622587548445;18909.810901890804;18865.71701424452;19102.713459297844;19287.324943626907;19396.4181074568;19493.8050619492;17804.3768468103;18019.279228831223;18232.270709171484;18672.81327186765;18883.244670213036;9142.405743626643;9241.676541321021;9439.81120377575;9446.055394460498;9637.903620963982;13981.650458738613;14065.648358791112;14099.295035248402;14129.516400778182;14290.42838286457 15:08:32 INFO - PID 3529 | __end_tp_report 15:08:32 INFO - PID 3529 | __start_cc_report 15:08:32 INFO - PID 3529 | _x_x_mozilla_cycle_collect,352 15:08:32 INFO - PID 3529 | __end_cc_report 15:08:32 INFO - PID 3529 | __startTimestamp1502230112801__endTimestamp 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | ------- Summary: start ------- 15:08:32 INFO - PID 3529 | Number of tests: 6 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#0] dojo.html Cycles:165 Average:6147.05 Median:6371.49 stddev:724.65 (11.4%) stddev-sans-first:686.79 15:08:32 INFO - PID 3529 | Values: 3117.1 3168.9 3186.7 3193.1 3224.3 6139.9 6141.7 6147.6 6228.1 6304.4 6163.0 6242.6 6259.6 6285.3 6296.2 5666.2 5689.6 5733.6 5757.4 5758.0 5481.7 5570.1 5615.9 5632.2 5717.9 5518.6 5581.8 5596.2 5718.7 5737.8 5658.4 5725.5 5731.4 5733.7 5737.9 5590.3 5605.3 5624.5 5647.4 5701.6 5983.9 6069.7 6110.6 6144.5 6178.1 6637.3 6720.2 6723.9 6727.0 6739.4 6689.0 6691.9 6719.5 6794.0 6813.6 6109.7 6180.1 6213.5 6269.6 6300.5 6910.9 6930.5 6935.1 6937.8 6954.0 6492.1 6591.7 6598.5 6610.8 6621.0 6639.6 6640.2 6659.2 6742.1 6775.7 6510.1 6536.7 6640.2 6701.7 6710.3 6719.2 6725.0 6736.6 6738.0 6739.3 5369.3 5399.0 5412.0 5444.5 5447.0 4622.8 4663.4 4675.6 4678.9 4682.3 5743.1 5827.4 5835.6 5910.6 5918.7 6677.4 6706.9 6752.8 6753.0 6761.7 5800.9 5887.4 5895.1 5904.1 5923.6 5827.6 5888.5 5906.9 5924.9 5941.3 6473.2 6497.6 6572.6 6584.7 6629.4 6589.9 6679.1 6701.0 6745.1 6780.7 6358.3 6422.8 6443.9 6450.9 6455.8 6370.9 6443.1 6456.9 6464.8 6469.6 6490.2 6559.4 6638.1 6643.5 6650.9 6340.6 6347.8 6371.5 6434.2 6446.8 6471.8 6496.0 6550.3 6551.1 6569.0 6481.8 6489.5 6547.8 6549.7 6551.0 6564.9 6605.3 6631.4 6682.5 6708.4 6249.4 6345.9 6358.6 6448.8 6471.8 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#1] ext.html Cycles:180 Average:37519.42 Median:34841.30 stddev:53450.78 (153.4%) stddev-sans-first:53529.69 15:08:32 INFO - PID 3529 | Values: 818.7 866.2 892.8 900.1 1087.2 29713.9 40979.8 41485.4 41715.7 41933.8 42288.5 42587.4 42598.6 42635.4 42804.4 7394.9 7485.3 7599.1 7607.9 7732.7 7538.7 7623.5 7627.8 7659.3 7665.3 7523.6 7554.0 7603.0 7634.5 7649.5 7561.7 7664.0 7668.4 7669.1 7670.4 7561.4 7561.7 7605.4 7608.1 7609.1 38350.2 38648.2 38810.8 38826.4 38826.6 3509.1 3553.2 3557.0 3563.3 3564.4 30868.7 31151.5 31280.4 31302.4 31333.8 4879.3 4885.3 4950.7 4962.0 4990.7 189872.0 190343.0 191085.0 191186.0 192105.0 48341.3 48724.3 48749.8 48930.5 49001.8 50938.2 51065.7 51066.0 51170.7 51204.0 16058.2 16320.6 16348.3 16423.4 16438.4 12055.5 12064.0 12065.9 12962.4 12999.5 14075.6 14090.2 14096.6 14195.9 14280.3 5705.1 5769.0 5798.5 5844.4 5872.8 967.7 990.9 1004.5 1013.0 1025.1 23347.2 23498.5 23556.0 23615.9 23729.8 1098.4 1107.6 1109.4 1117.2 1119.6 12155.9 12381.4 12395.2 12398.9 12533.6 237042.0 237243.0 238840.0 240350.0 240576.0 51729.0 52065.7 52340.2 54795.2 54874.7 1454.0 1456.6 1477.9 1478.0 1493.3 26375.2 26981.9 27174.5 27354.7 27649.0 34803.3 34879.3 34885.7 34892.1 35029.8 184037.1 184197.0 184639.0 185388.0 186251.0 32492.4 32803.0 32882.2 32971.8 33016.3 41397.4 41510.0 41521.6 41594.2 41987.8 31266.5 31587.8 31916.0 32054.2 32113.8 30936.4 31077.7 31114.7 31199.8 34353.8 37672.6 37735.4 38072.0 38084.8 38095.6 32471.4 33081.2 33613.7 33760.2 33888.5 24166.9 24508.4 24686.4 24734.8 24758.5 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#2] jquery.html Cycles:180 Average:36627.54 Median:22425.16 stddev:90238.09 (402.4%) stddev-sans-first:90450.63 15:08:32 INFO - PID 3529 | Values: 575.8 580.8 582.5 584.7 599.9 20999.7 21946.9 22058.0 22073.0 22777.3 25857.5 26156.9 26298.7 26446.3 26558.5 6384.4 6549.6 6549.9 6550.8 6562.5 5801.6 6117.1 6182.5 6192.0 6350.5 6317.2 6329.1 6333.7 6335.1 6335.4 6334.0 6342.2 6343.4 6344.8 6347.0 5848.5 5885.2 5885.5 5890.9 5891.1 29183.7 29375.9 29781.7 29809.0 30106.5 1894.9 1958.4 1960.2 1960.4 1960.8 19595.7 19868.2 19946.1 19953.7 19988.9 2352.5 2475.4 2499.8 2507.3 2507.4 135366.0 141076.0 141146.3 141642.0 141987.0 14746.0 15015.7 15126.7 15206.6 15435.2 24174.3 24228.6 24239.4 24257.8 24276.3 10337.9 10403.3 10495.6 10532.5 10741.4 9742.1 9757.4 9774.6 9894.2 10091.2 8640.8 9297.5 9350.8 9406.5 9531.6 2636.3 2695.0 2800.2 2808.2 2843.5 924.7 936.6 963.1 970.5 987.0 19494.4 19500.2 19855.9 20279.2 20461.2 1022.2 1029.2 1030.1 1039.8 1040.2 10871.7 11037.3 11106.6 11252.9 13628.7 518450.0 524023.0 538671.0 553519.0 553975.0 121394.4 123642.0 124250.0 126113.7 126143.0 1259.2 1262.7 1302.3 1302.8 1315.0 20783.9 20828.8 20848.4 21425.3 21440.4 57487.0 57818.4 59204.0 59311.0 59617.4 68689.7 68746.7 68854.3 68963.7 69680.3 12575.2 14868.7 15073.5 15089.5 15153.2 18837.8 23292.8 23920.4 24234.0 24311.9 18769.7 19023.6 19090.6 19131.1 19180.0 17022.6 17082.5 17333.7 17342.3 17490.0 19433.5 19660.5 19721.7 19870.7 20002.8 14688.0 14902.1 14994.6 15085.6 15086.0 18419.0 18558.3 18625.2 18920.1 18921.8 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#3] mootools.html Cycles:180 Average:8794.44 Median:2495.63 stddev:5978.64 (239.6%) stddev-sans-first:5969.12 15:08:32 INFO - PID 3529 | Values: 1331.7 1367.4 1396.1 1396.3 1413.4 13172.3 13674.2 13996.1 13996.9 14011.2 14268.4 14487.0 14499.3 14506.8 14518.6 2565.2 2607.2 2618.9 2619.6 2621.5 2468.2 2505.1 2551.1 2551.6 2552.6 2509.9 2526.0 2584.0 2632.1 2634.6 2488.2 2495.0 2496.3 2507.5 2510.5 2431.1 2486.3 2487.0 2497.7 2502.3 13532.6 13643.3 13783.1 13806.7 13815.3 7308.4 7607.2 7612.9 7620.1 7622.9 4934.2 5097.6 5132.8 5210.5 5243.7 1885.9 1889.9 1897.5 1912.7 1947.4 22709.9 22779.4 22813.8 22845.7 22907.3 6276.4 6480.8 6561.6 6573.7 6601.8 15489.5 15582.6 15605.1 16056.5 16066.8 7510.5 7752.4 7753.3 7760.3 7799.8 7085.8 7132.9 7209.4 7233.2 7293.9 5016.5 5184.9 5198.6 5207.8 5225.9 1528.4 1539.2 1547.1 1548.3 1558.7 883.1 915.8 917.3 927.1 928.3 7366.8 7367.5 7408.3 7448.3 7461.4 705.7 731.5 731.5 742.3 746.0 4428.7 4467.9 5619.0 5734.7 5803.7 19378.2 19476.8 19786.7 19852.6 19904.4 18487.5 19507.9 19526.8 19783.2 19855.6 10772.4 11012.3 11031.9 11040.7 11054.9 8150.4 8376.4 8640.7 8958.2 8975.1 16505.1 16557.7 16800.0 17139.6 17203.0 16601.7 17000.9 17248.2 17293.5 17492.3 12730.0 12929.4 13062.9 13070.8 13355.4 13274.1 13383.1 13391.6 13409.1 13425.5 10923.3 10927.6 11078.5 11090.7 11219.3 10420.7 10468.2 10559.8 10828.6 10898.3 9415.7 9458.8 9521.6 9541.9 9550.3 7208.0 7212.9 7229.5 7261.4 7287.5 7487.6 7513.8 7522.4 7553.4 7609.2 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#4] prototype.html Cycles:180 Average:5515.67 Median:6066.74 stddev:1520.39 (25.1%) stddev-sans-first:1477.35 15:08:32 INFO - PID 3529 | Values: 501.5 514.3 529.8 530.1 534.8 6075.6 6089.0 6097.9 6140.7 6188.0 5953.3 6020.9 6033.5 6055.9 6098.0 4913.6 4932.3 5000.4 5004.9 5017.0 4838.0 4932.4 4949.3 4971.9 5021.6 4927.0 4927.4 4941.2 4957.3 4979.9 4919.4 4964.5 4980.1 4999.3 5001.5 4460.4 4497.8 4515.5 4516.4 4523.3 6047.3 6062.6 6070.9 6079.3 6111.0 5666.2 5683.1 5707.9 5711.6 5730.4 6496.2 6570.2 6573.4 6577.1 6581.6 4893.7 4898.3 4907.4 4918.0 4919.8 6749.2 6877.0 6889.4 6894.8 6952.7 4909.7 4992.9 5005.7 5009.7 5025.5 5032.5 5102.9 5106.2 5121.1 5146.6 5594.3 5601.6 5674.7 5709.9 5718.6 6193.9 6484.2 6515.1 6567.2 6587.8 1690.8 1725.6 1893.5 1940.8 1949.2 1433.8 1439.1 1456.6 1463.9 1468.6 5696.0 5734.5 5762.7 5767.5 5786.4 6602.0 6650.5 6692.5 6740.4 6799.5 5807.8 5814.7 5822.4 5850.6 5866.3 3480.5 3558.5 3580.0 3580.9 3610.9 6546.6 6602.6 6621.4 6700.2 6746.7 6975.6 6992.3 6994.1 6994.4 7029.8 6455.4 6515.7 6629.5 6647.6 6699.9 6715.9 6730.3 6765.6 6767.9 6778.6 6697.7 6705.0 6709.3 6709.5 6714.6 6492.7 6503.2 6547.7 6578.2 6641.4 5005.9 5011.4 5046.8 5056.2 5097.4 6446.8 6701.3 6717.9 6751.3 6808.3 6396.3 6539.4 6539.9 6548.9 6585.9 6394.9 6522.3 6522.5 6544.1 6552.0 6240.3 6269.2 6356.7 6426.5 6461.6 6284.3 6414.8 6416.9 6496.2 6504.4 6237.9 6269.9 6270.9 6371.7 6408.0 15:08:32 INFO - PID 3529 | 15:08:32 INFO - PID 3529 | [#5] yui.html Cycles:180 Average:22659.56 Median:21998.90 stddev:30631.52 (139.2%) stddev-sans-first:30673.87 15:08:32 INFO - PID 3529 | Values: 900.1 908.8 917.8 924.0 924.9 17406.1 17920.9 17955.4 18027.1 22652.2 21528.7 21616.2 21969.2 21971.3 22026.4 977.5 986.0 987.6 1000.5 1000.6 898.2 906.7 980.9 984.4 986.4 1005.0 1046.6 1047.6 1047.8 1050.2 995.6 1043.4 1046.0 1046.6 1049.1 745.1 757.8 776.2 777.2 777.5 20001.0 20234.3 20425.8 20429.3 20561.2 21442.2 21566.6 21933.5 22086.3 22116.9 15135.7 15404.9 15652.5 15661.9 15711.1 3594.2 3615.5 3625.6 3628.0 3631.2 126889.4 127008.0 129496.4 130159.0 131766.3 16863.2 16872.7 17155.9 17279.5 17359.8 30653.7 31415.4 31989.2 31998.5 32098.2 7351.8 7747.5 8235.2 8804.4 9030.3 4057.5 4198.1 4203.9 4236.2 4247.7 5333.5 5437.7 5461.9 5485.9 5500.2 1067.3 1077.6 1078.8 1082.8 1091.2 680.1 695.1 702.4 710.4 718.8 10839.6 12211.6 12335.0 12504.3 12767.8 690.7 691.4 704.4 707.3 713.4 5614.2 5655.8 5657.5 5721.1 5747.1 102612.5 102875.0 103891.0 105163.0 108948.9 88254.6 89444.0 89525.0 89800.6 95287.5 80982.0 81363.0 82635.0 83746.6 85547.6 11716.0 11777.4 11884.3 12008.6 12391.3 33092.2 33156.5 33517.7 34698.8 35490.6 43038.6 44721.0 44721.1 45275.0 62036.4 18557.7 18885.0 18981.8 19083.2 19607.5 19477.2 21781.0 21875.9 21894.0 22262.4 18264.0 18748.8 18856.6 18870.6 18909.8 18865.7 19102.7 19287.3 19396.4 19493.8 17804.4 18019.3 18232.3 18672.8 18883.2 9142.4 9241.7 9439.8 9446.1 9637.9 13981.7 14065.6 14099.3 14129.5 14290.4 15:08:32 INFO - PID 3529 | -------- Summary: end -------- 15:08:32 INFO - PID 3529 | 15:08:33 INFO - TEST-INFO | 3529: exit 0 15:08:33 INFO - TEST-OK | dromaeo_css | took 1115162ms 15:08:33 INFO - TEST-START | kraken 15:08:33 INFO - Initialising browser for kraken test... 15:08:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56134/getInfo.html -profile /tmp/tmp2frWil/profile 15:08:33 INFO - TEST-INFO | started process 3902 (/builds/slave/test/build/application/firefox/firefox http://localhost:56134/getInfo.html) 15:08:39 INFO - TEST-INFO | 3902: exit 0 15:08:39 INFO - Browser initialized. 15:08:39 INFO - Running cycle 1/1 for kraken test... 15:08:39 INFO - TEST-INFO | started process 4128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2frWil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:40 INFO - PID 4128 | 15:08:40 INFO - PID 4128 | (/builds/slave/test/build/application/firefox/firefox:4183): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:40 INFO - PID 4128 | 15:08:51 INFO - PID 4128 | RSS: Main: 170147840 15:08:51 INFO - PID 4128 | 15:08:53 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56134/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:54 INFO - PID 4128 | RSS: Main: 175013888 15:08:54 INFO - PID 4128 | 15:08:57 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56134/tests/kraken/driver.html?testName=audio-dft) 15:08:58 INFO - PID 4128 | RSS: Main: 175300608 15:08:58 INFO - PID 4128 | 15:09:01 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56134/tests/kraken/driver.html?testName=audio-fft) 15:09:01 INFO - PID 4128 | RSS: Main: 170061824 15:09:01 INFO - PID 4128 | 15:09:04 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56134/tests/kraken/driver.html?testName=audio-oscillator) 15:09:04 INFO - PID 4128 | RSS: Main: 170909696 15:09:04 INFO - PID 4128 | 15:09:06 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56134/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:09:07 INFO - PID 4128 | RSS: Main: 170844160 15:09:07 INFO - PID 4128 | 15:09:10 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56134/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:11 INFO - PID 4128 | RSS: Main: 174071808 15:09:11 INFO - PID 4128 | 15:09:14 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56134/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:15 INFO - PID 4128 | RSS: Main: 173920256 15:09:15 INFO - PID 4128 | 15:09:18 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56134/tests/kraken/driver.html?testName=json-parse-financial) 15:09:18 INFO - PID 4128 | RSS: Main: 173764608 15:09:18 INFO - PID 4128 | 15:09:20 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56134/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:21 INFO - PID 4128 | RSS: Main: 174022656 15:09:21 INFO - PID 4128 | 15:09:23 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:23 INFO - PID 4128 | RSS: Main: 175079424 15:09:23 INFO - PID 4128 | 15:09:26 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:26 INFO - PID 4128 | RSS: Main: 174215168 15:09:26 INFO - PID 4128 | 15:09:29 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:30 INFO - PID 4128 | RSS: Main: 174903296 15:09:30 INFO - PID 4128 | 15:09:33 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:33 INFO - PID 4128 | RSS: Main: 174837760 15:09:33 INFO - PID 4128 | 15:09:35 INFO - PID 4128 | Cycle 1(1): loaded http://localhost:56134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56134/tests/kraken/driver.html?testName=ai-astar) 15:09:36 INFO - PID 4128 | RSS: Main: 176312320 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | __start_tp_report 15:09:36 INFO - PID 4128 | _x_x_mozilla_page_load 15:09:36 INFO - PID 4128 | _x_x_mozilla_page_load_details 15:09:36 INFO - PID 4128 | |i|pagename|runs| 15:09:36 INFO - PID 4128 | |0;ai-astar;105;108;97;107;109;109;112;107;107;110 15:09:36 INFO - PID 4128 | |1;audio-beat-detection;149;122;146;165;118;144;147;126;164;118 15:09:36 INFO - PID 4128 | |2;audio-dft;165;162;163;162;163;163;166;165;164;165 15:09:36 INFO - PID 4128 | |3;audio-fft;81;75;74;178;76;74;75;73;159;75 15:09:36 INFO - PID 4128 | |4;audio-oscillator;83;79;130;78;78;78;128;80;83;122 15:09:36 INFO - PID 4128 | |5;imaging-gaussian-blur;114;114;120;120;114;114;114;114;119;117 15:09:36 INFO - PID 4128 | |6;imaging-darkroom;153;151;154;150;150;151;157;150;150;151 15:09:36 INFO - PID 4128 | |7;imaging-desaturate;95;94;94;93;93;93;95;94;94;95 15:09:36 INFO - PID 4128 | |8;json-parse-financial;62;56;54;64;59;53;60;56;54;54 15:09:36 INFO - PID 4128 | |9;json-stringify-tinderbox;54;54;54;54;58;56;54;54;55;56 15:09:36 INFO - PID 4128 | |10;stanford-crypto-aes;81;90;79;92;77;92;96;83;100;90 15:09:36 INFO - PID 4128 | |11;stanford-crypto-ccm;131;128;140;131;135;130;126;132;126;179 15:09:36 INFO - PID 4128 | |12;stanford-crypto-pbkdf2;179;175;180;178;193;171;176;181;174;179 15:09:36 INFO - PID 4128 | |13;stanford-crypto-sha256-iterative;69;70;70;69;67;69;66;65;65;68 15:09:36 INFO - PID 4128 | __end_tp_report 15:09:36 INFO - PID 4128 | __start_cc_report 15:09:36 INFO - PID 4128 | _x_x_mozilla_cycle_collect,940 15:09:36 INFO - PID 4128 | __end_cc_report 15:09:36 INFO - PID 4128 | __startTimestamp1502230176005__endTimestamp 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | ------- Summary: start ------- 15:09:36 INFO - PID 4128 | Number of tests: 14 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:4.04 (3.7%) stddev-sans-first:4.21 15:09:36 INFO - PID 4128 | Values: 105.0 108.0 97.0 107.0 109.0 109.0 112.0 107.0 107.0 110.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:146.50 stddev:17.86 (12.2%) stddev-sans-first:18.64 15:09:36 INFO - PID 4128 | Values: 149.0 122.0 146.0 165.0 118.0 144.0 147.0 126.0 164.0 118.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 15:09:36 INFO - PID 4128 | Values: 165.0 162.0 163.0 162.0 163.0 163.0 166.0 165.0 164.0 165.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.58 (52.8%) stddev-sans-first:41.70 15:09:36 INFO - PID 4128 | Values: 81.0 75.0 74.0 178.0 76.0 74.0 75.0 73.0 159.0 75.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.50 stddev:22.77 (29.0%) stddev-sans-first:23.81 15:09:36 INFO - PID 4128 | Values: 83.0 79.0 130.0 78.0 78.0 78.0 128.0 80.0 83.0 122.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.50 stddev:2.71 (2.3%) stddev-sans-first:2.77 15:09:36 INFO - PID 4128 | Values: 114.0 114.0 120.0 120.0 114.0 114.0 114.0 114.0 119.0 117.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:151.00 stddev:2.31 (1.5%) stddev-sans-first:2.40 15:09:36 INFO - PID 4128 | Values: 153.0 151.0 154.0 150.0 150.0 151.0 157.0 150.0 150.0 151.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 15:09:36 INFO - PID 4128 | Values: 95.0 94.0 94.0 93.0 93.0 93.0 95.0 94.0 94.0 95.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:3.82 (6.7%) stddev-sans-first:3.64 15:09:36 INFO - PID 4128 | Values: 62.0 56.0 54.0 64.0 59.0 53.0 60.0 56.0 54.0 54.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:54.50 stddev:1.37 (2.5%) stddev-sans-first:1.41 15:09:36 INFO - PID 4128 | Values: 54.0 54.0 54.0 54.0 58.0 56.0 54.0 54.0 55.0 56.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:90.00 stddev:7.63 (8.5%) stddev-sans-first:7.66 15:09:36 INFO - PID 4128 | Values: 81.0 90.0 79.0 92.0 77.0 92.0 96.0 83.0 100.0 90.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:131.50 stddev:15.75 (12.0%) stddev-sans-first:16.61 15:09:36 INFO - PID 4128 | Values: 131.0 128.0 140.0 131.0 135.0 130.0 126.0 132.0 126.0 179.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.00 stddev:5.91 (3.3%) stddev-sans-first:6.27 15:09:36 INFO - PID 4128 | Values: 179.0 175.0 180.0 178.0 193.0 171.0 176.0 181.0 174.0 179.0 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.00 15:09:36 INFO - PID 4128 | Values: 69.0 70.0 70.0 69.0 67.0 69.0 66.0 65.0 65.0 68.0 15:09:36 INFO - PID 4128 | -------- Summary: end -------- 15:09:36 INFO - PID 4128 | 15:09:36 INFO - PID 4128 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:09:36 INFO - TEST-INFO | 4128: exit 0 15:09:36 INFO - TEST-OK | kraken | took 63107ms 15:09:36 INFO - SUITE-END | took 1178s 15:09:37 INFO - Completed test suite (00:19:38) 15:09:37 INFO - javascript benchmark 15:09:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8474.130635150732, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.1427857339213, 3168.920776980574, 3186.6813318668137, 3193.089969358733, 3224.290656055667, 6139.907901381477, 6141.662208578532, 6147.569670123082, 6228.128062071313, 6304.432601065903, 6162.969185154079, 6242.594231374969, 6259.593126446778, 6285.308616052242, 6296.212973378328, 5666.235058267143, 5689.6017278790505, 5733.598648094635, 5757.395473475288, 5758.0, 5481.725913704318, 5570.136628822519, 5615.9157612635845, 5632.239647647556, 5717.857053573653, 5518.558515318785, 5581.832545023656, 5596.244506991545, 5718.742656580423, 5737.770489180428, 5658.405867383948, 5725.484706376405, 5731.398203188689, 5733.655980641175, 5737.8565535861935, 5590.2732644756325, 5605.299337582802, 5624.493795558419, 5647.43525647436, 5701.600887937846, 5983.940160598426, 6069.666168360738, 6110.63336199825, 6144.539159563051, 6178.135061091451, 6637.269900310962, 6720.227173875018, 6723.924172132435, 6727.024581435713, 6739.393454589062, 6689.0, 6691.899621505681, 6719.496037797136, 6794.048833163361, 6813.591184528944, 6109.694515274218, 6180.072989051589, 6213.502919766408, 6269.62382257066, 6300.464460520861, 6910.896336554955, 6930.514863959575, 6935.133108361455, 6937.791866244021, 6954.0, 6492.09110724499, 6591.703373348211, 6598.505112116611, 6610.768623098168, 6620.966895165493, 6639.568428052161, 6640.169978752656, 6659.167604049494, 6742.056112144303, 6775.695093720795, 6510.056041873901, 6536.673166341664, 6640.169978752656, 6701.698423570951, 6710.295418981034, 6719.227288861745, 6725.024871393621, 6736.595804251662, 6737.966310168418, 6739.292374300726, 5369.27514785499, 5399.0, 5411.972940135274, 5444.50999410055, 5446.972765136149, 4622.791974361162, 4663.417072865892, 4675.602573781267, 4678.8770695032945, 4682.344471773954, 5743.10981797822, 5827.388124246978, 5835.5915085944425, 5910.586258961917, 5918.674472904032, 6677.3656502632175, 6706.899396509057, 6752.76365327221, 6753.0208119822355, 6761.695723692445, 5800.941990580124, 5887.381824908409, 5895.115732640138, 5904.0553511437965, 5923.585349025613, 5827.59206855516, 5888.4700376966275, 5906.852328691731, 5924.851878703067, 5941.31674857397, 6473.2232132144445, 6497.610143391317, 6572.605643661395, 6584.736610535525, 6629.436497897733, 6589.868202635825, 6679.06493090958, 6701.028350889192, 6745.055692202997, 6780.660966951534, 6358.332375100548, 6422.807315780347, 6443.903341449788, 6450.903236451551, 6455.7740479083, 6370.93629063722, 6443.097966284818, 6456.870862582816, 6464.806055818333, 6469.611823290617, 6490.156279683611, 6559.376859198369, 6638.070670106093, 6643.468522518284, 6650.866982660223, 6340.61956282606, 6347.841303967438, 6371.490280777434, 6434.163558737334, 6446.8388290293115, 6471.805845824632, 6495.967520162369, 6550.312217217123, 6551.115599394021, 6569.047488114292, 6481.805545833632, 6489.513286503437, 6547.770828020996, 6549.672516374258, 6550.967245163743, 6564.868702625825, 6605.273419923708, 6631.403173714389, 6682.465402767864, 6708.362705542965, 6249.406306400884, 6345.8730825384155, 6358.554901156875, 6448.806535803933, 6471.838204044937], "value": 6093.063299414889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.7339114787695, 866.2333834556417, 892.7768057985504, 900.0594378874076, 1087.2226358153919, 29713.85143074284, 40979.79510102449, 41485.37771933423, 41715.74852754414, 41933.7903310483, 42288.51990180344, 42587.36118958218, 42598.57401425985, 42635.36046959298, 42804.35793463093, 7394.926050739505, 7485.326320631142, 7599.088109426876, 7607.885881711779, 7732.690692372326, 7538.736144234953, 7623.542587444771, 7627.809304767397, 7659.348955338775, 7665.310122089011, 7523.623818809037, 7553.9622301888685, 7603.0, 7634.5037572557885, 7649.502782319159, 7561.659725312346, 7664.0, 7668.38652907766, 7669.079710434784, 7670.386369090459, 7561.357284630813, 7561.659725312375, 7605.429592780563, 7608.087029556488, 7609.124950630638, 38350.232995340215, 38648.227035459415, 38810.80594597037, 38826.417603735965, 38826.61173388258, 3509.0700964244497, 3553.1650062235353, 3556.982215088908, 3563.322968635977, 3564.41187204111, 30868.69131308703, 31151.532727009115, 31280.37439251225, 31302.373952520822, 31333.843330783428, 4879.292502587141, 4885.2916327132725, 4950.653454258203, 4962.0, 4990.725510096943, 189871.99999999863, 190343.0, 191085.0, 191185.9999999986, 192105.0, 48341.274880876816, 48724.26913596299, 48749.75625121922, 48930.5106948926, 49001.75499122553, 50938.23592646113, 51065.74467127641, 51066.0, 51170.74414627977, 51204.0, 16058.197090145446, 16320.591985200464, 16348.264328105264, 16423.42518011864, 16438.424655137012, 12055.457504412323, 12064.0, 12065.939670301592, 12962.351882405843, 12999.545015924397, 14075.577732668036, 14090.154590724589, 14096.647583810487, 14195.858041419453, 14280.285985700673, 5705.115707065412, 5769.0, 5798.478136967693, 5844.415558444207, 5872.823815285548, 967.7435479597913, 990.9058639429243, 1004.5379125602304, 1013.0477351289765, 1025.0825511167463, 23347.182848600216, 23498.53002939966, 23556.0, 23615.88192059063, 23729.762702372755, 1098.3794156301665, 1107.634480621393, 1109.417555783204, 1117.1509652664033, 1119.6193294279983, 12155.878441215475, 12381.380930953417, 12395.194312369667, 12398.938005309916, 12533.56132535375, 237042.0, 237243.0, 238840.0, 240350.0, 240576.0, 51729.0, 52065.73967130216, 52340.214896776575, 54795.17807232895, 54874.72562637161, 1453.9927300363431, 1456.5630310906686, 1477.8965472417042, 1477.9778303325459, 1493.2608358862215, 26375.20874373772, 26981.865090674422, 27174.456510870066, 27354.726452735216, 27649.03228386997, 34803.303933921685, 34879.302413951074, 34885.65114348824, 34892.12769680778, 35029.824850875586, 184037.07981460006, 184197.0, 184639.0, 185388.0, 186251.0, 32492.350152997282, 32803.0, 32882.17794555155, 32971.83514082414, 33016.33967320688, 41397.37903931383, 41510.0, 41521.584784151775, 41594.1681166381, 41987.7900610495, 31266.53100203544, 31587.84206078955, 31916.0, 32054.19864503406, 32113.8394308027, 30936.381272374878, 31077.689223107478, 31114.688853112086, 31199.84400078076, 34353.828230858686, 37672.62327376691, 37735.433968489946, 38072.0, 38084.80957595194, 38095.619043810315, 32471.350572987936, 33081.17297067593, 33613.66386336203, 33760.15599609931, 33888.49167262542, 24166.87916560406, 24508.430816466396, 24686.382840428414, 24734.752652473966, 24758.50482990294], "value": 17188.617221218377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7783253447421, 580.7734983356492, 582.478681579986, 584.6696616411728, 599.9460048595625, 20999.68500472492, 21946.89026554867, 22058.0, 22073.0, 22777.31668049957, 25857.48285034298, 26156.869215653944, 26298.737012629867, 26446.33884152897, 26558.468830623377, 6384.3934826191435, 6549.57427767196, 6549.869002619945, 6550.836229094263, 6562.507811914125, 5801.622894511865, 6117.113018612298, 6182.536309776762, 6192.0, 6350.460210882057, 6317.178766760315, 6329.113924050636, 6333.714982825761, 6335.144755458024, 6335.366463353651, 6333.9683301583655, 6342.175517182736, 6343.365663433666, 6344.7627712596295, 6347.047942808569, 5848.473637372615, 5885.176075349455, 5885.529157667419, 5890.941090589082, 5891.086881533369, 29183.708162918523, 29375.85312073426, 29781.702182978326, 29809.0, 30106.54840177399, 1894.9242030318771, 1958.432054704134, 1960.235508151822, 1960.3530834824473, 1960.8431325493925, 19595.706064409045, 19868.205271789113, 19946.10242539089, 19953.700694489595, 19988.90005549963, 2352.482453860148, 2475.3811547113223, 2499.825012249143, 2507.3104896153523, 2507.3731567108225, 135366.0, 141076.0, 141146.29426852902, 141642.0, 141987.0, 14745.967782255138, 15015.663174303549, 15126.697466050837, 15206.619834504227, 15435.228238588026, 24174.274771756875, 24228.636570451457, 24239.39401514941, 24257.757422425904, 24276.271711848673, 10337.896621033844, 10403.323783954018, 10495.580176792842, 10532.526036328383, 10741.40922249268, 9742.07450292221, 9757.365771224848, 9774.609015639437, 9894.208463322917, 10091.192704583616, 8640.827183456297, 9297.488638124969, 9350.812983740287, 9406.482643454676, 9531.618735250513, 2636.275024368276, 2694.986525067362, 2800.215939536933, 2808.1746864538213, 2843.469591226321, 924.6856068936594, 936.5691781780457, 963.0658261486348, 970.5244430229278, 986.9605215791431, 19494.415167544998, 19500.219991200476, 19855.900720496305, 20279.18883244683, 20461.18155273802, 1022.2282176956351, 1029.1869423155624, 1030.124394264869, 1039.776448063655, 1040.2250323509033, 10871.728206794893, 11037.282576632493, 11106.61126860556, 11252.943735281435, 13628.727425451436, 518450.0, 524023.0, 538671.0, 553519.0, 553975.0, 121394.39302803429, 123642.0, 124250.0, 126113.73886261204, 126143.0, 1259.1500737002486, 1262.678017105632, 1302.3032677517483, 1302.7850404683122, 1315.0137396952478, 20783.896080519502, 20828.791712082686, 20848.37454876356, 21425.250116245857, 21440.356789296347, 57487.0, 57818.4218157813, 59204.0, 59311.0, 59617.403825961184, 68689.65655171692, 68746.65626671835, 68854.3114568848, 68963.65518172376, 69680.30319696738, 12575.182613130117, 14868.702625947637, 15073.472428464951, 15089.47186848455, 15153.166575838435, 18837.811621883604, 23292.767072329738, 23920.401989949693, 24234.0, 24311.878440607685, 18769.71845422347, 19023.619527609648, 19090.618187635893, 19131.13909874031, 19180.0, 17022.57443563921, 17082.487525374258, 17333.739993900355, 17342.306307748055, 17490.0, 19433.51416214606, 19660.50848728793, 19721.70417443711, 19870.701939471208, 20002.799972000677, 14688.0, 14902.105873647615, 14994.550163495112, 15085.622859428602, 15086.0, 18419.0, 18558.2576696936, 18625.161867715713, 18920.148593313057, 18921.810781892003], "value": 12187.63401153006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.713681558465, 1367.3846768953974, 1396.0646366934157, 1396.322783450026, 1413.4063693248834, 13172.275524846129, 13674.247916364597, 13996.090254133487, 13996.930015349923, 14011.159330440181, 14268.429262829475, 14487.0, 14499.275036248171, 14506.782398264035, 14518.637034074154, 2565.1919645311714, 2607.1787386973137, 2618.93452663684, 2619.5808670612705, 2621.5150197213575, 2468.2225099093816, 2505.1232068775967, 2551.1453663022908, 2551.63001364802, 2552.553303171947, 2509.9372515687073, 2526.0401047601886, 2583.987080064597, 2632.1182403894622, 2634.5916382960672, 2488.228649118779, 2494.962575561368, 2496.2885577610386, 2507.523570521595, 2510.535550923085, 2431.112643884987, 2486.316263027664, 2487.0424886418677, 2497.7127630322566, 2502.2868482482404, 13532.59402217935, 13643.317834108355, 13783.104098233583, 13806.65483362914, 13815.309234538232, 7308.378787803043, 7607.239276072404, 7612.885806712904, 7620.123685776151, 7622.923770762277, 4934.235193545006, 5097.5667068299235, 5132.794688212504, 5210.53105220532, 5243.711595862226, 1885.8774179678278, 1889.8582606304444, 1897.4971632517395, 1912.741779859729, 1947.3865732294423, 22709.886450567807, 22779.430514237112, 22813.77186228133, 22845.657315140284, 22907.31278061661, 6276.435120839146, 6480.805575832733, 6561.639109849004, 6573.671316434159, 6601.8349541260895, 15489.457868974532, 15582.610434739223, 15605.141717205663, 16056.518304450885, 16066.839331606769, 7510.5493670378855, 7752.418568607377, 7753.263439973193, 7760.30157285847, 7799.844003119906, 7085.822854428578, 7132.928670713331, 7209.351158395664, 7233.168185658611, 7293.927060729325, 5016.473270306566, 5184.922226166535, 5198.558122559625, 5207.7916883325, 5225.921611175835, 1528.4039224702376, 1539.2303848075962, 1547.0794877048138, 1548.341954669261, 1558.688262347535, 883.1212943121507, 915.7527467583715, 917.3257655623112, 927.0729270729271, 928.3084102343797, 7366.77899663011, 7367.4842761007285, 7408.296211859864, 7448.255174482509, 7461.403087752967, 705.6577559883452, 731.4514114414189, 731.498923237584, 742.3244847189032, 746.0, 4428.734275943454, 4467.865964021084, 5618.988582055269, 5734.6845923473775, 5803.709814509342, 19378.224871005, 19476.8052319475, 19786.70319945202, 19852.60294794096, 19904.402867913985, 18487.53781155455, 19507.902460487607, 19526.804731952783, 19783.208671652974, 19855.60288794245, 10772.353658780341, 11012.284201526714, 11031.944840275748, 11040.668779936615, 11054.944725276322, 8150.4294699370475, 8376.413651044611, 8640.654373824977, 8958.193762561401, 8975.147361000694, 16505.092219928018, 16557.66884662324, 16800.0, 17139.571510712332, 17203.0, 16601.66796664084, 17000.91499542544, 17248.223829927432, 17293.481195564153, 17492.300307988047, 12730.0, 12929.353532323157, 13062.934685326512, 13070.80393794113, 13355.399007044512, 13274.07081504324, 13383.059456378965, 13391.598252052454, 13409.128406653535, 13425.462981480632, 10923.344599324066, 10927.617533386294, 11078.501467434146, 11090.722731931766, 11219.326840389604, 10420.68737937863, 10468.162546996375, 10559.78880422372, 10828.566857325619, 10898.291611045574, 9415.717528473882, 9458.810823783348, 9521.571529281338, 9541.904580954102, 9550.283728720235, 7207.9639601801655, 7212.927870721435, 7229.49393542447, 7261.382782463338, 7287.489875708861, 7487.625618718933, 7513.812154695957, 7522.398208143445, 7553.357964573072, 7609.162992070978], "value": 6366.058679377657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.52355262500635, 514.3416426973475, 529.8383992882169, 530.0776648631381, 534.7727215933228, 6075.574709770318, 6089.0, 6097.871893699663, 6140.662263575501, 6187.9690601547045, 5953.3451320354725, 6020.939790602092, 6033.517318614511, 6055.9394406056035, 6097.969510152454, 4913.606911447076, 4932.284818701286, 5000.42495113063, 5004.899902001957, 5017.0, 4837.951620483803, 4932.432770231416, 4949.307097006422, 4971.900561988758, 5021.59827213822, 4926.989967056745, 4927.44785392602, 4941.160002799515, 4957.256411538262, 4979.900401991958, 4919.409670839486, 4964.478729733362, 4980.12847751642, 4999.3000979862845, 5001.549860512571, 4460.353248778942, 4497.797599108048, 4515.503294637587, 4516.435445569304, 4523.276275795857, 6047.304559975615, 6062.605270917963, 6070.8785824283705, 6079.300880398767, 6111.0, 5666.206731057655, 5683.147527870811, 5707.885842283131, 5711.62874413166, 5730.36965933747, 6496.155499784998, 6570.211574611029, 6573.375529324707, 6577.112089867855, 6581.638009909453, 4893.654245082631, 4898.265260210961, 4907.386576677915, 4918.0, 4919.827806026772, 6749.190097188271, 6876.965615171942, 6889.380995466062, 6894.759203258911, 6952.652367381661, 4909.705417674951, 4992.929348450749, 5005.724685142352, 5009.699418034929, 5025.47232540578, 5032.521910418504, 5102.9489705103215, 5106.234064890296, 5121.129408000575, 5146.614003949719, 5594.328680558359, 5601.60788744784, 5674.659520428788, 5709.944420008794, 5718.571107166979, 6193.876122477615, 6484.221893372825, 6515.087887695727, 6567.179102612174, 6587.80236592903, 1690.7717458142993, 1725.568607848038, 1893.479293194355, 1940.796216397258, 1949.171602069115, 1433.7992681024664, 1439.1437094928501, 1456.6067161866238, 1463.8975271730876, 1468.6401831551339, 5695.971520142372, 5734.541236701054, 5762.74067666956, 5767.500449882977, 5786.392428795, 6602.0, 6650.46796256308, 6692.531522793358, 6740.416002239568, 6799.524033317719, 5807.82576522705, 5814.738336774855, 5822.388649191858, 5850.590458667937, 5866.325372582122, 3480.547528821237, 3558.4840198171637, 3580.0154957386408, 3580.856765729394, 3610.9097272568397, 6546.639934803631, 6602.636854972927, 6621.437177839841, 6700.195976482853, 6746.730130794714, 6975.558554505882, 6992.2658120897595, 6994.125734283215, 6994.4404447644065, 7029.753958611526, 6455.419012288917, 6515.7067931943175, 6629.502787290972, 6647.567908085959, 6699.933000669931, 6715.865682686416, 6730.259671436236, 6765.632028789884, 6767.86464270702, 6778.610694652673, 6697.698603562949, 6705.0, 6709.295523970108, 6709.496787741036, 6714.563553369016, 6492.675366231575, 6503.1791098492495, 6547.70535325921, 6578.24350199714, 6641.369069938348, 5005.874853128701, 5011.4487406386, 5046.823361182488, 5056.165732654071, 5097.388313402415, 6446.8388290293115, 6701.296363881722, 6717.899231511629, 6751.291114432914, 6808.276689324111, 6396.264429590657, 6539.444147247537, 6539.901901471387, 6548.901766473602, 6585.934140658532, 6394.936050639434, 6522.315156908646, 6522.478201743944, 6544.149260596092, 6552.0, 6240.282367527792, 6269.216347956505, 6356.682165891594, 6426.5218999629415, 6461.57999730016, 6284.340144284967, 6414.807555773335, 6416.903746443901, 6496.220453545605, 6504.38208370204, 6237.906431403442, 6269.905951410824, 6270.874582508415, 6371.74513019474, 6407.967960160356], "value": 5085.8749502486635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.113388312512, 908.8182363527295, 917.8164367126574, 924.0251534630962, 924.9445033298002, 17406.129693515322, 17920.910395448005, 17955.371561995333, 18027.09864506776, 22652.207172748957, 21528.677069843965, 21616.243431479863, 21969.23107691231, 21971.34085977419, 22026.4493387665, 977.4623956823737, 985.9992108010339, 987.6493844685141, 1000.4947501511763, 1000.6197644894929, 898.1871406377239, 906.6690657909882, 980.8921018687938, 984.44378925907, 986.3982970388057, 1005.03516624041, 1046.638909576195, 1047.6228557719214, 1047.7904419116169, 1050.154625526451, 995.6017592962836, 1043.4156872151543, 1045.9581616735322, 1046.6284469013467, 1049.0715716590835, 745.0649434959091, 757.8029712274794, 776.2237762237762, 777.2111307023375, 777.4596655324551, 20001.0, 20234.291799786937, 20425.795742042537, 20429.284975025952, 20561.177552897865, 21442.249521266836, 21566.568668626696, 21933.451663708376, 22086.337409877728, 22116.88941555298, 15135.697286054217, 15404.922975385163, 15652.452164174314, 15661.92169039159, 15711.135887526181, 3594.1733401317842, 3615.529981102466, 3625.6011838697723, 3627.9818600907092, 3631.237440137574, 126889.36555317257, 127008.0, 129496.35251823775, 130159.0, 131766.34116829452, 16863.15684215784, 16872.746908796376, 17155.91422042882, 17279.481615551555, 17359.826401736074, 30653.69346306553, 31415.37169256602, 31989.200269993435, 31998.520022199686, 32098.19754506109, 7351.77944661661, 7747.457677962489, 8235.21765432283, 8804.427712198687, 9030.27757779376, 4057.4928133983253, 4198.097409057006, 4203.894902627459, 4236.152769446123, 4247.681423893158, 5333.466653334635, 5437.728113594305, 5461.890762184814, 5485.917711234335, 5500.22996780451, 1067.2849191042021, 1077.606673564159, 1078.8166011778017, 1082.7509672775307, 1091.2034215023077, 680.1498127340824, 695.1345574759457, 702.4380495603497, 710.3500297227979, 718.7879575525233, 10839.615284637368, 12211.633650990485, 12335.0, 12504.312262825631, 12767.808482872764, 690.6650274616807, 691.4192078653955, 704.3907020427396, 707.2785758526275, 713.4363852556526, 5614.157876318503, 5655.773769049274, 5657.490825825613, 5721.141828725725, 5747.109198074305, 102612.48693756484, 102875.0, 103891.0, 105163.0, 108948.91051089547, 88254.55872720724, 89444.0, 89525.0, 89800.5509972446, 95287.52356238312, 80982.0, 81363.0, 82635.0, 83746.58126709328, 85547.57226213954, 11716.004139648225, 11777.411129443664, 11884.34636095023, 12008.579699710468, 12391.318477483825, 33092.1726956828, 33156.50265245975, 33517.66482335243, 34698.826505867306, 35490.64509354976, 43038.56961430346, 44721.0, 44721.10557788761, 45275.0, 62036.37963620487, 18557.72163417523, 18885.0, 18981.810181898556, 19083.236670533024, 19607.509812254808, 19477.220911163397, 21781.0, 21875.890620546794, 21894.0, 22262.44343891351, 18264.0, 18748.81251187471, 18856.622867542847, 18870.622587548445, 18909.810901890804, 18865.71701424452, 19102.713459297844, 19287.324943626907, 19396.4181074568, 19493.8050619492, 17804.3768468103, 18019.279228831223, 18232.270709171484, 18672.81327186765, 18883.244670213036, 9142.405743626643, 9241.676541321021, 9439.81120377575, 9446.055394460498, 9637.903620963982, 13981.650458738613, 14065.648358791112, 14099.295035248402, 14129.516400778182, 14290.42838286457], "value": 8960.078652534508, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 97.0, 107.0, 109.0, 109.0, 112.0, 107.0, 107.0, 110.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 146.0, 165.0, 118.0, 144.0, 147.0, 126.0, 164.0, 118.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 162.0, 163.0, 163.0, 166.0, 165.0, 164.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 74.0, 178.0, 76.0, 74.0, 75.0, 73.0, 159.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 130.0, 78.0, 78.0, 78.0, 128.0, 80.0, 83.0, 122.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 120.0, 120.0, 114.0, 114.0, 114.0, 114.0, 119.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 154.0, 150.0, 150.0, 151.0, 157.0, 150.0, 150.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 93.0, 93.0, 95.0, 94.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 56.0, 54.0, 64.0, 59.0, 53.0, 60.0, 56.0, 54.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 58.0, 56.0, 54.0, 54.0, 55.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 79.0, 92.0, 77.0, 92.0, 96.0, 83.0, 100.0, 90.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 140.0, 131.0, 135.0, 130.0, 126.0, 132.0, 126.0, 179.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 180.0, 178.0, 193.0, 171.0, 176.0, 181.0, 174.0, 179.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 67.0, 69.0, 66.0, 65.0, 65.0, 68.0], "value": 67.8, "unit": "score"}]}]} 15:09:37 INFO - Return code: 0 15:09:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:09:37 INFO - # TBPL SUCCESS # 15:09:37 INFO - Running post-action listener: _package_coverage_data 15:09:37 INFO - Running post-action listener: _resource_record_post_action 15:09:37 INFO - [mozharness: 2017-08-08 22:09:37.284198Z] Finished run-tests step (success) 15:09:37 INFO - Running post-run listener: _resource_record_post_run 15:09:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7102464; Write bytes: 441126912; Read time: 3572; Write time: 275120 15:09:37 INFO - TinderboxPrint: CPU usage
13.2% 15:09:37 INFO - TinderboxPrint: I/O read bytes / time
7,102,464 / 3,572 15:09:37 INFO - TinderboxPrint: I/O write bytes / time
441,126,912 / 275,120 15:09:37 INFO - TinderboxPrint: CPU idle
8,284.8 (86.8%) 15:09:37 INFO - TinderboxPrint: CPU user
1,206.0 (12.6%) 15:09:37 INFO - TinderboxPrint: Swap in / out
0 / 0 15:09:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 177811456; Read time: 164; Write time: 95524 15:09:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:09:37 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4911104; Write bytes: 170299392; Read time: 3036; Write time: 84172 15:09:37 INFO - Running post-run listener: _upload_blobber_files 15:09:37 INFO - Blob upload gear active. 15:09:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:37 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 15:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:09:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:39 INFO - (blobuploader) - INFO - Done attempting. 15:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:45 INFO - (blobuploader) - INFO - Done attempting. 15:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:46 INFO - (blobuploader) - INFO - Done attempting. 15:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:46 INFO - (blobuploader) - INFO - Done attempting. 15:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:09:46 INFO - Return code: 0 15:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:09:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/888bb0e8906830010f0e8ddc4daa4842da61c386e3d50f64a79511a4f3bbd5a12b800d82394048e28bc014961113e733cee59041a01c97821b12193805f22c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e91715365954295c1795c5c3cc64e783e089af3b22b73ff55116af7056ef1361f766c422885fbad4482f33ce7d41236bbbb613f48d4da2763ee5f0200dbcbd46", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5087afb30e6003e4fdb9881180eec73231d3d0bb58d466322bda3110da01c8649fd676f4b0a3c05702a85be5b2d845e576b1926642144fc3fcecf07e6713f8e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83f2143b405b06e0799850086f6a190fa435c6093defea69fd2959a5171d68bceaae767ac364ed7dc90efb2b1857ba9d17504d17fdf0a57f27ca050f7194ded8"} 15:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:09:46 INFO - Contents: 15:09:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/888bb0e8906830010f0e8ddc4daa4842da61c386e3d50f64a79511a4f3bbd5a12b800d82394048e28bc014961113e733cee59041a01c97821b12193805f22c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e91715365954295c1795c5c3cc64e783e089af3b22b73ff55116af7056ef1361f766c422885fbad4482f33ce7d41236bbbb613f48d4da2763ee5f0200dbcbd46", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5087afb30e6003e4fdb9881180eec73231d3d0bb58d466322bda3110da01c8649fd676f4b0a3c05702a85be5b2d845e576b1926642144fc3fcecf07e6713f8e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83f2143b405b06e0799850086f6a190fa435c6093defea69fd2959a5171d68bceaae767ac364ed7dc90efb2b1857ba9d17504d17fdf0a57f27ca050f7194ded8"} 15:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:09:46 INFO - Copying logs to upload dir... 15:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.719769 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-08 15:09:46.922668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:46.930028) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/888bb0e8906830010f0e8ddc4daa4842da61c386e3d50f64a79511a4f3bbd5a12b800d82394048e28bc014961113e733cee59041a01c97821b12193805f22c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e91715365954295c1795c5c3cc64e783e089af3b22b73ff55116af7056ef1361f766c422885fbad4482f33ce7d41236bbbb613f48d4da2763ee5f0200dbcbd46", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5087afb30e6003e4fdb9881180eec73231d3d0bb58d466322bda3110da01c8649fd676f4b0a3c05702a85be5b2d845e576b1926642144fc3fcecf07e6713f8e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83f2143b405b06e0799850086f6a190fa435c6093defea69fd2959a5171d68bceaae767ac364ed7dc90efb2b1857ba9d17504d17fdf0a57f27ca050f7194ded8"} build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/888bb0e8906830010f0e8ddc4daa4842da61c386e3d50f64a79511a4f3bbd5a12b800d82394048e28bc014961113e733cee59041a01c97821b12193805f22c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e91715365954295c1795c5c3cc64e783e089af3b22b73ff55116af7056ef1361f766c422885fbad4482f33ce7d41236bbbb613f48d4da2763ee5f0200dbcbd46", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5087afb30e6003e4fdb9881180eec73231d3d0bb58d466322bda3110da01c8649fd676f4b0a3c05702a85be5b2d845e576b1926642144fc3fcecf07e6713f8e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83f2143b405b06e0799850086f6a190fa435c6093defea69fd2959a5171d68bceaae767ac364ed7dc90efb2b1857ba9d17504d17fdf0a57f27ca050f7194ded8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:46.957835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:46.958180) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502226292.492191-1712022910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:47.039553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:09:47.042887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:09:47.043178) ========= ========= Total master_lag: 0.26 =========