builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1502851341.18 results: success (0) revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.176311) ========= 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:21.176944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.180360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.248881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.252244) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.3M=0s 2017-08-15 19:42:21 (86.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.358564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.358906) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.414021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-15 19:42:21.417407) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 19:42:21,563 truncating revision to first 12 chars 2017-08-15 19:42:21,563 Setting DEBUG logging. 2017-08-15 19:42:21,563 attempt 1/10 2017-08-15 19:42:21,563 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,504 attempt 1/10 2017-08-15 19:42:23,092 current task status: no status available at this point. state: STARTED 2017-08-15 19:42:23,093 sleeping for 11.00s (attempt 1/10) 2017-08-15 19:42:34,104 attempt 2/10 2017-08-15 19:42:34,413 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-15 19:42:34,619 unpacking tar archive at: mozilla-central-6966f27380bf/testing/mozharness/ program finished with exit code 0 elapsedTime=13.380373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-15 19:42:34.818162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:34.818619) ========= script_repo_revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:34.819129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:34.819435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:34.837085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 19:42:34.837530) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:35 INFO - MultiFileLogger online at 20170815 19:42:35 in /builds/slave/test 19:42:35 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:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:35 INFO - {'append_to_log': False, 19:42:35 INFO - 'base_work_dir': '/builds/slave/test', 19:42:35 INFO - 'blob_upload_branch': 'Firefox', 19:42:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:35 INFO - 'branch': 'Firefox', 19:42:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:35 INFO - 'code_coverage': False, 19:42:35 INFO - 'config_files': ('talos/linux_config.py',), 19:42:35 INFO - 'default_actions': ('clobber', 19:42:35 INFO - 'read-buildbot-config', 19:42:35 INFO - 'download-and-extract', 19:42:35 INFO - 'populate-webroot', 19:42:35 INFO - 'create-virtualenv', 19:42:35 INFO - 'install', 19:42:35 INFO - 'setup-mitmproxy', 19:42:35 INFO - 'run-tests'), 19:42:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:35 INFO - 'disable_ccov_upload': False, 19:42:35 INFO - 'download_minidump_stackwalk': True, 19:42:35 INFO - 'download_symbols': 'ondemand', 19:42:35 INFO - 'enable_stylo': False, 19:42:35 INFO - 'enable_webrender': False, 19:42:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:35 INFO - 'gecko_profile': False, 19:42:35 INFO - 'gecko_profile_interval': 0, 19:42:35 INFO - 'installer_path': 'installer.exe', 19:42:35 INFO - 'log_level': 'info', 19:42:35 INFO - 'log_name': 'talos', 19:42:35 INFO - 'log_to_console': True, 19:42:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:35 INFO - 'opt_config_files': (), 19:42:35 INFO - 'pip_index': False, 19:42:35 INFO - 'suite': 'dromaeojs-e10s', 19:42:35 INFO - 'system_bits': '32', 19:42:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:35 INFO - 'title': 'talos-linux64-ix-034', 19:42:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:35 INFO - 'use_talos_json': True, 19:42:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:35 INFO - 'work_dir': 'build'} 19:42:35 INFO - [mozharness: 2017-08-16 02:42:35.089987Z] Running clobber step. 19:42:35 INFO - Running pre-action listener: _resource_record_pre_action 19:42:35 INFO - Running main action method: clobber 19:42:35 INFO - rmtree: /builds/slave/test/build 19:42:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:36 INFO - Running post-action listener: _resource_record_post_action 19:42:36 INFO - [mozharness: 2017-08-16 02:42:36.107828Z] Finished clobber step (success) 19:42:36 INFO - [mozharness: 2017-08-16 02:42:36.107931Z] Running read-buildbot-config step. 19:42:36 INFO - Running pre-action listener: _resource_record_pre_action 19:42:36 INFO - Running main action method: read_buildbot_config 19:42:36 INFO - Using buildbot properties: 19:42:36 INFO - { 19:42:36 INFO - "project": "", 19:42:36 INFO - "product": "firefox", 19:42:36 INFO - "who": "kwierso@gmail.com", 19:42:36 INFO - "installer_path": "public/build/target.tar.bz2", 19:42:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:42:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:42:36 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:42:36 INFO - "stage_platform": "linux64-stylosequential", 19:42:36 INFO - "basedir": "/builds/slave/test", 19:42:36 INFO - "buildnumber": 191, 19:42:36 INFO - "platform": "ubuntu64_hw_styloseq", 19:42:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:42:36 INFO - "slavebuilddir": "test", 19:42:36 INFO - "taskId": "FIeOfBdOTM6BR0095EhI1g", 19:42:36 INFO - "branch": "mozilla-central", 19:42:36 INFO - "script_repo_revision": "production", 19:42:36 INFO - "revision": "6966f27380bf2e3e5ace3507f600852bd3ed9dbd", 19:42:36 INFO - "slavename": "talos-linux64-ix-034", 19:42:36 INFO - "repo_path": "mozilla-central" 19:42:36 INFO - } 19:42:36 INFO - Finding installer, test and symbols from parent task. 19:42:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FIeOfBdOTM6BR0095EhI1g'}, attempt #1 19:42:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FIeOfBdOTM6BR0095EhI1g'}, attempt #1 19:42:37 INFO - Task dependencies: YvnAGiJcTqymla8mJLMVSg 19:42:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg'}, attempt #1 19:42:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:42:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip 19:42:37 INFO - Running post-action listener: _resource_record_post_action 19:42:37 INFO - [mozharness: 2017-08-16 02:42:37.468960Z] Finished read-buildbot-config step (success) 19:42:37 INFO - [mozharness: 2017-08-16 02:42:37.469228Z] Running download-and-extract step. 19:42:37 INFO - Running pre-action listener: _resource_record_pre_action 19:42:37 INFO - Running main action method: download_and_extract 19:42:37 INFO - mkdir: /builds/slave/test/build/tests 19:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:42:37 INFO - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:37 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:37 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:38 INFO - Downloaded 989 bytes. 19:42:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:42:38 INFO - Using the following test package requirements: 19:42:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:42:38 INFO - u'common': [u'target.common.tests.zip'], 19:42:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:42:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:42:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:42:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:42:38 INFO - u'mozbase': [u'target.common.tests.zip'], 19:42:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:42:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:42:38 INFO - u'web-platform': [u'target.common.tests.zip', 19:42:38 INFO - u'target.web-platform.tests.tar.gz'], 19:42:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:42:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:42:38 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:38 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:38 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:40 INFO - Content-Length response header: 54002789 19:42:40 INFO - Bytes received: 54002789 19:42:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:42:51 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:51 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:51 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:53 INFO - Content-Length response header: 54002789 19:42:53 INFO - Bytes received: 54002789 19:43:07 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:07 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:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.talos.tests.zip into memory 19:43:08 INFO - Content-Length response header: 14496050 19:43:08 INFO - Bytes received: 14496050 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 - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:08 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:08 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:09 INFO - Downloaded 62021852 bytes. 19:43:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:09 INFO - mkdir: /builds/slave/test/properties 19:43:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:09 INFO - Contents: 19:43:09 INFO - build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:09 INFO - Running post-action listener: _resource_record_post_action 19:43:09 INFO - Running post-action listener: set_extra_try_arguments 19:43:09 INFO - [mozharness: 2017-08-16 02:43:09.453892Z] Finished download-and-extract step (success) 19:43:09 INFO - [mozharness: 2017-08-16 02:43:09.453991Z] Running populate-webroot step. 19:43:09 INFO - Running pre-action listener: _resource_record_pre_action 19:43:09 INFO - Running main action method: populate_webroot 19:43:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:43:09 INFO - 'tests': ['damp', 'tps']}, 19:43:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:43:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:43:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:43:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:09 INFO - 'ts_paint', 19:43:09 INFO - 'tpaint', 19:43:09 INFO - 'sessionrestore', 19:43:09 INFO - 'sessionrestore_many_windows', 19:43:09 INFO - 'sessionrestore_no_auto_restore', 19:43:09 INFO - 'tabpaint']}, 19:43:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:43:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:43:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:09 INFO - 'tsvgr_opacity', 19:43:09 INFO - 'tart', 19:43:09 INFO - 'tscrollx', 19:43:09 INFO - 'tsvg_static']}, 19:43:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:43:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:09 INFO - 'talos_options': ['--mitmproxy', 19:43:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:09 INFO - '--firstNonBlankPaint'], 19:43:09 INFO - 'tests': ['tp6_google', 19:43:09 INFO - 'tp6_youtube', 19:43:09 INFO - 'tp6_amazon', 19:43:09 INFO - 'tp6_facebook']}, 19:43:09 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:09 INFO - 'talos_options': ['--stylo', 19:43:09 INFO - '--mitmproxy', 19:43:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:09 INFO - '--firstNonBlankPaint'], 19:43:09 INFO - 'tests': ['tp6_google', 19:43:09 INFO - 'tp6_youtube', 19:43:09 INFO - 'tp6_amazon', 19:43:09 INFO - 'tp6_facebook']}, 19:43:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:09 INFO - 'talos_options': ['--stylo', 19:43:09 INFO - '--stylo-threads=1', 19:43:09 INFO - '--mitmproxy', 19:43:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:09 INFO - '--firstNonBlankPaint'], 19:43:09 INFO - 'tests': ['tp6_google', 19:43:09 INFO - 'tp6_youtube', 19:43:09 INFO - 'tp6_amazon', 19:43:09 INFO - 'tp6_facebook']}, 19:43:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:43:09 INFO - 'talos_options': ['--xperf_path', 19:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:09 INFO - 'tests': ['tp5n']}}} 19:43:09 INFO - Running post-action listener: _resource_record_post_action 19:43:09 INFO - [mozharness: 2017-08-16 02:43:09.462538Z] Finished populate-webroot step (success) 19:43:09 INFO - [mozharness: 2017-08-16 02:43:09.462629Z] Running create-virtualenv step. 19:43:09 INFO - Running pre-action listener: _resource_record_pre_action 19:43:09 INFO - Running main action method: create_virtualenv 19:43:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:09 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:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:43:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:09 INFO - Using real prefix '/usr' 19:43:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:12 INFO - Installing pip.................done. 19:43:12 INFO - Return code: 0 19:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:43:12 INFO - Reading from file tmpfile_stdout 19:43:12 INFO - Output received: 19:43:12 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:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:12 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 19:43:12 INFO - 'HOME': '/home/cltbld', 19:43:12 INFO - 'LANG': 'en_US.UTF-8', 19:43:12 INFO - 'LANGUAGE': 'en_US:en', 19:43:12 INFO - 'LOGNAME': 'cltbld', 19:43:12 INFO - 'MAIL': '/var/mail/cltbld', 19:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:12 INFO - 'MOZ_NO_REMOTE': '1', 19:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:12 INFO - 'NO_EM_RESTART': '1', 19:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:12 INFO - 'PWD': '/builds/slave/test', 19:43:12 INFO - 'SHELL': '/bin/bash', 19:43:12 INFO - 'SHLVL': '1', 19:43:12 INFO - 'TERM': 'linux', 19:43:12 INFO - 'TMOUT': '86400', 19:43:12 INFO - 'USER': 'cltbld', 19:43:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:12 INFO - '_': '/tools/buildbot/bin/python'} 19:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:12 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:12 INFO - Cleaning up... 19:43:12 INFO - Return code: 0 19:43:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:43:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:12 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 19:43:12 INFO - 'HOME': '/home/cltbld', 19:43:12 INFO - 'LANG': 'en_US.UTF-8', 19:43:12 INFO - 'LANGUAGE': 'en_US:en', 19:43:12 INFO - 'LOGNAME': 'cltbld', 19:43:12 INFO - 'MAIL': '/var/mail/cltbld', 19:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:12 INFO - 'MOZ_NO_REMOTE': '1', 19:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:12 INFO - 'NO_EM_RESTART': '1', 19:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:12 INFO - 'PWD': '/builds/slave/test', 19:43:12 INFO - 'SHELL': '/bin/bash', 19:43:12 INFO - 'SHLVL': '1', 19:43:12 INFO - 'TERM': 'linux', 19:43:12 INFO - 'TMOUT': '86400', 19:43:12 INFO - 'USER': 'cltbld', 19:43:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:12 INFO - '_': '/tools/buildbot/bin/python'} 19:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:12 INFO - Downloading/unpacking psutil>=3.1.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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:13 INFO - Installing collected packages: psutil 19:43:13 INFO - Running setup.py install for psutil 19:43:13 INFO - building 'psutil._psutil_linux' extension 19:43:13 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:14 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:14 INFO - building 'psutil._psutil_posix' extension 19:43:14 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:14 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:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:14 INFO - Successfully installed psutil 19:43:14 INFO - Cleaning up... 19:43:14 INFO - Return code: 0 19:43:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:14 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 19:43:14 INFO - 'HOME': '/home/cltbld', 19:43:14 INFO - 'LANG': 'en_US.UTF-8', 19:43:14 INFO - 'LANGUAGE': 'en_US:en', 19:43:14 INFO - 'LOGNAME': 'cltbld', 19:43:14 INFO - 'MAIL': '/var/mail/cltbld', 19:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:14 INFO - 'MOZ_NO_REMOTE': '1', 19:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:14 INFO - 'NO_EM_RESTART': '1', 19:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:14 INFO - 'PWD': '/builds/slave/test', 19:43:14 INFO - 'SHELL': '/bin/bash', 19:43:14 INFO - 'SHLVL': '1', 19:43:14 INFO - 'TERM': 'linux', 19:43:14 INFO - 'TMOUT': '86400', 19:43:14 INFO - 'USER': 'cltbld', 19:43:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:14 INFO - '_': '/tools/buildbot/bin/python'} 19:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:43:14 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:14 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:14 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:14 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 mozsystemmonitor-0.3.tar.gz 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:15 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:15 INFO - Installing collected packages: mozsystemmonitor 19:43:15 INFO - Running setup.py install for mozsystemmonitor 19:43:15 INFO - Successfully installed mozsystemmonitor 19:43:15 INFO - Cleaning up... 19:43:15 INFO - Return code: 0 19:43:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:43:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:15 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 19:43:15 INFO - 'HOME': '/home/cltbld', 19:43:15 INFO - 'LANG': 'en_US.UTF-8', 19:43:15 INFO - 'LANGUAGE': 'en_US:en', 19:43:15 INFO - 'LOGNAME': 'cltbld', 19:43:15 INFO - 'MAIL': '/var/mail/cltbld', 19:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:15 INFO - 'MOZ_NO_REMOTE': '1', 19:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:15 INFO - 'NO_EM_RESTART': '1', 19:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:15 INFO - 'PWD': '/builds/slave/test', 19:43:15 INFO - 'SHELL': '/bin/bash', 19:43:15 INFO - 'SHLVL': '1', 19:43:15 INFO - 'TERM': 'linux', 19:43:15 INFO - 'TMOUT': '86400', 19:43:15 INFO - 'USER': 'cltbld', 19:43:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:15 INFO - '_': '/tools/buildbot/bin/python'} 19:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:43:16 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:16 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:16 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:16 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:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:43:17 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:17 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:17 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:17 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:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:17 INFO - warning: no files found matching '*.txt' 19:43:17 INFO - no previously-included directories found matching 'build' 19:43:17 INFO - no previously-included directories found matching 'dist' 19:43:17 INFO - no previously-included directories found matching '.git*' 19:43:17 INFO - Installing collected packages: jsonschema, functools32 19:43:17 INFO - Running setup.py install for functools32 19:43:17 INFO - warning: no files found matching '*.txt' 19:43:17 INFO - no previously-included directories found matching 'build' 19:43:17 INFO - no previously-included directories found matching 'dist' 19:43:17 INFO - no previously-included directories found matching '.git*' 19:43:17 INFO - Successfully installed jsonschema functools32 19:43:17 INFO - Cleaning up... 19:43:17 INFO - Return code: 0 19:43:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:17 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 19:43:17 INFO - 'HOME': '/home/cltbld', 19:43:17 INFO - 'LANG': 'en_US.UTF-8', 19:43:17 INFO - 'LANGUAGE': 'en_US:en', 19:43:17 INFO - 'LOGNAME': 'cltbld', 19:43:17 INFO - 'MAIL': '/var/mail/cltbld', 19:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:17 INFO - 'MOZ_NO_REMOTE': '1', 19:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:17 INFO - 'NO_EM_RESTART': '1', 19:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:17 INFO - 'PWD': '/builds/slave/test', 19:43:17 INFO - 'SHELL': '/bin/bash', 19:43:17 INFO - 'SHLVL': '1', 19:43:17 INFO - 'TERM': 'linux', 19:43:17 INFO - 'TMOUT': '86400', 19:43:17 INFO - 'USER': 'cltbld', 19:43:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:17 INFO - '_': '/tools/buildbot/bin/python'} 19:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:43:17 INFO - Cleaning up... 19:43:17 INFO - Return code: 0 19:43:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:17 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 19:43:17 INFO - 'HOME': '/home/cltbld', 19:43:17 INFO - 'LANG': 'en_US.UTF-8', 19:43:17 INFO - 'LANGUAGE': 'en_US:en', 19:43:17 INFO - 'LOGNAME': 'cltbld', 19:43:17 INFO - 'MAIL': '/var/mail/cltbld', 19:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:17 INFO - 'MOZ_NO_REMOTE': '1', 19:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:17 INFO - 'NO_EM_RESTART': '1', 19:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:17 INFO - 'PWD': '/builds/slave/test', 19:43:17 INFO - 'SHELL': '/bin/bash', 19:43:17 INFO - 'SHLVL': '1', 19:43:17 INFO - 'TERM': 'linux', 19:43:17 INFO - 'TMOUT': '86400', 19:43:17 INFO - 'USER': 'cltbld', 19:43:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:17 INFO - '_': '/tools/buildbot/bin/python'} 19:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:18 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:18 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:18 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:18 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:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43:19 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:19 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:19 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:19 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:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43:19 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:19 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:19 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:19 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:19 INFO - Downloading docopt-0.6.1.tar.gz 19:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:19 INFO - Running setup.py install for blobuploader 19:43:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:19 INFO - Running setup.py install for requests 19:43:20 INFO - Running setup.py install for docopt 19:43:20 INFO - Successfully installed blobuploader requests docopt 19:43:20 INFO - Cleaning up... 19:43:20 INFO - Return code: 0 19:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:20 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 19:43:20 INFO - 'HOME': '/home/cltbld', 19:43:20 INFO - 'LANG': 'en_US.UTF-8', 19:43:20 INFO - 'LANGUAGE': 'en_US:en', 19:43:20 INFO - 'LOGNAME': 'cltbld', 19:43:20 INFO - 'MAIL': '/var/mail/cltbld', 19:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:20 INFO - 'MOZ_NO_REMOTE': '1', 19:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:20 INFO - 'NO_EM_RESTART': '1', 19:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:20 INFO - 'PWD': '/builds/slave/test', 19:43:20 INFO - 'SHELL': '/bin/bash', 19:43:20 INFO - 'SHLVL': '1', 19:43:20 INFO - 'TERM': 'linux', 19:43:20 INFO - 'TMOUT': '86400', 19:43:20 INFO - 'USER': 'cltbld', 19:43:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:20 INFO - '_': '/tools/buildbot/bin/python'} 19:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:20 INFO - Running setup.py (path:/tmp/pip-M0E9Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:20 INFO - Running setup.py (path:/tmp/pip-1icvlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:20 INFO - Running setup.py (path:/tmp/pip-RjM1Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:20 INFO - Running setup.py (path:/tmp/pip-ck0iDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:20 INFO - Running setup.py (path:/tmp/pip-Tv_Qus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:20 INFO - Running setup.py (path:/tmp/pip-icbFo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:20 INFO - Running setup.py (path:/tmp/pip-VLhs31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:21 INFO - Running setup.py (path:/tmp/pip-l_8ERp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:21 INFO - Running setup.py (path:/tmp/pip-h8EW4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:21 INFO - Running setup.py (path:/tmp/pip-OYGYhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:21 INFO - Running setup.py (path:/tmp/pip-7oUQCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:21 INFO - Running setup.py (path:/tmp/pip-ARVWSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:21 INFO - Running setup.py (path:/tmp/pip-P8BYx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:21 INFO - Running setup.py (path:/tmp/pip-q8xb4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:21 INFO - Running setup.py (path:/tmp/pip-PczCtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:21 INFO - Running setup.py (path:/tmp/pip-0l6yIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:21 INFO - Running setup.py (path:/tmp/pip-rqcf9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:21 INFO - Running setup.py install for manifestparser 19:43:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:21 INFO - Running setup.py install for mozcrash 19:43:21 INFO - Running setup.py install for mozdebug 19:43:22 INFO - Running setup.py install for mozdevice 19:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for mozfile 19:43:22 INFO - Running setup.py install for mozhttpd 19:43:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for mozinfo 19:43:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for mozInstall 19:43:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for mozleak 19:43:22 INFO - Running setup.py install for mozlog 19:43:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for moznetwork 19:43:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:22 INFO - Running setup.py install for mozprocess 19:43:22 INFO - Running setup.py install for mozprofile 19:43:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:23 INFO - Running setup.py install for mozrunner 19:43:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:23 INFO - Running setup.py install for mozscreenshot 19:43:23 INFO - Running setup.py install for moztest 19:43:23 INFO - Running setup.py install for mozversion 19:43:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:23 INFO - Cleaning up... 19:43:23 INFO - Return code: 0 19:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:23 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 19:43:23 INFO - 'HOME': '/home/cltbld', 19:43:23 INFO - 'LANG': 'en_US.UTF-8', 19:43:23 INFO - 'LANGUAGE': 'en_US:en', 19:43:23 INFO - 'LOGNAME': 'cltbld', 19:43:23 INFO - 'MAIL': '/var/mail/cltbld', 19:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:23 INFO - 'MOZ_NO_REMOTE': '1', 19:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:23 INFO - 'NO_EM_RESTART': '1', 19:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:23 INFO - 'PWD': '/builds/slave/test', 19:43:23 INFO - 'SHELL': '/bin/bash', 19:43:23 INFO - 'SHLVL': '1', 19:43:23 INFO - 'TERM': 'linux', 19:43:23 INFO - 'TMOUT': '86400', 19:43:23 INFO - 'USER': 'cltbld', 19:43:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:23 INFO - '_': '/tools/buildbot/bin/python'} 19:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:23 INFO - Running setup.py (path:/tmp/pip-L74Nre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:23 INFO - Running setup.py (path:/tmp/pip-pRgTP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:23 INFO - Running setup.py (path:/tmp/pip-X8zLSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:23 INFO - Running setup.py (path:/tmp/pip-KZbbCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:24 INFO - Running setup.py (path:/tmp/pip-gwvANQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:24 INFO - Running setup.py (path:/tmp/pip-9V7btp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:24 INFO - Running setup.py (path:/tmp/pip-78VECQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:24 INFO - Running setup.py (path:/tmp/pip-KJV1xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:24 INFO - Running setup.py (path:/tmp/pip-PTu8CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:24 INFO - Running setup.py (path:/tmp/pip-4Bx8mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:24 INFO - Running setup.py (path:/tmp/pip-5t8HYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:24 INFO - Running setup.py (path:/tmp/pip-LjQCef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:24 INFO - Running setup.py (path:/tmp/pip-hXtFb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:24 INFO - Running setup.py (path:/tmp/pip-ChOSTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:24 INFO - Running setup.py (path:/tmp/pip-vyt2KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:24 INFO - Running setup.py (path:/tmp/pip-niK3hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:24 INFO - Running setup.py (path:/tmp/pip-cAPcAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:26 INFO - Downloading blessings-1.6.tar.gz 19:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:26 INFO - Installing collected packages: blessings 19:43:26 INFO - Running setup.py install for blessings 19:43:26 INFO - Successfully installed blessings 19:43:26 INFO - Cleaning up... 19:43:26 INFO - Return code: 0 19:43:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:26 INFO - Reading from file tmpfile_stdout 19:43:26 INFO - Current package versions: 19:43:26 INFO - argparse == 1.2.1 19:43:26 INFO - blessings == 1.6 19:43:26 INFO - blobuploader == 1.2.4 19:43:26 INFO - docopt == 0.6.1 19:43:26 INFO - functools32 == 3.2.3-2 19:43:26 INFO - jsonschema == 2.5.1 19:43:26 INFO - manifestparser == 1.1 19:43:26 INFO - mozInstall == 1.13 19:43:26 INFO - mozcrash == 1.0 19:43:26 INFO - mozdebug == 0.1 19:43:26 INFO - mozdevice == 0.51 19:43:26 INFO - mozfile == 1.2 19:43:26 INFO - mozhttpd == 0.7 19:43:26 INFO - mozinfo == 0.10 19:43:26 INFO - mozleak == 0.1 19:43:26 INFO - mozlog == 3.5 19:43:26 INFO - moznetwork == 0.27 19:43:26 INFO - mozprocess == 0.25 19:43:26 INFO - mozprofile == 0.28 19:43:26 INFO - mozrunner == 6.13 19:43:26 INFO - mozscreenshot == 0.1 19:43:26 INFO - mozsystemmonitor == 0.3 19:43:26 INFO - moztest == 0.8 19:43:26 INFO - mozversion == 1.4 19:43:26 INFO - psutil == 3.1.1 19:43:26 INFO - requests == 1.2.3 19:43:26 INFO - wsgiref == 0.1.2 19:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:26 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 19:43:26 INFO - 'HOME': '/home/cltbld', 19:43:26 INFO - 'LANG': 'en_US.UTF-8', 19:43:26 INFO - 'LANGUAGE': 'en_US:en', 19:43:26 INFO - 'LOGNAME': 'cltbld', 19:43:26 INFO - 'MAIL': '/var/mail/cltbld', 19:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:26 INFO - 'MOZ_NO_REMOTE': '1', 19:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:26 INFO - 'NO_EM_RESTART': '1', 19:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:26 INFO - 'PWD': '/builds/slave/test', 19:43:26 INFO - 'SHELL': '/bin/bash', 19:43:26 INFO - 'SHLVL': '1', 19:43:26 INFO - 'TERM': 'linux', 19:43:26 INFO - 'TMOUT': '86400', 19:43:26 INFO - 'USER': 'cltbld', 19:43:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:26 INFO - '_': '/tools/buildbot/bin/python'} 19:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:43:27 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:27 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:27 INFO - Installing collected packages: simplejson 19:43:27 INFO - Running setup.py install for simplejson 19:43:27 INFO - building 'simplejson._speedups' extension 19:43:27 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:28 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:28 INFO - Successfully installed simplejson 19:43:28 INFO - Cleaning up... 19:43:28 INFO - Return code: 0 19:43:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:28 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 0x1f121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2016a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 19:43:28 INFO - 'HOME': '/home/cltbld', 19:43:28 INFO - 'LANG': 'en_US.UTF-8', 19:43:28 INFO - 'LANGUAGE': 'en_US:en', 19:43:28 INFO - 'LOGNAME': 'cltbld', 19:43:28 INFO - 'MAIL': '/var/mail/cltbld', 19:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:28 INFO - 'MOZ_NO_REMOTE': '1', 19:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:28 INFO - 'NO_EM_RESTART': '1', 19:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:28 INFO - 'PWD': '/builds/slave/test', 19:43:28 INFO - 'SHELL': '/bin/bash', 19:43:28 INFO - 'SHLVL': '1', 19:43:28 INFO - 'TERM': 'linux', 19:43:28 INFO - 'TMOUT': '86400', 19:43:28 INFO - 'USER': 'cltbld', 19:43:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:28 INFO - '_': '/tools/buildbot/bin/python'} 19:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:43:29 INFO - Cleaning up... 19:43:29 INFO - Return code: 0 19:43:29 INFO - Running post-action listener: _resource_record_post_action 19:43:29 INFO - Running post-action listener: _start_resource_monitoring 19:43:29 INFO - Starting resource monitoring. 19:43:29 INFO - [mozharness: 2017-08-16 02:43:29.211705Z] Finished create-virtualenv step (success) 19:43:29 INFO - [mozharness: 2017-08-16 02:43:29.212160Z] Running install step. 19:43:29 INFO - Running pre-action listener: _resource_record_pre_action 19:43:29 INFO - Running main action method: install 19:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:29 INFO - Reading from file tmpfile_stdout 19:43:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:29 INFO - Reading from file tmpfile_stdout 19:43:29 INFO - Output received: 19:43:29 INFO - Usage: mozinstall [options] installer 19:43:29 INFO - Options: 19:43:29 INFO - -h, --help show this help message and exit 19:43:29 INFO - -d DEST, --destination=DEST 19:43:29 INFO - Directory to install application into. [default: 19:43:29 INFO - "/builds/slave/test"] 19:43:29 INFO - --app=APP Application being installed. [default: firefox] 19:43:29 INFO - mkdir: /builds/slave/test/build/application 19:43:29 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:29 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:47 INFO - Reading from file tmpfile_stdout 19:43:47 INFO - Output received: 19:43:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:43:47 INFO - Running post-action listener: _resource_record_post_action 19:43:47 INFO - [mozharness: 2017-08-16 02:43:47.517613Z] Finished install step (success) 19:43:47 INFO - [mozharness: 2017-08-16 02:43:47.517864Z] Running setup-mitmproxy step. 19:43:47 INFO - Running pre-action listener: _resource_record_pre_action 19:43:47 INFO - Running main action method: setup_mitmproxy 19:43:47 INFO - Skipping: mitmproxy is not required 19:43:47 INFO - Running post-action listener: _resource_record_post_action 19:43:47 INFO - [mozharness: 2017-08-16 02:43:47.519003Z] Finished setup-mitmproxy step (success) 19:43:47 INFO - [mozharness: 2017-08-16 02:43:47.519224Z] Running run-tests step. 19:43:47 INFO - Running pre-action listener: _resource_record_pre_action 19:43:47 INFO - Running pre-action listener: _set_gcov_prefix 19:43:47 INFO - Running main action method: run_tests 19:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:47 INFO - Python 2.7.3 19:43:47 INFO - Return code: 0 19:43:47 INFO - grabbing minidump binary from tooltool 19:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:47 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 0x21b70b0>, '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 0x21b7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:47 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:47 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:47 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:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:47 INFO - Return code: 0 19:43:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:47 INFO - ENV: RUST_BACKTRACE is now full 19:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:47 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-034', '--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:47 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-034 --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:47 INFO - Using env: {'DISPLAY': ':0', 19:43:47 INFO - 'HOME': '/home/cltbld', 19:43:47 INFO - 'LANG': 'en_US.UTF-8', 19:43:47 INFO - 'LANGUAGE': 'en_US:en', 19:43:47 INFO - 'LOGNAME': 'cltbld', 19:43:47 INFO - 'MAIL': '/var/mail/cltbld', 19:43:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:47 INFO - 'MOZ_NO_REMOTE': '1', 19:43:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:47 INFO - 'NO_EM_RESTART': '1', 19:43:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:47 INFO - 'PWD': '/builds/slave/test', 19:43:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:47 INFO - 'RUST_BACKTRACE': 'full', 19:43:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:43:47 INFO - 'SHELL': '/bin/bash', 19:43:47 INFO - 'SHLVL': '1', 19:43:47 INFO - 'STYLO_FORCE_ENABLED': '1', 19:43:47 INFO - 'TERM': 'linux', 19:43:47 INFO - 'TMOUT': '86400', 19:43:47 INFO - 'USER': 'cltbld', 19:43:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373', 19:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:47 INFO - '_': '/tools/buildbot/bin/python'} 19:43:47 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-034', '--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:47 INFO - mozversion application_buildid: 20170816015150 19:43:47 INFO - mozversion application_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:47 INFO - mozversion application_display_name: Nightly 19:43:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:47 INFO - mozversion application_name: Firefox 19:43:47 INFO - mozversion application_remotingname: firefox 19:43:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:43:47 INFO - mozversion application_vendor: Mozilla 19:43:47 INFO - mozversion application_version: 57.0a1 19:43:47 INFO - mozversion platform_buildid: 20170816015150 19:43:47 INFO - mozversion platform_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:43:47 INFO - mozversion platform_version: 57.0a1 19:43:47 INFO - using testdate: 1502851427 19:43:47 INFO - actual date: 1502851427 19:43:47 INFO - starting webserver on 'localhost:58569' 19:43:47 INFO - SUITE-START | Running 2 tests 19:43:47 INFO - TEST-START | dromaeo_css 19:43:47 INFO - Initialising browser for dromaeo_css test... 19:43:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html -profile /tmp/tmpevZKbg/profile 19:43:47 INFO - TEST-INFO | started process 4790 (/builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html) 19:43:54 INFO - TEST-INFO | 4790: exit 0 19:43:54 INFO - Browser initialized. 19:43:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:54 INFO - TEST-INFO | started process 5025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevZKbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:55 INFO - PID 5025 | 19:43:55 INFO - PID 5025 | (/builds/slave/test/build/application/firefox/firefox:5079): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:43:55 INFO - PID 5025 | 19:44:05 INFO - PID 5025 | RSS: Main: 167161856 19:44:05 INFO - PID 5025 | 19:47:04 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58569/tests/dromaeo/cssquery-ext.html) 19:47:05 INFO - PID 5025 | RSS: Main: 172892160 19:47:05 INFO - PID 5025 | 19:50:07 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-ext.html (next: http://localhost:58569/tests/dromaeo/cssquery-jquery.html) 19:50:08 INFO - PID 5025 | RSS: Main: 172281856 19:50:08 INFO - PID 5025 | 19:53:10 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58569/tests/dromaeo/cssquery-mootools.html) 19:53:10 INFO - PID 5025 | RSS: Main: 174202880 19:53:10 INFO - PID 5025 | 19:56:12 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58569/tests/dromaeo/cssquery-prototype.html) 19:56:13 INFO - PID 5025 | RSS: Main: 172314624 19:56:13 INFO - PID 5025 | 19:59:16 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58569/tests/dromaeo/cssquery-yui.html) 19:59:17 INFO - PID 5025 | RSS: Main: 174235648 19:59:17 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-yui.html (next: http://localhost:58569/tests/dromaeo/cssquery-dojo.html) 20:02:19 INFO - PID 5025 | RSS: Main: 176443392 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | __start_tp_report 20:02:19 INFO - PID 5025 | _x_x_mozilla_page_load 20:02:19 INFO - PID 5025 | _x_x_mozilla_page_load_details 20:02:19 INFO - PID 5025 | |i|pagename|runs| 20:02:19 INFO - PID 5025 | |0;dojo.html;3137.529370594409;3142.0730884389104;3184.3153721949784;3184.490481522956;3218.5976752905885;6029.306629737582;6241.843953901155;6242.06369044643;6245.625262484243;6252.124702541642;6008.068749343859;6135.8772824543485;6142.785002524902;6169.81490555284;6172.01247800352;5580.720963951807;5594.160875868612;5725.055365864628;5726.99777538929;5749.482546570808;5679;5690.40250773667;5694.829155125353;5752.2234498342605;5777.19119323295;5540.944590554103;5592.161175823619;5619.859503512404;5674.177244299594;5692.5161361284345;5613.831585052455;5614.522765564931;5684;5693.800716974927;5704.458076482728;5532.114861622121;5541.0580201365865;5626.859328516779;5680.4319568042865;5696.886062278772;6018.307894592091;6046.6069705469445;6048;6065.5450841187085;6091.664958427285;6608.240052393988;6627.138471998657;6642.568233064883;6702.463802895757;6705.899411508832;6548.246951600531;6657.300983396771;6691.4312283455965;6770.898436523456;6782.8304292392595;6155.261368635793;6164.352742961969;6167.414095660905;6173.938260617381;6185.536084793658;6764.323567643295;6779.0509328694025;6782.559133656297;6794.558353706993;6799.524033317621;6402.807915762442;6453.419192272718;6548.410643042149;6575.178102737158;6584.979328204136;6506.3493650634555;6565.934340656532;6570.540062195696;6571.934280657132;6596.142501474777;6445.9355406446275;6452.257990331172;6549.574277671936;6569.737210511622;6572.211334639874;6479.870402591921;6482.254540727877;6570.901436478457;6574.8356291093105;6579.243387010555;5395.082835917825;5401.783928642889;5453.918191227135;5460.863478412992;5479.424660410599;4600.401947746772;4632.745199014086;4662.790174442158;4668;4696.553827386393;5661.830145095653;5671.744771485293;5722.456366645162;5765.625234359837;5770.624909380961;6512.218533775977;6622.403983641495;6638.402543771083;6642.96678516614;6692.564983276072;5754.223179870748;5757.85605359861;5764.193012978187;5764.654120752684;5765.279340082489;5816.88366232673;5819.73811178498;5865.970670146708;5895.086261629454;5911.704414779244;6413.29453760086;6452.709628066748;6530.412262896362;6537.901931471032;6539.934600654028;6486.383793539606;6576.769813056711;6582.572132811543;6587.505937054644;6668.399844014062;6440.2915679276175;6445.323241059621;6454.031895215568;6471;6562.737490500517;6483;6535.705893234911;6550.279469258473;6554.541182117206;6576.145101136822;6656.5340426169705;6728.125343705287;6759.087523184307;6766.492513061442;6771.458283337222;6432.067350234283;6446.67766611677;6480.44916182111;6516.543841931019;6519.674016299071;6303.527235457451;6349.841253968688;6398.392152745481;6426.4216220540375;6496.805095847132;6424.903626445701;6428.228612566522;6434.710438030394;6440.194975628046;6442.226932768098;6490.221173459215;6528;6548.869022619426;6550.574212676161;6576;6278.340774218641;6307.558470907176;6378.744850206125;6387.8722425550295;6407.679616019087 20:02:19 INFO - PID 5025 | |1;ext.html;779.4972242903327;838.7861095420667;870.7823044238938;873.3886279604278;1151.9712007199814;30156;40592;41830;41911.37132943008;41946;42223.57776422235;42500.57499425013;42530.36204456936;42663;42716.57283427165;7469.701211951529;7667.961660191691;7670;7674.731384401547;7676.1939996300425;7507.699692012313;7601;7617.085949686046;7618.771436856903;7621.123570789375;7597.08834939808;7655.119661238945;7657.885131723028;7658.540487570735;7660.731874384398;7569.886451703173;7578;7588.658510367047;7596.430267729887;7623.123340815794;7511.586862722548;7571.924280757232;7597.708389573786;7598.696052157962;7619.390448764141;37228.25543489115;37358.505659773575;37375.813120934225;37424.25151496955;37545.812270938746;3551.5027896094566;3556.324298383299;3566.821658917044;3573.0888623400865;3573.213892943548;30355;30581.847090764626;30585.38829223403;30664.38671226563;30780;4975.203967365241;4997.250412438163;5038.193888977746;5048.697078175322;5117.283580298761;179909;181138;181179.09410452863;181267;181479;47217.76391118091;47310.76344618255;47409.52590474051;47416.28875566869;49361.259581106315;51874.22188667173;51947.480525195024;52292.21561676578;52343;52425.7378713104;12185.939070304768;12354.75290494185;13041.739165216832;14578;14594.197319147548;10440.791184176274;10445.582176712998;10453.477326133663;10459;10461.895381046244;14237.715245695235;14459.638509037359;14496.34766435513;14510.709785804225;14573.125612463286;5563.610547261734;5595.244641973281;5604.131359639263;5676.574256930747;5765.509931655773;992;1017.2065788684838;1017.5980487707315;1022.974425639365;1040.4121671255716;22982.195623153108;23147.88426057859;23230.419239518807;23233.535329293318;23273.7672623275;1101.4878081692052;1102.4653043274006;1114.5764609448358;1131.8189089745601;1132.5526417065378;12403.25580465157;12422.068344874171;12519.749605008032;12572.622821315192;12591.748165036832;228866;230004;230747;231487;233726;51176.48823511717;51211.23183152256;51337.74331128321;51389.22916156261;51432.485675143515;1405.1709491399918;1473.7273604383224;1482.088515562921;1492.2389581313607;1496.3715239599394;22443.32670019902;22449.32652020442;22477.43806404853;22498.662520061884;22548.774512254666;33670.3265934675;33971.15072123217;33998;34020.1494962618;34076.488852666735;182681;182682;183003.08498457423;184079;184219;30539;31145.221369465944;33474.83262583769;33906;34533.481997770556;42737;43087.56912430961;43092.13815723731;43158.35262471128;43385;32164.51753223657;32307.19232019218;32427;32605;33142.66857331492;30972.690273097884;31166.22084447907;31472.685273146977;31708.524372133976;31756.364872702878;34886.82556587201;34999.82500087585;35090.824545877105;35105.29789404147;35133.121671958404;30524.542131868486;30567.847160764053;30580.84709576438;30928.381432371676;31234.68765312318;22823.858807059914;23331.300060998197;23377.181798636968;23397.88301058484;23851.165209217594 20:02:19 INFO - PID 5025 | |2;jquery.html;566.7959534567558;567.6310398241143;568.3009897825677;569.1491220625167;577.1832856508041;21552.784472155272;22347.44131396716;22443.55112897741;22472.55054898903;22487.887560562176;24744.25767226986;25966.350841228978;27661.308467288327;27675.446491070215;27710.722892771068;7090.858182836353;7232.13214414271;7242.311980361857;7247.383972362356;7253.782386528413;6640.468762499013;6994.1607007158955;7159.677814498334;7244;7252.383547398477;7005.404540614054;7013.82465438363;7015.508914375996;7017.929820701805;7020.262872398402;6963.40811031063;7025.8594828103405;7027.5080744347915;7031.261717519664;7035.613041282727;6817.931820681779;6834.829129271759;6899.62052087135;6913.89629155563;6918.481113916477;30480;31546.369072618418;31956.520652190236;32190;32218.83890580532;2042.652749032668;2053.887036213023;2059.6807494838176;2066.183857376343;2068.2761033638258;20563.897180514152;20993.160273589037;21154.15383384678;21232.150713971423;21327.68008479874;2506.4736405354897;2520.218732193026;2571.472848066142;2606.1790535981104;2648.562987107125;140485.2975735125;143646.28176859047;144757;144818;144996.27501862423;19966;21994.560108797734;22182.88908555479;22696.822444857735;23133.30600082;22850.657240141412;24124;24244.151454699;46182.30726539105;46183.76908115505;9563.426194428357;9574.521273936276;9693.757656058655;9798.46108464027;9908.207343412654;8671.869921951176;8694.478331300143;8745.431546949429;8763.211310982042;8864.556772161366;9445;9551.617935282511;9756.707298781048;9828.901710982798;9841.458719770339;2898.087102562686;2925.224815423914;2927.8682459289384;2960.985195074011;3026.455238057171;967.5355829202023;985.531872360623;996.267743208741;997.5909876950416;1020.698893826323;19414.611707765765;19628.62599618013;19797.703034454495;20425.591488170154;24109.638355424682;1000.6847842929454;1042.61944390297;1042.6455005298235;1045.984310235347;1053.210092430677;10730.658667666541;11436.828447573293;13402.329883505785;14667.193304368362;14956.626084347761;505510;531676;533371;542471;549354;120429;121322.36032919027;122312;124882;124925.37537312256;1229.2317301686446;1270.0855384123417;1278.335265661832;1284.8329717136712;1290.5483080921601;21313.89343053275;21525.03137358854;21622.243221487803;21673.458163546038;21799.891000544896;47784.283235752184;58032.70983645055;58740.70629646824;59490.40509594849;60424;71321;71677.28322716914;72020;72419.27580724336;73034.63482682765;14580.927095364455;14698.044627099205;15024.474143404928;15046.172460514339;15089.849101509284;23444.88277558601;23631.291061268188;23696.52606947817;23860.403489912893;23874.761252387947;18000.639987200444;18565.628687426444;18654.44036678902;18767.90616046911;18795.90602046981;14114.364853581408;16063.839361606702;16540.421085261958;16557.58606034859;17166.82833171702;18618.255269789057;18758.812411875708;18963.525911852314;19107.713384299524;19110.522236944187;14055.437782488585;14454.566363009126;14660.486882959045;14752.704945900807;14763.114213147246;17624.471265862045;18407.53981150482;18602.162902669683;18846.811531885054;18983.43049708456 20:02:19 INFO - PID 5025 | |3;mootools.html;1327.34296523221;1370.7669696151659;1373.361386955067;1383.4950243161243;1384;12316;13910.791338129924;14519.782203266946;14591.854081459169;14612.269386530685;12341.382930853444;12488.50045998159;14159.504417345395;14695;14698.118112913206;2684.5973104034406;2737.9726202737916;2741.3557813913712;2741.8903243870222;2743;2444.2056331692183;2510.8619025953567;2516.962245566318;2520.0675749972534;2520.5463016656995;2587.3919628887197;2598.688157421112;2600.7139214686463;2616.7775739062204;2619.4499155177436;2464.691913510811;2481.0944005437977;2488.8382255153447;2496.2012156110054;2499.187763976715;2476.430421003179;2481.900723971039;2492.1152990688224;2501.0996041425074;2505.073122944504;13930.094543854617;14236.501722439665;14243.145411275356;14255.215963122024;14265.215413152273;7450.515716478466;7696.4227682924;7718.112417072052;7718.228177182293;7719.884201736979;4837.564619184255;4970.179920313144;5099.668521546125;5291.920621190685;5296.841094767163;1848.2145088337402;1871.2702046201855;1880.0975531744702;1899.6580615489206;1907.8664493485462;21658.133674652996;21686.45783855416;21910.89044554767;21955.451113722123;21980.78019219803;6775.559588626724;6940.167179938338;6998.405135563432;7149.785506434815;7166.390856777128;18822.153003114894;18861.339853105077;18871;18883.150258238413;18903.90548047251;7666.578338191342;7801.921980780233;7814.257645523666;7857.017872765904;7868.763937081897;5624.97187514068;5746.396628354046;6032.758689652453;6042.1843051187525;6980.650967451607;5323.254744335796;5429.239906413105;5530.059889818741;5561.193626924073;5565.248691426606;1663.5508412728736;1673.3892129372691;1678.337056862557;1705.5224537129623;1720.4580557124466;921.5484412637893;921.9861702074475;926.837803384405;937.7655586103474;939.6429356844355;8361.790955226046;8397.202265784741;8486.533240671823;8490.872636910452;8588.957055214809;695.626651012627;702.0942983551264;729.3334730141706;739.0392489763286;745.5601195294802;4581.396511221046;4620.19146649335;4644.303354496852;4706.458757242893;4729.290606409066;19605.607887842165;20470.897645511675;20726.067326970322;20728.896355518427;20738.377848664564;18734.344297949505;20066.498337541387;20226.797732022787;20274.18903243854;20330.085146168458;10809.919008099285;11120.833187502194;11242.38166900812;11332.376719280353;11336.886631133748;8070.959645201971;8184.672613095409;8220.136885626924;8264.752057438287;8340.41617086798;17182.39861604888;17257.827421725622;17298.567535811704;17417;17981.550461238574;17466.30134794594;18095.547611309823;18268.90865545664;18290.288174958532;18340.449786506426;10788;11365.54537818478;11374;11411.60059397917;11415.086793056702;13445.126066805626;13547;13665;13675.179489230679;13675.794863076862;11166.49750761234;11222.10223182127;11389.487473063566;11389.829152562552;11663;10919.890801092206;11001.394923278976;11089.667309980714;11119.221654484432;11303.095752339957;10008.549615267184;10100.191984641358;10116.342437741523;10118.241131915283;10119.898801011896;7487.5507469552;7571.886421703569;7638.197989211275;7656.196099409704;7728.381729461742;7443.516171448839;7637;7676.96360991259;7760.18518055596;7819.960900195462 20:02:19 INFO - PID 5025 | |4;prototype.html;477.9163646361886;501.6137574067969;510.7931287828429;516.9431362550118;529.6848375216747;6165;6212.254529456466;6220.751169953208;6225.190725205728;6346.936530634698;6108.930937086004;6126.6017708849;6217.129601855744;6230.25236971564;6238.812835614939;5119.38567371915;5174.586033117361;5182.274481572583;5194.792208311663;5208.583313334924;4797.712137271775;5131.538161565459;5149.588032957355;5151.175811870102;5176.948230517684;4883.926741098869;4900.362952816129;4937.80248790048;4963.578095861856;4973.229149481818;4907.214845624683;4916.852494425155;4925.335079764258;4959.256111583255;4969.434628092139;4460.353248778942;4485.865424037284;4487.596116349511;4500.524711408712;4519.186546421643;6056.242969628796;6068.605540639845;6097.3597772233725;6101.359357267512;6147.047207682816;5646.491815736563;5686.488216060575;5719.628224165416;5728.8854222915725;5753.510951569122;6409.647469389181;6525.575837570543;6543.869122617521;6593.835154121138;6625.933740662628;4912;4913.975430122827;4920.507949205086;4925.768557860535;4928.408590969107;6713.429358504533;6777.288384719632;6798.456123510107;6899.896501552481;6953.20038195609;4925.40895092584;5000.199968005102;5050.924236136461;5058;5059.392872855207;5115.1559992600805;5119.846404607868;5131.409887862869;5135.229715542624;5151.7681704323395;5694.829155125353;5714.285714285715;5717.371089180187;5728.112142617901;5781.485054001523;6596.571222870498;6625.966870165618;6637.6349300788925;6642.767503137464;6664.166979127609;1770.2741875830848;1796.9550761230812;1798.3615816384995;1800.828921252479;1802.8551869562923;1184.490669012333;1200.8138738495547;1226.2397313665585;1229;1229.7417542316034;5708.4862362387585;5738.351934932718;5773.740181691834;5816.767329306865;5865.442782935615;6625.138731964814;6680.19837619479;6731.1922569292;6789.830254243683;6797.411747070708;5723.3418156912485;5731.770729170787;5744.655320680689;5746.281714785652;5843.565484099743;3517.66582174693;3522.5068490411363;3530.929381412409;3580.1944562473236;3585.928281434357;6495.577787443801;6540.509461790385;6581.934180658228;6628.436582890508;6692.966535167293;6881.724731010803;6921.411680007155;6969.756058537927;6993.755218567326;6996.146021304358;6492.513061520405;6525.8694826104165;6542.527931215438;6560.639164845979;6566.4418524425955;6227.782027629011;6806.727730890907;6822.522423430511;6832.214295356098;6834;6632.83417914556;6665.2334981475815;6675.165604299463;6713.832154196184;6753.189617245962;6652.866942661217;6664.500162487736;6668.966655166693;6715.597064176165;6732.6297053660555;4912.231596625284;4966.577840883421;5016.072026675077;5071.264666623245;5074.949250507595;6488.578242414228;6503.6097834130105;6552.08270842092;6766.966165169143;6782.67737791126;6477.708503117276;6501.1548498694865;6511.158416534267;6530.869382612416;6572.422618571604;6515.609063456208;6515.641639709862;6548.738050477928;6559.147310849559;6598.3401659833635;6469.514786391133;6496.187976502937;6509.153810004669;6542.672866356758;6606.207255129415;6536.673166341759;6548.705308261045;6616.305287944889;6660.766873159416;6666.400023997669;6299.401556852092;6401.839954001187;6430.485561155003;6453.903191452226;6475.125858009108 20:02:19 INFO - PID 5025 | |5;yui.html;876.6756300168938;897.5332826929997;902.6615019367737;911.7994041310914;915.9313051521137;17242.13789310534;17948.46154615362;17972.91013544932;18008.729869051975;21328.4667883303;19236.230550777986;19365.03174841259;19365.709514357295;19413.32053378132;19458;950.5057370167526;1009.5255230041905;1013.0426746724348;1024.8821385540646;1032.4682788363998;1017.4404077757241;1021.9846702299471;1024.4109636958742;1025.1542477456092;1026.179056754597;981.087588542655;1084.6203828659984;1086.098538213281;1087.4780105549341;1089.6785448292733;1058.0688993685546;1068.3910171202417;1073.6403304892792;1074.6668532754832;1081.1566977757361;785.4305628419407;787.3307688464816;788.0858204482772;788.1055002572065;788.2157253532714;18796.906015469835;19272.80727192738;19432;19444.125014374247;19935.40193794174;21559.461013474633;21766.891165544228;22349;22373.55252894933;22487.55024899493;16621.50135495937;16827.91586042074;17030.233639486254;17052.062136582485;17190.570235744082;3517.26137511123;3542.6103128655827;3545.929081418383;3547.0245682437535;3551.6093229744706;123529.38235308856;124586;125838.37080814537;127589;128155;17218.225179866935;17513.12434378276;17622.207000685;17821.821781782277;18186;29858.552121718192;31003.68996310008;31409.8429507851;32310.83844580762;32353.838230808695;7514.39884809214;7900.170482099412;8746.38775285724;9018.413803102778;9022.86465703015;4002.8799136025964;4185.58144185579;4211.536730959592;4217.641500472494;4220.978895105505;5100.234964755242;5234.7906083756225;5239.44985776488;5260.13207820713;5286.867828304323;1019.5106348952544;1039.5322105052755;1040.2822052783556;1043.108142538119;1046.7697106636529;641.4996302883758;652.9771457998947;660.4914216053612;665.0755449924609;696.0603185699265;11824.881751182378;12008.03935685143;12253.326067066397;12743.04427167966;13651.658708532366;672.0993868216516;679.2155060904663;690.5683947532792;695.9721611135498;715.3919168706558;5703.800366987136;5796.710164491843;5826.796062137805;5937.881242375129;6042.093685947055;112124.83313417678;113179.43410282896;114148;116531.41734291274;122347;98409;101569;101987;105359;106960;91005.54497227471;92749.5362523183;93045.069549305;95609;95618.5219073914;10775.461226938465;10798.434227036878;11112.722181945515;11264.324140551593;11336.206465547333;36819;38396.232075358894;39043;39698.206035879695;40353.596464036156;73062.63468682622;73125.63437182993;73231;74544;76781.61609191919;20078.598428031648;20374.18503259853;20389.89805050965;20644.793552064286;20728;20145.597088057864;21701.457463563536;22035.77964220337;22743;22882.656760148944;18862.717059244398;18977.43067707971;19299.710504342725;19535.413937581896;19890.5027374311;18405.171767270236;18661;18739.250429983193;19222.231110755412;19485.610287794447;18437.631247375244;18734.625307494047;18772.718409224144;18824.152913119215;19541.51146221299;13562.59312220635;14729.55811325662;14842.257887105818;14911.552653420415;14960.700785984436;13954.651133721738;14124.646883827987;14161.291935402982;14194.645133871736;14292.642683932985 20:02:19 INFO - PID 5025 | __end_tp_report 20:02:19 INFO - PID 5025 | __start_cc_report 20:02:19 INFO - PID 5025 | _x_x_mozilla_cycle_collect,365 20:02:19 INFO - PID 5025 | __end_cc_report 20:02:19 INFO - PID 5025 | __startTimestamp1502852539584__endTimestamp 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | ------- Summary: start ------- 20:02:19 INFO - PID 5025 | Number of tests: 6 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#0] dojo.html Cycles:165 Average:6101.84 Median:6402.81 stddev:706.34 (11.0%) stddev-sans-first:669.13 20:02:19 INFO - PID 5025 | Values: 3137.5 3142.1 3184.3 3184.5 3218.6 6029.3 6241.8 6242.1 6245.6 6252.1 6008.1 6135.9 6142.8 6169.8 6172.0 5580.7 5594.2 5725.1 5727.0 5749.5 5679.0 5690.4 5694.8 5752.2 5777.2 5540.9 5592.2 5619.9 5674.2 5692.5 5613.8 5614.5 5684.0 5693.8 5704.5 5532.1 5541.1 5626.9 5680.4 5696.9 6018.3 6046.6 6048.0 6065.5 6091.7 6608.2 6627.1 6642.6 6702.5 6705.9 6548.2 6657.3 6691.4 6770.9 6782.8 6155.3 6164.4 6167.4 6173.9 6185.5 6764.3 6779.1 6782.6 6794.6 6799.5 6402.8 6453.4 6548.4 6575.2 6585.0 6506.3 6565.9 6570.5 6571.9 6596.1 6445.9 6452.3 6549.6 6569.7 6572.2 6479.9 6482.3 6570.9 6574.8 6579.2 5395.1 5401.8 5453.9 5460.9 5479.4 4600.4 4632.7 4662.8 4668.0 4696.6 5661.8 5671.7 5722.5 5765.6 5770.6 6512.2 6622.4 6638.4 6643.0 6692.6 5754.2 5757.9 5764.2 5764.7 5765.3 5816.9 5819.7 5866.0 5895.1 5911.7 6413.3 6452.7 6530.4 6537.9 6539.9 6486.4 6576.8 6582.6 6587.5 6668.4 6440.3 6445.3 6454.0 6471.0 6562.7 6483.0 6535.7 6550.3 6554.5 6576.1 6656.5 6728.1 6759.1 6766.5 6771.5 6432.1 6446.7 6480.4 6516.5 6519.7 6303.5 6349.8 6398.4 6426.4 6496.8 6424.9 6428.2 6434.7 6440.2 6442.2 6490.2 6528.0 6548.9 6550.6 6576.0 6278.3 6307.6 6378.7 6387.9 6407.7 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#1] ext.html Cycles:180 Average:36455.38 Median:33938.58 stddev:51817.79 (152.7%) stddev-sans-first:51893.91 20:02:19 INFO - PID 5025 | Values: 779.5 838.8 870.8 873.4 1152.0 30156.0 40592.0 41830.0 41911.4 41946.0 42223.6 42500.6 42530.4 42663.0 42716.6 7469.7 7668.0 7670.0 7674.7 7676.2 7507.7 7601.0 7617.1 7618.8 7621.1 7597.1 7655.1 7657.9 7658.5 7660.7 7569.9 7578.0 7588.7 7596.4 7623.1 7511.6 7571.9 7597.7 7598.7 7619.4 37228.3 37358.5 37375.8 37424.3 37545.8 3551.5 3556.3 3566.8 3573.1 3573.2 30355.0 30581.8 30585.4 30664.4 30780.0 4975.2 4997.3 5038.2 5048.7 5117.3 179909.0 181138.0 181179.1 181267.0 181479.0 47217.8 47310.8 47409.5 47416.3 49361.3 51874.2 51947.5 52292.2 52343.0 52425.7 12185.9 12354.8 13041.7 14578.0 14594.2 10440.8 10445.6 10453.5 10459.0 10461.9 14237.7 14459.6 14496.3 14510.7 14573.1 5563.6 5595.2 5604.1 5676.6 5765.5 992.0 1017.2 1017.6 1023.0 1040.4 22982.2 23147.9 23230.4 23233.5 23273.8 1101.5 1102.5 1114.6 1131.8 1132.6 12403.3 12422.1 12519.7 12572.6 12591.7 228866.0 230004.0 230747.0 231487.0 233726.0 51176.5 51211.2 51337.7 51389.2 51432.5 1405.2 1473.7 1482.1 1492.2 1496.4 22443.3 22449.3 22477.4 22498.7 22548.8 33670.3 33971.2 33998.0 34020.1 34076.5 182681.0 182682.0 183003.1 184079.0 184219.0 30539.0 31145.2 33474.8 33906.0 34533.5 42737.0 43087.6 43092.1 43158.4 43385.0 32164.5 32307.2 32427.0 32605.0 33142.7 30972.7 31166.2 31472.7 31708.5 31756.4 34886.8 34999.8 35090.8 35105.3 35133.1 30524.5 30567.8 30580.8 30928.4 31234.7 22823.9 23331.3 23377.2 23397.9 23851.2 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#2] jquery.html Cycles:180 Average:37213.39 Median:23992.20 stddev:89433.04 (372.8%) stddev-sans-first:89641.60 20:02:19 INFO - PID 5025 | Values: 566.8 567.6 568.3 569.1 577.2 21552.8 22347.4 22443.6 22472.6 22487.9 24744.3 25966.4 27661.3 27675.4 27710.7 7090.9 7232.1 7242.3 7247.4 7253.8 6640.5 6994.2 7159.7 7244.0 7252.4 7005.4 7013.8 7015.5 7017.9 7020.3 6963.4 7025.9 7027.5 7031.3 7035.6 6817.9 6834.8 6899.6 6913.9 6918.5 30480.0 31546.4 31956.5 32190.0 32218.8 2042.7 2053.9 2059.7 2066.2 2068.3 20563.9 20993.2 21154.2 21232.2 21327.7 2506.5 2520.2 2571.5 2606.2 2648.6 140485.3 143646.3 144757.0 144818.0 144996.3 19966.0 21994.6 22182.9 22696.8 23133.3 22850.7 24124.0 24244.2 46182.3 46183.8 9563.4 9574.5 9693.8 9798.5 9908.2 8671.9 8694.5 8745.4 8763.2 8864.6 9445.0 9551.6 9756.7 9828.9 9841.5 2898.1 2925.2 2927.9 2961.0 3026.5 967.5 985.5 996.3 997.6 1020.7 19414.6 19628.6 19797.7 20425.6 24109.6 1000.7 1042.6 1042.6 1046.0 1053.2 10730.7 11436.8 13402.3 14667.2 14956.6 505510.0 531676.0 533371.0 542471.0 549354.0 120429.0 121322.4 122312.0 124882.0 124925.4 1229.2 1270.1 1278.3 1284.8 1290.5 21313.9 21525.0 21622.2 21673.5 21799.9 47784.3 58032.7 58740.7 59490.4 60424.0 71321.0 71677.3 72020.0 72419.3 73034.6 14580.9 14698.0 15024.5 15046.2 15089.8 23444.9 23631.3 23696.5 23860.4 23874.8 18000.6 18565.6 18654.4 18767.9 18795.9 14114.4 16063.8 16540.4 16557.6 17166.8 18618.3 18758.8 18963.5 19107.7 19110.5 14055.4 14454.6 14660.5 14752.7 14763.1 17624.5 18407.5 18602.2 18846.8 18983.4 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#3] mootools.html Cycles:180 Average:8950.16 Median:2454.45 stddev:6153.08 (250.7%) stddev-sans-first:6143.68 20:02:19 INFO - PID 5025 | Values: 1327.3 1370.8 1373.4 1383.5 1384.0 12316.0 13910.8 14519.8 14591.9 14612.3 12341.4 12488.5 14159.5 14695.0 14698.1 2684.6 2738.0 2741.4 2741.9 2743.0 2444.2 2510.9 2517.0 2520.1 2520.5 2587.4 2598.7 2600.7 2616.8 2619.4 2464.7 2481.1 2488.8 2496.2 2499.2 2476.4 2481.9 2492.1 2501.1 2505.1 13930.1 14236.5 14243.1 14255.2 14265.2 7450.5 7696.4 7718.1 7718.2 7719.9 4837.6 4970.2 5099.7 5291.9 5296.8 1848.2 1871.3 1880.1 1899.7 1907.9 21658.1 21686.5 21910.9 21955.5 21980.8 6775.6 6940.2 6998.4 7149.8 7166.4 18822.2 18861.3 18871.0 18883.2 18903.9 7666.6 7801.9 7814.3 7857.0 7868.8 5625.0 5746.4 6032.8 6042.2 6980.7 5323.3 5429.2 5530.1 5561.2 5565.2 1663.6 1673.4 1678.3 1705.5 1720.5 921.5 922.0 926.8 937.8 939.6 8361.8 8397.2 8486.5 8490.9 8589.0 695.6 702.1 729.3 739.0 745.6 4581.4 4620.2 4644.3 4706.5 4729.3 19605.6 20470.9 20726.1 20728.9 20738.4 18734.3 20066.5 20226.8 20274.2 20330.1 10809.9 11120.8 11242.4 11332.4 11336.9 8071.0 8184.7 8220.1 8264.8 8340.4 17182.4 17257.8 17298.6 17417.0 17981.6 17466.3 18095.5 18268.9 18290.3 18340.4 10788.0 11365.5 11374.0 11411.6 11415.1 13445.1 13547.0 13665.0 13675.2 13675.8 11166.5 11222.1 11389.5 11389.8 11663.0 10919.9 11001.4 11089.7 11119.2 11303.1 10008.5 10100.2 10116.3 10118.2 10119.9 7487.6 7571.9 7638.2 7656.2 7728.4 7443.5 7637.0 7677.0 7760.2 7820.0 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#4] prototype.html Cycles:180 Average:5537.58 Median:6136.82 stddev:1551.73 (25.3%) stddev-sans-first:1508.90 20:02:19 INFO - PID 5025 | Values: 477.9 501.6 510.8 516.9 529.7 6165.0 6212.3 6220.8 6225.2 6346.9 6108.9 6126.6 6217.1 6230.3 6238.8 5119.4 5174.6 5182.3 5194.8 5208.6 4797.7 5131.5 5149.6 5151.2 5176.9 4883.9 4900.4 4937.8 4963.6 4973.2 4907.2 4916.9 4925.3 4959.3 4969.4 4460.4 4485.9 4487.6 4500.5 4519.2 6056.2 6068.6 6097.4 6101.4 6147.0 5646.5 5686.5 5719.6 5728.9 5753.5 6409.6 6525.6 6543.9 6593.8 6625.9 4912.0 4914.0 4920.5 4925.8 4928.4 6713.4 6777.3 6798.5 6899.9 6953.2 4925.4 5000.2 5050.9 5058.0 5059.4 5115.2 5119.8 5131.4 5135.2 5151.8 5694.8 5714.3 5717.4 5728.1 5781.5 6596.6 6626.0 6637.6 6642.8 6664.2 1770.3 1797.0 1798.4 1800.8 1802.9 1184.5 1200.8 1226.2 1229.0 1229.7 5708.5 5738.4 5773.7 5816.8 5865.4 6625.1 6680.2 6731.2 6789.8 6797.4 5723.3 5731.8 5744.7 5746.3 5843.6 3517.7 3522.5 3530.9 3580.2 3585.9 6495.6 6540.5 6581.9 6628.4 6693.0 6881.7 6921.4 6969.8 6993.8 6996.1 6492.5 6525.9 6542.5 6560.6 6566.4 6227.8 6806.7 6822.5 6832.2 6834.0 6632.8 6665.2 6675.2 6713.8 6753.2 6652.9 6664.5 6669.0 6715.6 6732.6 4912.2 4966.6 5016.1 5071.3 5074.9 6488.6 6503.6 6552.1 6767.0 6782.7 6477.7 6501.2 6511.2 6530.9 6572.4 6515.6 6515.6 6548.7 6559.1 6598.3 6469.5 6496.2 6509.2 6542.7 6606.2 6536.7 6548.7 6616.3 6660.8 6666.4 6299.4 6401.8 6430.5 6453.9 6475.1 20:02:19 INFO - PID 5025 | 20:02:19 INFO - PID 5025 | [#5] yui.html Cycles:180 Average:24545.52 Median:19471.81 stddev:33405.44 (171.6%) stddev-sans-first:33451.87 20:02:19 INFO - PID 5025 | Values: 876.7 897.5 902.7 911.8 915.9 17242.1 17948.5 17972.9 18008.7 21328.5 19236.2 19365.0 19365.7 19413.3 19458.0 950.5 1009.5 1013.0 1024.9 1032.5 1017.4 1022.0 1024.4 1025.2 1026.2 981.1 1084.6 1086.1 1087.5 1089.7 1058.1 1068.4 1073.6 1074.7 1081.2 785.4 787.3 788.1 788.1 788.2 18796.9 19272.8 19432.0 19444.1 19935.4 21559.5 21766.9 22349.0 22373.6 22487.6 16621.5 16827.9 17030.2 17052.1 17190.6 3517.3 3542.6 3545.9 3547.0 3551.6 123529.4 124586.0 125838.4 127589.0 128155.0 17218.2 17513.1 17622.2 17821.8 18186.0 29858.6 31003.7 31409.8 32310.8 32353.8 7514.4 7900.2 8746.4 9018.4 9022.9 4002.9 4185.6 4211.5 4217.6 4221.0 5100.2 5234.8 5239.4 5260.1 5286.9 1019.5 1039.5 1040.3 1043.1 1046.8 641.5 653.0 660.5 665.1 696.1 11824.9 12008.0 12253.3 12743.0 13651.7 672.1 679.2 690.6 696.0 715.4 5703.8 5796.7 5826.8 5937.9 6042.1 112124.8 113179.4 114148.0 116531.4 122347.0 98409.0 101569.0 101987.0 105359.0 106960.0 91005.5 92749.5 93045.1 95609.0 95618.5 10775.5 10798.4 11112.7 11264.3 11336.2 36819.0 38396.2 39043.0 39698.2 40353.6 73062.6 73125.6 73231.0 74544.0 76781.6 20078.6 20374.2 20389.9 20644.8 20728.0 20145.6 21701.5 22035.8 22743.0 22882.7 18862.7 18977.4 19299.7 19535.4 19890.5 18405.2 18661.0 18739.3 19222.2 19485.6 18437.6 18734.6 18772.7 18824.2 19541.5 13562.6 14729.6 14842.3 14911.6 14960.7 13954.7 14124.6 14161.3 14194.6 14292.6 20:02:19 INFO - PID 5025 | -------- Summary: end -------- 20:02:19 INFO - PID 5025 | 20:02:20 INFO - TEST-INFO | 5025: exit 0 20:02:20 INFO - TEST-OK | dromaeo_css | took 1112394ms 20:02:20 INFO - TEST-START | kraken 20:02:20 INFO - Initialising browser for kraken test... 20:02:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html -profile /tmp/tmpHx1rCy/profile 20:02:20 INFO - TEST-INFO | started process 5400 (/builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html) 20:02:26 INFO - TEST-INFO | 5400: exit 0 20:02:26 INFO - Browser initialized. 20:02:26 INFO - Running cycle 1/1 for kraken test... 20:02:26 INFO - TEST-INFO | started process 5637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHx1rCy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:27 INFO - PID 5637 | 20:02:27 INFO - PID 5637 | (/builds/slave/test/build/application/firefox/firefox:5691): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:02:27 INFO - PID 5637 | 20:02:37 INFO - PID 5637 | RSS: Main: 167538688 20:02:37 INFO - PID 5637 | 20:02:40 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:41 INFO - PID 5637 | RSS: Main: 174264320 20:02:41 INFO - PID 5637 | 20:02:44 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-dft) 20:02:44 INFO - PID 5637 | RSS: Main: 174469120 20:02:44 INFO - PID 5637 | 20:02:47 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-fft) 20:02:48 INFO - PID 5637 | RSS: Main: 169504768 20:02:48 INFO - PID 5637 | 20:02:50 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-oscillator) 20:02:51 INFO - PID 5637 | RSS: Main: 169832448 20:02:51 INFO - PID 5637 | 20:02:53 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:54 INFO - PID 5637 | RSS: Main: 169816064 20:02:54 INFO - PID 5637 | 20:02:57 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:58 INFO - PID 5637 | RSS: Main: 172781568 20:02:58 INFO - PID 5637 | 20:03:01 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:02 INFO - PID 5637 | RSS: Main: 172380160 20:03:02 INFO - PID 5637 | 20:03:05 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58569/tests/kraken/driver.html?testName=json-parse-financial) 20:03:05 INFO - PID 5637 | RSS: Main: 173248512 20:03:05 INFO - PID 5637 | 20:03:07 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:08 INFO - PID 5637 | RSS: Main: 173027328 20:03:08 INFO - PID 5637 | 20:03:09 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:10 INFO - PID 5637 | RSS: Main: 174014464 20:03:10 INFO - PID 5637 | 20:03:12 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:13 INFO - PID 5637 | RSS: Main: 173244416 20:03:13 INFO - PID 5637 | 20:03:16 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:17 INFO - PID 5637 | RSS: Main: 174149632 20:03:17 INFO - PID 5637 | 20:03:20 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:20 INFO - PID 5637 | RSS: Main: 173826048 20:03:20 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58569/tests/kraken/driver.html?testName=ai-astar) 20:03:22 INFO - PID 5637 | RSS: Main: 175505408 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | __start_tp_report 20:03:22 INFO - PID 5637 | _x_x_mozilla_page_load 20:03:22 INFO - PID 5637 | _x_x_mozilla_page_load_details 20:03:22 INFO - PID 5637 | |i|pagename|runs| 20:03:22 INFO - PID 5637 | |0;ai-astar;99;112;100;115;111;110;115;98;108;115 20:03:22 INFO - PID 5637 | |1;audio-beat-detection;150;118;152;168;117;152;151;125;177;127 20:03:22 INFO - PID 5637 | |2;audio-dft;163;163;163;161;161;171;168;169;172;165 20:03:22 INFO - PID 5637 | |3;audio-fft;83;76;76;178;87;77;75;75;162;76 20:03:22 INFO - PID 5637 | |4;audio-oscillator;78;79;134;79;78;81;136;84;80;132 20:03:22 INFO - PID 5637 | |5;imaging-gaussian-blur;120;114;113;114;113;114;114;116;114;115 20:03:22 INFO - PID 5637 | |6;imaging-darkroom;151;152;151;152;152;151;153;150;150;151 20:03:22 INFO - PID 5637 | |7;imaging-desaturate;94;99;97;98;98;99;97;99;97;99 20:03:22 INFO - PID 5637 | |8;json-parse-financial;53;54;53;53;52;53;54;56;53;53 20:03:22 INFO - PID 5637 | |9;json-stringify-tinderbox;56;56;56;61;60;62;55;56;57;63 20:03:22 INFO - PID 5637 | |10;stanford-crypto-aes;80;87;80;79;78;83;86;97;80;83 20:03:22 INFO - PID 5637 | |11;stanford-crypto-ccm;131;128;137;134;125;131;128;129;131;163 20:03:22 INFO - PID 5637 | |12;stanford-crypto-pbkdf2;187;177;184;176;179;173;185;173;170;176 20:03:22 INFO - PID 5637 | |13;stanford-crypto-sha256-iterative;70;67;68;66;66;68;69;68;65;69 20:03:22 INFO - PID 5637 | __end_tp_report 20:03:22 INFO - PID 5637 | __start_cc_report 20:03:22 INFO - PID 5637 | _x_x_mozilla_cycle_collect,950 20:03:22 INFO - PID 5637 | __end_cc_report 20:03:22 INFO - PID 5637 | __startTimestamp1502852602722__endTimestamp 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | ------- Summary: start ------- 20:03:22 INFO - PID 5637 | Number of tests: 14 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#0] ai-astar Cycles:10 Average:108.30 Median:115.00 stddev:6.83 (5.9%) stddev-sans-first:6.36 20:03:22 INFO - PID 5637 | Values: 99.0 112.0 100.0 115.0 111.0 110.0 115.0 98.0 108.0 115.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:151.50 stddev:20.90 (13.8%) stddev-sans-first:22.05 20:03:22 INFO - PID 5637 | Values: 150.0 118.0 152.0 168.0 117.0 152.0 151.0 125.0 177.0 127.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.50 stddev:4.09 (2.5%) stddev-sans-first:4.23 20:03:22 INFO - PID 5637 | Values: 163.0 163.0 163.0 161.0 161.0 171.0 168.0 169.0 172.0 165.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:39.12 (51.5%) stddev-sans-first:41.18 20:03:22 INFO - PID 5637 | Values: 83.0 76.0 76.0 178.0 87.0 77.0 75.0 75.0 162.0 76.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:26.23 (33.2%) stddev-sans-first:26.99 20:03:22 INFO - PID 5637 | Values: 78.0 79.0 134.0 79.0 78.0 81.0 136.0 84.0 80.0 132.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:2.06 (1.8%) stddev-sans-first:0.93 20:03:22 INFO - PID 5637 | Values: 120.0 114.0 113.0 114.0 113.0 114.0 114.0 116.0 114.0 115.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 20:03:22 INFO - PID 5637 | Values: 151.0 152.0 151.0 152.0 152.0 151.0 153.0 150.0 150.0 151.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:98.50 stddev:1.57 (1.6%) stddev-sans-first:0.93 20:03:22 INFO - PID 5637 | Values: 94.0 99.0 97.0 98.0 98.0 99.0 97.0 99.0 97.0 99.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.13 20:03:22 INFO - PID 5637 | Values: 53.0 54.0 53.0 53.0 52.0 53.0 54.0 56.0 53.0 53.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:2.97 (5.1%) stddev-sans-first:3.05 20:03:22 INFO - PID 5637 | Values: 56.0 56.0 56.0 61.0 60.0 62.0 55.0 56.0 57.0 63.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:5.66 (6.8%) stddev-sans-first:5.87 20:03:22 INFO - PID 5637 | Values: 80.0 87.0 80.0 79.0 78.0 83.0 86.0 97.0 80.0 83.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:131.00 stddev:10.82 (8.3%) stddev-sans-first:11.43 20:03:22 INFO - PID 5637 | Values: 131.0 128.0 137.0 134.0 125.0 131.0 128.0 129.0 131.0 163.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:178.00 stddev:5.68 (3.2%) stddev-sans-first:5.00 20:03:22 INFO - PID 5637 | Values: 187.0 177.0 184.0 176.0 179.0 173.0 185.0 173.0 170.0 176.0 20:03:22 INFO - PID 5637 | 20:03:22 INFO - PID 5637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.41 20:03:22 INFO - PID 5637 | Values: 70.0 67.0 68.0 66.0 66.0 68.0 69.0 68.0 65.0 69.0 20:03:22 INFO - PID 5637 | -------- Summary: end -------- 20:03:22 INFO - PID 5637 | 20:03:23 INFO - PID 5637 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:03:23 INFO - TEST-INFO | 5637: exit 0 20:03:23 INFO - TEST-OK | kraken | took 63152ms 20:03:23 INFO - SUITE-END | took 1175s 20:03:23 INFO - Completed test suite (00:19:35) 20:03:23 INFO - javascript benchmark 20:03:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8559.328778292267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.529370594409, 3142.0730884389104, 3184.3153721949784, 3184.490481522956, 3218.5976752905885, 6029.306629737582, 6241.843953901155, 6242.06369044643, 6245.625262484243, 6252.124702541642, 6008.068749343859, 6135.8772824543485, 6142.785002524902, 6169.81490555284, 6172.01247800352, 5580.720963951807, 5594.160875868612, 5725.055365864628, 5726.99777538929, 5749.482546570808, 5679.0, 5690.40250773667, 5694.829155125353, 5752.2234498342605, 5777.19119323295, 5540.944590554103, 5592.161175823619, 5619.859503512404, 5674.177244299594, 5692.5161361284345, 5613.831585052455, 5614.522765564931, 5684.0, 5693.800716974927, 5704.458076482728, 5532.114861622121, 5541.0580201365865, 5626.859328516779, 5680.4319568042865, 5696.886062278772, 6018.307894592091, 6046.6069705469445, 6048.0, 6065.5450841187085, 6091.664958427285, 6608.240052393988, 6627.138471998657, 6642.568233064883, 6702.463802895757, 6705.899411508832, 6548.246951600531, 6657.300983396771, 6691.4312283455965, 6770.898436523456, 6782.8304292392595, 6155.261368635793, 6164.352742961969, 6167.414095660905, 6173.938260617381, 6185.536084793658, 6764.323567643295, 6779.0509328694025, 6782.559133656297, 6794.558353706993, 6799.524033317621, 6402.807915762442, 6453.419192272718, 6548.410643042149, 6575.178102737158, 6584.979328204136, 6506.3493650634555, 6565.934340656532, 6570.540062195696, 6571.934280657132, 6596.142501474777, 6445.9355406446275, 6452.257990331172, 6549.574277671936, 6569.737210511622, 6572.211334639874, 6479.870402591921, 6482.254540727877, 6570.901436478457, 6574.8356291093105, 6579.243387010555, 5395.082835917825, 5401.783928642889, 5453.918191227135, 5460.863478412992, 5479.424660410599, 4600.401947746772, 4632.745199014086, 4662.790174442158, 4668.0, 4696.553827386393, 5661.830145095653, 5671.744771485293, 5722.456366645162, 5765.625234359837, 5770.624909380961, 6512.218533775977, 6622.403983641495, 6638.402543771083, 6642.96678516614, 6692.564983276072, 5754.223179870748, 5757.85605359861, 5764.193012978187, 5764.654120752684, 5765.279340082489, 5816.88366232673, 5819.73811178498, 5865.970670146708, 5895.086261629454, 5911.704414779244, 6413.29453760086, 6452.709628066748, 6530.412262896362, 6537.901931471032, 6539.934600654028, 6486.383793539606, 6576.769813056711, 6582.572132811543, 6587.505937054644, 6668.399844014062, 6440.2915679276175, 6445.323241059621, 6454.031895215568, 6471.0, 6562.737490500517, 6483.0, 6535.705893234911, 6550.279469258473, 6554.541182117206, 6576.145101136822, 6656.5340426169705, 6728.125343705287, 6759.087523184307, 6766.492513061442, 6771.458283337222, 6432.067350234283, 6446.67766611677, 6480.44916182111, 6516.543841931019, 6519.674016299071, 6303.527235457451, 6349.841253968688, 6398.392152745481, 6426.4216220540375, 6496.805095847132, 6424.903626445701, 6428.228612566522, 6434.710438030394, 6440.194975628046, 6442.226932768098, 6490.221173459215, 6528.0, 6548.869022619426, 6550.574212676161, 6576.0, 6278.340774218641, 6307.558470907176, 6378.744850206125, 6387.8722425550295, 6407.679616019087], "value": 6050.018600481343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.4972242903327, 838.7861095420667, 870.7823044238938, 873.3886279604278, 1151.9712007199814, 30156.0, 40592.0, 41830.0, 41911.37132943008, 41946.0, 42223.57776422235, 42500.57499425013, 42530.36204456936, 42663.0, 42716.57283427165, 7469.701211951529, 7667.961660191691, 7670.0, 7674.731384401547, 7676.1939996300425, 7507.699692012313, 7601.0, 7617.085949686046, 7618.771436856903, 7621.123570789375, 7597.08834939808, 7655.119661238945, 7657.885131723028, 7658.540487570735, 7660.731874384398, 7569.886451703173, 7578.0, 7588.658510367047, 7596.430267729887, 7623.123340815794, 7511.586862722548, 7571.924280757232, 7597.708389573786, 7598.696052157962, 7619.390448764141, 37228.25543489115, 37358.505659773575, 37375.813120934225, 37424.25151496955, 37545.812270938746, 3551.5027896094566, 3556.324298383299, 3566.821658917044, 3573.0888623400865, 3573.213892943548, 30355.0, 30581.847090764626, 30585.38829223403, 30664.38671226563, 30780.0, 4975.203967365241, 4997.250412438163, 5038.193888977746, 5048.697078175322, 5117.283580298761, 179909.0, 181138.0, 181179.09410452863, 181267.0, 181479.0, 47217.76391118091, 47310.76344618255, 47409.52590474051, 47416.28875566869, 49361.259581106315, 51874.22188667173, 51947.480525195024, 52292.21561676578, 52343.0, 52425.7378713104, 12185.939070304768, 12354.75290494185, 13041.739165216832, 14578.0, 14594.197319147548, 10440.791184176274, 10445.582176712998, 10453.477326133663, 10459.0, 10461.895381046244, 14237.715245695235, 14459.638509037359, 14496.34766435513, 14510.709785804225, 14573.125612463286, 5563.610547261734, 5595.244641973281, 5604.131359639263, 5676.574256930747, 5765.509931655773, 992.0, 1017.2065788684838, 1017.5980487707315, 1022.974425639365, 1040.4121671255716, 22982.195623153108, 23147.88426057859, 23230.419239518807, 23233.535329293318, 23273.7672623275, 1101.4878081692052, 1102.4653043274006, 1114.5764609448358, 1131.8189089745601, 1132.5526417065378, 12403.25580465157, 12422.068344874171, 12519.749605008032, 12572.622821315192, 12591.748165036832, 228866.0, 230004.0, 230747.0, 231487.0, 233726.0, 51176.48823511717, 51211.23183152256, 51337.74331128321, 51389.22916156261, 51432.485675143515, 1405.1709491399918, 1473.7273604383224, 1482.088515562921, 1492.2389581313607, 1496.3715239599394, 22443.32670019902, 22449.32652020442, 22477.43806404853, 22498.662520061884, 22548.774512254666, 33670.3265934675, 33971.15072123217, 33998.0, 34020.1494962618, 34076.488852666735, 182681.0, 182682.0, 183003.08498457423, 184079.0, 184219.0, 30539.0, 31145.221369465944, 33474.83262583769, 33906.0, 34533.481997770556, 42737.0, 43087.56912430961, 43092.13815723731, 43158.35262471128, 43385.0, 32164.51753223657, 32307.19232019218, 32427.0, 32605.0, 33142.66857331492, 30972.690273097884, 31166.22084447907, 31472.685273146977, 31708.524372133976, 31756.364872702878, 34886.82556587201, 34999.82500087585, 35090.824545877105, 35105.29789404147, 35133.121671958404, 30524.542131868486, 30567.847160764053, 30580.84709576438, 30928.381432371676, 31234.68765312318, 22823.858807059914, 23331.300060998197, 23377.181798636968, 23397.88301058484, 23851.165209217594], "value": 16759.457729706788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7959534567558, 567.6310398241143, 568.3009897825677, 569.1491220625167, 577.1832856508041, 21552.784472155272, 22347.44131396716, 22443.55112897741, 22472.55054898903, 22487.887560562176, 24744.25767226986, 25966.350841228978, 27661.308467288327, 27675.446491070215, 27710.722892771068, 7090.858182836353, 7232.13214414271, 7242.311980361857, 7247.383972362356, 7253.782386528413, 6640.468762499013, 6994.1607007158955, 7159.677814498334, 7244.0, 7252.383547398477, 7005.404540614054, 7013.82465438363, 7015.508914375996, 7017.929820701805, 7020.262872398402, 6963.40811031063, 7025.8594828103405, 7027.5080744347915, 7031.261717519664, 7035.613041282727, 6817.931820681779, 6834.829129271759, 6899.62052087135, 6913.89629155563, 6918.481113916477, 30480.0, 31546.369072618418, 31956.520652190236, 32190.0, 32218.83890580532, 2042.652749032668, 2053.887036213023, 2059.6807494838176, 2066.183857376343, 2068.2761033638258, 20563.897180514152, 20993.160273589037, 21154.15383384678, 21232.150713971423, 21327.68008479874, 2506.4736405354897, 2520.218732193026, 2571.472848066142, 2606.1790535981104, 2648.562987107125, 140485.2975735125, 143646.28176859047, 144757.0, 144818.0, 144996.27501862423, 19966.0, 21994.560108797734, 22182.88908555479, 22696.822444857735, 23133.30600082, 22850.657240141412, 24124.0, 24244.151454699, 46182.30726539105, 46183.76908115505, 9563.426194428357, 9574.521273936276, 9693.757656058655, 9798.46108464027, 9908.207343412654, 8671.869921951176, 8694.478331300143, 8745.431546949429, 8763.211310982042, 8864.556772161366, 9445.0, 9551.617935282511, 9756.707298781048, 9828.901710982798, 9841.458719770339, 2898.087102562686, 2925.224815423914, 2927.8682459289384, 2960.985195074011, 3026.455238057171, 967.5355829202023, 985.531872360623, 996.267743208741, 997.5909876950416, 1020.698893826323, 19414.611707765765, 19628.62599618013, 19797.703034454495, 20425.591488170154, 24109.638355424682, 1000.6847842929454, 1042.61944390297, 1042.6455005298235, 1045.984310235347, 1053.210092430677, 10730.658667666541, 11436.828447573293, 13402.329883505785, 14667.193304368362, 14956.626084347761, 505510.0, 531676.0, 533371.0, 542471.0, 549354.0, 120429.0, 121322.36032919027, 122312.0, 124882.0, 124925.37537312256, 1229.2317301686446, 1270.0855384123417, 1278.335265661832, 1284.8329717136712, 1290.5483080921601, 21313.89343053275, 21525.03137358854, 21622.243221487803, 21673.458163546038, 21799.891000544896, 47784.283235752184, 58032.70983645055, 58740.70629646824, 59490.40509594849, 60424.0, 71321.0, 71677.28322716914, 72020.0, 72419.27580724336, 73034.63482682765, 14580.927095364455, 14698.044627099205, 15024.474143404928, 15046.172460514339, 15089.849101509284, 23444.88277558601, 23631.291061268188, 23696.52606947817, 23860.403489912893, 23874.761252387947, 18000.639987200444, 18565.628687426444, 18654.44036678902, 18767.90616046911, 18795.90602046981, 14114.364853581408, 16063.839361606702, 16540.421085261958, 16557.58606034859, 17166.82833171702, 18618.255269789057, 18758.812411875708, 18963.525911852314, 19107.713384299524, 19110.522236944187, 14055.437782488585, 14454.566363009126, 14660.486882959045, 14752.704945900807, 14763.114213147246, 17624.471265862045, 18407.53981150482, 18602.162902669683, 18846.811531885054, 18983.43049708456], "value": 12714.698167480401, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.34296523221, 1370.7669696151659, 1373.361386955067, 1383.4950243161243, 1384.0, 12316.0, 13910.791338129924, 14519.782203266946, 14591.854081459169, 14612.269386530685, 12341.382930853444, 12488.50045998159, 14159.504417345395, 14695.0, 14698.118112913206, 2684.5973104034406, 2737.9726202737916, 2741.3557813913712, 2741.8903243870222, 2743.0, 2444.2056331692183, 2510.8619025953567, 2516.962245566318, 2520.0675749972534, 2520.5463016656995, 2587.3919628887197, 2598.688157421112, 2600.7139214686463, 2616.7775739062204, 2619.4499155177436, 2464.691913510811, 2481.0944005437977, 2488.8382255153447, 2496.2012156110054, 2499.187763976715, 2476.430421003179, 2481.900723971039, 2492.1152990688224, 2501.0996041425074, 2505.073122944504, 13930.094543854617, 14236.501722439665, 14243.145411275356, 14255.215963122024, 14265.215413152273, 7450.515716478466, 7696.4227682924, 7718.112417072052, 7718.228177182293, 7719.884201736979, 4837.564619184255, 4970.179920313144, 5099.668521546125, 5291.920621190685, 5296.841094767163, 1848.2145088337402, 1871.2702046201855, 1880.0975531744702, 1899.6580615489206, 1907.8664493485462, 21658.133674652996, 21686.45783855416, 21910.89044554767, 21955.451113722123, 21980.78019219803, 6775.559588626724, 6940.167179938338, 6998.405135563432, 7149.785506434815, 7166.390856777128, 18822.153003114894, 18861.339853105077, 18871.0, 18883.150258238413, 18903.90548047251, 7666.578338191342, 7801.921980780233, 7814.257645523666, 7857.017872765904, 7868.763937081897, 5624.97187514068, 5746.396628354046, 6032.758689652453, 6042.1843051187525, 6980.650967451607, 5323.254744335796, 5429.239906413105, 5530.059889818741, 5561.193626924073, 5565.248691426606, 1663.5508412728736, 1673.3892129372691, 1678.337056862557, 1705.5224537129623, 1720.4580557124466, 921.5484412637893, 921.9861702074475, 926.837803384405, 937.7655586103474, 939.6429356844355, 8361.790955226046, 8397.202265784741, 8486.533240671823, 8490.872636910452, 8588.957055214809, 695.626651012627, 702.0942983551264, 729.3334730141706, 739.0392489763286, 745.5601195294802, 4581.396511221046, 4620.19146649335, 4644.303354496852, 4706.458757242893, 4729.290606409066, 19605.607887842165, 20470.897645511675, 20726.067326970322, 20728.896355518427, 20738.377848664564, 18734.344297949505, 20066.498337541387, 20226.797732022787, 20274.18903243854, 20330.085146168458, 10809.919008099285, 11120.833187502194, 11242.38166900812, 11332.376719280353, 11336.886631133748, 8070.959645201971, 8184.672613095409, 8220.136885626924, 8264.752057438287, 8340.41617086798, 17182.39861604888, 17257.827421725622, 17298.567535811704, 17417.0, 17981.550461238574, 17466.30134794594, 18095.547611309823, 18268.90865545664, 18290.288174958532, 18340.449786506426, 10788.0, 11365.54537818478, 11374.0, 11411.60059397917, 11415.086793056702, 13445.126066805626, 13547.0, 13665.0, 13675.179489230679, 13675.794863076862, 11166.49750761234, 11222.10223182127, 11389.487473063566, 11389.829152562552, 11663.0, 10919.890801092206, 11001.394923278976, 11089.667309980714, 11119.221654484432, 11303.095752339957, 10008.549615267184, 10100.191984641358, 10116.342437741523, 10118.241131915283, 10119.898801011896, 7487.5507469552, 7571.886421703569, 7638.197989211275, 7656.196099409704, 7728.381729461742, 7443.516171448839, 7637.0, 7676.96360991259, 7760.18518055596, 7819.960900195462], "value": 6445.612646162672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.9163646361886, 501.6137574067969, 510.7931287828429, 516.9431362550118, 529.6848375216747, 6165.0, 6212.254529456466, 6220.751169953208, 6225.190725205728, 6346.936530634698, 6108.930937086004, 6126.6017708849, 6217.129601855744, 6230.25236971564, 6238.812835614939, 5119.38567371915, 5174.586033117361, 5182.274481572583, 5194.792208311663, 5208.583313334924, 4797.712137271775, 5131.538161565459, 5149.588032957355, 5151.175811870102, 5176.948230517684, 4883.926741098869, 4900.362952816129, 4937.80248790048, 4963.578095861856, 4973.229149481818, 4907.214845624683, 4916.852494425155, 4925.335079764258, 4959.256111583255, 4969.434628092139, 4460.353248778942, 4485.865424037284, 4487.596116349511, 4500.524711408712, 4519.186546421643, 6056.242969628796, 6068.605540639845, 6097.3597772233725, 6101.359357267512, 6147.047207682816, 5646.491815736563, 5686.488216060575, 5719.628224165416, 5728.8854222915725, 5753.510951569122, 6409.647469389181, 6525.575837570543, 6543.869122617521, 6593.835154121138, 6625.933740662628, 4912.0, 4913.975430122827, 4920.507949205086, 4925.768557860535, 4928.408590969107, 6713.429358504533, 6777.288384719632, 6798.456123510107, 6899.896501552481, 6953.20038195609, 4925.40895092584, 5000.199968005102, 5050.924236136461, 5058.0, 5059.392872855207, 5115.1559992600805, 5119.846404607868, 5131.409887862869, 5135.229715542624, 5151.7681704323395, 5694.829155125353, 5714.285714285715, 5717.371089180187, 5728.112142617901, 5781.485054001523, 6596.571222870498, 6625.966870165618, 6637.6349300788925, 6642.767503137464, 6664.166979127609, 1770.2741875830848, 1796.9550761230812, 1798.3615816384995, 1800.828921252479, 1802.8551869562923, 1184.490669012333, 1200.8138738495547, 1226.2397313665585, 1229.0, 1229.7417542316034, 5708.4862362387585, 5738.351934932718, 5773.740181691834, 5816.767329306865, 5865.442782935615, 6625.138731964814, 6680.19837619479, 6731.1922569292, 6789.830254243683, 6797.411747070708, 5723.3418156912485, 5731.770729170787, 5744.655320680689, 5746.281714785652, 5843.565484099743, 3517.66582174693, 3522.5068490411363, 3530.929381412409, 3580.1944562473236, 3585.928281434357, 6495.577787443801, 6540.509461790385, 6581.934180658228, 6628.436582890508, 6692.966535167293, 6881.724731010803, 6921.411680007155, 6969.756058537927, 6993.755218567326, 6996.146021304358, 6492.513061520405, 6525.8694826104165, 6542.527931215438, 6560.639164845979, 6566.4418524425955, 6227.782027629011, 6806.727730890907, 6822.522423430511, 6832.214295356098, 6834.0, 6632.83417914556, 6665.2334981475815, 6675.165604299463, 6713.832154196184, 6753.189617245962, 6652.866942661217, 6664.500162487736, 6668.966655166693, 6715.597064176165, 6732.6297053660555, 4912.231596625284, 4966.577840883421, 5016.072026675077, 5071.264666623245, 5074.949250507595, 6488.578242414228, 6503.6097834130105, 6552.08270842092, 6766.966165169143, 6782.67737791126, 6477.708503117276, 6501.1548498694865, 6511.158416534267, 6530.869382612416, 6572.422618571604, 6515.609063456208, 6515.641639709862, 6548.738050477928, 6559.147310849559, 6598.3401659833635, 6469.514786391133, 6496.187976502937, 6509.153810004669, 6542.672866356758, 6606.207255129415, 6536.673166341759, 6548.705308261045, 6616.305287944889, 6660.766873159416, 6666.400023997669, 6299.401556852092, 6401.839954001187, 6430.485561155003, 6453.903191452226, 6475.125858009108], "value": 5078.920262847818, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.6756300168938, 897.5332826929997, 902.6615019367737, 911.7994041310914, 915.9313051521137, 17242.13789310534, 17948.46154615362, 17972.91013544932, 18008.729869051975, 21328.4667883303, 19236.230550777986, 19365.03174841259, 19365.709514357295, 19413.32053378132, 19458.0, 950.5057370167526, 1009.5255230041905, 1013.0426746724348, 1024.8821385540646, 1032.4682788363998, 1017.4404077757241, 1021.9846702299471, 1024.4109636958742, 1025.1542477456092, 1026.179056754597, 981.087588542655, 1084.6203828659984, 1086.098538213281, 1087.4780105549341, 1089.6785448292733, 1058.0688993685546, 1068.3910171202417, 1073.6403304892792, 1074.6668532754832, 1081.1566977757361, 785.4305628419407, 787.3307688464816, 788.0858204482772, 788.1055002572065, 788.2157253532714, 18796.906015469835, 19272.80727192738, 19432.0, 19444.125014374247, 19935.40193794174, 21559.461013474633, 21766.891165544228, 22349.0, 22373.55252894933, 22487.55024899493, 16621.50135495937, 16827.91586042074, 17030.233639486254, 17052.062136582485, 17190.570235744082, 3517.26137511123, 3542.6103128655827, 3545.929081418383, 3547.0245682437535, 3551.6093229744706, 123529.38235308856, 124586.0, 125838.37080814537, 127589.0, 128155.0, 17218.225179866935, 17513.12434378276, 17622.207000685, 17821.821781782277, 18186.0, 29858.552121718192, 31003.68996310008, 31409.8429507851, 32310.83844580762, 32353.838230808695, 7514.39884809214, 7900.170482099412, 8746.38775285724, 9018.413803102778, 9022.86465703015, 4002.8799136025964, 4185.58144185579, 4211.536730959592, 4217.641500472494, 4220.978895105505, 5100.234964755242, 5234.7906083756225, 5239.44985776488, 5260.13207820713, 5286.867828304323, 1019.5106348952544, 1039.5322105052755, 1040.2822052783556, 1043.108142538119, 1046.7697106636529, 641.4996302883758, 652.9771457998947, 660.4914216053612, 665.0755449924609, 696.0603185699265, 11824.881751182378, 12008.03935685143, 12253.326067066397, 12743.04427167966, 13651.658708532366, 672.0993868216516, 679.2155060904663, 690.5683947532792, 695.9721611135498, 715.3919168706558, 5703.800366987136, 5796.710164491843, 5826.796062137805, 5937.881242375129, 6042.093685947055, 112124.83313417678, 113179.43410282896, 114148.0, 116531.41734291274, 122347.0, 98409.0, 101569.0, 101987.0, 105359.0, 106960.0, 91005.54497227471, 92749.5362523183, 93045.069549305, 95609.0, 95618.5219073914, 10775.461226938465, 10798.434227036878, 11112.722181945515, 11264.324140551593, 11336.206465547333, 36819.0, 38396.232075358894, 39043.0, 39698.206035879695, 40353.596464036156, 73062.63468682622, 73125.63437182993, 73231.0, 74544.0, 76781.61609191919, 20078.598428031648, 20374.18503259853, 20389.89805050965, 20644.793552064286, 20728.0, 20145.597088057864, 21701.457463563536, 22035.77964220337, 22743.0, 22882.656760148944, 18862.717059244398, 18977.43067707971, 19299.710504342725, 19535.413937581896, 19890.5027374311, 18405.171767270236, 18661.0, 18739.250429983193, 19222.231110755412, 19485.610287794447, 18437.631247375244, 18734.625307494047, 18772.718409224144, 18824.152913119215, 19541.51146221299, 13562.59312220635, 14729.55811325662, 14842.257887105818, 14911.552653420415, 14960.700785984436, 13954.651133721738, 14124.646883827987, 14161.291935402982, 14194.645133871736, 14292.642683932985], "value": 9316.50480654123, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 100.0, 115.0, 111.0, 110.0, 115.0, 98.0, 108.0, 115.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 152.0, 168.0, 117.0, 152.0, 151.0, 125.0, 177.0, 127.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 161.0, 171.0, 168.0, 169.0, 172.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 76.0, 178.0, 87.0, 77.0, 75.0, 75.0, 162.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 134.0, 79.0, 78.0, 81.0, 136.0, 84.0, 80.0, 132.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 116.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 152.0, 152.0, 151.0, 153.0, 150.0, 150.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 97.0, 98.0, 98.0, 99.0, 97.0, 99.0, 97.0, 99.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 52.0, 53.0, 54.0, 56.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 61.0, 60.0, 62.0, 55.0, 56.0, 57.0, 63.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 80.0, 79.0, 78.0, 83.0, 86.0, 97.0, 80.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 137.0, 134.0, 125.0, 131.0, 128.0, 129.0, 131.0, 163.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 177.0, 184.0, 176.0, 179.0, 173.0, 185.0, 173.0, 170.0, 176.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 66.0, 66.0, 68.0, 69.0, 68.0, 65.0, 69.0], "value": 67.6, "unit": "score"}]}]} 20:03:23 INFO - Return code: 0 20:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:03:23 INFO - # TBPL SUCCESS # 20:03:23 INFO - Running post-action listener: _package_coverage_data 20:03:23 INFO - Running post-action listener: _resource_record_post_action 20:03:23 INFO - [mozharness: 2017-08-16 03:03:23.996584Z] Finished run-tests step (success) 20:03:23 INFO - Running post-run listener: _resource_record_post_run 20:03:24 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 442081280; Read time: 388; Write time: 298988 20:03:24 INFO - TinderboxPrint: CPU usage
13.1% 20:03:24 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 388 20:03:24 INFO - TinderboxPrint: I/O write bytes / time
442,081,280 / 298,988 20:03:24 INFO - TinderboxPrint: CPU idle
8,267.4 (86.8%) 20:03:24 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 20:03:24 INFO - TinderboxPrint: Swap in / out
0 / 0 20:03:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118308864; Read time: 188; Write time: 77404 20:03:24 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:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323772416; Read time: 188; Write time: 221584 20:03:24 INFO - Running post-run listener: _upload_blobber_files 20:03:24 INFO - Blob upload gear active. 20:03:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:24 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:24 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:24 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:25 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:03:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:25 INFO - (blobuploader) - INFO - Done attempting. 20:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:26 INFO - (blobuploader) - INFO - Done attempting. 20:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:27 INFO - (blobuploader) - INFO - Done attempting. 20:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:03:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:34 INFO - (blobuploader) - INFO - Done attempting. 20:03:34 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:34 INFO - Return code: 0 20:03:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb95f93403425253ba1774fd88bb36996a4cc5c1e3eaa82fc26d0c2c24a6d8aeb8dc6c8a0063696ae4bf346dda63ebc2b9c9d94f23ef9136e27435d46ef9cb85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c4c4fd86d0b744ab6f20683968e0b53102cd36d17c6038a940e2d43d9cdf1571eacc2a27676cbdf960af3b0703419a35935b16dc9b6db12d9711fc0df82f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6455c760caf4d1e9eab27470822b3b10c537eb4e082fd781539aeb049cd5326d9a8ad27d4e338fdce29da96c8b3ec6599d6ca0e2b85fae1cade8febcbd6bb831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b84aa69e9605a80e61941869b411e6d38465e09ee865f88650917ae81658885086249f7083cb6593d9c32a693cb4431d6543f27eaf80aa9f5dd5ba83843d2169"} 20:03:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:34 INFO - Contents: 20:03:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb95f93403425253ba1774fd88bb36996a4cc5c1e3eaa82fc26d0c2c24a6d8aeb8dc6c8a0063696ae4bf346dda63ebc2b9c9d94f23ef9136e27435d46ef9cb85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c4c4fd86d0b744ab6f20683968e0b53102cd36d17c6038a940e2d43d9cdf1571eacc2a27676cbdf960af3b0703419a35935b16dc9b6db12d9711fc0df82f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6455c760caf4d1e9eab27470822b3b10c537eb4e082fd781539aeb049cd5326d9a8ad27d4e338fdce29da96c8b3ec6599d6ca0e2b85fae1cade8febcbd6bb831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b84aa69e9605a80e61941869b411e6d38465e09ee865f88650917ae81658885086249f7083cb6593d9c32a693cb4431d6543f27eaf80aa9f5dd5ba83843d2169"} 20:03:34 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:34 INFO - Copying logs to upload dir... 20:03:34 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.566678 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 20:03:34.420331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:34.423555) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb95f93403425253ba1774fd88bb36996a4cc5c1e3eaa82fc26d0c2c24a6d8aeb8dc6c8a0063696ae4bf346dda63ebc2b9c9d94f23ef9136e27435d46ef9cb85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c4c4fd86d0b744ab6f20683968e0b53102cd36d17c6038a940e2d43d9cdf1571eacc2a27676cbdf960af3b0703419a35935b16dc9b6db12d9711fc0df82f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6455c760caf4d1e9eab27470822b3b10c537eb4e082fd781539aeb049cd5326d9a8ad27d4e338fdce29da96c8b3ec6599d6ca0e2b85fae1cade8febcbd6bb831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b84aa69e9605a80e61941869b411e6d38465e09ee865f88650917ae81658885086249f7083cb6593d9c32a693cb4431d6543f27eaf80aa9f5dd5ba83843d2169"} build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011833 build_url: 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb95f93403425253ba1774fd88bb36996a4cc5c1e3eaa82fc26d0c2c24a6d8aeb8dc6c8a0063696ae4bf346dda63ebc2b9c9d94f23ef9136e27435d46ef9cb85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c4c4fd86d0b744ab6f20683968e0b53102cd36d17c6038a940e2d43d9cdf1571eacc2a27676cbdf960af3b0703419a35935b16dc9b6db12d9711fc0df82f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6455c760caf4d1e9eab27470822b3b10c537eb4e082fd781539aeb049cd5326d9a8ad27d4e338fdce29da96c8b3ec6599d6ca0e2b85fae1cade8febcbd6bb831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b84aa69e9605a80e61941869b411e6d38465e09ee865f88650917ae81658885086249f7083cb6593d9c32a693cb4431d6543f27eaf80aa9f5dd5ba83843d2169"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:34.454413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:34.454826) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502848635.380953-162956373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004763 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:34.540716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:34.541409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:34.541915) ========= ========= Total master_lag: 0.19 =========