builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1502851341.0 results: success (0) revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:20.997617) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:20.998149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:20.998495) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.018126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.018461) ========= 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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 19:42:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-15 19:42:21 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145562 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.205250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.205606) ========= 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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017853 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.301226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-15 19:42:21.301631) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6966f27380bf2e3e5ace3507f600852bd3ed9dbd --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 6966f27380bf2e3e5ace3507f600852bd3ed9dbd --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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 19:42:21,463 truncating revision to first 12 chars 2017-08-15 19:42:21,463 Setting DEBUG logging. 2017-08-15 19:42:21,463 attempt 1/10 2017-08-15 19:42:21,463 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6966f27380bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 19:42:22,056 attempt 1/10 2017-08-15 19:42:22,586 current task status: no status available at this point. state: STARTED 2017-08-15 19:42:22,586 sleeping for 9.00s (attempt 1/10) 2017-08-15 19:42:31,596 attempt 2/10 2017-08-15 19:42:31,932 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-15 19:42:32,214 unpacking tar archive at: mozilla-central-6966f27380bf/testing/mozharness/ program finished with exit code 0 elapsedTime=11.124479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-15 19:42:32.440888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:32.444278) ========= script_repo_revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:32.444749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:32.445076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:32.457338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 19:42:32.457782) ========= /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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:32 INFO - MultiFileLogger online at 20170815 19:42:32 in /builds/slave/test 19:42:32 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 19:42:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:32 INFO - {'append_to_log': False, 19:42:32 INFO - 'base_work_dir': '/builds/slave/test', 19:42:32 INFO - 'blob_upload_branch': 'Firefox', 19:42:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:32 INFO - 'branch': 'Firefox', 19:42:32 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:32 INFO - 'code_coverage': False, 19:42:32 INFO - 'config_files': ('talos/linux_config.py',), 19:42:32 INFO - 'default_actions': ('clobber', 19:42:32 INFO - 'read-buildbot-config', 19:42:32 INFO - 'download-and-extract', 19:42:32 INFO - 'populate-webroot', 19:42:32 INFO - 'create-virtualenv', 19:42:32 INFO - 'install', 19:42:32 INFO - 'setup-mitmproxy', 19:42:32 INFO - 'run-tests'), 19:42:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:32 INFO - 'disable_ccov_upload': False, 19:42:32 INFO - 'download_minidump_stackwalk': True, 19:42:32 INFO - 'download_symbols': 'ondemand', 19:42:32 INFO - 'enable_stylo': False, 19:42:32 INFO - 'enable_webrender': False, 19:42:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:32 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:32 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:32 INFO - 'gecko_profile': False, 19:42:32 INFO - 'gecko_profile_interval': 0, 19:42:32 INFO - 'installer_path': 'installer.exe', 19:42:32 INFO - 'log_level': 'info', 19:42:32 INFO - 'log_name': 'talos', 19:42:32 INFO - 'log_to_console': True, 19:42:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:32 INFO - 'opt_config_files': (), 19:42:32 INFO - 'pip_index': False, 19:42:32 INFO - 'suite': 'dromaeojs-e10s', 19:42:32 INFO - 'system_bits': '32', 19:42:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:32 INFO - 'title': 'talos-linux64-ix-065', 19:42:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:32 INFO - 'use_talos_json': True, 19:42:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:32 INFO - 'work_dir': 'build'} 19:42:32 INFO - [mozharness: 2017-08-16 02:42:32.723184Z] Running clobber step. 19:42:32 INFO - Running pre-action listener: _resource_record_pre_action 19:42:32 INFO - Running main action method: clobber 19:42:32 INFO - rmtree: /builds/slave/test/build 19:42:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:33 INFO - Running post-action listener: _resource_record_post_action 19:42:33 INFO - [mozharness: 2017-08-16 02:42:33.754524Z] Finished clobber step (success) 19:42:33 INFO - [mozharness: 2017-08-16 02:42:33.754627Z] Running read-buildbot-config step. 19:42:33 INFO - Running pre-action listener: _resource_record_pre_action 19:42:33 INFO - Running main action method: read_buildbot_config 19:42:33 INFO - Using buildbot properties: 19:42:33 INFO - { 19:42:33 INFO - "project": "", 19:42:33 INFO - "product": "firefox", 19:42:33 INFO - "who": "kwierso@gmail.com", 19:42:33 INFO - "installer_path": "public/build/target.tar.bz2", 19:42:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:42:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:42:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:42:33 INFO - "stage_platform": "linux64-stylo", 19:42:33 INFO - "basedir": "/builds/slave/test", 19:42:33 INFO - "buildnumber": 270, 19:42:33 INFO - "platform": "ubuntu64_hw_stylo", 19:42:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:42:33 INFO - "slavebuilddir": "test", 19:42:33 INFO - "taskId": "D1IM0xGVQ3qbmghbAytm-g", 19:42:33 INFO - "branch": "mozilla-central", 19:42:33 INFO - "script_repo_revision": "production", 19:42:33 INFO - "revision": "6966f27380bf2e3e5ace3507f600852bd3ed9dbd", 19:42:33 INFO - "slavename": "talos-linux64-ix-065", 19:42:33 INFO - "repo_path": "mozilla-central" 19:42:33 INFO - } 19:42:33 INFO - Finding installer, test and symbols from parent task. 19:42:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1IM0xGVQ3qbmghbAytm-g'}, attempt #1 19:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1IM0xGVQ3qbmghbAytm-g'}, attempt #1 19:42:34 INFO - Task dependencies: YvnAGiJcTqymla8mJLMVSg 19:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg'}, attempt #1 19:42:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:42:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip 19:42:35 INFO - Running post-action listener: _resource_record_post_action 19:42:35 INFO - [mozharness: 2017-08-16 02:42:35.129182Z] Finished read-buildbot-config step (success) 19:42:35 INFO - [mozharness: 2017-08-16 02:42:35.129450Z] Running download-and-extract step. 19:42:35 INFO - Running pre-action listener: _resource_record_pre_action 19:42:35 INFO - Running main action method: download_and_extract 19:42:35 INFO - mkdir: /builds/slave/test/build/tests 19:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:42:35 INFO - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:42:35 INFO - Downloaded 989 bytes. 19:42:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:42:35 INFO - Using the following test package requirements: 19:42:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:42:35 INFO - u'common': [u'target.common.tests.zip'], 19:42:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:42:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:42:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:42:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:42:35 INFO - u'mozbase': [u'target.common.tests.zip'], 19:42:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:42:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:42:35 INFO - u'web-platform': [u'target.common.tests.zip', 19:42:35 INFO - u'target.web-platform.tests.tar.gz'], 19:42:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:42:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:42:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip 19:42:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:42:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:37 INFO - Content-Length response header: 54002789 19:42:37 INFO - Bytes received: 54002789 19:42:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:42:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip 19:42:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:42:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:49 INFO - Content-Length response header: 54002789 19:42:49 INFO - Bytes received: 54002789 19:43:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.talos.tests.zip 19:43:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:43:01 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.talos.tests.zip into memory 19:43:02 INFO - Content-Length response header: 14496050 19:43:02 INFO - Bytes received: 14496050 19:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:02 INFO - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:43:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:43:05 INFO - Downloaded 62021852 bytes. 19:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:05 INFO - mkdir: /builds/slave/test/properties 19:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:05 INFO - Contents: 19:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:05 INFO - Running post-action listener: _resource_record_post_action 19:43:05 INFO - Running post-action listener: set_extra_try_arguments 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.347856Z] Finished download-and-extract step (success) 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.348086Z] Running populate-webroot step. 19:43:05 INFO - Running pre-action listener: _resource_record_pre_action 19:43:05 INFO - Running main action method: populate_webroot 19:43:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['damp', 'tps']}, 19:43:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:43:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:43:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:05 INFO - 'ts_paint', 19:43:05 INFO - 'tpaint', 19:43:05 INFO - 'sessionrestore', 19:43:05 INFO - 'sessionrestore_many_windows', 19:43:05 INFO - 'sessionrestore_no_auto_restore', 19:43:05 INFO - 'tabpaint']}, 19:43:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:43:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:43:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:05 INFO - 'tsvgr_opacity', 19:43:05 INFO - 'tart', 19:43:05 INFO - 'tscrollx', 19:43:05 INFO - 'tsvg_static']}, 19:43:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:43:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--stylo', 19:43:05 INFO - '--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--stylo', 19:43:05 INFO - '--stylo-threads=1', 19:43:05 INFO - '--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'talos_options': ['--xperf_path', 19:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:05 INFO - 'tests': ['tp5n']}}} 19:43:05 INFO - Running post-action listener: _resource_record_post_action 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.364727Z] Finished populate-webroot step (success) 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.364818Z] Running create-virtualenv step. 19:43:05 INFO - Running pre-action listener: _resource_record_pre_action 19:43:05 INFO - Running main action method: create_virtualenv 19:43:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:05 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 19:43:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:43:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:05 INFO - Using real prefix '/usr' 19:43:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:07 INFO - Installing pip.................done. 19:43:07 INFO - Return code: 0 19:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:43:08 INFO - Reading from file tmpfile_stdout 19:43:08 INFO - Output received: 19:43:08 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) 19:43:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:08 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')]} 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:08 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')]} 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:08 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:08 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 19:43:08 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 19:43:08 INFO - Using env: {'DISPLAY': ':0', 19:43:08 INFO - 'HOME': '/home/cltbld', 19:43:08 INFO - 'LANG': 'en_US.UTF-8', 19:43:08 INFO - 'LANGUAGE': 'en_US:en', 19:43:08 INFO - 'LOGNAME': 'cltbld', 19:43:08 INFO - 'MAIL': '/var/mail/cltbld', 19:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:08 INFO - 'MOZ_NO_REMOTE': '1', 19:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:08 INFO - 'NO_EM_RESTART': '1', 19:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:08 INFO - 'PWD': '/builds/slave/test', 19:43:08 INFO - 'SHELL': '/bin/bash', 19:43:08 INFO - 'SHLVL': '1', 19:43:08 INFO - 'TERM': 'linux', 19:43:08 INFO - 'TMOUT': '86400', 19:43:08 INFO - 'USER': 'cltbld', 19:43:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:08 INFO - '_': '/tools/buildbot/bin/python'} 19:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:08 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 19:43:08 INFO - Cleaning up... 19:43:08 INFO - Return code: 0 19:43:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:43:08 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')]} 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:08 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')]} 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:08 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:08 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 19:43:08 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 19:43:08 INFO - Using env: {'DISPLAY': ':0', 19:43:08 INFO - 'HOME': '/home/cltbld', 19:43:08 INFO - 'LANG': 'en_US.UTF-8', 19:43:08 INFO - 'LANGUAGE': 'en_US:en', 19:43:08 INFO - 'LOGNAME': 'cltbld', 19:43:08 INFO - 'MAIL': '/var/mail/cltbld', 19:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:08 INFO - 'MOZ_NO_REMOTE': '1', 19:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:08 INFO - 'NO_EM_RESTART': '1', 19:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:08 INFO - 'PWD': '/builds/slave/test', 19:43:08 INFO - 'SHELL': '/bin/bash', 19:43:08 INFO - 'SHLVL': '1', 19:43:08 INFO - 'TERM': 'linux', 19:43:08 INFO - 'TMOUT': '86400', 19:43:08 INFO - 'USER': 'cltbld', 19:43:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:08 INFO - '_': '/tools/buildbot/bin/python'} 19:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:08 INFO - Downloading/unpacking psutil>=3.1.1 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:09 INFO - Installing collected packages: psutil 19:43:09 INFO - Running setup.py install for psutil 19:43:09 INFO - building 'psutil._psutil_linux' extension 19:43:09 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 19:43:10 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 19:43:10 INFO - building 'psutil._psutil_posix' extension 19:43:10 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 19:43:10 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 19:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:10 INFO - Successfully installed psutil 19:43:10 INFO - Cleaning up... 19:43:10 INFO - Return code: 0 19:43:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:10 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:10 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 19:43:10 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 19:43:10 INFO - Using env: {'DISPLAY': ':0', 19:43:10 INFO - 'HOME': '/home/cltbld', 19:43:10 INFO - 'LANG': 'en_US.UTF-8', 19:43:10 INFO - 'LANGUAGE': 'en_US:en', 19:43:10 INFO - 'LOGNAME': 'cltbld', 19:43:10 INFO - 'MAIL': '/var/mail/cltbld', 19:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:10 INFO - 'MOZ_NO_REMOTE': '1', 19:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:10 INFO - 'NO_EM_RESTART': '1', 19:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:10 INFO - 'PWD': '/builds/slave/test', 19:43:10 INFO - 'SHELL': '/bin/bash', 19:43:10 INFO - 'SHLVL': '1', 19:43:10 INFO - 'TERM': 'linux', 19:43:10 INFO - 'TMOUT': '86400', 19:43:10 INFO - 'USER': 'cltbld', 19:43:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:10 INFO - '_': '/tools/buildbot/bin/python'} 19:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:43:11 INFO - Installing collected packages: mozsystemmonitor 19:43:11 INFO - Running setup.py install for mozsystemmonitor 19:43:11 INFO - Successfully installed mozsystemmonitor 19:43:11 INFO - Cleaning up... 19:43:11 INFO - Return code: 0 19:43:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:43:11 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')]} 19:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:11 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')]} 19:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:11 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:11 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 19:43:11 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 19:43:11 INFO - Using env: {'DISPLAY': ':0', 19:43:11 INFO - 'HOME': '/home/cltbld', 19:43:11 INFO - 'LANG': 'en_US.UTF-8', 19:43:11 INFO - 'LANGUAGE': 'en_US:en', 19:43:11 INFO - 'LOGNAME': 'cltbld', 19:43:11 INFO - 'MAIL': '/var/mail/cltbld', 19:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:11 INFO - 'MOZ_NO_REMOTE': '1', 19:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:11 INFO - 'NO_EM_RESTART': '1', 19:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:11 INFO - 'PWD': '/builds/slave/test', 19:43:11 INFO - 'SHELL': '/bin/bash', 19:43:11 INFO - 'SHLVL': '1', 19:43:11 INFO - 'TERM': 'linux', 19:43:11 INFO - 'TMOUT': '86400', 19:43:11 INFO - 'USER': 'cltbld', 19:43:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:11 INFO - '_': '/tools/buildbot/bin/python'} 19:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:12 INFO - Downloading/unpacking jsonschema==2.5.1 19:43:12 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 19:43:12 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 19:43:12 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 19:43:12 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 19:43:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:13 INFO - warning: no files found matching '*.txt' 19:43:13 INFO - no previously-included directories found matching 'build' 19:43:13 INFO - no previously-included directories found matching 'dist' 19:43:13 INFO - no previously-included directories found matching '.git*' 19:43:13 INFO - Installing collected packages: jsonschema, functools32 19:43:13 INFO - Running setup.py install for functools32 19:43:13 INFO - warning: no files found matching '*.txt' 19:43:13 INFO - no previously-included directories found matching 'build' 19:43:13 INFO - no previously-included directories found matching 'dist' 19:43:13 INFO - no previously-included directories found matching '.git*' 19:43:13 INFO - Successfully installed jsonschema functools32 19:43:13 INFO - Cleaning up... 19:43:13 INFO - Return code: 0 19:43:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:43:13 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')]} 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:13 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')]} 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:13 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:13 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 19:43:13 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 19:43:13 INFO - Using env: {'DISPLAY': ':0', 19:43:13 INFO - 'HOME': '/home/cltbld', 19:43:13 INFO - 'LANG': 'en_US.UTF-8', 19:43:13 INFO - 'LANGUAGE': 'en_US:en', 19:43:13 INFO - 'LOGNAME': 'cltbld', 19:43:13 INFO - 'MAIL': '/var/mail/cltbld', 19:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:13 INFO - 'MOZ_NO_REMOTE': '1', 19:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:13 INFO - 'NO_EM_RESTART': '1', 19:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:13 INFO - 'PWD': '/builds/slave/test', 19:43:13 INFO - 'SHELL': '/bin/bash', 19:43:13 INFO - 'SHLVL': '1', 19:43:13 INFO - 'TERM': 'linux', 19:43:13 INFO - 'TMOUT': '86400', 19:43:13 INFO - 'USER': 'cltbld', 19:43:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:13 INFO - '_': '/tools/buildbot/bin/python'} 19:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:43:13 INFO - Cleaning up... 19:43:13 INFO - Return code: 0 19:43:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43:13 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')]} 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:13 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')]} 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:13 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:13 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 19:43:13 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 19:43:13 INFO - Using env: {'DISPLAY': ':0', 19:43:13 INFO - 'HOME': '/home/cltbld', 19:43:13 INFO - 'LANG': 'en_US.UTF-8', 19:43:13 INFO - 'LANGUAGE': 'en_US:en', 19:43:13 INFO - 'LOGNAME': 'cltbld', 19:43:13 INFO - 'MAIL': '/var/mail/cltbld', 19:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:13 INFO - 'MOZ_NO_REMOTE': '1', 19:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:13 INFO - 'NO_EM_RESTART': '1', 19:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:13 INFO - 'PWD': '/builds/slave/test', 19:43:13 INFO - 'SHELL': '/bin/bash', 19:43:13 INFO - 'SHLVL': '1', 19:43:13 INFO - 'TERM': 'linux', 19:43:13 INFO - 'TMOUT': '86400', 19:43:13 INFO - 'USER': 'cltbld', 19:43:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:13 INFO - '_': '/tools/buildbot/bin/python'} 19:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 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 19:43:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43:15 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 19:43:15 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 19:43:15 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 19:43:15 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 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43:15 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 19:43:15 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 19:43:15 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 19:43:15 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 19:43:15 INFO - Downloading docopt-0.6.1.tar.gz 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:15 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:15 INFO - Running setup.py install for blobuploader 19:43:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:15 INFO - Running setup.py install for requests 19:43:16 INFO - Running setup.py install for docopt 19:43:16 INFO - Successfully installed blobuploader requests docopt 19:43:16 INFO - Cleaning up... 19:43:16 INFO - Return code: 0 19:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43: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')]} 19:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:16 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:16 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 19:43:16 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 19:43:16 INFO - Using env: {'DISPLAY': ':0', 19:43:16 INFO - 'HOME': '/home/cltbld', 19:43:16 INFO - 'LANG': 'en_US.UTF-8', 19:43:16 INFO - 'LANGUAGE': 'en_US:en', 19:43:16 INFO - 'LOGNAME': 'cltbld', 19:43:16 INFO - 'MAIL': '/var/mail/cltbld', 19:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:16 INFO - 'MOZ_NO_REMOTE': '1', 19:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:16 INFO - 'NO_EM_RESTART': '1', 19:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:16 INFO - 'PWD': '/builds/slave/test', 19:43:16 INFO - 'SHELL': '/bin/bash', 19:43:16 INFO - 'SHLVL': '1', 19:43:16 INFO - 'TERM': 'linux', 19:43:16 INFO - 'TMOUT': '86400', 19:43:16 INFO - 'USER': 'cltbld', 19:43:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:16 INFO - '_': '/tools/buildbot/bin/python'} 19:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:16 INFO - Running setup.py (path:/tmp/pip-wfOkw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:16 INFO - Running setup.py (path:/tmp/pip-P4YG4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:16 INFO - Running setup.py (path:/tmp/pip-PD6SRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:16 INFO - Running setup.py (path:/tmp/pip-XzWA8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:16 INFO - Running setup.py (path:/tmp/pip-fm57eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:17 INFO - Running setup.py (path:/tmp/pip-8_UyrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:17 INFO - Running setup.py (path:/tmp/pip-mmkHUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:17 INFO - Running setup.py (path:/tmp/pip-2B2rp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:17 INFO - Running setup.py (path:/tmp/pip-svCD4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:17 INFO - Running setup.py (path:/tmp/pip-RgAxLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:17 INFO - Running setup.py (path:/tmp/pip-MnYCQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:17 INFO - Running setup.py (path:/tmp/pip-S1BBWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:17 INFO - Running setup.py (path:/tmp/pip-TCCCj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:17 INFO - Running setup.py (path:/tmp/pip-H6hGbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:17 INFO - Running setup.py (path:/tmp/pip-HtUdHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:17 INFO - Running setup.py (path:/tmp/pip-ENWagN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:17 INFO - Running setup.py (path:/tmp/pip-9pu__j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:17 INFO - Running setup.py install for manifestparser 19:43:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozcrash 19:43:18 INFO - Running setup.py install for mozdebug 19:43:18 INFO - Running setup.py install for mozdevice 19:43:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozfile 19:43:18 INFO - Running setup.py install for mozhttpd 19:43:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozinfo 19:43:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozInstall 19:43:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozleak 19:43:18 INFO - Running setup.py install for mozlog 19:43:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for moznetwork 19:43:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozprocess 19:43:19 INFO - Running setup.py install for mozprofile 19:43:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozrunner 19:43:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozscreenshot 19:43:19 INFO - Running setup.py install for moztest 19:43:19 INFO - Running setup.py install for mozversion 19:43:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:19 INFO - Cleaning up... 19:43:19 INFO - Return code: 0 19:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:19 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')]} 19:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:19 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')]} 19:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:19 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:19 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 19:43:19 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 19:43:19 INFO - Using env: {'DISPLAY': ':0', 19:43:19 INFO - 'HOME': '/home/cltbld', 19:43:19 INFO - 'LANG': 'en_US.UTF-8', 19:43:19 INFO - 'LANGUAGE': 'en_US:en', 19:43:19 INFO - 'LOGNAME': 'cltbld', 19:43:19 INFO - 'MAIL': '/var/mail/cltbld', 19:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:19 INFO - 'MOZ_NO_REMOTE': '1', 19:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:19 INFO - 'NO_EM_RESTART': '1', 19:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:19 INFO - 'PWD': '/builds/slave/test', 19:43:19 INFO - 'SHELL': '/bin/bash', 19:43:19 INFO - 'SHLVL': '1', 19:43:19 INFO - 'TERM': 'linux', 19:43:19 INFO - 'TMOUT': '86400', 19:43:19 INFO - 'USER': 'cltbld', 19:43:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:19 INFO - '_': '/tools/buildbot/bin/python'} 19:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:19 INFO - Running setup.py (path:/tmp/pip-ON9Ik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:19 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)) 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:19 INFO - Running setup.py (path:/tmp/pip-8MghSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:20 INFO - Running setup.py (path:/tmp/pip-9vA86N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:20 INFO - Running setup.py (path:/tmp/pip-9Wwgdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:20 INFO - Running setup.py (path:/tmp/pip-M0zgXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:20 INFO - Running setup.py (path:/tmp/pip-s5Mm1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:20 INFO - Running setup.py (path:/tmp/pip-_OjY7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:20 INFO - Running setup.py (path:/tmp/pip-os1717-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:20 INFO - Running setup.py (path:/tmp/pip-1xiGNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:20 INFO - Running setup.py (path:/tmp/pip-FMmyWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:20 INFO - Running setup.py (path:/tmp/pip-KbjYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:20 INFO - Running setup.py (path:/tmp/pip-evUVJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:20 INFO - Running setup.py (path:/tmp/pip-HgXYto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:20 INFO - Running setup.py (path:/tmp/pip-84bc4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:20 INFO - Running setup.py (path:/tmp/pip-N6hhxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:20 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)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:20 INFO - Running setup.py (path:/tmp/pip-fypG5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:21 INFO - Running setup.py (path:/tmp/pip-chGYYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:21 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)) 19:43:21 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)) 19:43:21 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)) 19:43:21 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)) 19:43:21 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)) 19:43:21 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)) 19:43:21 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)) 19:43:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43: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 19:43: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 19:43: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 19:43: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 19:43:22 INFO - Downloading blessings-1.6.tar.gz 19:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:22 INFO - Installing collected packages: blessings 19:43:22 INFO - Running setup.py install for blessings 19:43:22 INFO - Successfully installed blessings 19:43:22 INFO - Cleaning up... 19:43:22 INFO - Return code: 0 19:43:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:22 INFO - Reading from file tmpfile_stdout 19:43:22 INFO - Current package versions: 19:43:22 INFO - argparse == 1.2.1 19:43:22 INFO - blessings == 1.6 19:43:22 INFO - blobuploader == 1.2.4 19:43:22 INFO - docopt == 0.6.1 19:43:22 INFO - functools32 == 3.2.3-2 19:43:22 INFO - jsonschema == 2.5.1 19:43:22 INFO - manifestparser == 1.1 19:43:22 INFO - mozInstall == 1.13 19:43:22 INFO - mozcrash == 1.0 19:43:22 INFO - mozdebug == 0.1 19:43:22 INFO - mozdevice == 0.51 19:43:22 INFO - mozfile == 1.2 19:43:22 INFO - mozhttpd == 0.7 19:43:22 INFO - mozinfo == 0.10 19:43:22 INFO - mozleak == 0.1 19:43:22 INFO - mozlog == 3.5 19:43:22 INFO - moznetwork == 0.27 19:43:22 INFO - mozprocess == 0.25 19:43:22 INFO - mozprofile == 0.28 19:43:22 INFO - mozrunner == 6.13 19:43:22 INFO - mozscreenshot == 0.1 19:43:22 INFO - mozsystemmonitor == 0.3 19:43:22 INFO - moztest == 0.8 19:43:22 INFO - mozversion == 1.4 19:43:22 INFO - psutil == 3.1.1 19:43:22 INFO - requests == 1.2.3 19:43:22 INFO - wsgiref == 0.1.2 19:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:22 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')]} 19:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:22 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')]} 19:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:22 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:22 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 19:43:22 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 19:43:22 INFO - Using env: {'DISPLAY': ':0', 19:43:22 INFO - 'HOME': '/home/cltbld', 19:43:22 INFO - 'LANG': 'en_US.UTF-8', 19:43:22 INFO - 'LANGUAGE': 'en_US:en', 19:43:22 INFO - 'LOGNAME': 'cltbld', 19:43:22 INFO - 'MAIL': '/var/mail/cltbld', 19:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:22 INFO - 'MOZ_NO_REMOTE': '1', 19:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:22 INFO - 'NO_EM_RESTART': '1', 19:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:22 INFO - 'PWD': '/builds/slave/test', 19:43:22 INFO - 'SHELL': '/bin/bash', 19:43:22 INFO - 'SHLVL': '1', 19:43:22 INFO - 'TERM': 'linux', 19:43:22 INFO - 'TMOUT': '86400', 19:43:22 INFO - 'USER': 'cltbld', 19:43:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:22 INFO - '_': '/tools/buildbot/bin/python'} 19:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:43:22 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 19:43:22 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 19:43:22 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 19:43:22 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 19:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:43:24 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)) 19:43:24 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)) 19:43:24 INFO - Installing collected packages: simplejson 19:43:24 INFO - Running setup.py install for simplejson 19:43:24 INFO - building 'simplejson._speedups' extension 19:43:24 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 19:43:25 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 19:43:25 INFO - Successfully installed simplejson 19:43:25 INFO - Cleaning up... 19:43:25 INFO - Return code: 0 19:43:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43:25 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')]} 19:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:25 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')]} 19:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:25 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 0x28001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, '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': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', '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 19:43:25 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 19:43:25 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 19:43:25 INFO - Using env: {'DISPLAY': ':0', 19:43:25 INFO - 'HOME': '/home/cltbld', 19:43:25 INFO - 'LANG': 'en_US.UTF-8', 19:43:25 INFO - 'LANGUAGE': 'en_US:en', 19:43:25 INFO - 'LOGNAME': 'cltbld', 19:43:25 INFO - 'MAIL': '/var/mail/cltbld', 19:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:25 INFO - 'MOZ_NO_REMOTE': '1', 19:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:25 INFO - 'NO_EM_RESTART': '1', 19:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:25 INFO - 'PWD': '/builds/slave/test', 19:43:25 INFO - 'SHELL': '/bin/bash', 19:43:25 INFO - 'SHLVL': '1', 19:43:25 INFO - 'TERM': 'linux', 19:43:25 INFO - 'TMOUT': '86400', 19:43:25 INFO - 'USER': 'cltbld', 19:43:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:25 INFO - '_': '/tools/buildbot/bin/python'} 19:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:43:25 INFO - Cleaning up... 19:43:25 INFO - Return code: 0 19:43:25 INFO - Running post-action listener: _resource_record_post_action 19:43:25 INFO - Running post-action listener: _start_resource_monitoring 19:43:25 INFO - Starting resource monitoring. 19:43:25 INFO - [mozharness: 2017-08-16 02:43:25.415617Z] Finished create-virtualenv step (success) 19:43:25 INFO - [mozharness: 2017-08-16 02:43:25.416134Z] Running install step. 19:43:25 INFO - Running pre-action listener: _resource_record_pre_action 19:43:25 INFO - Running main action method: install 19:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:25 INFO - Reading from file tmpfile_stdout 19:43:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:25 INFO - Reading from file tmpfile_stdout 19:43:25 INFO - Output received: 19:43:25 INFO - Usage: mozinstall [options] installer 19:43:25 INFO - Options: 19:43:25 INFO - -h, --help show this help message and exit 19:43:25 INFO - -d DEST, --destination=DEST 19:43:25 INFO - Directory to install application into. [default: 19:43:25 INFO - "/builds/slave/test"] 19:43:25 INFO - --app=APP Application being installed. [default: firefox] 19:43:25 INFO - mkdir: /builds/slave/test/build/application 19:43:25 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'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:43:44 INFO - Reading from file tmpfile_stdout 19:43:44 INFO - Output received: 19:43:44 INFO - /builds/slave/test/build/application/firefox/firefox 19:43:44 INFO - Running post-action listener: _resource_record_post_action 19:43:44 INFO - [mozharness: 2017-08-16 02:43:44.056725Z] Finished install step (success) 19:43:44 INFO - [mozharness: 2017-08-16 02:43:44.057068Z] Running setup-mitmproxy step. 19:43:44 INFO - Running pre-action listener: _resource_record_pre_action 19:43:44 INFO - Running main action method: setup_mitmproxy 19:43:44 INFO - Skipping: mitmproxy is not required 19:43:44 INFO - Running post-action listener: _resource_record_post_action 19:43:44 INFO - [mozharness: 2017-08-16 02:43:44.058768Z] Finished setup-mitmproxy step (success) 19:43:44 INFO - [mozharness: 2017-08-16 02:43:44.059081Z] Running run-tests step. 19:43:44 INFO - Running pre-action listener: _resource_record_pre_action 19:43:44 INFO - Running pre-action listener: _set_gcov_prefix 19:43:44 INFO - Running main action method: run_tests 19:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:44 INFO - Python 2.7.3 19:43:44 INFO - Return code: 0 19:43:44 INFO - grabbing minidump binary from tooltool 19:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:44 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 0x2aa4cc0>, '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 0x2aa5cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:44 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 19:43:44 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 19:43:44 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 19:43:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:44 INFO - Return code: 0 19:43:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:43:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:44 INFO - ENV: RUST_BACKTRACE is now full 19:43:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:43:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:44 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/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:43:44 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/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 19:43:44 INFO - Using env: {'DISPLAY': ':0', 19:43:44 INFO - 'HOME': '/home/cltbld', 19:43:44 INFO - 'LANG': 'en_US.UTF-8', 19:43:44 INFO - 'LANGUAGE': 'en_US:en', 19:43:44 INFO - 'LOGNAME': 'cltbld', 19:43:44 INFO - 'MAIL': '/var/mail/cltbld', 19:43:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:44 INFO - 'MOZ_NO_REMOTE': '1', 19:43:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:44 INFO - 'NO_EM_RESTART': '1', 19:43:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:44 INFO - 'PWD': '/builds/slave/test', 19:43:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:44 INFO - 'RUST_BACKTRACE': 'full', 19:43:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:43:44 INFO - 'SHELL': '/bin/bash', 19:43:44 INFO - 'SHLVL': '1', 19:43:44 INFO - 'STYLO_FORCE_ENABLED': '1', 19:43:44 INFO - 'TERM': 'linux', 19:43:44 INFO - 'TMOUT': '86400', 19:43:44 INFO - 'USER': 'cltbld', 19:43:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320', 19:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:44 INFO - '_': '/tools/buildbot/bin/python'} 19:43:44 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/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:43:44 INFO - mozversion application_buildid: 20170816015150 19:43:44 INFO - mozversion application_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:44 INFO - mozversion application_display_name: Nightly 19:43:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:44 INFO - mozversion application_name: Firefox 19:43:44 INFO - mozversion application_remotingname: firefox 19:43:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:43:44 INFO - mozversion application_vendor: Mozilla 19:43:44 INFO - mozversion application_version: 57.0a1 19:43:44 INFO - mozversion platform_buildid: 20170816015150 19:43:44 INFO - mozversion platform_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:43:44 INFO - mozversion platform_version: 57.0a1 19:43:44 INFO - using testdate: 1502851424 19:43:44 INFO - actual date: 1502851424 19:43:44 INFO - starting webserver on 'localhost:34692' 19:43:44 INFO - SUITE-START | Running 2 tests 19:43:44 INFO - TEST-START | dromaeo_css 19:43:44 INFO - Initialising browser for dromaeo_css test... 19:43:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34692/getInfo.html -profile /tmp/tmpSlLdGF/profile 19:43:44 INFO - TEST-INFO | started process 23200 (/builds/slave/test/build/application/firefox/firefox http://localhost:34692/getInfo.html) 19:43:50 INFO - TEST-INFO | 23200: exit 0 19:43:50 INFO - Browser initialized. 19:43:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:50 INFO - TEST-INFO | started process 23437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSlLdGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:51 INFO - PID 23437 | 19:43:51 INFO - PID 23437 | (/builds/slave/test/build/application/firefox/firefox:23491): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:43:51 INFO - PID 23437 | 19:44:01 INFO - PID 23437 | RSS: Main: 167378944 19:44:01 INFO - PID 23437 | 19:46:59 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34692/tests/dromaeo/cssquery-ext.html) 19:47:01 INFO - PID 23437 | RSS: Main: 174694400 19:47:01 INFO - PID 23437 | 19:50:02 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-ext.html (next: http://localhost:34692/tests/dromaeo/cssquery-jquery.html) 19:50:03 INFO - PID 23437 | RSS: Main: 172404736 19:50:03 INFO - PID 23437 | 19:53:05 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34692/tests/dromaeo/cssquery-mootools.html) 19:53:05 INFO - PID 23437 | RSS: Main: 174084096 19:53:05 INFO - PID 23437 | 19:56:07 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34692/tests/dromaeo/cssquery-prototype.html) 19:56:08 INFO - PID 23437 | RSS: Main: 172621824 19:56:08 INFO - PID 23437 | 19:59:11 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34692/tests/dromaeo/cssquery-yui.html) 19:59:12 INFO - PID 23437 | RSS: Main: 176005120 19:59:12 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | Cycle 1(1): loaded http://localhost:34692/tests/dromaeo/cssquery-yui.html (next: http://localhost:34692/tests/dromaeo/cssquery-dojo.html) 20:02:14 INFO - PID 23437 | RSS: Main: 175058944 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | __start_tp_report 20:02:14 INFO - PID 23437 | _x_x_mozilla_page_load 20:02:14 INFO - PID 23437 | _x_x_mozilla_page_load_details 20:02:14 INFO - PID 23437 | |i|pagename|runs| 20:02:14 INFO - PID 23437 | |0;dojo.html;3145.2294187923962;3158.526221066841;3164.224764932591;3191.9840400797993;3202.0393881835444;6082.27012758469;6197.225346831646;6203.162573052637;6210.596311239767;6237.781677641284;6067.059605761103;6160.168377269068;6195.132681424604;6209.348018458053;6301;5617.466340697627;5707.514861236789;5716.742746576393;5750.453706897859;5756.8272951811305;165.26241803606854;5567.192757050246;5639.859003524924;5784.82645520635;5804.100364443518;5252.185911183773;5580.888382232373;5644.6613203207935;5652.236948012007;5727.2268243786975;5640.266765320482;5642.830715078554;5647.3505546862225;5660.264165658479;5665.971670141664;5568.192612071268;5581.358143813472;5613.07384281593;5617.185508101344;5650;6035.879282414371;6142.754289828402;6159.599626024294;6171.907421388682;6185.103160041769;6628.3371662833815;6629.6022238665355;6721.361470660328;6724.663766811689;6727.798166055026;6507.9023814642815;6559.60642361455;6606.372394622503;6619.834504137387;6663.600183988976;6078.0882867569335;6143.846403839895;6155.722992465305;6166.599171053867;6168.506519478431;6772.187337519529;6774.559653622498;6776.593404395752;6786.69459874297;6796.52424330302;6395.904061439082;6405.711742971577;6427.2929977702415;6428.485721142298;6429.292777794439;6559.278479367265;6629.635370054693;6666.899996500057;6682.632455214913;6711.597304161766;6565.67171641416;6592.703328350236;6615.239247486601;6665.166854143232;6690.966545167243;6513.446357059703;6656.034874943106;6719.462443004548;6732.798016059526;6734.629595372204;5356.571474282048;5399.055165346049;5405.243265942771;5408.729563521808;5415.83752487426;4670.065986802653;4693.530646935279;4715.905681886343;4754.334393184957;4755.619550435957;5755.712214389264;5822.184894114827;5832.475077242983;5835.5915085944425;5839.970800145972;6646.235682896432;6688.297728738413;6764.627945463047;6777.220619628806;6784.3894049535775;5559.444055594489;5674.375818659944;5744.597878148573;5767.653940763567;5770.105633626795;5874.9118763218585;5892.587518873724;5892.793752218652;5940.287165540077;5945.851353716192;6462.192225971754;6473.255575608771;6540.6729663516635;6543.607383557001;6555.704993275314;6641.933580664325;6664.233613134552;6730.596164230162;6752.3922846944015;6764.8985265222045;6359.14151589548;6459.838504037249;6466.870662586816;6537.248216455168;6555.639439830855;6467.126937863516;6473.2232132144445;6474.902876456951;6563.540552161303;6564.934350656624;6568.638724870178;6667.899981500378;6679.666016699049;6761.594304341756;6766.18805743314;6429.774957876639;6433.292337842927;6510.837229069311;6520.673966301761;6533.771318003847;6362.872742545031;6436.967815160894;6443.581167224115;6463.806085817433;6532.118164047983;6179.320274769681;6308.968455157695;6313.05304204373;6428;6450.935490645221;6401.775937842153;6428.132202152837;6471.255805582418;6476.319986401549;6514.511411644051;6339.175907132043;6361.395667411589;6398.4561312287115;6399.616023038632;6405.679716014088 20:02:14 INFO - PID 23437 | |1;ext.html;780.9414293927953;820.0937963550281;836.7113345895665;856.4518708026864;864.4813112132721;38827.80586097069;40006.399904001424;40016.59983400165;40031.59968400315;40166;36668;36818;37007;37087.25825483489;37157.62842371575;6666;6794.864102717967;6798.558093723892;6802.931970680279;6807.183138023444;6596.67016649168;7332.156801967789;7514.286142816451;7578.469507134503;7601.733939312126;7534.886976695327;7578.825282081259;7642.656080476364;7658.387329013665;7666.118396384403;7409.962950185269;7582.582957937311;7592.392608591327;7596.240375962359;7608.277213664693;7450.0687414073245;7469.402447804163;7506.699732010713;7512.737054203131;7517.699292028312;36445.45331820025;36913.81543092294;36923;36969.63030369716;36987;3487.511748355207;3531.382008148589;3537.7523573349877;3540.132667496454;3545.982270088659;30311;30404.8479757602;30418.84790576033;30459;30467.695323046708;4835.347228124193;4966.801327946878;4996.1756310208775;5018.422881368653;5054.292399064134;191989;192916;193432;193590;193683.0315848426;47631.28553071707;47699;47738;47739.28391074137;47916.28125578119;49922.50077499251;53650.46349536533;54390.45609543933;54411.45588544143;54450.727746361015;15375.384984600714;15461.226938653022;15491.922540387226;15535.766963495556;15544.455944041903;12565.120441569003;12582;12628.936855315664;12680.112392132462;12683.809742853864;14267.78598321026;14398.280085995868;14401.63995900111;14423.278836058154;14441.49454769078;5766.990776614076;5790.334111577138;5794.710264486759;5823.213866128103;5879.265091863517;1013.4172850610928;1032.5560009195967;1033.9379637221791;1034.5448002878709;1037.2117190934944;22848.771512284664;23678.763212367656;23900.40248993789;29515;30194.54708179379;1101.8126918423886;1110.5557776889148;1112.2714621922653;1121.8934201250868;1130.6325444230658;12383.380830958416;12497.062720296015;16435.83564164367;16486.422975196052;16682.999020058836;230048;230352;230591;230728;231601;46528.30207546889;54990.450095498534;55281.72359138259;55335;55982;1495.3345761136407;1496.349088146638;1503.4812989518598;1512.7352713275134;1513.2660659580094;26691;27795.44409111766;28005.43989120247;28047.439051218455;28077.859610701817;49850.501494986034;50169.24746128738;50342.748286258335;50397;50741.49258507515;204032;206757;207559;207757;208347;35524.822375887954;35550.288994220486;35819.64180358163;35828.283434331686;35855;42862.57137428711;44018;44099.33850992302;44297;44311.55688443074;31568.210794730316;31901;32027.67972320247;32115;32265.51601725929;32035.839820800746;32123.196920077185;32244.516332255505;32471.675283246866;32675.673243268215;35265;35290.47064294089;35370.823145884104;35453.58185672544;35547.82226088853;31019.84490077535;31426.371472569965;31447.528287075256;31494;31602;22447;23713.407164820328;23902.52194956126;23993.400164996016;24241.51516969686 20:02:14 INFO - PID 23437 | |2;jquery.html;556.8886222755448;562.66802586474;564.6809552602779;571.3543695623945;587.0841487279843;21714.24000159995;22438;22504.32487025392;22508.774912250894;22549;24193;25498.470091794505;26657.466850662975;26710.332241693966;26713.931442742316;6542.93457065428;6672.899906501382;6703.363180497845;6714.093597364342;6751.932480675204;6319.936800631981;6521.413072823445;6532;6539.6730163491875;6557.409833115019;6526.641034743087;6534.477241820667;6543.934560654404;6561.409473147416;6566.80299591013;6499.545031847772;6544.181977252796;6560.048792925047;6578.868422631521;6590.275069742349;6045.516358691294;6066.636001839904;6069.514438844882;6072.787452439144;6078.817635470943;29343.55984660232;29434.705652943412;29621.11136665882;29771.70228297711;30283.545746813594;1943.689009758446;2006.1975209916004;2006.9799302006938;2007.8996050197431;2016.344687976399;18941.81058189428;19663.41009769695;19718.80281197184;19721.901390493098;19733.80266197334;2270.965935510969;2362.433016076129;2385.940351491209;2389.880505974712;2390.175389490623;136250.31874840663;138708;138928;139037;139148;14282.642933926734;15359.462418815288;15366.385344586315;15487.225638718019;15852.1281329528;23751.7624823753;23770.16804411872;23776;23782.64326035111;23782.88108559446;10355.896441035493;10515.474226288808;10531.315464494783;10553.050225479743;10649.414282214553;9562.270714421382;9611.951940240255;9642.807143857084;9734.36726612768;9829.410235385756;7603.315701586773;9037.367384283038;9319.767005824908;9474.384165029389;9676.854847177297;2691.1926422073298;2791.6650001999483;2798.118592643311;2799.202227365191;2915.53351463769;972.6498460554195;993.5975929748463;1010.939343639384;1011.1657882247175;1011.8684571005722;20203;20309.593808123755;20358.694619580718;20444.28445004418;21081;1031.3914790273625;1049.3284298049255;1056.313396292416;1061.3313612424279;1064.6752740414247;10992.17558683102;11477.713057173638;11515.827262591069;11527.250728702775;11537.942310288563;464919;465827;468734;487821;491917;111786;113757;116168;116700;116748;1172.3727805624121;1186.3000829510459;1197.6526807225807;1205.6865215044152;1207.034372501995;17659.735103973708;17955.551111222325;18024.729629055837;18040.18819153115;18319.816801832345;56044.43955560392;56348;56639.150412743016;57611.423885762284;57993.71003144957;70125.29874701188;70728.64635676789;73746.63126684546;78141;78398.6080069596;12150.392480376122;12554.686132846387;12600.55898043564;14590.708185836436;15398.538043858702;22952.540949180588;23797.52404951926;23897.522049558564;23961;24062.15782447606;18606.162722677782;18653.720194196827;18943.33698320552;18956.43130706081;18984.810151898306;17236.655266894842;17290.13549322554;17310.480685579452;17623.118844057488;17708.203130858885;18842.623147537248;19908.50228744293;19990.400287991382;20071.899640501702;20088;14891.851081489047;15122.034135562306;15259.23703814827;15335.233238337816;15362.769558456408;19004.23983040663;19061;19074.618507630046;19264.229430822612;19264.422067338 20:02:14 INFO - PID 23437 | |3;mootools.html;1321.464806753265;1369.2058606008513;1376.655836040989;1378.7862881253402;1383.2945197949043;14172.433102675894;14398.856011439882;14862.925685371585;14896.92551537242;14898.180600066991;14624.707505849876;15081.019733717329;15123.697526049473;15133.697326053472;15135.318910649019;2673.5588627876377;2736.480068786924;2736.6852811926583;2742.3555464465835;2749.1065403743764;2658.3221278573938;2726.9181924542195;2757.8483183424905;2771.431856469419;2773.4314465534617;2673.46530693862;2673.9598906016327;2708.7155848635907;2711.267957651433;2719.789693586355;2576.2013775729397;2590.235880415282;2591.818572699912;2593.987030064847;2612.686477622688;2548.5412625727363;2562.705288891783;2584.5089433007856;2601.50571391435;2602.817802753808;14061.648458788612;14311.713765724628;14390.784138237936;14397.85602143986;14428.639284017878;7396.260373962561;7718.112417072052;7722.382209423233;7738.845223095563;7739.57432341221;4991.7753701083175;5033.84898453047;5067.315912351823;5181.015607034689;5188.844334669966;1878.5021969178179;1882.2941396976134;1893.384649988759;1926.6050459655878;1937.4865660599812;22332.441688957904;22692.20577279787;22801.087956481722;22813.42966425836;22822.77177228223;6558.6064836109035;6598.802035938929;6641.86716265672;6772.966135169293;6801.659917004229;17910.731339029924;17937.730934036;17960.730589041174;17965.910170449326;17985.1007449627;7417.147028091731;7682.423818213656;7689.50018248812;7705.730299439493;7712.537247765152;5823.94176058234;5945.494632956161;6272.1219029335925;6900.7929762107215;7147.749828755968;5502.184279187858;5636.154576813511;5643.5767317451355;5669.092945128842;5740.598158128974;1696.2282161616436;1756.47305808257;1756.8594512439229;1758.1033672826695;1775.3608700867678;873.1399571422144;884.2174675412178;888.3515034025069;895.1048951048951;898.3666515106834;7266.92733072673;7309.086364204474;7312.085989251344;7370.041894553674;7403.777886663409;707.6426404665611;711.6584039660992;723.4068064187315;726.5713229194695;733.5195446982235;4650.720956742606;5159.47326631811;5285.788568457296;5449.5640348772;5503.944960550423;19363;20077.196912123352;20077.899610501852;20180.29368972079;20199;19150.808491914904;19539.120739566755;19817.702734458995;19823.207071717257;20145.395638130878;11258.493367798468;11285.492152853141;11291;11300.54797808095;11303.491342889425;8283.461574997606;8338.332933365438;8563.314934805076;8867.556622168737;9114.088591140833;17028.14859257057;17195.05427201516;17409.390671326444;17420.216090275713;17519.124043797503;17920.820791791914;17953.73069403934;18041.819581804015;18050.458486245432;18150.18324175389;11058.22592418523;11428.599998999995;11491.770164596828;11933.164678472423;12132.211406258564;13375.732485350432;13476.258805765778;13489.662758431117;13499.190048597116;13515.39180736889;10522;10590.099841513249;10602.25784195099;10662.946685266525;10801.513931873242;10177.134943529587;10384.636537721144;10449.111825494614;10485.475726213506;10698.465076746288;9338.112879276458;9379.343445958717;9450.858237126311;9586.137247647745;9587.328886978125;7402.259774022555;7495.325420712162;7498.287662672037;7530;7634.50375725576;6995.860082798417;7028.613426261605;7039.859202816017;7092.326229008236;7148.535345202546 20:02:14 INFO - PID 23437 | |4;prototype.html;472.3434426147653;502.4473079612427;507.80195723667777;513.7970501651847;522.7203446156306;6187.319394866567;6265.24817021958;6298.905516417251;6304.294613374903;6318.652474113922;5921.615095018821;6167.969160154193;6180.938190618092;6208.534359923001;6241.344658810827;4928.531789479994;4956.107900577895;4956.942868709481;4967.726775027372;4971;4815.903681926359;4918.778654960535;4946.159152944008;4952.479989601094;4989.9750501247445;4861.73260470674;4888.975555122237;4912.754362281889;4952.034353301107;4960.156773348522;4894.877628059309;4925.13810083234;4929.260610908356;4934.407871055479;4964.528369804862;4437.4009508716235;4444.466664000341;4452.933206001912;4453.465584129925;4465.343120843093;6030.547708921805;6071.787487437919;6082.1180928765525;6129.233845769279;6169.96915015422;5681.431856814327;5683.5169010634145;5703;5720.140954189905;5723.599348045638;6525.282218955911;6554.377334153248;6580.341965803382;6620.702068406885;6668.066470694107;4860.149473842063;4871.82948596801;4878.487758785312;4889;4901.2158054711435;6944.236134025253;6945.78448771468;6986.266442023565;6995.650217489156;7022.4733145014325;5002.474740152305;5009.649324547319;5011.123053465629;5034.89930201394;5040.899182016413;5074.492550744896;5077.669951453144;5091.821786237464;5106.514881086291;5122.718250496184;5559.9444005560235;5634.802781902614;5651.632643878134;5652.943470565242;5708.9714551427805;6303.621782693053;6528.836779080466;6535.509836762262;6598.911179655303;6630.403263706289;1639.524537884024;1677.3793696332434;1705.5139285303628;1717.1671739206474;1741.8780685352158;1194.796884529632;1205.4515195585986;1213.635909227246;1222.6943264183953;1247.2391840976998;5659.26429564154;5706.9429305707245;5746.195532625436;5756.1653560233535;5759.740811663485;6569.572977756526;6739.393454589111;6753.561018533779;6756.966215168893;6884.896726549106;5708.257926469615;5760.423957604206;5772.855678607984;5788.681622510718;5801.53587712982;3572.857085716594;3582.4089025311055;3599.3341231871664;3617.7105831533413;3631.4371272452813;6626.933730662631;6636.435902948207;6685.128164114056;6708.865822683519;6725.831854203684;6864.176298844171;6880.208775990825;6880.827979300558;6896.344847239504;7019.92980070203;6533.183352081085;6598.802035938929;6612.7354905804195;6643.634600097041;6718.764843230463;6794.76218332356;6820.31796820314;6845.755631508497;6848.3494068063455;6874.634607024475;6706.329367063255;6727.293634168537;6734.528582999143;6795.966020169867;6847.246802851582;6463.741450341934;6568.967155164193;6573.57271777333;6658.43403310724;6681.498887583353;4906.607471402351;4929.876753081202;4964.751762411793;5010.8496745096245;5030.415419143104;6544.004078755835;6728.562643428161;6780.355866192704;6803.829904252433;6812.523123381514;6263.248410190807;6435.485161187187;6529.902051469327;6588.8352791180605;6633.767818126343;6439.613623182624;6470.188347262774;6556.2788093308745;6576.473882089325;6581.6709164542535;6354;6506.121673574196;6527.934720652923;6561.704723287559;6584.5184833412095;6677.399034086956;6688.665566721742;6696.665166741546;6706.5976041435715;6711.46308295345;6467;6474.935250647622;6483;6490.675466226764;6498.870022599616 20:02:14 INFO - PID 23437 | |5;yui.html;890.2521881619439;902.8194361127776;908.6592527802075;909.1226965977833;941.1858742188007;17457.127143642814;18024.81975180248;18088.728669069973;18161.4551563453;18180.090995450224;14916.403343866232;14916.776248356284;19222.111241968436;21902.671459928115;21977.120915163414;965.92755543334;987.8370068938652;988.4859872866106;990.2573070197352;990.747359423346;937.9343445958785;1047.6804574604741;1048.1719441641094;1048.4390850894772;1048.6906362623045;1080.9675709728722;1081.291753901196;1081.7674200046988;1082.9675109746681;1084.322298563398;1075.7955988362187;1076.5424694504843;1077.5420446310286;1077.617445806735;1082.3019152646539;795.3398679096337;795.431266644352;795.677750511044;796.0328201235527;801.1587832775563;19629.116689748997;19931.30240441592;20088.89955550213;20338.49153771153;20422.79577204224;21275.46811329729;21599;21843.563128737336;21942.341729748132;22029.118835246732;16539;16644.50066498007;16830.410935617194;16849;16851.241694123793;3510.473428985647;3554.680078792921;3557.9822100889587;3558.733095017858;3582.946255806165;121806.39096804548;122335.38832305782;124909.37545312307;126377.36811315885;127588.36205819005;15503.069815811088;15505.922470387575;15522.301496432689;15612.063276203464;15672.764908526382;31716.682833171373;32018.519722204186;32023.83988080091;32751;32825.50761738576;8346.8330633387;8387.161283871565;8413.74758757226;8418.536980466133;8421.705240316682;3929.115948911472;3991.2416640838146;4026.6778657707314;4040.1919616076902;4057.776822274744;4933.260010998379;4994.275830004629;4994.825181118644;5024.572911302507;5028.673136246132;904.2675432899373;928.215657769184;940.182041623778;942.1520631431766;948.1561410344799;680.6086500262369;692.6882902693808;693.8751024815481;696.2828286864537;707.5012116457884;11372.260803047775;12105.87894121065;12382.81425778614;12400.875991240153;12441.502339906303;684.8527566573111;686.3205426627702;688.834679676874;690.2407351912956;700.3171907390356;5522.91715624266;5780.768769249183;5806.941930580725;5993.700314984233;6322.841928951721;106720.46639766906;111985;112298;113165;114211.42894285642;95192;96623;99086.5045674767;100154;102935.4853225744;86821.56589217139;88482;89169;90114.54942725244;90314.54842725876;12188.390580471118;12242.387880605756;12340.938295308466;12964.8055279169;13065.738685226432;39028.414573781985;39531.40702889401;39567.2086558273;39978;41329.380059298535;54653.45346546484;72609.6369518149;73313;73486.63256683682;75173;17559.12204389801;17692.11539422998;17697.557561061076;19125.713114303573;20030;22394.552108957403;22651.546969060855;23519.52960940806;23615;23766.287011389686;19803.91078490697;20303.4924126898;20647.58704825865;20730;21012.68480972756;18198.636027279117;18620.44138675842;18876.33932812345;19223.23107075757;19410.51473713112;18528;18629.347972820888;18908.716369254747;19862.304819331253;20257;14349.928250358682;14382;14453.277336133362;14726.558203253919;14938.925305373403;14264.286785660468;14788.704225915637;15199.556042175976;15449.382024718885;15545.611359715645 20:02:14 INFO - PID 23437 | __end_tp_report 20:02:14 INFO - PID 23437 | __start_cc_report 20:02:14 INFO - PID 23437 | _x_x_mozilla_cycle_collect,350 20:02:14 INFO - PID 23437 | __end_cc_report 20:02:14 INFO - PID 23437 | __startTimestamp1502852534325__endTimestamp 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | ------- Summary: start ------- 20:02:14 INFO - PID 23437 | Number of tests: 6 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#0] dojo.html Cycles:165 Average:6080.79 Median:6395.90 stddev:848.39 (13.3%) stddev-sans-first:819.14 20:02:14 INFO - PID 23437 | Values: 3145.2 3158.5 3164.2 3192.0 3202.0 6082.3 6197.2 6203.2 6210.6 6237.8 6067.1 6160.2 6195.1 6209.3 6301.0 5617.5 5707.5 5716.7 5750.5 5756.8 165.3 5567.2 5639.9 5784.8 5804.1 5252.2 5580.9 5644.7 5652.2 5727.2 5640.3 5642.8 5647.4 5660.3 5666.0 5568.2 5581.4 5613.1 5617.2 5650.0 6035.9 6142.8 6159.6 6171.9 6185.1 6628.3 6629.6 6721.4 6724.7 6727.8 6507.9 6559.6 6606.4 6619.8 6663.6 6078.1 6143.8 6155.7 6166.6 6168.5 6772.2 6774.6 6776.6 6786.7 6796.5 6395.9 6405.7 6427.3 6428.5 6429.3 6559.3 6629.6 6666.9 6682.6 6711.6 6565.7 6592.7 6615.2 6665.2 6691.0 6513.4 6656.0 6719.5 6732.8 6734.6 5356.6 5399.1 5405.2 5408.7 5415.8 4670.1 4693.5 4715.9 4754.3 4755.6 5755.7 5822.2 5832.5 5835.6 5840.0 6646.2 6688.3 6764.6 6777.2 6784.4 5559.4 5674.4 5744.6 5767.7 5770.1 5874.9 5892.6 5892.8 5940.3 5945.9 6462.2 6473.3 6540.7 6543.6 6555.7 6641.9 6664.2 6730.6 6752.4 6764.9 6359.1 6459.8 6466.9 6537.2 6555.6 6467.1 6473.2 6474.9 6563.5 6564.9 6568.6 6667.9 6679.7 6761.6 6766.2 6429.8 6433.3 6510.8 6520.7 6533.8 6362.9 6437.0 6443.6 6463.8 6532.1 6179.3 6309.0 6313.1 6428.0 6450.9 6401.8 6428.1 6471.3 6476.3 6514.5 6339.2 6361.4 6398.5 6399.6 6405.7 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#1] ext.html Cycles:180 Average:38355.36 Median:19455.48 stddev:54627.83 (280.8%) stddev-sans-first:54708.22 20:02:14 INFO - PID 23437 | Values: 780.9 820.1 836.7 856.5 864.5 38827.8 40006.4 40016.6 40031.6 40166.0 36668.0 36818.0 37007.0 37087.3 37157.6 6666.0 6794.9 6798.6 6802.9 6807.2 6596.7 7332.2 7514.3 7578.5 7601.7 7534.9 7578.8 7642.7 7658.4 7666.1 7410.0 7582.6 7592.4 7596.2 7608.3 7450.1 7469.4 7506.7 7512.7 7517.7 36445.5 36913.8 36923.0 36969.6 36987.0 3487.5 3531.4 3537.8 3540.1 3546.0 30311.0 30404.8 30418.8 30459.0 30467.7 4835.3 4966.8 4996.2 5018.4 5054.3 191989.0 192916.0 193432.0 193590.0 193683.0 47631.3 47699.0 47738.0 47739.3 47916.3 49922.5 53650.5 54390.5 54411.5 54450.7 15375.4 15461.2 15491.9 15535.8 15544.5 12565.1 12582.0 12628.9 12680.1 12683.8 14267.8 14398.3 14401.6 14423.3 14441.5 5767.0 5790.3 5794.7 5823.2 5879.3 1013.4 1032.6 1033.9 1034.5 1037.2 22848.8 23678.8 23900.4 29515.0 30194.5 1101.8 1110.6 1112.3 1121.9 1130.6 12383.4 12497.1 16435.8 16486.4 16683.0 230048.0 230352.0 230591.0 230728.0 231601.0 46528.3 54990.5 55281.7 55335.0 55982.0 1495.3 1496.3 1503.5 1512.7 1513.3 26691.0 27795.4 28005.4 28047.4 28077.9 49850.5 50169.2 50342.7 50397.0 50741.5 204032.0 206757.0 207559.0 207757.0 208347.0 35524.8 35550.3 35819.6 35828.3 35855.0 42862.6 44018.0 44099.3 44297.0 44311.6 31568.2 31901.0 32027.7 32115.0 32265.5 32035.8 32123.2 32244.5 32471.7 32675.7 35265.0 35290.5 35370.8 35453.6 35547.8 31019.8 31426.4 31447.5 31494.0 31602.0 22447.0 23713.4 23902.5 23993.4 24241.5 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#2] jquery.html Cycles:180 Average:34639.28 Median:22506.55 stddev:80422.41 (357.3%) stddev-sans-first:80607.30 20:02:14 INFO - PID 23437 | Values: 556.9 562.7 564.7 571.4 587.1 21714.2 22438.0 22504.3 22508.8 22549.0 24193.0 25498.5 26657.5 26710.3 26713.9 6542.9 6672.9 6703.4 6714.1 6751.9 6319.9 6521.4 6532.0 6539.7 6557.4 6526.6 6534.5 6543.9 6561.4 6566.8 6499.5 6544.2 6560.0 6578.9 6590.3 6045.5 6066.6 6069.5 6072.8 6078.8 29343.6 29434.7 29621.1 29771.7 30283.5 1943.7 2006.2 2007.0 2007.9 2016.3 18941.8 19663.4 19718.8 19721.9 19733.8 2271.0 2362.4 2385.9 2389.9 2390.2 136250.3 138708.0 138928.0 139037.0 139148.0 14282.6 15359.5 15366.4 15487.2 15852.1 23751.8 23770.2 23776.0 23782.6 23782.9 10355.9 10515.5 10531.3 10553.1 10649.4 9562.3 9612.0 9642.8 9734.4 9829.4 7603.3 9037.4 9319.8 9474.4 9676.9 2691.2 2791.7 2798.1 2799.2 2915.5 972.6 993.6 1010.9 1011.2 1011.9 20203.0 20309.6 20358.7 20444.3 21081.0 1031.4 1049.3 1056.3 1061.3 1064.7 10992.2 11477.7 11515.8 11527.3 11537.9 464919.0 465827.0 468734.0 487821.0 491917.0 111786.0 113757.0 116168.0 116700.0 116748.0 1172.4 1186.3 1197.7 1205.7 1207.0 17659.7 17955.6 18024.7 18040.2 18319.8 56044.4 56348.0 56639.2 57611.4 57993.7 70125.3 70728.6 73746.6 78141.0 78398.6 12150.4 12554.7 12600.6 14590.7 15398.5 22952.5 23797.5 23897.5 23961.0 24062.2 18606.2 18653.7 18943.3 18956.4 18984.8 17236.7 17290.1 17310.5 17623.1 17708.2 18842.6 19908.5 19990.4 20071.9 20088.0 14891.9 15122.0 15259.2 15335.2 15362.8 19004.2 19061.0 19074.6 19264.2 19264.4 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#3] mootools.html Cycles:180 Average:8927.52 Median:2592.90 stddev:6138.82 (236.8%) stddev-sans-first:6129.44 20:02:14 INFO - PID 23437 | Values: 1321.5 1369.2 1376.7 1378.8 1383.3 14172.4 14398.9 14862.9 14896.9 14898.2 14624.7 15081.0 15123.7 15133.7 15135.3 2673.6 2736.5 2736.7 2742.4 2749.1 2658.3 2726.9 2757.8 2771.4 2773.4 2673.5 2674.0 2708.7 2711.3 2719.8 2576.2 2590.2 2591.8 2594.0 2612.7 2548.5 2562.7 2584.5 2601.5 2602.8 14061.6 14311.7 14390.8 14397.9 14428.6 7396.3 7718.1 7722.4 7738.8 7739.6 4991.8 5033.8 5067.3 5181.0 5188.8 1878.5 1882.3 1893.4 1926.6 1937.5 22332.4 22692.2 22801.1 22813.4 22822.8 6558.6 6598.8 6641.9 6773.0 6801.7 17910.7 17937.7 17960.7 17965.9 17985.1 7417.1 7682.4 7689.5 7705.7 7712.5 5823.9 5945.5 6272.1 6900.8 7147.7 5502.2 5636.2 5643.6 5669.1 5740.6 1696.2 1756.5 1756.9 1758.1 1775.4 873.1 884.2 888.4 895.1 898.4 7266.9 7309.1 7312.1 7370.0 7403.8 707.6 711.7 723.4 726.6 733.5 4650.7 5159.5 5285.8 5449.6 5503.9 19363.0 20077.2 20077.9 20180.3 20199.0 19150.8 19539.1 19817.7 19823.2 20145.4 11258.5 11285.5 11291.0 11300.5 11303.5 8283.5 8338.3 8563.3 8867.6 9114.1 17028.1 17195.1 17409.4 17420.2 17519.1 17920.8 17953.7 18041.8 18050.5 18150.2 11058.2 11428.6 11491.8 11933.2 12132.2 13375.7 13476.3 13489.7 13499.2 13515.4 10522.0 10590.1 10602.3 10662.9 10801.5 10177.1 10384.6 10449.1 10485.5 10698.5 9338.1 9379.3 9450.9 9586.1 9587.3 7402.3 7495.3 7498.3 7530.0 7634.5 6995.9 7028.6 7039.9 7092.3 7148.5 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#4] prototype.html Cycles:180 Average:5532.42 Median:6168.97 stddev:1573.01 (25.5%) stddev-sans-first:1530.88 20:02:14 INFO - PID 23437 | Values: 472.3 502.4 507.8 513.8 522.7 6187.3 6265.2 6298.9 6304.3 6318.7 5921.6 6168.0 6180.9 6208.5 6241.3 4928.5 4956.1 4956.9 4967.7 4971.0 4815.9 4918.8 4946.2 4952.5 4990.0 4861.7 4889.0 4912.8 4952.0 4960.2 4894.9 4925.1 4929.3 4934.4 4964.5 4437.4 4444.5 4452.9 4453.5 4465.3 6030.5 6071.8 6082.1 6129.2 6170.0 5681.4 5683.5 5703.0 5720.1 5723.6 6525.3 6554.4 6580.3 6620.7 6668.1 4860.1 4871.8 4878.5 4889.0 4901.2 6944.2 6945.8 6986.3 6995.7 7022.5 5002.5 5009.6 5011.1 5034.9 5040.9 5074.5 5077.7 5091.8 5106.5 5122.7 5559.9 5634.8 5651.6 5652.9 5709.0 6303.6 6528.8 6535.5 6598.9 6630.4 1639.5 1677.4 1705.5 1717.2 1741.9 1194.8 1205.5 1213.6 1222.7 1247.2 5659.3 5706.9 5746.2 5756.2 5759.7 6569.6 6739.4 6753.6 6757.0 6884.9 5708.3 5760.4 5772.9 5788.7 5801.5 3572.9 3582.4 3599.3 3617.7 3631.4 6626.9 6636.4 6685.1 6708.9 6725.8 6864.2 6880.2 6880.8 6896.3 7019.9 6533.2 6598.8 6612.7 6643.6 6718.8 6794.8 6820.3 6845.8 6848.3 6874.6 6706.3 6727.3 6734.5 6796.0 6847.2 6463.7 6569.0 6573.6 6658.4 6681.5 4906.6 4929.9 4964.8 5010.8 5030.4 6544.0 6728.6 6780.4 6803.8 6812.5 6263.2 6435.5 6529.9 6588.8 6633.8 6439.6 6470.2 6556.3 6576.5 6581.7 6354.0 6506.1 6527.9 6561.7 6584.5 6677.4 6688.7 6696.7 6706.6 6711.5 6467.0 6474.9 6483.0 6490.7 6498.9 20:02:14 INFO - PID 23437 | 20:02:14 INFO - PID 23437 | [#5] yui.html Cycles:180 Average:24064.53 Median:21721.28 stddev:32335.98 (148.9%) stddev-sans-first:32379.86 20:02:14 INFO - PID 23437 | Values: 890.3 902.8 908.7 909.1 941.2 17457.1 18024.8 18088.7 18161.5 18180.1 14916.4 14916.8 19222.1 21902.7 21977.1 965.9 987.8 988.5 990.3 990.7 937.9 1047.7 1048.2 1048.4 1048.7 1081.0 1081.3 1081.8 1083.0 1084.3 1075.8 1076.5 1077.5 1077.6 1082.3 795.3 795.4 795.7 796.0 801.2 19629.1 19931.3 20088.9 20338.5 20422.8 21275.5 21599.0 21843.6 21942.3 22029.1 16539.0 16644.5 16830.4 16849.0 16851.2 3510.5 3554.7 3558.0 3558.7 3582.9 121806.4 122335.4 124909.4 126377.4 127588.4 15503.1 15505.9 15522.3 15612.1 15672.8 31716.7 32018.5 32023.8 32751.0 32825.5 8346.8 8387.2 8413.7 8418.5 8421.7 3929.1 3991.2 4026.7 4040.2 4057.8 4933.3 4994.3 4994.8 5024.6 5028.7 904.3 928.2 940.2 942.2 948.2 680.6 692.7 693.9 696.3 707.5 11372.3 12105.9 12382.8 12400.9 12441.5 684.9 686.3 688.8 690.2 700.3 5522.9 5780.8 5806.9 5993.7 6322.8 106720.5 111985.0 112298.0 113165.0 114211.4 95192.0 96623.0 99086.5 100154.0 102935.5 86821.6 88482.0 89169.0 90114.5 90314.5 12188.4 12242.4 12340.9 12964.8 13065.7 39028.4 39531.4 39567.2 39978.0 41329.4 54653.5 72609.6 73313.0 73486.6 75173.0 17559.1 17692.1 17697.6 19125.7 20030.0 22394.6 22651.5 23519.5 23615.0 23766.3 19803.9 20303.5 20647.6 20730.0 21012.7 18198.6 18620.4 18876.3 19223.2 19410.5 18528.0 18629.3 18908.7 19862.3 20257.0 14349.9 14382.0 14453.3 14726.6 14938.9 14264.3 14788.7 15199.6 15449.4 15545.6 20:02:14 INFO - PID 23437 | -------- Summary: end -------- 20:02:14 INFO - PID 23437 | 20:02:14 INFO - TEST-INFO | 23437: exit 0 20:02:14 INFO - TEST-OK | dromaeo_css | took 1110564ms 20:02:14 INFO - TEST-START | kraken 20:02:14 INFO - Initialising browser for kraken test... 20:02:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34692/getInfo.html -profile /tmp/tmp_cXV7G/profile 20:02:15 INFO - TEST-INFO | started process 23818 (/builds/slave/test/build/application/firefox/firefox http://localhost:34692/getInfo.html) 20:02:20 INFO - TEST-INFO | 23818: exit 0 20:02:20 INFO - Browser initialized. 20:02:20 INFO - Running cycle 1/1 for kraken test... 20:02:20 INFO - TEST-INFO | started process 24051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_cXV7G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:21 INFO - PID 24051 | 20:02:21 INFO - PID 24051 | (/builds/slave/test/build/application/firefox/firefox:24105): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:02:21 INFO - PID 24051 | 20:02:32 INFO - PID 24051 | RSS: Main: 167776256 20:02:32 INFO - PID 24051 | 20:02:34 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34692/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:35 INFO - PID 24051 | RSS: Main: 173764608 20:02:35 INFO - PID 24051 | 20:02:38 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34692/tests/kraken/driver.html?testName=audio-dft) 20:02:39 INFO - PID 24051 | RSS: Main: 177782784 20:02:39 INFO - PID 24051 | 20:02:42 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34692/tests/kraken/driver.html?testName=audio-fft) 20:02:42 INFO - PID 24051 | RSS: Main: 171855872 20:02:42 INFO - PID 24051 | 20:02:45 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34692/tests/kraken/driver.html?testName=audio-oscillator) 20:02:45 INFO - PID 24051 | RSS: Main: 172052480 20:02:45 INFO - PID 24051 | 20:02:48 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:48 INFO - PID 24051 | RSS: Main: 172326912 20:02:48 INFO - PID 24051 | 20:02:51 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34692/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:52 INFO - PID 24051 | RSS: Main: 173375488 20:02:52 INFO - PID 24051 | 20:02:55 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34692/tests/kraken/driver.html?testName=imaging-desaturate) 20:02:56 INFO - PID 24051 | RSS: Main: 172630016 20:02:56 INFO - PID 24051 | 20:02:59 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34692/tests/kraken/driver.html?testName=json-parse-financial) 20:03:00 INFO - PID 24051 | RSS: Main: 173723648 20:03:00 INFO - PID 24051 | 20:03:01 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:02 INFO - PID 24051 | RSS: Main: 173731840 20:03:02 INFO - PID 24051 | 20:03:04 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:04 INFO - PID 24051 | RSS: Main: 173850624 20:03:04 INFO - PID 24051 | 20:03:07 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:07 INFO - PID 24051 | RSS: Main: 173400064 20:03:07 INFO - PID 24051 | 20:03:10 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:11 INFO - PID 24051 | RSS: Main: 174075904 20:03:11 INFO - PID 24051 | 20:03:14 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:15 INFO - PID 24051 | RSS: Main: 173760512 20:03:15 INFO - PID 24051 | 20:03:16 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:34692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34692/tests/kraken/driver.html?testName=ai-astar) 20:03:17 INFO - PID 24051 | RSS: Main: 175562752 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | __start_tp_report 20:03:17 INFO - PID 24051 | _x_x_mozilla_page_load 20:03:17 INFO - PID 24051 | _x_x_mozilla_page_load_details 20:03:17 INFO - PID 24051 | |i|pagename|runs| 20:03:17 INFO - PID 24051 | |0;ai-astar;101;108;100;107;108;108;110;98;108;108 20:03:17 INFO - PID 24051 | |1;audio-beat-detection;143;121;139;189;121;155;150;119;179;124 20:03:17 INFO - PID 24051 | |2;audio-dft;165;173;163;162;164;163;172;162;164;167 20:03:17 INFO - PID 24051 | |3;audio-fft;75;76;79;168;84;81;77;76;162;76 20:03:17 INFO - PID 24051 | |4;audio-oscillator;85;78;138;79;82;80;141;92;79;130 20:03:17 INFO - PID 24051 | |5;imaging-gaussian-blur;122;118;113;115;117;118;117;119;115;114 20:03:17 INFO - PID 24051 | |6;imaging-darkroom;150;149;150;158;151;150;150;150;157;150 20:03:17 INFO - PID 24051 | |7;imaging-desaturate;94;94;94;99;93;98;99;94;94;93 20:03:17 INFO - PID 24051 | |8;json-parse-financial;53;54;54;59;54;52;56;53;53;53 20:03:17 INFO - PID 24051 | |9;json-stringify-tinderbox;59;57;60;62;62;59;60;55;57;57 20:03:17 INFO - PID 24051 | |10;stanford-crypto-aes;78;79;79;78;82;80;80;78;89;79 20:03:17 INFO - PID 24051 | |11;stanford-crypto-ccm;125;126;126;123;123;127;122;124;130;168 20:03:17 INFO - PID 24051 | |12;stanford-crypto-pbkdf2;180;177;178;174;188;174;184;183;184;180 20:03:17 INFO - PID 24051 | |13;stanford-crypto-sha256-iterative;71;68;69;70;70;72;67;72;72;69 20:03:17 INFO - PID 24051 | __end_tp_report 20:03:17 INFO - PID 24051 | __start_cc_report 20:03:17 INFO - PID 24051 | _x_x_mozilla_cycle_collect,956 20:03:17 INFO - PID 24051 | __end_cc_report 20:03:17 INFO - PID 24051 | __startTimestamp1502852597098__endTimestamp 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | ------- Summary: start ------- 20:03:17 INFO - PID 24051 | Number of tests: 14 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#0] ai-astar Cycles:10 Average:105.60 Median:108.00 stddev:4.22 (3.9%) stddev-sans-first:4.14 20:03:17 INFO - PID 24051 | Values: 101.0 108.0 100.0 107.0 108.0 108.0 110.0 98.0 108.0 108.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:146.50 stddev:24.76 (16.9%) stddev-sans-first:26.26 20:03:17 INFO - PID 24051 | Values: 143.0 121.0 139.0 189.0 121.0 155.0 150.0 119.0 179.0 124.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#2] audio-dft Cycles:10 Average:165.50 Median:164.50 stddev:3.98 (2.4%) stddev-sans-first:4.22 20:03:17 INFO - PID 24051 | Values: 165.0 173.0 163.0 162.0 164.0 163.0 172.0 162.0 164.0 167.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:36.81 (48.1%) stddev-sans-first:38.30 20:03:17 INFO - PID 24051 | Values: 75.0 76.0 79.0 168.0 84.0 81.0 77.0 76.0 162.0 76.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:79.50 stddev:26.62 (33.5%) stddev-sans-first:27.79 20:03:17 INFO - PID 24051 | Values: 85.0 78.0 138.0 79.0 82.0 80.0 141.0 92.0 79.0 130.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.50 stddev:2.66 (2.3%) stddev-sans-first:2.05 20:03:17 INFO - PID 24051 | Values: 122.0 118.0 113.0 115.0 117.0 118.0 117.0 119.0 115.0 114.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:150.00 stddev:3.21 (2.1%) stddev-sans-first:3.35 20:03:17 INFO - PID 24051 | Values: 150.0 149.0 150.0 158.0 151.0 150.0 150.0 150.0 157.0 150.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.44 (2.6%) stddev-sans-first:2.55 20:03:17 INFO - PID 24051 | Values: 94.0 94.0 94.0 99.0 93.0 98.0 99.0 94.0 94.0 93.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:2.02 (3.7%) stddev-sans-first:2.11 20:03:17 INFO - PID 24051 | Values: 53.0 54.0 54.0 59.0 54.0 52.0 56.0 53.0 53.0 53.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.50 stddev:2.30 (3.9%) stddev-sans-first:2.44 20:03:17 INFO - PID 24051 | Values: 59.0 57.0 60.0 62.0 62.0 59.0 60.0 55.0 57.0 57.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:3.33 (4.2%) stddev-sans-first:3.43 20:03:17 INFO - PID 24051 | Values: 78.0 79.0 79.0 78.0 82.0 80.0 80.0 78.0 89.0 79.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:126.00 stddev:13.76 (10.9%) stddev-sans-first:14.50 20:03:17 INFO - PID 24051 | Values: 125.0 126.0 126.0 123.0 123.0 127.0 122.0 124.0 130.0 168.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:181.50 stddev:4.59 (2.5%) stddev-sans-first:4.87 20:03:17 INFO - PID 24051 | Values: 180.0 177.0 178.0 174.0 188.0 174.0 184.0 183.0 184.0 180.0 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.76 (2.5%) stddev-sans-first:1.83 20:03:17 INFO - PID 24051 | Values: 71.0 68.0 69.0 70.0 70.0 72.0 67.0 72.0 72.0 69.0 20:03:17 INFO - PID 24051 | -------- Summary: end -------- 20:03:17 INFO - PID 24051 | 20:03:17 INFO - PID 24051 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:03:17 INFO - TEST-INFO | 24051: exit 0 20:03:17 INFO - TEST-OK | kraken | took 62838ms 20:03:17 INFO - SUITE-END | took 1173s 20:03:18 INFO - Completed test suite (00:19:33) 20:03:18 INFO - javascript benchmark 20:03:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8521.693505352794, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.2294187923962, 3158.526221066841, 3164.224764932591, 3191.9840400797993, 3202.0393881835444, 6082.27012758469, 6197.225346831646, 6203.162573052637, 6210.596311239767, 6237.781677641284, 6067.059605761103, 6160.168377269068, 6195.132681424604, 6209.348018458053, 6301.0, 5617.466340697627, 5707.514861236789, 5716.742746576393, 5750.453706897859, 5756.8272951811305, 165.26241803606854, 5567.192757050246, 5639.859003524924, 5784.82645520635, 5804.100364443518, 5252.185911183773, 5580.888382232373, 5644.6613203207935, 5652.236948012007, 5727.2268243786975, 5640.266765320482, 5642.830715078554, 5647.3505546862225, 5660.264165658479, 5665.971670141664, 5568.192612071268, 5581.358143813472, 5613.07384281593, 5617.185508101344, 5650.0, 6035.879282414371, 6142.754289828402, 6159.599626024294, 6171.907421388682, 6185.103160041769, 6628.3371662833815, 6629.6022238665355, 6721.361470660328, 6724.663766811689, 6727.798166055026, 6507.9023814642815, 6559.60642361455, 6606.372394622503, 6619.834504137387, 6663.600183988976, 6078.0882867569335, 6143.846403839895, 6155.722992465305, 6166.599171053867, 6168.506519478431, 6772.187337519529, 6774.559653622498, 6776.593404395752, 6786.69459874297, 6796.52424330302, 6395.904061439082, 6405.711742971577, 6427.2929977702415, 6428.485721142298, 6429.292777794439, 6559.278479367265, 6629.635370054693, 6666.899996500057, 6682.632455214913, 6711.597304161766, 6565.67171641416, 6592.703328350236, 6615.239247486601, 6665.166854143232, 6690.966545167243, 6513.446357059703, 6656.034874943106, 6719.462443004548, 6732.798016059526, 6734.629595372204, 5356.571474282048, 5399.055165346049, 5405.243265942771, 5408.729563521808, 5415.83752487426, 4670.065986802653, 4693.530646935279, 4715.905681886343, 4754.334393184957, 4755.619550435957, 5755.712214389264, 5822.184894114827, 5832.475077242983, 5835.5915085944425, 5839.970800145972, 6646.235682896432, 6688.297728738413, 6764.627945463047, 6777.220619628806, 6784.3894049535775, 5559.444055594489, 5674.375818659944, 5744.597878148573, 5767.653940763567, 5770.105633626795, 5874.9118763218585, 5892.587518873724, 5892.793752218652, 5940.287165540077, 5945.851353716192, 6462.192225971754, 6473.255575608771, 6540.6729663516635, 6543.607383557001, 6555.704993275314, 6641.933580664325, 6664.233613134552, 6730.596164230162, 6752.3922846944015, 6764.8985265222045, 6359.14151589548, 6459.838504037249, 6466.870662586816, 6537.248216455168, 6555.639439830855, 6467.126937863516, 6473.2232132144445, 6474.902876456951, 6563.540552161303, 6564.934350656624, 6568.638724870178, 6667.899981500378, 6679.666016699049, 6761.594304341756, 6766.18805743314, 6429.774957876639, 6433.292337842927, 6510.837229069311, 6520.673966301761, 6533.771318003847, 6362.872742545031, 6436.967815160894, 6443.581167224115, 6463.806085817433, 6532.118164047983, 6179.320274769681, 6308.968455157695, 6313.05304204373, 6428.0, 6450.935490645221, 6401.775937842153, 6428.132202152837, 6471.255805582418, 6476.319986401549, 6514.511411644051, 6339.175907132043, 6361.395667411589, 6398.4561312287115, 6399.616023038632, 6405.679716014088], "value": 6022.540099804293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.9414293927953, 820.0937963550281, 836.7113345895665, 856.4518708026864, 864.4813112132721, 38827.80586097069, 40006.399904001424, 40016.59983400165, 40031.59968400315, 40166.0, 36668.0, 36818.0, 37007.0, 37087.25825483489, 37157.62842371575, 6666.0, 6794.864102717967, 6798.558093723892, 6802.931970680279, 6807.183138023444, 6596.67016649168, 7332.156801967789, 7514.286142816451, 7578.469507134503, 7601.733939312126, 7534.886976695327, 7578.825282081259, 7642.656080476364, 7658.387329013665, 7666.118396384403, 7409.962950185269, 7582.582957937311, 7592.392608591327, 7596.240375962359, 7608.277213664693, 7450.0687414073245, 7469.402447804163, 7506.699732010713, 7512.737054203131, 7517.699292028312, 36445.45331820025, 36913.81543092294, 36923.0, 36969.63030369716, 36987.0, 3487.511748355207, 3531.382008148589, 3537.7523573349877, 3540.132667496454, 3545.982270088659, 30311.0, 30404.8479757602, 30418.84790576033, 30459.0, 30467.695323046708, 4835.347228124193, 4966.801327946878, 4996.1756310208775, 5018.422881368653, 5054.292399064134, 191989.0, 192916.0, 193432.0, 193590.0, 193683.0315848426, 47631.28553071707, 47699.0, 47738.0, 47739.28391074137, 47916.28125578119, 49922.50077499251, 53650.46349536533, 54390.45609543933, 54411.45588544143, 54450.727746361015, 15375.384984600714, 15461.226938653022, 15491.922540387226, 15535.766963495556, 15544.455944041903, 12565.120441569003, 12582.0, 12628.936855315664, 12680.112392132462, 12683.809742853864, 14267.78598321026, 14398.280085995868, 14401.63995900111, 14423.278836058154, 14441.49454769078, 5766.990776614076, 5790.334111577138, 5794.710264486759, 5823.213866128103, 5879.265091863517, 1013.4172850610928, 1032.5560009195967, 1033.9379637221791, 1034.5448002878709, 1037.2117190934944, 22848.771512284664, 23678.763212367656, 23900.40248993789, 29515.0, 30194.54708179379, 1101.8126918423886, 1110.5557776889148, 1112.2714621922653, 1121.8934201250868, 1130.6325444230658, 12383.380830958416, 12497.062720296015, 16435.83564164367, 16486.422975196052, 16682.999020058836, 230048.0, 230352.0, 230591.0, 230728.0, 231601.0, 46528.30207546889, 54990.450095498534, 55281.72359138259, 55335.0, 55982.0, 1495.3345761136407, 1496.349088146638, 1503.4812989518598, 1512.7352713275134, 1513.2660659580094, 26691.0, 27795.44409111766, 28005.43989120247, 28047.439051218455, 28077.859610701817, 49850.501494986034, 50169.24746128738, 50342.748286258335, 50397.0, 50741.49258507515, 204032.0, 206757.0, 207559.0, 207757.0, 208347.0, 35524.822375887954, 35550.288994220486, 35819.64180358163, 35828.283434331686, 35855.0, 42862.57137428711, 44018.0, 44099.33850992302, 44297.0, 44311.55688443074, 31568.210794730316, 31901.0, 32027.67972320247, 32115.0, 32265.51601725929, 32035.839820800746, 32123.196920077185, 32244.516332255505, 32471.675283246866, 32675.673243268215, 35265.0, 35290.47064294089, 35370.823145884104, 35453.58185672544, 35547.82226088853, 31019.84490077535, 31426.371472569965, 31447.528287075256, 31494.0, 31602.0, 22447.0, 23713.407164820328, 23902.52194956126, 23993.400164996016, 24241.51516969686], "value": 17363.366961292162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8886222755448, 562.66802586474, 564.6809552602779, 571.3543695623945, 587.0841487279843, 21714.24000159995, 22438.0, 22504.32487025392, 22508.774912250894, 22549.0, 24193.0, 25498.470091794505, 26657.466850662975, 26710.332241693966, 26713.931442742316, 6542.93457065428, 6672.899906501382, 6703.363180497845, 6714.093597364342, 6751.932480675204, 6319.936800631981, 6521.413072823445, 6532.0, 6539.6730163491875, 6557.409833115019, 6526.641034743087, 6534.477241820667, 6543.934560654404, 6561.409473147416, 6566.80299591013, 6499.545031847772, 6544.181977252796, 6560.048792925047, 6578.868422631521, 6590.275069742349, 6045.516358691294, 6066.636001839904, 6069.514438844882, 6072.787452439144, 6078.817635470943, 29343.55984660232, 29434.705652943412, 29621.11136665882, 29771.70228297711, 30283.545746813594, 1943.689009758446, 2006.1975209916004, 2006.9799302006938, 2007.8996050197431, 2016.344687976399, 18941.81058189428, 19663.41009769695, 19718.80281197184, 19721.901390493098, 19733.80266197334, 2270.965935510969, 2362.433016076129, 2385.940351491209, 2389.880505974712, 2390.175389490623, 136250.31874840663, 138708.0, 138928.0, 139037.0, 139148.0, 14282.642933926734, 15359.462418815288, 15366.385344586315, 15487.225638718019, 15852.1281329528, 23751.7624823753, 23770.16804411872, 23776.0, 23782.64326035111, 23782.88108559446, 10355.896441035493, 10515.474226288808, 10531.315464494783, 10553.050225479743, 10649.414282214553, 9562.270714421382, 9611.951940240255, 9642.807143857084, 9734.36726612768, 9829.410235385756, 7603.315701586773, 9037.367384283038, 9319.767005824908, 9474.384165029389, 9676.854847177297, 2691.1926422073298, 2791.6650001999483, 2798.118592643311, 2799.202227365191, 2915.53351463769, 972.6498460554195, 993.5975929748463, 1010.939343639384, 1011.1657882247175, 1011.8684571005722, 20203.0, 20309.593808123755, 20358.694619580718, 20444.28445004418, 21081.0, 1031.3914790273625, 1049.3284298049255, 1056.313396292416, 1061.3313612424279, 1064.6752740414247, 10992.17558683102, 11477.713057173638, 11515.827262591069, 11527.250728702775, 11537.942310288563, 464919.0, 465827.0, 468734.0, 487821.0, 491917.0, 111786.0, 113757.0, 116168.0, 116700.0, 116748.0, 1172.3727805624121, 1186.3000829510459, 1197.6526807225807, 1205.6865215044152, 1207.034372501995, 17659.735103973708, 17955.551111222325, 18024.729629055837, 18040.18819153115, 18319.816801832345, 56044.43955560392, 56348.0, 56639.150412743016, 57611.423885762284, 57993.71003144957, 70125.29874701188, 70728.64635676789, 73746.63126684546, 78141.0, 78398.6080069596, 12150.392480376122, 12554.686132846387, 12600.55898043564, 14590.708185836436, 15398.538043858702, 22952.540949180588, 23797.52404951926, 23897.522049558564, 23961.0, 24062.15782447606, 18606.162722677782, 18653.720194196827, 18943.33698320552, 18956.43130706081, 18984.810151898306, 17236.655266894842, 17290.13549322554, 17310.480685579452, 17623.118844057488, 17708.203130858885, 18842.623147537248, 19908.50228744293, 19990.400287991382, 20071.899640501702, 20088.0, 14891.851081489047, 15122.034135562306, 15259.23703814827, 15335.233238337816, 15362.769558456408, 19004.23983040663, 19061.0, 19074.618507630046, 19264.229430822612, 19264.422067338], "value": 12106.452209734063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.464806753265, 1369.2058606008513, 1376.655836040989, 1378.7862881253402, 1383.2945197949043, 14172.433102675894, 14398.856011439882, 14862.925685371585, 14896.92551537242, 14898.180600066991, 14624.707505849876, 15081.019733717329, 15123.697526049473, 15133.697326053472, 15135.318910649019, 2673.5588627876377, 2736.480068786924, 2736.6852811926583, 2742.3555464465835, 2749.1065403743764, 2658.3221278573938, 2726.9181924542195, 2757.8483183424905, 2771.431856469419, 2773.4314465534617, 2673.46530693862, 2673.9598906016327, 2708.7155848635907, 2711.267957651433, 2719.789693586355, 2576.2013775729397, 2590.235880415282, 2591.818572699912, 2593.987030064847, 2612.686477622688, 2548.5412625727363, 2562.705288891783, 2584.5089433007856, 2601.50571391435, 2602.817802753808, 14061.648458788612, 14311.713765724628, 14390.784138237936, 14397.85602143986, 14428.639284017878, 7396.260373962561, 7718.112417072052, 7722.382209423233, 7738.845223095563, 7739.57432341221, 4991.7753701083175, 5033.84898453047, 5067.315912351823, 5181.015607034689, 5188.844334669966, 1878.5021969178179, 1882.2941396976134, 1893.384649988759, 1926.6050459655878, 1937.4865660599812, 22332.441688957904, 22692.20577279787, 22801.087956481722, 22813.42966425836, 22822.77177228223, 6558.6064836109035, 6598.802035938929, 6641.86716265672, 6772.966135169293, 6801.659917004229, 17910.731339029924, 17937.730934036, 17960.730589041174, 17965.910170449326, 17985.1007449627, 7417.147028091731, 7682.423818213656, 7689.50018248812, 7705.730299439493, 7712.537247765152, 5823.94176058234, 5945.494632956161, 6272.1219029335925, 6900.7929762107215, 7147.749828755968, 5502.184279187858, 5636.154576813511, 5643.5767317451355, 5669.092945128842, 5740.598158128974, 1696.2282161616436, 1756.47305808257, 1756.8594512439229, 1758.1033672826695, 1775.3608700867678, 873.1399571422144, 884.2174675412178, 888.3515034025069, 895.1048951048951, 898.3666515106834, 7266.92733072673, 7309.086364204474, 7312.085989251344, 7370.041894553674, 7403.777886663409, 707.6426404665611, 711.6584039660992, 723.4068064187315, 726.5713229194695, 733.5195446982235, 4650.720956742606, 5159.47326631811, 5285.788568457296, 5449.5640348772, 5503.944960550423, 19363.0, 20077.196912123352, 20077.899610501852, 20180.29368972079, 20199.0, 19150.808491914904, 19539.120739566755, 19817.702734458995, 19823.207071717257, 20145.395638130878, 11258.493367798468, 11285.492152853141, 11291.0, 11300.54797808095, 11303.491342889425, 8283.461574997606, 8338.332933365438, 8563.314934805076, 8867.556622168737, 9114.088591140833, 17028.14859257057, 17195.05427201516, 17409.390671326444, 17420.216090275713, 17519.124043797503, 17920.820791791914, 17953.73069403934, 18041.819581804015, 18050.458486245432, 18150.18324175389, 11058.22592418523, 11428.599998999995, 11491.770164596828, 11933.164678472423, 12132.211406258564, 13375.732485350432, 13476.258805765778, 13489.662758431117, 13499.190048597116, 13515.39180736889, 10522.0, 10590.099841513249, 10602.25784195099, 10662.946685266525, 10801.513931873242, 10177.134943529587, 10384.636537721144, 10449.111825494614, 10485.475726213506, 10698.465076746288, 9338.112879276458, 9379.343445958717, 9450.858237126311, 9586.137247647745, 9587.328886978125, 7402.259774022555, 7495.325420712162, 7498.287662672037, 7530.0, 7634.50375725576, 6995.860082798417, 7028.613426261605, 7039.859202816017, 7092.326229008236, 7148.535345202546], "value": 6456.963874460167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.3434426147653, 502.4473079612427, 507.80195723667777, 513.7970501651847, 522.7203446156306, 6187.319394866567, 6265.24817021958, 6298.905516417251, 6304.294613374903, 6318.652474113922, 5921.615095018821, 6167.969160154193, 6180.938190618092, 6208.534359923001, 6241.344658810827, 4928.531789479994, 4956.107900577895, 4956.942868709481, 4967.726775027372, 4971.0, 4815.903681926359, 4918.778654960535, 4946.159152944008, 4952.479989601094, 4989.9750501247445, 4861.73260470674, 4888.975555122237, 4912.754362281889, 4952.034353301107, 4960.156773348522, 4894.877628059309, 4925.13810083234, 4929.260610908356, 4934.407871055479, 4964.528369804862, 4437.4009508716235, 4444.466664000341, 4452.933206001912, 4453.465584129925, 4465.343120843093, 6030.547708921805, 6071.787487437919, 6082.1180928765525, 6129.233845769279, 6169.96915015422, 5681.431856814327, 5683.5169010634145, 5703.0, 5720.140954189905, 5723.599348045638, 6525.282218955911, 6554.377334153248, 6580.341965803382, 6620.702068406885, 6668.066470694107, 4860.149473842063, 4871.82948596801, 4878.487758785312, 4889.0, 4901.2158054711435, 6944.236134025253, 6945.78448771468, 6986.266442023565, 6995.650217489156, 7022.4733145014325, 5002.474740152305, 5009.649324547319, 5011.123053465629, 5034.89930201394, 5040.899182016413, 5074.492550744896, 5077.669951453144, 5091.821786237464, 5106.514881086291, 5122.718250496184, 5559.9444005560235, 5634.802781902614, 5651.632643878134, 5652.943470565242, 5708.9714551427805, 6303.621782693053, 6528.836779080466, 6535.509836762262, 6598.911179655303, 6630.403263706289, 1639.524537884024, 1677.3793696332434, 1705.5139285303628, 1717.1671739206474, 1741.8780685352158, 1194.796884529632, 1205.4515195585986, 1213.635909227246, 1222.6943264183953, 1247.2391840976998, 5659.26429564154, 5706.9429305707245, 5746.195532625436, 5756.1653560233535, 5759.740811663485, 6569.572977756526, 6739.393454589111, 6753.561018533779, 6756.966215168893, 6884.896726549106, 5708.257926469615, 5760.423957604206, 5772.855678607984, 5788.681622510718, 5801.53587712982, 3572.857085716594, 3582.4089025311055, 3599.3341231871664, 3617.7105831533413, 3631.4371272452813, 6626.933730662631, 6636.435902948207, 6685.128164114056, 6708.865822683519, 6725.831854203684, 6864.176298844171, 6880.208775990825, 6880.827979300558, 6896.344847239504, 7019.92980070203, 6533.183352081085, 6598.802035938929, 6612.7354905804195, 6643.634600097041, 6718.764843230463, 6794.76218332356, 6820.31796820314, 6845.755631508497, 6848.3494068063455, 6874.634607024475, 6706.329367063255, 6727.293634168537, 6734.528582999143, 6795.966020169867, 6847.246802851582, 6463.741450341934, 6568.967155164193, 6573.57271777333, 6658.43403310724, 6681.498887583353, 4906.607471402351, 4929.876753081202, 4964.751762411793, 5010.8496745096245, 5030.415419143104, 6544.004078755835, 6728.562643428161, 6780.355866192704, 6803.829904252433, 6812.523123381514, 6263.248410190807, 6435.485161187187, 6529.902051469327, 6588.8352791180605, 6633.767818126343, 6439.613623182624, 6470.188347262774, 6556.2788093308745, 6576.473882089325, 6581.6709164542535, 6354.0, 6506.121673574196, 6527.934720652923, 6561.704723287559, 6584.5184833412095, 6677.399034086956, 6688.665566721742, 6696.665166741546, 6706.5976041435715, 6711.46308295345, 6467.0, 6474.935250647622, 6483.0, 6490.675466226764, 6498.870022599616], "value": 5064.92954657443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.2521881619439, 902.8194361127776, 908.6592527802075, 909.1226965977833, 941.1858742188007, 17457.127143642814, 18024.81975180248, 18088.728669069973, 18161.4551563453, 18180.090995450224, 14916.403343866232, 14916.776248356284, 19222.111241968436, 21902.671459928115, 21977.120915163414, 965.92755543334, 987.8370068938652, 988.4859872866106, 990.2573070197352, 990.747359423346, 937.9343445958785, 1047.6804574604741, 1048.1719441641094, 1048.4390850894772, 1048.6906362623045, 1080.9675709728722, 1081.291753901196, 1081.7674200046988, 1082.9675109746681, 1084.322298563398, 1075.7955988362187, 1076.5424694504843, 1077.5420446310286, 1077.617445806735, 1082.3019152646539, 795.3398679096337, 795.431266644352, 795.677750511044, 796.0328201235527, 801.1587832775563, 19629.116689748997, 19931.30240441592, 20088.89955550213, 20338.49153771153, 20422.79577204224, 21275.46811329729, 21599.0, 21843.563128737336, 21942.341729748132, 22029.118835246732, 16539.0, 16644.50066498007, 16830.410935617194, 16849.0, 16851.241694123793, 3510.473428985647, 3554.680078792921, 3557.9822100889587, 3558.733095017858, 3582.946255806165, 121806.39096804548, 122335.38832305782, 124909.37545312307, 126377.36811315885, 127588.36205819005, 15503.069815811088, 15505.922470387575, 15522.301496432689, 15612.063276203464, 15672.764908526382, 31716.682833171373, 32018.519722204186, 32023.83988080091, 32751.0, 32825.50761738576, 8346.8330633387, 8387.161283871565, 8413.74758757226, 8418.536980466133, 8421.705240316682, 3929.115948911472, 3991.2416640838146, 4026.6778657707314, 4040.1919616076902, 4057.776822274744, 4933.260010998379, 4994.275830004629, 4994.825181118644, 5024.572911302507, 5028.673136246132, 904.2675432899373, 928.215657769184, 940.182041623778, 942.1520631431766, 948.1561410344799, 680.6086500262369, 692.6882902693808, 693.8751024815481, 696.2828286864537, 707.5012116457884, 11372.260803047775, 12105.87894121065, 12382.81425778614, 12400.875991240153, 12441.502339906303, 684.8527566573111, 686.3205426627702, 688.834679676874, 690.2407351912956, 700.3171907390356, 5522.91715624266, 5780.768769249183, 5806.941930580725, 5993.700314984233, 6322.841928951721, 106720.46639766906, 111985.0, 112298.0, 113165.0, 114211.42894285642, 95192.0, 96623.0, 99086.5045674767, 100154.0, 102935.4853225744, 86821.56589217139, 88482.0, 89169.0, 90114.54942725244, 90314.54842725876, 12188.390580471118, 12242.387880605756, 12340.938295308466, 12964.8055279169, 13065.738685226432, 39028.414573781985, 39531.40702889401, 39567.2086558273, 39978.0, 41329.380059298535, 54653.45346546484, 72609.6369518149, 73313.0, 73486.63256683682, 75173.0, 17559.12204389801, 17692.11539422998, 17697.557561061076, 19125.713114303573, 20030.0, 22394.552108957403, 22651.546969060855, 23519.52960940806, 23615.0, 23766.287011389686, 19803.91078490697, 20303.4924126898, 20647.58704825865, 20730.0, 21012.68480972756, 18198.636027279117, 18620.44138675842, 18876.33932812345, 19223.23107075757, 19410.51473713112, 18528.0, 18629.347972820888, 18908.716369254747, 19862.304819331253, 20257.0, 14349.928250358682, 14382.0, 14453.277336133362, 14726.558203253919, 14938.925305373403, 14264.286785660468, 14788.704225915637, 15199.556042175976, 15449.382024718885, 15545.611359715645], "value": 9249.02575218595, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 100.0, 107.0, 108.0, 108.0, 110.0, 98.0, 108.0, 108.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 139.0, 189.0, 121.0, 155.0, 150.0, 119.0, 179.0, 124.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 163.0, 162.0, 164.0, 163.0, 172.0, 162.0, 164.0, 167.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 168.0, 84.0, 81.0, 77.0, 76.0, 162.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 138.0, 79.0, 82.0, 80.0, 141.0, 92.0, 79.0, 130.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 113.0, 115.0, 117.0, 118.0, 117.0, 119.0, 115.0, 114.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 158.0, 151.0, 150.0, 150.0, 150.0, 157.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 99.0, 93.0, 98.0, 99.0, 94.0, 94.0, 93.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 59.0, 54.0, 52.0, 56.0, 53.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 60.0, 62.0, 62.0, 59.0, 60.0, 55.0, 57.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 82.0, 80.0, 80.0, 78.0, 89.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 126.0, 123.0, 123.0, 127.0, 122.0, 124.0, 130.0, 168.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 178.0, 174.0, 188.0, 174.0, 184.0, 183.0, 184.0, 180.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 70.0, 70.0, 72.0, 67.0, 72.0, 72.0, 69.0], "value": 70.0, "unit": "score"}]}]} 20:03:18 INFO - Return code: 0 20:03:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:03:18 INFO - # TBPL SUCCESS # 20:03:18 INFO - Running post-action listener: _package_coverage_data 20:03:18 INFO - Running post-action listener: _resource_record_post_action 20:03:18 INFO - [mozharness: 2017-08-16 03:03:18.395794Z] Finished run-tests step (success) 20:03:18 INFO - Running post-run listener: _resource_record_post_run 20:03:18 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437821440; Read time: 16; Write time: 353604 20:03:18 INFO - TinderboxPrint: CPU usage
13.1% 20:03:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:03:18 INFO - TinderboxPrint: I/O write bytes / time
437,821,440 / 353,604 20:03:18 INFO - TinderboxPrint: CPU idle
8,252.9 (86.8%) 20:03:18 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 20:03:18 INFO - TinderboxPrint: Swap in / out
0 / 0 20:03:18 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 112922624; Read time: 0; Write time: 135976 20:03:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:03:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324898816; Read time: 16; Write time: 217628 20:03:19 INFO - Running post-run listener: _upload_blobber_files 20:03:19 INFO - Blob upload gear active. 20:03:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:19 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 20:03:19 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'] 20:03:19 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 20:03:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:20 INFO - (blobuploader) - INFO - Done attempting. 20:03:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:03:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:21 INFO - (blobuploader) - INFO - Done attempting. 20:03:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:03:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:03:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:22 INFO - (blobuploader) - INFO - Done attempting. 20:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:29 INFO - (blobuploader) - INFO - Done attempting. 20:03:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:29 INFO - Return code: 0 20:03:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac794b1190f57f14e438e1952fcd665a0c930728ff91ba8323a404b51f3975f70c1dc3fbf0f51735990acc8c8784a4f52a79896f52c75bc4596df77393222c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53016957ddc70cde468c8d98a922e6258cbbb878e24efe489a5c0554654481bb9dec66b11d8fe412a6ffe91cbcc2fea61e49affa55882de4a5271e5648fb8d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159c38ec5b69c95d7ca4d343ecd529bde959dc66888b9735dbaac9af1a39f1eb5746dc2bd260b06e5098c36e03bc7aef9a1376ceec87fb78cb421bc58c15edbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3e9a1cb4b6712a26aaadde51eabfaa5019ee0af5add16bae6c3022671004784b223d0fa5b03c265ee57c21f64ba157023db4e5f18a126625baae42065f41c7a"} 20:03:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:29 INFO - Contents: 20:03:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac794b1190f57f14e438e1952fcd665a0c930728ff91ba8323a404b51f3975f70c1dc3fbf0f51735990acc8c8784a4f52a79896f52c75bc4596df77393222c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53016957ddc70cde468c8d98a922e6258cbbb878e24efe489a5c0554654481bb9dec66b11d8fe412a6ffe91cbcc2fea61e49affa55882de4a5271e5648fb8d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159c38ec5b69c95d7ca4d343ecd529bde959dc66888b9735dbaac9af1a39f1eb5746dc2bd260b06e5098c36e03bc7aef9a1376ceec87fb78cb421bc58c15edbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3e9a1cb4b6712a26aaadde51eabfaa5019ee0af5add16bae6c3022671004784b223d0fa5b03c265ee57c21f64ba157023db4e5f18a126625baae42065f41c7a"} 20:03:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:29 INFO - Copying logs to upload dir... 20:03:29 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.984747 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 20:03:29.452750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:29.456553) ========= 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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac794b1190f57f14e438e1952fcd665a0c930728ff91ba8323a404b51f3975f70c1dc3fbf0f51735990acc8c8784a4f52a79896f52c75bc4596df77393222c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53016957ddc70cde468c8d98a922e6258cbbb878e24efe489a5c0554654481bb9dec66b11d8fe412a6ffe91cbcc2fea61e49affa55882de4a5271e5648fb8d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159c38ec5b69c95d7ca4d343ecd529bde959dc66888b9735dbaac9af1a39f1eb5746dc2bd260b06e5098c36e03bc7aef9a1376ceec87fb78cb421bc58c15edbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3e9a1cb4b6712a26aaadde51eabfaa5019ee0af5add16bae6c3022671004784b223d0fa5b03c265ee57c21f64ba157023db4e5f18a126625baae42065f41c7a"} build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac794b1190f57f14e438e1952fcd665a0c930728ff91ba8323a404b51f3975f70c1dc3fbf0f51735990acc8c8784a4f52a79896f52c75bc4596df77393222c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53016957ddc70cde468c8d98a922e6258cbbb878e24efe489a5c0554654481bb9dec66b11d8fe412a6ffe91cbcc2fea61e49affa55882de4a5271e5648fb8d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159c38ec5b69c95d7ca4d343ecd529bde959dc66888b9735dbaac9af1a39f1eb5746dc2bd260b06e5098c36e03bc7aef9a1376ceec87fb78cb421bc58c15edbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3e9a1cb4b6712a26aaadde51eabfaa5019ee0af5add16bae6c3022671004784b223d0fa5b03c265ee57c21f64ba157023db4e5f18a126625baae42065f41c7a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:29.487946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:29.488383) ========= 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=523ca41ca1e0623de333ad52000001bf-1502851054.996673-1076363320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:29.568824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:29.569230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:29.569628) ========= ========= Total master_lag: 0.24 =========