builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1502851341.68 results: success (0) revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.682706) ========= 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.683245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.683593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.723198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.723644) ========= 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=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 19:42:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-08-15 19:42:21 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.844190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.847358) ========= 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=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021048 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:21.910404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-15 19:42:21.910774) ========= 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=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 19:42:22,022 truncating revision to first 12 chars 2017-08-15 19:42:22,022 Setting DEBUG logging. 2017-08-15 19:42:22,022 attempt 1/10 2017-08-15 19:42:22,022 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,708 attempt 1/10 2017-08-15 19:42:23,436 current task status: no status available at this point. state: STARTED 2017-08-15 19:42:23,436 sleeping for 9.00s (attempt 1/10) 2017-08-15 19:42:32,445 attempt 2/10 2017-08-15 19:42:32,789 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-15 19:42:33,008 unpacking tar archive at: mozilla-central-6966f27380bf/testing/mozharness/ program finished with exit code 0 elapsedTime=11.298051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-15 19:42:33.228982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:33.229357) ========= script_repo_revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:33.229824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:33.231167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 19:42:33.244021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 19:42:33.244516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:33 INFO - MultiFileLogger online at 20170815 19:42:33 in /builds/slave/test 19:42:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:42:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:33 INFO - {'append_to_log': False, 19:42:33 INFO - 'base_work_dir': '/builds/slave/test', 19:42:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:42:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:33 INFO - 'branch': 'Firefox-Non-PGO', 19:42:33 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:33 INFO - 'code_coverage': False, 19:42:33 INFO - 'config_files': ('talos/linux_config.py',), 19:42:33 INFO - 'default_actions': ('clobber', 19:42:33 INFO - 'read-buildbot-config', 19:42:33 INFO - 'download-and-extract', 19:42:33 INFO - 'populate-webroot', 19:42:33 INFO - 'create-virtualenv', 19:42:33 INFO - 'install', 19:42:33 INFO - 'setup-mitmproxy', 19:42:33 INFO - 'run-tests'), 19:42:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:33 INFO - 'disable_ccov_upload': False, 19:42:33 INFO - 'download_minidump_stackwalk': True, 19:42:33 INFO - 'download_symbols': 'ondemand', 19:42:33 INFO - 'enable_stylo': False, 19:42:33 INFO - 'enable_webrender': False, 19:42:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:33 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:33 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:33 INFO - 'gecko_profile': False, 19:42:33 INFO - 'gecko_profile_interval': 0, 19:42:33 INFO - 'installer_path': 'installer.exe', 19:42:33 INFO - 'log_level': 'info', 19:42:33 INFO - 'log_name': 'talos', 19:42:33 INFO - 'log_to_console': True, 19:42:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:33 INFO - 'opt_config_files': (), 19:42:33 INFO - 'pip_index': False, 19:42:33 INFO - 'suite': 'dromaeojs-e10s', 19:42:33 INFO - 'system_bits': '32', 19:42:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:33 INFO - 'title': 'talos-linux64-ix-043', 19:42:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:33 INFO - 'use_talos_json': True, 19:42:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:33 INFO - 'work_dir': 'build'} 19:42:33 INFO - [mozharness: 2017-08-16 02:42:33.454698Z] Running clobber step. 19:42:33 INFO - Running pre-action listener: _resource_record_pre_action 19:42:33 INFO - Running main action method: clobber 19:42:33 INFO - rmtree: /builds/slave/test/build 19:42:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:34 INFO - Running post-action listener: _resource_record_post_action 19:42:34 INFO - [mozharness: 2017-08-16 02:42:34.992928Z] Finished clobber step (success) 19:42:34 INFO - [mozharness: 2017-08-16 02:42:34.993030Z] Running read-buildbot-config step. 19:42:34 INFO - Running pre-action listener: _resource_record_pre_action 19:42:34 INFO - Running main action method: read_buildbot_config 19:42:34 INFO - Using buildbot properties: 19:42:34 INFO - { 19:42:34 INFO - "project": "", 19:42:34 INFO - "product": "firefox", 19:42:34 INFO - "who": "kwierso@gmail.com", 19:42:34 INFO - "installer_path": "public/build/target.tar.bz2", 19:42:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:42:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:42:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:42:34 INFO - "stage_platform": "linux64", 19:42:34 INFO - "basedir": "/builds/slave/test", 19:42:34 INFO - "buildnumber": 1079, 19:42:34 INFO - "platform": "ubuntu64_hw", 19:42:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:42:34 INFO - "slavebuilddir": "test", 19:42:34 INFO - "taskId": "J4Mn6oQwTUiZz63o5cjWwg", 19:42:34 INFO - "branch": "mozilla-central", 19:42:34 INFO - "script_repo_revision": "production", 19:42:34 INFO - "revision": "6966f27380bf2e3e5ace3507f600852bd3ed9dbd", 19:42:34 INFO - "slavename": "talos-linux64-ix-043", 19:42:34 INFO - "repo_path": "mozilla-central" 19:42:34 INFO - } 19:42:34 INFO - Finding installer, test and symbols from parent task. 19:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4Mn6oQwTUiZz63o5cjWwg'}, attempt #1 19:42:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4Mn6oQwTUiZz63o5cjWwg'}, attempt #1 19:42:35 INFO - Task dependencies: YvnAGiJcTqymla8mJLMVSg 19:42:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg'}, attempt #1 19:42:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:42:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip 19:42:36 INFO - Running post-action listener: _resource_record_post_action 19:42:36 INFO - [mozharness: 2017-08-16 02:42:36.362701Z] Finished read-buildbot-config step (success) 19:42:36 INFO - [mozharness: 2017-08-16 02:42:36.362919Z] Running download-and-extract step. 19:42:36 INFO - Running pre-action listener: _resource_record_pre_action 19:42:36 INFO - Running main action method: download_and_extract 19:42:36 INFO - mkdir: /builds/slave/test/build/tests 19:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:42:36 INFO - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.test_packages.json 19:42:36 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:36 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:36 INFO - Downloaded 989 bytes. 19:42:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:42:36 INFO - Using the following test package requirements: 19:42:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:42:36 INFO - u'common': [u'target.common.tests.zip'], 19:42:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:42:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:42:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:42:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:42:36 INFO - u'mozbase': [u'target.common.tests.zip'], 19:42:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:42:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:42:36 INFO - u'web-platform': [u'target.common.tests.zip', 19:42:36 INFO - u'target.web-platform.tests.tar.gz'], 19:42:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:42:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:42:36 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:36 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:36 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:38 INFO - Content-Length response header: 54002789 19:42:38 INFO - Bytes received: 54002789 19:42:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:42:49 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:49 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:49 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.common.tests.zip into memory 19:42:50 INFO - Content-Length response header: 54002789 19:42:50 INFO - Bytes received: 54002789 19:43:02 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:02 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:02 INFO - Fetch https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.talos.tests.zip into memory 19:43:03 INFO - Content-Length response header: 14496050 19:43:03 INFO - Bytes received: 14496050 19:43:03 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:03 INFO - trying https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:03 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:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:43:05 INFO - Downloaded 62021852 bytes. 19:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:05 INFO - mkdir: /builds/slave/test/properties 19:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:05 INFO - Contents: 19:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 19:43:05 INFO - Running post-action listener: _resource_record_post_action 19:43:05 INFO - Running post-action listener: set_extra_try_arguments 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.300772Z] Finished download-and-extract step (success) 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.301002Z] Running populate-webroot step. 19:43:05 INFO - Running pre-action listener: _resource_record_pre_action 19:43:05 INFO - Running main action method: populate_webroot 19:43:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['damp', 'tps']}, 19:43:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:43:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:43:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:05 INFO - 'ts_paint', 19:43:05 INFO - 'tpaint', 19:43:05 INFO - 'sessionrestore', 19:43:05 INFO - 'sessionrestore_many_windows', 19:43:05 INFO - 'sessionrestore_no_auto_restore', 19:43:05 INFO - 'tabpaint']}, 19:43:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:43:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:43:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:05 INFO - 'tsvgr_opacity', 19:43:05 INFO - 'tart', 19:43:05 INFO - 'tscrollx', 19:43:05 INFO - 'tsvg_static']}, 19:43:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:43:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--stylo', 19:43:05 INFO - '--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:43:05 INFO - 'talos_options': ['--stylo', 19:43:05 INFO - '--stylo-threads=1', 19:43:05 INFO - '--mitmproxy', 19:43:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:43:05 INFO - '--firstNonBlankPaint'], 19:43:05 INFO - 'tests': ['tp6_google', 19:43:05 INFO - 'tp6_youtube', 19:43:05 INFO - 'tp6_amazon', 19:43:05 INFO - 'tp6_facebook']}, 19:43:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:43:05 INFO - 'talos_options': ['--xperf_path', 19:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:05 INFO - 'tests': ['tp5n']}}} 19:43:05 INFO - Running post-action listener: _resource_record_post_action 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.319571Z] Finished populate-webroot step (success) 19:43:05 INFO - [mozharness: 2017-08-16 02:43:05.319661Z] Running create-virtualenv step. 19:43:05 INFO - Running pre-action listener: _resource_record_pre_action 19:43:05 INFO - Running main action method: create_virtualenv 19:43:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:43:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:43:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:05 INFO - Using real prefix '/usr' 19:43:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:07 INFO - Installing pip.................done. 19:43:07 INFO - Return code: 0 19:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:43:08 INFO - Reading from file tmpfile_stdout 19:43:08 INFO - Output received: 19:43:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:43:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:43:08 INFO - Using env: {'DISPLAY': ':0', 19:43:08 INFO - 'HOME': '/home/cltbld', 19:43:08 INFO - 'LANG': 'en_US.UTF-8', 19:43:08 INFO - 'LANGUAGE': 'en_US:en', 19:43:08 INFO - 'LOGNAME': 'cltbld', 19:43:08 INFO - 'MAIL': '/var/mail/cltbld', 19:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:08 INFO - 'MOZ_NO_REMOTE': '1', 19:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:08 INFO - 'NO_EM_RESTART': '1', 19:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:08 INFO - 'PWD': '/builds/slave/test', 19:43:08 INFO - 'SHELL': '/bin/bash', 19:43:08 INFO - 'SHLVL': '1', 19:43:08 INFO - 'TERM': 'linux', 19:43:08 INFO - 'TMOUT': '86400', 19:43:08 INFO - 'USER': 'cltbld', 19:43:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:08 INFO - '_': '/tools/buildbot/bin/python'} 19:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:43:08 INFO - Cleaning up... 19:43:08 INFO - Return code: 0 19:43:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:43:08 INFO - Using env: {'DISPLAY': ':0', 19:43:08 INFO - 'HOME': '/home/cltbld', 19:43:08 INFO - 'LANG': 'en_US.UTF-8', 19:43:08 INFO - 'LANGUAGE': 'en_US:en', 19:43:08 INFO - 'LOGNAME': 'cltbld', 19:43:08 INFO - 'MAIL': '/var/mail/cltbld', 19:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:08 INFO - 'MOZ_NO_REMOTE': '1', 19:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:08 INFO - 'NO_EM_RESTART': '1', 19:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:08 INFO - 'PWD': '/builds/slave/test', 19:43:08 INFO - 'SHELL': '/bin/bash', 19:43:08 INFO - 'SHLVL': '1', 19:43:08 INFO - 'TERM': 'linux', 19:43:08 INFO - 'TMOUT': '86400', 19:43:08 INFO - 'USER': 'cltbld', 19:43:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:08 INFO - '_': '/tools/buildbot/bin/python'} 19:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:08 INFO - Downloading/unpacking psutil>=3.1.1 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:09 INFO - Installing collected packages: psutil 19:43:09 INFO - Running setup.py install for psutil 19:43:09 INFO - building 'psutil._psutil_linux' extension 19:43:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:43:09 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:09 INFO - building 'psutil._psutil_posix' extension 19:43:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:43:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:10 INFO - Successfully installed psutil 19:43:10 INFO - Cleaning up... 19:43:10 INFO - Return code: 0 19:43:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:43:10 INFO - Using env: {'DISPLAY': ':0', 19:43:10 INFO - 'HOME': '/home/cltbld', 19:43:10 INFO - 'LANG': 'en_US.UTF-8', 19:43:10 INFO - 'LANGUAGE': 'en_US:en', 19:43:10 INFO - 'LOGNAME': 'cltbld', 19:43:10 INFO - 'MAIL': '/var/mail/cltbld', 19:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:10 INFO - 'MOZ_NO_REMOTE': '1', 19:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:10 INFO - 'NO_EM_RESTART': '1', 19:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:10 INFO - 'PWD': '/builds/slave/test', 19:43:10 INFO - 'SHELL': '/bin/bash', 19:43:10 INFO - 'SHLVL': '1', 19:43:10 INFO - 'TERM': 'linux', 19:43:10 INFO - 'TMOUT': '86400', 19:43:10 INFO - 'USER': 'cltbld', 19:43:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:10 INFO - '_': '/tools/buildbot/bin/python'} 19:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:43:11 INFO - Installing collected packages: mozsystemmonitor 19:43:11 INFO - Running setup.py install for mozsystemmonitor 19:43:11 INFO - Successfully installed mozsystemmonitor 19:43:11 INFO - Cleaning up... 19:43:11 INFO - Return code: 0 19:43:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:43:11 INFO - Using env: {'DISPLAY': ':0', 19:43:11 INFO - 'HOME': '/home/cltbld', 19:43:11 INFO - 'LANG': 'en_US.UTF-8', 19:43:11 INFO - 'LANGUAGE': 'en_US:en', 19:43:11 INFO - 'LOGNAME': 'cltbld', 19:43:11 INFO - 'MAIL': '/var/mail/cltbld', 19:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:11 INFO - 'MOZ_NO_REMOTE': '1', 19:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:11 INFO - 'NO_EM_RESTART': '1', 19:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:11 INFO - 'PWD': '/builds/slave/test', 19:43:11 INFO - 'SHELL': '/bin/bash', 19:43:11 INFO - 'SHLVL': '1', 19:43:11 INFO - 'TERM': 'linux', 19:43:11 INFO - 'TMOUT': '86400', 19:43:11 INFO - 'USER': 'cltbld', 19:43:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:11 INFO - '_': '/tools/buildbot/bin/python'} 19:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:11 INFO - Downloading/unpacking jsonschema==2.5.1 19:43:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:11 INFO - 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:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:13 INFO - warning: no files found matching '*.txt' 19:43:13 INFO - no previously-included directories found matching 'build' 19:43:13 INFO - no previously-included directories found matching 'dist' 19:43:13 INFO - no previously-included directories found matching '.git*' 19:43:13 INFO - Installing collected packages: jsonschema, functools32 19:43:13 INFO - Running setup.py install for functools32 19:43:13 INFO - warning: no files found matching '*.txt' 19:43:13 INFO - no previously-included directories found matching 'build' 19:43:13 INFO - no previously-included directories found matching 'dist' 19:43:13 INFO - no previously-included directories found matching '.git*' 19:43:13 INFO - Successfully installed jsonschema functools32 19:43:13 INFO - Cleaning up... 19:43:13 INFO - Return code: 0 19:43:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:43:13 INFO - Using env: {'DISPLAY': ':0', 19:43:13 INFO - 'HOME': '/home/cltbld', 19:43:13 INFO - 'LANG': 'en_US.UTF-8', 19:43:13 INFO - 'LANGUAGE': 'en_US:en', 19:43:13 INFO - 'LOGNAME': 'cltbld', 19:43:13 INFO - 'MAIL': '/var/mail/cltbld', 19:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:13 INFO - 'MOZ_NO_REMOTE': '1', 19:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:13 INFO - 'NO_EM_RESTART': '1', 19:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:13 INFO - 'PWD': '/builds/slave/test', 19:43:13 INFO - 'SHELL': '/bin/bash', 19:43:13 INFO - 'SHLVL': '1', 19:43:13 INFO - 'TERM': 'linux', 19:43:13 INFO - 'TMOUT': '86400', 19:43:13 INFO - 'USER': 'cltbld', 19:43:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:13 INFO - '_': '/tools/buildbot/bin/python'} 19:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:43:13 INFO - Cleaning up... 19:43:13 INFO - Return code: 0 19:43:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:43:13 INFO - Using env: {'DISPLAY': ':0', 19:43:13 INFO - 'HOME': '/home/cltbld', 19:43:13 INFO - 'LANG': 'en_US.UTF-8', 19:43:13 INFO - 'LANGUAGE': 'en_US:en', 19:43:13 INFO - 'LOGNAME': 'cltbld', 19:43:13 INFO - 'MAIL': '/var/mail/cltbld', 19:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:13 INFO - 'MOZ_NO_REMOTE': '1', 19:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:13 INFO - 'NO_EM_RESTART': '1', 19:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:13 INFO - 'PWD': '/builds/slave/test', 19:43:13 INFO - 'SHELL': '/bin/bash', 19:43:13 INFO - 'SHLVL': '1', 19:43:13 INFO - 'TERM': 'linux', 19:43:13 INFO - 'TMOUT': '86400', 19:43:13 INFO - 'USER': 'cltbld', 19:43:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:13 INFO - '_': '/tools/buildbot/bin/python'} 19:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:15 INFO - Downloading docopt-0.6.1.tar.gz 19:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:15 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:15 INFO - Running setup.py install for blobuploader 19:43:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:15 INFO - Running setup.py install for requests 19:43:16 INFO - Running setup.py install for docopt 19:43:16 INFO - Successfully installed blobuploader requests docopt 19:43:16 INFO - Cleaning up... 19:43:16 INFO - Return code: 0 19:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:43:16 INFO - Using env: {'DISPLAY': ':0', 19:43:16 INFO - 'HOME': '/home/cltbld', 19:43:16 INFO - 'LANG': 'en_US.UTF-8', 19:43:16 INFO - 'LANGUAGE': 'en_US:en', 19:43:16 INFO - 'LOGNAME': 'cltbld', 19:43:16 INFO - 'MAIL': '/var/mail/cltbld', 19:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:16 INFO - 'MOZ_NO_REMOTE': '1', 19:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:16 INFO - 'NO_EM_RESTART': '1', 19:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:16 INFO - 'PWD': '/builds/slave/test', 19:43:16 INFO - 'SHELL': '/bin/bash', 19:43:16 INFO - 'SHLVL': '1', 19:43:16 INFO - 'TERM': 'linux', 19:43:16 INFO - 'TMOUT': '86400', 19:43:16 INFO - 'USER': 'cltbld', 19:43:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:16 INFO - '_': '/tools/buildbot/bin/python'} 19:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:16 INFO - Running setup.py (path:/tmp/pip-ceKKY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:16 INFO - Running setup.py (path:/tmp/pip-wyr9eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:16 INFO - Running setup.py (path:/tmp/pip-bPjPb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:16 INFO - Running setup.py (path:/tmp/pip-mgCoPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:16 INFO - Running setup.py (path:/tmp/pip-wxP5j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:16 INFO - Running setup.py (path:/tmp/pip-u3Axpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:16 INFO - Running setup.py (path:/tmp/pip-VvQamv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:16 INFO - Running setup.py (path:/tmp/pip-2egTqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:17 INFO - Running setup.py (path:/tmp/pip-2ydSh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:17 INFO - Running setup.py (path:/tmp/pip-VKjryn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:17 INFO - Running setup.py (path:/tmp/pip-5I41Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:17 INFO - Running setup.py (path:/tmp/pip-fuaDJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:17 INFO - Running setup.py (path:/tmp/pip-jgIbGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:17 INFO - Running setup.py (path:/tmp/pip-_xW_wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:17 INFO - Running setup.py (path:/tmp/pip-2ayYPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:17 INFO - Running setup.py (path:/tmp/pip-1JB78X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:17 INFO - Running setup.py (path:/tmp/pip-wEyNpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:17 INFO - Running setup.py install for manifestparser 19:43:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:17 INFO - Running setup.py install for mozcrash 19:43:17 INFO - Running setup.py install for mozdebug 19:43:17 INFO - Running setup.py install for mozdevice 19:43:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozfile 19:43:18 INFO - Running setup.py install for mozhttpd 19:43:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozinfo 19:43:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozInstall 19:43:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozleak 19:43:18 INFO - Running setup.py install for mozlog 19:43:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for moznetwork 19:43:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozprocess 19:43:18 INFO - Running setup.py install for mozprofile 19:43:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:18 INFO - Running setup.py install for mozrunner 19:43:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozscreenshot 19:43:19 INFO - Running setup.py install for moztest 19:43:19 INFO - Running setup.py install for mozversion 19:43:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:19 INFO - Cleaning up... 19:43:19 INFO - Return code: 0 19:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:43:19 INFO - Using env: {'DISPLAY': ':0', 19:43:19 INFO - 'HOME': '/home/cltbld', 19:43:19 INFO - 'LANG': 'en_US.UTF-8', 19:43:19 INFO - 'LANGUAGE': 'en_US:en', 19:43:19 INFO - 'LOGNAME': 'cltbld', 19:43:19 INFO - 'MAIL': '/var/mail/cltbld', 19:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:19 INFO - 'MOZ_NO_REMOTE': '1', 19:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:19 INFO - 'NO_EM_RESTART': '1', 19:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:19 INFO - 'PWD': '/builds/slave/test', 19:43:19 INFO - 'SHELL': '/bin/bash', 19:43:19 INFO - 'SHLVL': '1', 19:43:19 INFO - 'TERM': 'linux', 19:43:19 INFO - 'TMOUT': '86400', 19:43:19 INFO - 'USER': 'cltbld', 19:43:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:19 INFO - '_': '/tools/buildbot/bin/python'} 19:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:19 INFO - Running setup.py (path:/tmp/pip-N2h4Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:19 INFO - Running setup.py (path:/tmp/pip-hTerjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:19 INFO - Running setup.py (path:/tmp/pip-J3Qpnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:19 INFO - Running setup.py (path:/tmp/pip-uPVn8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:19 INFO - Running setup.py (path:/tmp/pip-74HUmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:19 INFO - Running setup.py (path:/tmp/pip-QgjNFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:20 INFO - Running setup.py (path:/tmp/pip-9WnriQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:20 INFO - Running setup.py (path:/tmp/pip-jseFKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:20 INFO - Running setup.py (path:/tmp/pip-TpJeFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:20 INFO - Running setup.py (path:/tmp/pip-e3oTJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:20 INFO - Running setup.py (path:/tmp/pip-a8IXa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:20 INFO - Running setup.py (path:/tmp/pip-EVK2Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:20 INFO - Running setup.py (path:/tmp/pip-l4fZR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:20 INFO - Running setup.py (path:/tmp/pip-Zylfjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:20 INFO - Running setup.py (path:/tmp/pip-YOJSUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:20 INFO - Running setup.py (path:/tmp/pip-Ws7Bov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:20 INFO - Running setup.py (path:/tmp/pip-F0zE3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43:20 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:20 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:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:21 INFO - Downloading blessings-1.6.tar.gz 19:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:22 INFO - Installing collected packages: blessings 19:43:22 INFO - Running setup.py install for blessings 19:43:22 INFO - Successfully installed blessings 19:43:22 INFO - Cleaning up... 19:43:22 INFO - Return code: 0 19:43:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:22 INFO - Reading from file tmpfile_stdout 19:43:22 INFO - Current package versions: 19:43:22 INFO - argparse == 1.2.1 19:43:22 INFO - blessings == 1.6 19:43:22 INFO - blobuploader == 1.2.4 19:43:22 INFO - docopt == 0.6.1 19:43:22 INFO - functools32 == 3.2.3-2 19:43:22 INFO - jsonschema == 2.5.1 19:43:22 INFO - manifestparser == 1.1 19:43:22 INFO - mozInstall == 1.13 19:43:22 INFO - mozcrash == 1.0 19:43:22 INFO - mozdebug == 0.1 19:43:22 INFO - mozdevice == 0.51 19:43:22 INFO - mozfile == 1.2 19:43:22 INFO - mozhttpd == 0.7 19:43:22 INFO - mozinfo == 0.10 19:43:22 INFO - mozleak == 0.1 19:43:22 INFO - mozlog == 3.5 19:43:22 INFO - moznetwork == 0.27 19:43:22 INFO - mozprocess == 0.25 19:43:22 INFO - mozprofile == 0.28 19:43:22 INFO - mozrunner == 6.13 19:43:22 INFO - mozscreenshot == 0.1 19:43:22 INFO - mozsystemmonitor == 0.3 19:43:22 INFO - moztest == 0.8 19:43:22 INFO - mozversion == 1.4 19:43:22 INFO - psutil == 3.1.1 19:43:22 INFO - requests == 1.2.3 19:43:22 INFO - wsgiref == 0.1.2 19:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:43:22 INFO - Using env: {'DISPLAY': ':0', 19:43:22 INFO - 'HOME': '/home/cltbld', 19:43:22 INFO - 'LANG': 'en_US.UTF-8', 19:43:22 INFO - 'LANGUAGE': 'en_US:en', 19:43:22 INFO - 'LOGNAME': 'cltbld', 19:43:22 INFO - 'MAIL': '/var/mail/cltbld', 19:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:22 INFO - 'MOZ_NO_REMOTE': '1', 19:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:22 INFO - 'NO_EM_RESTART': '1', 19:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:22 INFO - 'PWD': '/builds/slave/test', 19:43:22 INFO - 'SHELL': '/bin/bash', 19:43:22 INFO - 'SHLVL': '1', 19:43:22 INFO - 'TERM': 'linux', 19:43:22 INFO - 'TMOUT': '86400', 19:43:22 INFO - 'USER': 'cltbld', 19:43:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:22 INFO - '_': '/tools/buildbot/bin/python'} 19:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:43:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:43:23 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:23 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:23 INFO - Installing collected packages: simplejson 19:43:23 INFO - Running setup.py install for simplejson 19:43:23 INFO - building 'simplejson._speedups' extension 19:43:23 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:24 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:24 INFO - Successfully installed simplejson 19:43:24 INFO - Cleaning up... 19:43:24 INFO - Return code: 0 19:43:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, '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': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', '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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:43:24 INFO - Using env: {'DISPLAY': ':0', 19:43:24 INFO - 'HOME': '/home/cltbld', 19:43:24 INFO - 'LANG': 'en_US.UTF-8', 19:43:24 INFO - 'LANGUAGE': 'en_US:en', 19:43:24 INFO - 'LOGNAME': 'cltbld', 19:43:24 INFO - 'MAIL': '/var/mail/cltbld', 19:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:24 INFO - 'MOZ_NO_REMOTE': '1', 19:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:24 INFO - 'NO_EM_RESTART': '1', 19:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:24 INFO - 'PWD': '/builds/slave/test', 19:43:24 INFO - 'SHELL': '/bin/bash', 19:43:24 INFO - 'SHLVL': '1', 19:43:24 INFO - 'TERM': 'linux', 19:43:24 INFO - 'TMOUT': '86400', 19:43:24 INFO - 'USER': 'cltbld', 19:43:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:24 INFO - '_': '/tools/buildbot/bin/python'} 19:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:43:25 INFO - Cleaning up... 19:43:25 INFO - Return code: 0 19:43:25 INFO - Running post-action listener: _resource_record_post_action 19:43:25 INFO - Running post-action listener: _start_resource_monitoring 19:43:25 INFO - Starting resource monitoring. 19:43:25 INFO - [mozharness: 2017-08-16 02:43:25.107255Z] Finished create-virtualenv step (success) 19:43:25 INFO - [mozharness: 2017-08-16 02:43:25.107763Z] Running install step. 19:43:25 INFO - Running pre-action listener: _resource_record_pre_action 19:43:25 INFO - Running main action method: install 19:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:25 INFO - Reading from file tmpfile_stdout 19:43:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:25 INFO - Reading from file tmpfile_stdout 19:43:25 INFO - Output received: 19:43:25 INFO - Usage: mozinstall [options] installer 19:43:25 INFO - Options: 19:43:25 INFO - -h, --help show this help message and exit 19:43:25 INFO - -d DEST, --destination=DEST 19:43:25 INFO - Directory to install application into. [default: 19:43:25 INFO - "/builds/slave/test"] 19:43:25 INFO - --app=APP Application being installed. [default: firefox] 19:43:25 INFO - mkdir: /builds/slave/test/build/application 19:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:43:43 INFO - Reading from file tmpfile_stdout 19:43:43 INFO - Output received: 19:43:43 INFO - /builds/slave/test/build/application/firefox/firefox 19:43:43 INFO - Running post-action listener: _resource_record_post_action 19:43:43 INFO - [mozharness: 2017-08-16 02:43:43.418860Z] Finished install step (success) 19:43:43 INFO - [mozharness: 2017-08-16 02:43:43.419142Z] Running setup-mitmproxy step. 19:43:43 INFO - Running pre-action listener: _resource_record_pre_action 19:43:43 INFO - Running main action method: setup_mitmproxy 19:43:43 INFO - Skipping: mitmproxy is not required 19:43:43 INFO - Running post-action listener: _resource_record_post_action 19:43:43 INFO - [mozharness: 2017-08-16 02:43:43.420295Z] Finished setup-mitmproxy step (success) 19:43:43 INFO - [mozharness: 2017-08-16 02:43:43.420516Z] Running run-tests step. 19:43:43 INFO - Running pre-action listener: _resource_record_pre_action 19:43:43 INFO - Running pre-action listener: _set_gcov_prefix 19:43:43 INFO - Running main action method: run_tests 19:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:43 INFO - Python 2.7.3 19:43:43 INFO - Return code: 0 19:43:43 INFO - grabbing minidump binary from tooltool 19:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:43 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 0x2b25bb0>, '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 0x2b26ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b26f40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:43 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:43 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:43 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:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:43 INFO - Return code: 0 19:43:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:43:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:43 INFO - ENV: RUST_BACKTRACE is now full 19:43:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:43:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:43 INFO - Using env: {'DISPLAY': ':0', 19:43:43 INFO - 'HOME': '/home/cltbld', 19:43:43 INFO - 'LANG': 'en_US.UTF-8', 19:43:43 INFO - 'LANGUAGE': 'en_US:en', 19:43:43 INFO - 'LOGNAME': 'cltbld', 19:43:43 INFO - 'MAIL': '/var/mail/cltbld', 19:43:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:43 INFO - 'MOZ_NO_REMOTE': '1', 19:43:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:43 INFO - 'NO_EM_RESTART': '1', 19:43:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:43 INFO - 'PWD': '/builds/slave/test', 19:43:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:43 INFO - 'RUST_BACKTRACE': 'full', 19:43:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:43:43 INFO - 'SHELL': '/bin/bash', 19:43:43 INFO - 'SHLVL': '1', 19:43:43 INFO - 'TERM': 'linux', 19:43:43 INFO - 'TMOUT': '86400', 19:43:43 INFO - 'USER': 'cltbld', 19:43:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502848456.909151-332348608', 19:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:43 INFO - '_': '/tools/buildbot/bin/python'} 19:43:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:43 INFO - mozversion application_buildid: 20170816015150 19:43:43 INFO - mozversion application_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:43 INFO - mozversion application_display_name: Nightly 19:43:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:43 INFO - mozversion application_name: Firefox 19:43:43 INFO - mozversion application_remotingname: firefox 19:43:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:43:43 INFO - mozversion application_vendor: Mozilla 19:43:43 INFO - mozversion application_version: 57.0a1 19:43:43 INFO - mozversion platform_buildid: 20170816015150 19:43:43 INFO - mozversion platform_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 19:43:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:43:43 INFO - mozversion platform_version: 57.0a1 19:43:43 INFO - using testdate: 1502851423 19:43:43 INFO - actual date: 1502851423 19:43:43 INFO - starting webserver on 'localhost:52968' 19:43:43 INFO - SUITE-START | Running 2 tests 19:43:43 INFO - TEST-START | dromaeo_css 19:43:43 INFO - Initialising browser for dromaeo_css test... 19:43:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52968/getInfo.html -profile /tmp/tmpienawy/profile 19:43:43 INFO - TEST-INFO | started process 21076 (/builds/slave/test/build/application/firefox/firefox http://localhost:52968/getInfo.html) 19:43:50 INFO - TEST-INFO | 21076: exit 0 19:43:50 INFO - Browser initialized. 19:43:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:50 INFO - TEST-INFO | started process 21288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpienawy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:51 INFO - PID 21288 | 19:43:51 INFO - PID 21288 | (/builds/slave/test/build/application/firefox/firefox:21336): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:43:51 INFO - PID 21288 | 19:44:01 INFO - PID 21288 | RSS: Main: 164872192 19:44:01 INFO - PID 21288 | 19:47:00 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52968/tests/dromaeo/cssquery-ext.html) 19:47:01 INFO - PID 21288 | RSS: Main: 169922560 19:47:01 INFO - PID 21288 | 19:50:03 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-ext.html (next: http://localhost:52968/tests/dromaeo/cssquery-jquery.html) 19:50:04 INFO - PID 21288 | RSS: Main: 169926656 19:50:04 INFO - PID 21288 | 19:53:05 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52968/tests/dromaeo/cssquery-mootools.html) 19:53:06 INFO - PID 21288 | RSS: Main: 171843584 19:53:06 INFO - PID 21288 | 19:56:08 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52968/tests/dromaeo/cssquery-prototype.html) 19:56:08 INFO - PID 21288 | RSS: Main: 170049536 19:56:08 INFO - PID 21288 | 19:59:12 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52968/tests/dromaeo/cssquery-yui.html) 19:59:13 INFO - PID 21288 | RSS: Main: 172957696 19:59:13 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | Cycle 1(1): loaded http://localhost:52968/tests/dromaeo/cssquery-yui.html (next: http://localhost:52968/tests/dromaeo/cssquery-dojo.html) 20:02:15 INFO - PID 21288 | RSS: Main: 174186496 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | __start_tp_report 20:02:15 INFO - PID 21288 | _x_x_mozilla_page_load 20:02:15 INFO - PID 21288 | _x_x_mozilla_page_load_details 20:02:15 INFO - PID 21288 | |i|pagename|runs| 20:02:15 INFO - PID 21288 | |0;dojo.html;3176.364727054588;3187.4900015997446;3202.4395730747115;3225.467797813361;3228.015455286138;6122.877542449149;6199.039148931923;6213.005919052953;6230.221222347207;6250.656213908233;6053.182820319255;6109.053096769997;6162.845928851781;6173.475254603364;6197.194364732579;5640.943590564083;5661.8584535386735;5663.716814159276;5673.177389278552;5775.047117225653;5732.2548068751;5753.597248192628;5778.682172480512;5787.797427090053;5851.736671849777;5565.638233514808;5647.689377084259;5714.057180565202;5808.303003639569;5812.738426770784;5612.214289999403;5631.155326700987;5676.290463692038;5734.225879506297;5772.6536407815665;5625.662460252398;5659.7453114609525;5712.514436272922;5733.569982251306;5744.856378590527;5941.643501389887;6042.214512113441;6105.084237364386;6119.632822030692;6190.41191086846;6592.274849766522;6606.405423511859;6647.76732814354;6726.3609957054005;6734.259231484532;6759.662016899136;6790.830229244309;6811.557248778813;6820.488463365267;6826.078479405316;6207.751689932397;6229.003359462465;6299.968500157515;6314.87370252597;6314.936850631527;6669.866602667919;6793.286704896013;6877.449804015667;6881.277465866012;6989.685464154125;6496.610203387811;6564;6629.86740265192;6632;6657.800265992028;6660.300668429842;6756.0879281297375;6759.121314229119;6759.898601520981;6766.188057433041;6640.701168447432;6647.401733843881;6732.629705366154;6736.360045795642;6740.83147921296;6529.934700653028;6641.070250164981;6670.132882725215;6672;6731.730730770812;5526.281583394213;5543.279373681396;5544.112941929272;5545.639533430314;5546.584006199551;4553.33976573395;4559.931601025987;4618.099470603267;4623.144718227139;4652.581267685857;5762.654240745569;5845.678487683133;5856.502197313191;5877.353491115974;5928.673922934194;6741.157355330583;6745.831354216086;6825.590464572141;6828.658567071627;6852;5713.171590119409;5786.94213057864;5825.184474173534;5908.20239267702;5911.467967882912;5931.288245410578;5995.760169593254;6000.729967151488;6001.879962400728;6006.429389208019;6557.245916719543;6565.934340656628;6589.044588534635;6600.702968366435;6653.866922661617;6728.529002969745;6729.427998619976;6733.66331683404;6806.965965170142;6831.385175334244;6421.614703117828;6547.476201903741;6554.213494380705;6643.269240383651;6652.567583107082;6636.070950067091;6646.268910419753;6647.700853461509;6660.666966651745;6662.267150613526;6697.631630260383;6701.430378417694;6749.763758268437;6793.320667933167;6800.047993281044;6480.060391243338;6489.675516224075;6553.574017688835;6577.276499585138;6584.407403333723;6312.116303717575;6408.807735767934;6455.3221911700475;6554.311797261219;6560.015997600398;6369.713362898588;6425.132607097982;6443.677816109082;6453.645049522322;6459.870802584016;6460.12788273577;6498.837529061811;6506.219253689587;6533.771318003847;6614.4708423325055;6255.718492667932;6314.210723659543;6344.682765861596;6364.045393190873;6398.456131228898 20:02:15 INFO - PID 21288 | |1;ext.html;803.5861531311372;838.8490071787076;860.2687715441874;887.2990337633267;888.484678886246;40510.59489405105;41835.163296734085;41876.79061604695;41938.161236775246;41991.58008419919;39084.80457597715;39389.212215755666;39415.80292098543;39527.80236098816;39528.80235598818;6860.142482189739;6973.372396484316;6975.0932378790685;6988.371046605805;6990.266022067686;6842.760503382383;6909.274526174755;6911.101556797635;6914.308569143096;6917.5127347620255;7509.173990861001;7679.347255483291;7684.769456916273;7685.50044247125;7685.730999415022;7575.772726818204;7607.467477276593;7616.314531692175;7634.923650763477;7639.197884222188;7344.596047217401;7471.252874712485;7541.472096953215;7547.50941188821;7557.357624601916;40318.79840600778;40588.39117413241;40637.39043914343;40639.18721625551;40687.186256275;3521.1373213562583;3568.0901370150705;3570.535830342039;3571.196480791827;3575.034740620044;31596.842015789774;31667.683323166704;31673;31684.207894802814;31688.04935851928;5035.420926593452;5048.0156369507595;5052.444231134572;5065.848024559269;5081.466446023152;189555;190465.9999999986;190809;191145;191269;50524.24213636798;50594.74702626463;50667;50683;50685.23972140421;51976;52176;52214;52217.47782522126;52255.73872130691;15406.768898466533;15647.295871685574;15725.370985160465;15779.68440631181;15832.28754706041;12669.176503527242;12769.808452873214;12778.808317875239;12789.808152877715;12833.614991550268;14599.124052556881;14793.778093328609;14915.925420373045;14996.400143994118;15118.244087795787;5815.505682016991;5937.792177273861;5941.732622032019;5950.137230101697;5990.9700451497465;993.2252842782641;995.6564985080136;1011.5346940407495;1013.9239557033252;1018.4754851251612;23116.19093331759;23310.76689233086;23408.882955585454;23453.41366465818;23787.048518059084;1073.8013467508536;1082.6860210539014;1086.869575650927;1089.8256278995323;1108.5510368300852;12515.812262816065;12594.43325050375;16375.42686005984;16535.83464165343;16642.417515386904;223785;226098;226160;227334;227431;48622.75688621605;49366;49592.504074959514;58113.41886581165;58752.70623646854;1340.7251513439721;1467.1710483576744;1470.3897882378908;1477.8448262932238;1492.9776053359208;27692.307692307855;28415;28679.426411471235;28705.856470717514;28889.277768055967;33174.502382464765;38066.048348791504;38165.4275185878;38190.045248869;38232.61767382402;184813;185451;185604.43186704422;185891;186208.06895965434;34961.47557786686;35042.29915401729;35241;35396.23018849099;35543.28913421769;42167.57832421637;43453.348199776396;43895;44171.11657766762;44276;32862.34275314528;33076.503852441754;33335.49996750099;33551.83224083864;33581.664183357854;31950.840245798623;32292;32316.19209519781;32793.67206327906;32937.01188964335;35399.82300088586;35519.46720799242;35713.46429803503;35717.82141089278;35764.284714305046;31177.220569485944;31338;31448.52827207548;31536.52695209528;31815.522767158047;23275.952582133505;23553.0578776847;24028.39929001719;24152.275431737075;24156.51686966286 20:02:15 INFO - PID 21288 | |2;jquery.html;554.4621716934574;562.4572287742328;571.6855729348858;574.9971250143751;582.5368831778735;22008.669869951962;22850.08599656012;22854.771452285473;22870.313890583308;22885.31344059681;24600.138995135174;25727.22818315449;26851.462970740624;26919.730802691967;26975.595366069476;6413.390727880867;6577.210734711842;6582.308857569958;6582.93417065828;6589.637569933676;6283.088952101943;6480.222373315209;6514.543981921267;6543.836404089912;6569.244536878248;6518.641474718888;6533;6535.575187612813;6536.967315163418;6539.182602174728;6551.77068802592;6551.836204094888;6568.343165683441;6569.08032875393;6579.046038324416;6045.697715114271;6067.484263837535;6072.666003369813;6086.117512960596;6087.817365479043;28832.567511487345;29630.40739185204;30095.548566771515;30238.54642180369;30338.089857304316;1927.759030121235;1955.6675365187953;1958.206926194879;1958.6768183249746;1960.3138901384543;19332.323368682028;20045.298414555422;20055.1977920883;20055.398338049883;20086;2346.2783171521123;2436.646686230504;2485.9875700621383;2487.4776296977657;2487.950240995188;129963;134604;135313;136014;136154;14470.20413877247;15177.392904283926;15205.467808626645;15242.799012207339;15268.31292591836;23127.76872231256;23170.304890853302;23247;23300.65049024266;23357.2992810216;10273.589056437659;10360.067593916583;10453.26827122094;10474.842877356845;10484.790304193873;7197.640117994079;9196.172344489029;9485.193758530602;9505.382150160218;9505.857412138823;8218.794530136794;9205.849268841395;9533.38033027865;9616.807663846685;9631.518424078768;2734.7265273472494;2754.4850332317146;2759.310172456886;2776.4447110577967;2865.212066681679;948.8244674735196;962.1581116523042;971.4171497101682;975.3903810118676;993.3692105513052;20017.899910500644;20076.39770806878;20179.956934237318;20455.181792728123;20760.79239207619;984.2372161574837;1032.5560009195967;1035.4201647077662;1037.336104892854;1040.6461802986869;11126;11594.47824847884;11647.068234541217;13981.930090349686;14884.851151488563;499969;503850;508921;511223;527931;126806;128288;131579;132414.33792831167;134207.32896335455;1210.449245593253;1253.129075292663;1279.0535004097087;1301.0437328563498;1302.8892544133855;20661.690074649192;21591.784082159607;21837.468877390183;21970.780292196872;21981.450463738536;61912;63321.683391582745;63823.6808815953;64236;64816.675916620115;75854;76868;77173.61413192897;77396;77874.2212577867;20917.686234706794;21446.142154313653;21519.784802152404;21531.354059378245;21595.676064858726;23815.880920595286;23865.284041478782;23910.402239943443;24134.75865241325;24302.149424770047;18584.907075464536;18925.621487570446;19014.334498292494;19071.427857164308;19082.61834763269;17143.971361718337;17180.742288865928;17192.656146876743;17594;17971.640567188322;19061.71407428862;19357.348789417436;19475.513112171742;19561.804381955997;19661.901690492028;21015.264465743625;21042.894785525976;21047.684284735435;21099.78900210978;21104.366868993955;18564.44306670802;18858.151383188066;18966.810331896504;18973;18996 20:02:15 INFO - PID 21288 | |3;mootools.html;1370.8423531293902;1420.7442660321144;1444.277861069465;1450.0719539494726;1457.1839769728958;14089.295535223237;14378.352974116164;14688.632784180387;14697.191654459;14698.33857476412;14932.029418087817;15140;15147.772783408258;15155.772663410058;15172.924135379335;2729.495043416964;2774.0290898185576;2775.2090654163567;2775.514285000127;2778.3193117686196;2681.209043332222;2692.31346006768;2731.8224315419434;2737.767289780371;2737.890484380622;2672.706002339741;2722.3738540135782;2769.418422131355;2782.3600571868483;2783.8747256373413;2556.5526032944254;2557.6802899637546;2570.768630823216;2576.0468626608085;2577.1108967406217;2562.8077894158014;2568.460623269116;2570.768630823216;2578.6647735794227;2580.148550978173;14111.435542578285;14374;14384.784228236585;14403;14410.85589144116;7383.33549980499;7626.885596716053;7630.4658673892845;7650.502717323412;7655.157932627407;4973.179425394806;5114.195927053154;5118.334616499868;5191.532762051395;5222.294990176316;1727.637196188802;1751.95620109497;1759.8504127149079;1791.1551102364585;1797.4068557376036;24092.397690057714;24282.514349713085;24284.87857560701;24303.756962430503;24329.878350608487;6139.570230083851;6332.303446620868;6543.607383557001;6570.342965703391;6570.802875913635;15690.76463853043;15692;15770.526884193263;15779.447719329768;15800.762988555181;7029.3673569379;7944.6027698614835;7945.682172713143;7958.562279074707;7965.641546130438;5860.560457965669;6106.664133472613;6316.147320111818;6336.20797400325;6914.965425172943;5007.123753343223;5037.370328708911;5146.125158723026;5167.974160129175;5174.43081261061;1469.5150600301874;1498.0786816108232;1514.8106486689164;1517.2944580769995;1527.5188315680748;901.4230892228978;923.5382308845577;925.0934084596998;935.6163972771132;936.2743873497957;7530.736424225126;7581.962090189514;7618.885716714254;7637.694492220249;7649.464537482434;709.2092317066433;727.2908913808994;731.8682637125369;736.4991805572263;747.114669117098;4658.697184682985;5666.631668941505;5826.126081087871;5834.27071616048;5945.970270148708;20379.694304585442;21127.683084753742;21269.36191914245;21294.25470108539;21297.467563311042;18212.908935455238;20332.288369906983;20729.170833166805;20748.170073196903;20796.480087997617;10056.396616203052;10252.794944101226;10271.537780799881;10315.123214526699;10362.430066346273;8133.371302388535;8396.244338009608;8520.446170998865;8576.614052367784;8790.956045219733;17321.393751218646;17832.19755111049;17991.640167196845;18170.545736356697;18229;17713.557161071076;18089;18141.81858181454;18231.361902333887;18315.54211144732;11756.529738810694;11940.641780746591;11997.580084696994;12012.279263244232;12015.819762703391;12899.871001289866;13167.802482962572;13340.466381344637;13341.066125371131;13617.659558511117;10846.511906964364;10847.945760271148;10923.563057477611;11054.834177487504;11187.944060279646;10430.947845260725;10529.42088185157;10645.574177032831;10788.838167427339;10803.621873234399;9035.412698174598;9195;9237.261019118589;9380.390274632127;9410.200132988773;7135.928640713734;7202.603856787927;7249.927500724925;7319.304666056716;7335.816604584928;7232.240614735377;7326.487145899736;7327.487075904849;7329.596872172082;7464.514806537558 20:02:15 INFO - PID 21288 | |4;prototype.html;499.7256994663608;502.29427654145894;523.6413057055917;525.8317338451697;531.9148936170211;6241.001439769638;6276.529260305484;6285.779997700081;6315.021171718386;6323.9051414228825;5958.165856780043;6084.2090528231265;6108.175396321495;6137.539684523656;6204.81385558434;4946.3817022872145;4949;4953.281774142747;4961.330220420233;5014.749262536868;4985.800567977277;4986.975065124688;4992.251162325662;4997.600191984632;5029.522195391451;5143.094151804218;5177.301064356301;5199.610029247821;5200.3759548854005;5226.817061402851;5158.458361871987;5167.379914410276;5181.689098654093;5183;5193.948060519384;4818.469968303484;4833.637477189225;4837.572915989756;4840.90182283339;4844.806207751721;6105.32841387447;6136.969315153396;6145.385461453819;6154.661493617849;6185.670080932576;5987.670678112702;6017.939820601781;6030.4572588467245;6043.365446628085;6076.756929722806;6631.403173714389;6648.036034774979;6653.634050127241;6655.600663960178;6667.533272670915;5302.1781623848365;5313.1764576490705;5353.277307563468;5356.68761153516;5366.973165134188;6936.4797640177185;6986.720531178747;6986.9650651746415;7014.19336776267;7041.366277035091;5400.189971504227;5441.2654291670115;5444.183372494078;5444.537214336747;5488.725563721798;5525.585581081435;5537.342075803636;5556.277683901067;5592.245046918614;5604.943950560524;6010.7295171716505;6028.186194863637;6071.271447426248;6080.635161890301;6105.023196288573;6507.154069970874;6621.834454138685;6626.271110177877;6685.498587605949;6689.364510371507;1790.8209179082248;1865.6455273498264;1877.8122187781387;1904.3715573860593;1930.2568511123318;1341.7920222365549;1406.7702691234304;1412.7880817877194;1430.1919415530192;1457.3077788050591;5718.342390625048;5733.799317023884;5750;5778.27771528559;5792.391798861143;6449.774257900951;6618.7021584028835;6629.86740265192;6706.295838936939;6795.728170873209;5758.62568933018;5787.826365209051;5791.420857914259;5798.681072540966;5824.271966004249;3523.612402635708;3547.5388199533895;3571.6428357164077;3600.42393217084;3620.420732682758;6696.363845434676;6708.161479815023;6716.261211266757;6719.563228390139;6752.257251702309;6910.827229319308;6928.896066559006;6981.162260528769;6995.300469952964;7016.7544135954995;6508.479321654351;6598;6651.767188148391;6668.533202675863;6694.732210711614;6760.391564759196;6769.356911093439;6790.42281406086;6812.455003599799;6820.283870193757;6727.0982829959485;6739.663016849236;6742.157230346207;6746.499410742598;6773.017912402773;6597.538172327891;6643.269240383651;6648.667566621552;6666.133402657623;6696.966515167393;5016.874578135576;5046.444891061907;5063.113955057776;5063.645544811975;5070.847874563769;6829.89755153683;6835;6846;6853.0405743195;6887.827804304932;6581.901271481028;6595.4393876521035;6605.339466053356;6614.867702646016;6651.102101216274;6539.738410463528;6543.509236807164;6568.343165683394;6587.80236592903;6608.966955165193;6213.409726076015;6334.303226644974;6334.968325158345;6488;6507.316731743099;6381.489480841428;6521.217453905372;6532.281449040697;6620.536562440583;6640.966795165993;6367.968160159169;6374.553781235269;6377.298497165215;6400.583962042452;6402.583832050902 20:02:15 INFO - PID 21288 | |5;yui.html;895.753667741371;904.9728508144756;923.8060007398446;930.1070971867007;933.1648174883479;18010.81989180108;18870.905645471772;18906.243750249992;18953.431397058077;19755.40733777989;20462.590748185026;21811.454713632167;22220.666689999623;22237.777622223774;22256.443588910286;1028.7222449938492;1061.0450594464967;1062.054771253585;1062.075993885321;1062.2086545523596;1054.1724746074333;1059.8039362717884;1059.89930956559;1065.605725881421;1067.8077945969721;1105.778844231153;1110.3448965110583;1110.4114819145866;1110.8333749937533;1111.4887151910132;1103.9006489415951;1105.8728246251703;1107.7618312062864;1108.501174471487;1110.0675432636624;808.3896658023154;809.6275713171948;813.6175997281268;814.1776805426503;815.1929589706208;19671;19864.30474933385;20076.39770806878;20216;20293.086811093537;20767.5846483071;21194.470138246514;21379;22150.22474213395;22396.888015559816;14723.558293251219;14969.326380312803;15024.248787560578;15172.317245723969;15250.771238431433;3598.9100272493133;3619.963800361989;3648.6533779290926;3651.379265524867;3652.3973544365413;124404.37797811044;125421;127369;128416;128529.35735321356;14511.564653060424;14921.925390372979;14966.17686027279;14982.62543436401;15044.699106017819;31077.223069423446;31419.842900785807;31420.214494637818;31463.37073258522;31663.20841978969;6871.5189936703955;7222.855542889113;8162.6734930602115;8264.256216940505;8358.582070896431;4023.376376661622;4125.66994640428;4150.066235097079;4163.500379954425;4166.895827604273;5061.190209566452;5154.768035438415;5166.43169251382;5228.477152284817;5251.133562962144;987.0770829274508;1000.6097621927308;1006.8590397344377;1009.8737657792776;1010.0354161775487;681.0907438569466;703.8873780195145;708.2810946888912;708.8972099045609;718.8813845715503;12154.270743755404;12372.381380930918;12709.300988445724;12810.167339123114;13441.932790335986;694.9200841903246;697.4978015828596;705.206642527157;706.8692291925908;707.8265824872939;5577.143998801243;5718.714064296769;5730.796532728091;5960.374160713062;5961.135635332939;104379;107436;110520;112036;115388.42305788417;92883.535582323;93168.53415732877;93822.5308873465;97789.51105244429;97954.51022744841;82156.58921705354;84957.72563411431;86929;87416.6887496688;88367;10626.681199564026;10706.73233169177;10807.729806754895;10874.510647020745;11042.785293617535;38758.224835502566;39948.201035978534;40454.595454045084;41329.58670413378;41543;69680.30319696738;70859.29140708527;72005;72251;73941;19298.22807087701;19468.513287167934;19481.123349449026;19553.511162221057;19679.21283148658;21077.78922210758;21335.25326613561;21643.567128657654;21726.45683857853;21924.342269731933;18674.159662815477;19203.90398048057;19407.708884367028;19440.2223911042;19593.8040619592;18787.96666183373;19470.12384442675;19841.80158198457;19865;20224.494387640425;17001;19059.90470047641;19143.23427062902;19756.703649444982;19853.205871764967;14442;14513.274336282933;14609.488667896572;14635.34140963638;14757.335919883846;14433.134011959317;14625.561233163022;14846.628834279229;15024.774628380801;15341.079535227922 20:02:15 INFO - PID 21288 | __end_tp_report 20:02:15 INFO - PID 21288 | __start_cc_report 20:02:15 INFO - PID 21288 | _x_x_mozilla_cycle_collect,370 20:02:15 INFO - PID 21288 | __end_cc_report 20:02:15 INFO - PID 21288 | __startTimestamp1502852535258__endTimestamp 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | ------- Summary: start ------- 20:02:15 INFO - PID 21288 | Number of tests: 6 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#0] dojo.html Cycles:165 Average:6171.55 Median:6408.81 stddev:725.88 (11.3%) stddev-sans-first:689.03 20:02:15 INFO - PID 21288 | Values: 3176.4 3187.5 3202.4 3225.5 3228.0 6122.9 6199.0 6213.0 6230.2 6250.7 6053.2 6109.1 6162.8 6173.5 6197.2 5640.9 5661.9 5663.7 5673.2 5775.0 5732.3 5753.6 5778.7 5787.8 5851.7 5565.6 5647.7 5714.1 5808.3 5812.7 5612.2 5631.2 5676.3 5734.2 5772.7 5625.7 5659.7 5712.5 5733.6 5744.9 5941.6 6042.2 6105.1 6119.6 6190.4 6592.3 6606.4 6647.8 6726.4 6734.3 6759.7 6790.8 6811.6 6820.5 6826.1 6207.8 6229.0 6300.0 6314.9 6314.9 6669.9 6793.3 6877.4 6881.3 6989.7 6496.6 6564.0 6629.9 6632.0 6657.8 6660.3 6756.1 6759.1 6759.9 6766.2 6640.7 6647.4 6732.6 6736.4 6740.8 6529.9 6641.1 6670.1 6672.0 6731.7 5526.3 5543.3 5544.1 5545.6 5546.6 4553.3 4559.9 4618.1 4623.1 4652.6 5762.7 5845.7 5856.5 5877.4 5928.7 6741.2 6745.8 6825.6 6828.7 6852.0 5713.2 5786.9 5825.2 5908.2 5911.5 5931.3 5995.8 6000.7 6001.9 6006.4 6557.2 6565.9 6589.0 6600.7 6653.9 6728.5 6729.4 6733.7 6807.0 6831.4 6421.6 6547.5 6554.2 6643.3 6652.6 6636.1 6646.3 6647.7 6660.7 6662.3 6697.6 6701.4 6749.8 6793.3 6800.0 6480.1 6489.7 6553.6 6577.3 6584.4 6312.1 6408.8 6455.3 6554.3 6560.0 6369.7 6425.1 6443.7 6453.6 6459.9 6460.1 6498.8 6506.2 6533.8 6614.5 6255.7 6314.2 6344.7 6364.0 6398.5 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#1] ext.html Cycles:180 Average:37492.10 Median:35531.38 stddev:52175.13 (146.8%) stddev-sans-first:52248.76 20:02:15 INFO - PID 21288 | Values: 803.6 838.8 860.3 887.3 888.5 40510.6 41835.2 41876.8 41938.2 41991.6 39084.8 39389.2 39415.8 39527.8 39528.8 6860.1 6973.4 6975.1 6988.4 6990.3 6842.8 6909.3 6911.1 6914.3 6917.5 7509.2 7679.3 7684.8 7685.5 7685.7 7575.8 7607.5 7616.3 7634.9 7639.2 7344.6 7471.3 7541.5 7547.5 7557.4 40318.8 40588.4 40637.4 40639.2 40687.2 3521.1 3568.1 3570.5 3571.2 3575.0 31596.8 31667.7 31673.0 31684.2 31688.0 5035.4 5048.0 5052.4 5065.8 5081.5 189555.0 190466.0 190809.0 191145.0 191269.0 50524.2 50594.7 50667.0 50683.0 50685.2 51976.0 52176.0 52214.0 52217.5 52255.7 15406.8 15647.3 15725.4 15779.7 15832.3 12669.2 12769.8 12778.8 12789.8 12833.6 14599.1 14793.8 14915.9 14996.4 15118.2 5815.5 5937.8 5941.7 5950.1 5991.0 993.2 995.7 1011.5 1013.9 1018.5 23116.2 23310.8 23408.9 23453.4 23787.0 1073.8 1082.7 1086.9 1089.8 1108.6 12515.8 12594.4 16375.4 16535.8 16642.4 223785.0 226098.0 226160.0 227334.0 227431.0 48622.8 49366.0 49592.5 58113.4 58752.7 1340.7 1467.2 1470.4 1477.8 1493.0 27692.3 28415.0 28679.4 28705.9 28889.3 33174.5 38066.0 38165.4 38190.0 38232.6 184813.0 185451.0 185604.4 185891.0 186208.1 34961.5 35042.3 35241.0 35396.2 35543.3 42167.6 43453.3 43895.0 44171.1 44276.0 32862.3 33076.5 33335.5 33551.8 33581.7 31950.8 32292.0 32316.2 32793.7 32937.0 35399.8 35519.5 35713.5 35717.8 35764.3 31177.2 31338.0 31448.5 31536.5 31815.5 23276.0 23553.1 24028.4 24152.3 24156.5 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#2] jquery.html Cycles:180 Average:36682.67 Median:23208.65 stddev:86027.63 (370.7%) stddev-sans-first:86226.20 20:02:15 INFO - PID 21288 | Values: 554.5 562.5 571.7 575.0 582.5 22008.7 22850.1 22854.8 22870.3 22885.3 24600.1 25727.2 26851.5 26919.7 26975.6 6413.4 6577.2 6582.3 6582.9 6589.6 6283.1 6480.2 6514.5 6543.8 6569.2 6518.6 6533.0 6535.6 6537.0 6539.2 6551.8 6551.8 6568.3 6569.1 6579.0 6045.7 6067.5 6072.7 6086.1 6087.8 28832.6 29630.4 30095.5 30238.5 30338.1 1927.8 1955.7 1958.2 1958.7 1960.3 19332.3 20045.3 20055.2 20055.4 20086.0 2346.3 2436.6 2486.0 2487.5 2488.0 129963.0 134604.0 135313.0 136014.0 136154.0 14470.2 15177.4 15205.5 15242.8 15268.3 23127.8 23170.3 23247.0 23300.7 23357.3 10273.6 10360.1 10453.3 10474.8 10484.8 7197.6 9196.2 9485.2 9505.4 9505.9 8218.8 9205.8 9533.4 9616.8 9631.5 2734.7 2754.5 2759.3 2776.4 2865.2 948.8 962.2 971.4 975.4 993.4 20017.9 20076.4 20180.0 20455.2 20760.8 984.2 1032.6 1035.4 1037.3 1040.6 11126.0 11594.5 11647.1 13981.9 14884.9 499969.0 503850.0 508921.0 511223.0 527931.0 126806.0 128288.0 131579.0 132414.3 134207.3 1210.4 1253.1 1279.1 1301.0 1302.9 20661.7 21591.8 21837.5 21970.8 21981.5 61912.0 63321.7 63823.7 64236.0 64816.7 75854.0 76868.0 77173.6 77396.0 77874.2 20917.7 21446.1 21519.8 21531.4 21595.7 23815.9 23865.3 23910.4 24134.8 24302.1 18584.9 18925.6 19014.3 19071.4 19082.6 17144.0 17180.7 17192.7 17594.0 17971.6 19061.7 19357.3 19475.5 19561.8 19661.9 21015.3 21042.9 21047.7 21099.8 21104.4 18564.4 18858.2 18966.8 18973.0 18996.0 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#3] mootools.html Cycles:180 Average:8940.23 Median:2573.41 stddev:6277.97 (244.0%) stddev-sans-first:6269.82 20:02:15 INFO - PID 21288 | Values: 1370.8 1420.7 1444.3 1450.1 1457.2 14089.3 14378.4 14688.6 14697.2 14698.3 14932.0 15140.0 15147.8 15155.8 15172.9 2729.5 2774.0 2775.2 2775.5 2778.3 2681.2 2692.3 2731.8 2737.8 2737.9 2672.7 2722.4 2769.4 2782.4 2783.9 2556.6 2557.7 2570.8 2576.0 2577.1 2562.8 2568.5 2570.8 2578.7 2580.1 14111.4 14374.0 14384.8 14403.0 14410.9 7383.3 7626.9 7630.5 7650.5 7655.2 4973.2 5114.2 5118.3 5191.5 5222.3 1727.6 1752.0 1759.9 1791.2 1797.4 24092.4 24282.5 24284.9 24303.8 24329.9 6139.6 6332.3 6543.6 6570.3 6570.8 15690.8 15692.0 15770.5 15779.4 15800.8 7029.4 7944.6 7945.7 7958.6 7965.6 5860.6 6106.7 6316.1 6336.2 6915.0 5007.1 5037.4 5146.1 5168.0 5174.4 1469.5 1498.1 1514.8 1517.3 1527.5 901.4 923.5 925.1 935.6 936.3 7530.7 7582.0 7618.9 7637.7 7649.5 709.2 727.3 731.9 736.5 747.1 4658.7 5666.6 5826.1 5834.3 5946.0 20379.7 21127.7 21269.4 21294.3 21297.5 18212.9 20332.3 20729.2 20748.2 20796.5 10056.4 10252.8 10271.5 10315.1 10362.4 8133.4 8396.2 8520.4 8576.6 8791.0 17321.4 17832.2 17991.6 18170.5 18229.0 17713.6 18089.0 18141.8 18231.4 18315.5 11756.5 11940.6 11997.6 12012.3 12015.8 12899.9 13167.8 13340.5 13341.1 13617.7 10846.5 10847.9 10923.6 11054.8 11187.9 10430.9 10529.4 10645.6 10788.8 10803.6 9035.4 9195.0 9237.3 9380.4 9410.2 7135.9 7202.6 7249.9 7319.3 7335.8 7232.2 7326.5 7327.5 7329.6 7464.5 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#4] prototype.html Cycles:180 Average:5634.48 Median:6141.46 stddev:1529.91 (24.9%) stddev-sans-first:1484.87 20:02:15 INFO - PID 21288 | Values: 499.7 502.3 523.6 525.8 531.9 6241.0 6276.5 6285.8 6315.0 6323.9 5958.2 6084.2 6108.2 6137.5 6204.8 4946.4 4949.0 4953.3 4961.3 5014.7 4985.8 4987.0 4992.3 4997.6 5029.5 5143.1 5177.3 5199.6 5200.4 5226.8 5158.5 5167.4 5181.7 5183.0 5193.9 4818.5 4833.6 4837.6 4840.9 4844.8 6105.3 6137.0 6145.4 6154.7 6185.7 5987.7 6017.9 6030.5 6043.4 6076.8 6631.4 6648.0 6653.6 6655.6 6667.5 5302.2 5313.2 5353.3 5356.7 5367.0 6936.5 6986.7 6987.0 7014.2 7041.4 5400.2 5441.3 5444.2 5444.5 5488.7 5525.6 5537.3 5556.3 5592.2 5604.9 6010.7 6028.2 6071.3 6080.6 6105.0 6507.2 6621.8 6626.3 6685.5 6689.4 1790.8 1865.6 1877.8 1904.4 1930.3 1341.8 1406.8 1412.8 1430.2 1457.3 5718.3 5733.8 5750.0 5778.3 5792.4 6449.8 6618.7 6629.9 6706.3 6795.7 5758.6 5787.8 5791.4 5798.7 5824.3 3523.6 3547.5 3571.6 3600.4 3620.4 6696.4 6708.2 6716.3 6719.6 6752.3 6910.8 6928.9 6981.2 6995.3 7016.8 6508.5 6598.0 6651.8 6668.5 6694.7 6760.4 6769.4 6790.4 6812.5 6820.3 6727.1 6739.7 6742.2 6746.5 6773.0 6597.5 6643.3 6648.7 6666.1 6697.0 5016.9 5046.4 5063.1 5063.6 5070.8 6829.9 6835.0 6846.0 6853.0 6887.8 6581.9 6595.4 6605.3 6614.9 6651.1 6539.7 6543.5 6568.3 6587.8 6609.0 6213.4 6334.3 6335.0 6488.0 6507.3 6381.5 6521.2 6532.3 6620.5 6641.0 6368.0 6374.6 6377.3 6400.6 6402.6 20:02:15 INFO - PID 21288 | 20:02:15 INFO - PID 21288 | [#5] yui.html Cycles:180 Average:23902.02 Median:20146.20 stddev:32072.03 (159.2%) stddev-sans-first:32115.48 20:02:15 INFO - PID 21288 | Values: 895.8 905.0 923.8 930.1 933.2 18010.8 18870.9 18906.2 18953.4 19755.4 20462.6 21811.5 22220.7 22237.8 22256.4 1028.7 1061.0 1062.1 1062.1 1062.2 1054.2 1059.8 1059.9 1065.6 1067.8 1105.8 1110.3 1110.4 1110.8 1111.5 1103.9 1105.9 1107.8 1108.5 1110.1 808.4 809.6 813.6 814.2 815.2 19671.0 19864.3 20076.4 20216.0 20293.1 20767.6 21194.5 21379.0 22150.2 22396.9 14723.6 14969.3 15024.2 15172.3 15250.8 3598.9 3620.0 3648.7 3651.4 3652.4 124404.4 125421.0 127369.0 128416.0 128529.4 14511.6 14921.9 14966.2 14982.6 15044.7 31077.2 31419.8 31420.2 31463.4 31663.2 6871.5 7222.9 8162.7 8264.3 8358.6 4023.4 4125.7 4150.1 4163.5 4166.9 5061.2 5154.8 5166.4 5228.5 5251.1 987.1 1000.6 1006.9 1009.9 1010.0 681.1 703.9 708.3 708.9 718.9 12154.3 12372.4 12709.3 12810.2 13441.9 694.9 697.5 705.2 706.9 707.8 5577.1 5718.7 5730.8 5960.4 5961.1 104379.0 107436.0 110520.0 112036.0 115388.4 92883.5 93168.5 93822.5 97789.5 97954.5 82156.6 84957.7 86929.0 87416.7 88367.0 10626.7 10706.7 10807.7 10874.5 11042.8 38758.2 39948.2 40454.6 41329.6 41543.0 69680.3 70859.3 72005.0 72251.0 73941.0 19298.2 19468.5 19481.1 19553.5 19679.2 21077.8 21335.3 21643.6 21726.5 21924.3 18674.2 19203.9 19407.7 19440.2 19593.8 18788.0 19470.1 19841.8 19865.0 20224.5 17001.0 19059.9 19143.2 19756.7 19853.2 14442.0 14513.3 14609.5 14635.3 14757.3 14433.1 14625.6 14846.6 15024.8 15341.1 20:02:15 INFO - PID 21288 | -------- Summary: end -------- 20:02:15 INFO - PID 21288 | 20:02:16 INFO - TEST-INFO | 21288: exit 0 20:02:16 INFO - TEST-OK | dromaeo_css | took 1112236ms 20:02:16 INFO - TEST-START | kraken 20:02:16 INFO - Initialising browser for kraken test... 20:02:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52968/getInfo.html -profile /tmp/tmpY_kJ3Y/profile 20:02:16 INFO - TEST-INFO | started process 21651 (/builds/slave/test/build/application/firefox/firefox http://localhost:52968/getInfo.html) 20:02:22 INFO - TEST-INFO | 21651: exit 0 20:02:22 INFO - Browser initialized. 20:02:22 INFO - Running cycle 1/1 for kraken test... 20:02:22 INFO - TEST-INFO | started process 21859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY_kJ3Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:23 INFO - PID 21859 | 20:02:23 INFO - PID 21859 | (/builds/slave/test/build/application/firefox/firefox:21907): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:02:23 INFO - PID 21859 | 20:02:33 INFO - PID 21859 | RSS: Main: 165060608 20:02:33 INFO - PID 21859 | 20:02:36 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52968/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:37 INFO - PID 21859 | RSS: Main: 172474368 20:02:37 INFO - PID 21859 | 20:02:39 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52968/tests/kraken/driver.html?testName=audio-dft) 20:02:40 INFO - PID 21859 | RSS: Main: 172433408 20:02:40 INFO - PID 21859 | 20:02:43 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52968/tests/kraken/driver.html?testName=audio-fft) 20:02:43 INFO - PID 21859 | RSS: Main: 166453248 20:02:43 INFO - PID 21859 | 20:02:46 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52968/tests/kraken/driver.html?testName=audio-oscillator) 20:02:46 INFO - PID 21859 | RSS: Main: 167006208 20:02:46 INFO - PID 21859 | 20:02:48 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:49 INFO - PID 21859 | RSS: Main: 167260160 20:02:49 INFO - PID 21859 | 20:02:52 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52968/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:53 INFO - PID 21859 | RSS: Main: 169455616 20:02:53 INFO - PID 21859 | 20:02:56 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52968/tests/kraken/driver.html?testName=imaging-desaturate) 20:02:57 INFO - PID 21859 | RSS: Main: 170315776 20:02:57 INFO - PID 21859 | 20:03:00 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52968/tests/kraken/driver.html?testName=json-parse-financial) 20:03:00 INFO - PID 21859 | RSS: Main: 170913792 20:03:00 INFO - PID 21859 | 20:03:02 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:02 INFO - PID 21859 | RSS: Main: 171233280 20:03:02 INFO - PID 21859 | 20:03:04 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:05 INFO - PID 21859 | RSS: Main: 171511808 20:03:05 INFO - PID 21859 | 20:03:07 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:08 INFO - PID 21859 | RSS: Main: 171536384 20:03:08 INFO - PID 21859 | 20:03:10 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:11 INFO - PID 21859 | RSS: Main: 171786240 20:03:11 INFO - PID 21859 | 20:03:14 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:15 INFO - PID 21859 | RSS: Main: 172478464 20:03:15 INFO - PID 21859 | 20:03:16 INFO - PID 21859 | Cycle 1(1): loaded http://localhost:52968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52968/tests/kraken/driver.html?testName=ai-astar) 20:03:17 INFO - PID 21859 | RSS: Main: 173309952 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | __start_tp_report 20:03:17 INFO - PID 21859 | _x_x_mozilla_page_load 20:03:17 INFO - PID 21859 | _x_x_mozilla_page_load_details 20:03:17 INFO - PID 21859 | |i|pagename|runs| 20:03:17 INFO - PID 21859 | |0;ai-astar;100;107;101;107;108;108;108;98;106;109 20:03:17 INFO - PID 21859 | |1;audio-beat-detection;147;119;154;177;117;150;143;118;170;118 20:03:17 INFO - PID 21859 | |2;audio-dft;164;164;165;162;164;163;164;169;162;163 20:03:17 INFO - PID 21859 | |3;audio-fft;76;76;76;171;77;75;76;87;98;74 20:03:17 INFO - PID 21859 | |4;audio-oscillator;79;89;135;79;78;79;121;80;78;130 20:03:17 INFO - PID 21859 | |5;imaging-gaussian-blur;114;115;115;118;117;114;114;114;114;114 20:03:17 INFO - PID 21859 | |6;imaging-darkroom;151;150;151;150;151;150;151;151;152;150 20:03:17 INFO - PID 21859 | |7;imaging-desaturate;94;93;95;94;94;93;94;94;94;94 20:03:17 INFO - PID 21859 | |8;json-parse-financial;55;53;53;54;53;53;54;54;53;53 20:03:17 INFO - PID 21859 | |9;json-stringify-tinderbox;55;56;56;56;55;55;56;56;57;56 20:03:17 INFO - PID 21859 | |10;stanford-crypto-aes;79;78;76;78;78;78;79;79;79;77 20:03:17 INFO - PID 21859 | |11;stanford-crypto-ccm;137;136;126;127;129;121;126;131;124;159 20:03:17 INFO - PID 21859 | |12;stanford-crypto-pbkdf2;177;174;179;182;184;175;179;176;183;178 20:03:17 INFO - PID 21859 | |13;stanford-crypto-sha256-iterative;67;70;68;68;67;69;67;68;69;69 20:03:17 INFO - PID 21859 | __end_tp_report 20:03:17 INFO - PID 21859 | __start_cc_report 20:03:17 INFO - PID 21859 | _x_x_mozilla_cycle_collect,953 20:03:17 INFO - PID 21859 | __end_cc_report 20:03:17 INFO - PID 21859 | __startTimestamp1502852597165__endTimestamp 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | ------- Summary: start ------- 20:03:17 INFO - PID 21859 | Number of tests: 14 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.00 stddev:3.97 (3.7%) stddev-sans-first:3.73 20:03:17 INFO - PID 21859 | Values: 100.0 107.0 101.0 107.0 108.0 108.0 108.0 98.0 106.0 109.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.50 stddev:22.47 (15.1%) stddev-sans-first:23.74 20:03:17 INFO - PID 21859 | Values: 147.0 119.0 154.0 177.0 117.0 150.0 143.0 118.0 170.0 118.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 20:03:17 INFO - PID 21859 | Values: 164.0 164.0 165.0 162.0 164.0 163.0 164.0 169.0 162.0 163.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#3] audio-fft Cycles:10 Average:88.60 Median:76.00 stddev:29.90 (39.3%) stddev-sans-first:31.37 20:03:17 INFO - PID 21859 | Values: 76.0 76.0 76.0 171.0 77.0 75.0 76.0 87.0 98.0 74.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:23.82 (30.2%) stddev-sans-first:24.57 20:03:17 INFO - PID 21859 | Values: 79.0 89.0 135.0 79.0 78.0 79.0 121.0 80.0 78.0 130.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.45 (1.3%) stddev-sans-first:1.50 20:03:17 INFO - PID 21859 | Values: 114.0 115.0 115.0 118.0 117.0 114.0 114.0 114.0 114.0 114.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 20:03:17 INFO - PID 21859 | Values: 151.0 150.0 151.0 150.0 151.0 150.0 151.0 151.0 152.0 150.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:03:17 INFO - PID 21859 | Values: 94.0 93.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.50 20:03:17 INFO - PID 21859 | Values: 55.0 53.0 53.0 54.0 53.0 53.0 54.0 54.0 53.0 53.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 20:03:17 INFO - PID 21859 | Values: 55.0 56.0 56.0 56.0 55.0 55.0 56.0 56.0 57.0 56.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:0.99 (1.3%) stddev-sans-first:1.00 20:03:17 INFO - PID 21859 | Values: 79.0 78.0 76.0 78.0 78.0 78.0 79.0 79.0 79.0 77.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.00 stddev:10.85 (8.3%) stddev-sans-first:11.34 20:03:17 INFO - PID 21859 | Values: 137.0 136.0 126.0 127.0 129.0 121.0 126.0 131.0 124.0 159.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.00 stddev:3.40 (1.9%) stddev-sans-first:3.55 20:03:17 INFO - PID 21859 | Values: 177.0 174.0 179.0 182.0 184.0 175.0 179.0 176.0 183.0 178.0 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 20:03:17 INFO - PID 21859 | Values: 67.0 70.0 68.0 68.0 67.0 69.0 67.0 68.0 69.0 69.0 20:03:17 INFO - PID 21859 | -------- Summary: end -------- 20:03:17 INFO - PID 21859 | 20:03:17 INFO - PID 21859 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:03:17 INFO - TEST-INFO | 21859: exit 0 20:03:17 INFO - TEST-OK | kraken | took 61861ms 20:03:17 INFO - SUITE-END | took 1174s 20:03:18 INFO - Completed test suite (00:19:34) 20:03:18 INFO - javascript benchmark 20:03:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8621.142577134266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.364727054588, 3187.4900015997446, 3202.4395730747115, 3225.467797813361, 3228.015455286138, 6122.877542449149, 6199.039148931923, 6213.005919052953, 6230.221222347207, 6250.656213908233, 6053.182820319255, 6109.053096769997, 6162.845928851781, 6173.475254603364, 6197.194364732579, 5640.943590564083, 5661.8584535386735, 5663.716814159276, 5673.177389278552, 5775.047117225653, 5732.2548068751, 5753.597248192628, 5778.682172480512, 5787.797427090053, 5851.736671849777, 5565.638233514808, 5647.689377084259, 5714.057180565202, 5808.303003639569, 5812.738426770784, 5612.214289999403, 5631.155326700987, 5676.290463692038, 5734.225879506297, 5772.6536407815665, 5625.662460252398, 5659.7453114609525, 5712.514436272922, 5733.569982251306, 5744.856378590527, 5941.643501389887, 6042.214512113441, 6105.084237364386, 6119.632822030692, 6190.41191086846, 6592.274849766522, 6606.405423511859, 6647.76732814354, 6726.3609957054005, 6734.259231484532, 6759.662016899136, 6790.830229244309, 6811.557248778813, 6820.488463365267, 6826.078479405316, 6207.751689932397, 6229.003359462465, 6299.968500157515, 6314.87370252597, 6314.936850631527, 6669.866602667919, 6793.286704896013, 6877.449804015667, 6881.277465866012, 6989.685464154125, 6496.610203387811, 6564.0, 6629.86740265192, 6632.0, 6657.800265992028, 6660.300668429842, 6756.0879281297375, 6759.121314229119, 6759.898601520981, 6766.188057433041, 6640.701168447432, 6647.401733843881, 6732.629705366154, 6736.360045795642, 6740.83147921296, 6529.934700653028, 6641.070250164981, 6670.132882725215, 6672.0, 6731.730730770812, 5526.281583394213, 5543.279373681396, 5544.112941929272, 5545.639533430314, 5546.584006199551, 4553.33976573395, 4559.931601025987, 4618.099470603267, 4623.144718227139, 4652.581267685857, 5762.654240745569, 5845.678487683133, 5856.502197313191, 5877.353491115974, 5928.673922934194, 6741.157355330583, 6745.831354216086, 6825.590464572141, 6828.658567071627, 6852.0, 5713.171590119409, 5786.94213057864, 5825.184474173534, 5908.20239267702, 5911.467967882912, 5931.288245410578, 5995.760169593254, 6000.729967151488, 6001.879962400728, 6006.429389208019, 6557.245916719543, 6565.934340656628, 6589.044588534635, 6600.702968366435, 6653.866922661617, 6728.529002969745, 6729.427998619976, 6733.66331683404, 6806.965965170142, 6831.385175334244, 6421.614703117828, 6547.476201903741, 6554.213494380705, 6643.269240383651, 6652.567583107082, 6636.070950067091, 6646.268910419753, 6647.700853461509, 6660.666966651745, 6662.267150613526, 6697.631630260383, 6701.430378417694, 6749.763758268437, 6793.320667933167, 6800.047993281044, 6480.060391243338, 6489.675516224075, 6553.574017688835, 6577.276499585138, 6584.407403333723, 6312.116303717575, 6408.807735767934, 6455.3221911700475, 6554.311797261219, 6560.015997600398, 6369.713362898588, 6425.132607097982, 6443.677816109082, 6453.645049522322, 6459.870802584016, 6460.12788273577, 6498.837529061811, 6506.219253689587, 6533.771318003847, 6614.4708423325055, 6255.718492667932, 6314.210723659543, 6344.682765861596, 6364.045393190873, 6398.456131228898], "value": 6117.6123340635795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.5861531311372, 838.8490071787076, 860.2687715441874, 887.2990337633267, 888.484678886246, 40510.59489405105, 41835.163296734085, 41876.79061604695, 41938.161236775246, 41991.58008419919, 39084.80457597715, 39389.212215755666, 39415.80292098543, 39527.80236098816, 39528.80235598818, 6860.142482189739, 6973.372396484316, 6975.0932378790685, 6988.371046605805, 6990.266022067686, 6842.760503382383, 6909.274526174755, 6911.101556797635, 6914.308569143096, 6917.5127347620255, 7509.173990861001, 7679.347255483291, 7684.769456916273, 7685.50044247125, 7685.730999415022, 7575.772726818204, 7607.467477276593, 7616.314531692175, 7634.923650763477, 7639.197884222188, 7344.596047217401, 7471.252874712485, 7541.472096953215, 7547.50941188821, 7557.357624601916, 40318.79840600778, 40588.39117413241, 40637.39043914343, 40639.18721625551, 40687.186256275, 3521.1373213562583, 3568.0901370150705, 3570.535830342039, 3571.196480791827, 3575.034740620044, 31596.842015789774, 31667.683323166704, 31673.0, 31684.207894802814, 31688.04935851928, 5035.420926593452, 5048.0156369507595, 5052.444231134572, 5065.848024559269, 5081.466446023152, 189555.0, 190465.9999999986, 190809.0, 191145.0, 191269.0, 50524.24213636798, 50594.74702626463, 50667.0, 50683.0, 50685.23972140421, 51976.0, 52176.0, 52214.0, 52217.47782522126, 52255.73872130691, 15406.768898466533, 15647.295871685574, 15725.370985160465, 15779.68440631181, 15832.28754706041, 12669.176503527242, 12769.808452873214, 12778.808317875239, 12789.808152877715, 12833.614991550268, 14599.124052556881, 14793.778093328609, 14915.925420373045, 14996.400143994118, 15118.244087795787, 5815.505682016991, 5937.792177273861, 5941.732622032019, 5950.137230101697, 5990.9700451497465, 993.2252842782641, 995.6564985080136, 1011.5346940407495, 1013.9239557033252, 1018.4754851251612, 23116.19093331759, 23310.76689233086, 23408.882955585454, 23453.41366465818, 23787.048518059084, 1073.8013467508536, 1082.6860210539014, 1086.869575650927, 1089.8256278995323, 1108.5510368300852, 12515.812262816065, 12594.43325050375, 16375.42686005984, 16535.83464165343, 16642.417515386904, 223785.0, 226098.0, 226160.0, 227334.0, 227431.0, 48622.75688621605, 49366.0, 49592.504074959514, 58113.41886581165, 58752.70623646854, 1340.7251513439721, 1467.1710483576744, 1470.3897882378908, 1477.8448262932238, 1492.9776053359208, 27692.307692307855, 28415.0, 28679.426411471235, 28705.856470717514, 28889.277768055967, 33174.502382464765, 38066.048348791504, 38165.4275185878, 38190.045248869, 38232.61767382402, 184813.0, 185451.0, 185604.43186704422, 185891.0, 186208.06895965434, 34961.47557786686, 35042.29915401729, 35241.0, 35396.23018849099, 35543.28913421769, 42167.57832421637, 43453.348199776396, 43895.0, 44171.11657766762, 44276.0, 32862.34275314528, 33076.503852441754, 33335.49996750099, 33551.83224083864, 33581.664183357854, 31950.840245798623, 32292.0, 32316.19209519781, 32793.67206327906, 32937.01188964335, 35399.82300088586, 35519.46720799242, 35713.46429803503, 35717.82141089278, 35764.284714305046, 31177.220569485944, 31338.0, 31448.52827207548, 31536.52695209528, 31815.522767158047, 23275.952582133505, 23553.0578776847, 24028.39929001719, 24152.275431737075, 24156.51686966286], "value": 17273.15332626641, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4621716934574, 562.4572287742328, 571.6855729348858, 574.9971250143751, 582.5368831778735, 22008.669869951962, 22850.08599656012, 22854.771452285473, 22870.313890583308, 22885.31344059681, 24600.138995135174, 25727.22818315449, 26851.462970740624, 26919.730802691967, 26975.595366069476, 6413.390727880867, 6577.210734711842, 6582.308857569958, 6582.93417065828, 6589.637569933676, 6283.088952101943, 6480.222373315209, 6514.543981921267, 6543.836404089912, 6569.244536878248, 6518.641474718888, 6533.0, 6535.575187612813, 6536.967315163418, 6539.182602174728, 6551.77068802592, 6551.836204094888, 6568.343165683441, 6569.08032875393, 6579.046038324416, 6045.697715114271, 6067.484263837535, 6072.666003369813, 6086.117512960596, 6087.817365479043, 28832.567511487345, 29630.40739185204, 30095.548566771515, 30238.54642180369, 30338.089857304316, 1927.759030121235, 1955.6675365187953, 1958.206926194879, 1958.6768183249746, 1960.3138901384543, 19332.323368682028, 20045.298414555422, 20055.1977920883, 20055.398338049883, 20086.0, 2346.2783171521123, 2436.646686230504, 2485.9875700621383, 2487.4776296977657, 2487.950240995188, 129963.0, 134604.0, 135313.0, 136014.0, 136154.0, 14470.20413877247, 15177.392904283926, 15205.467808626645, 15242.799012207339, 15268.31292591836, 23127.76872231256, 23170.304890853302, 23247.0, 23300.65049024266, 23357.2992810216, 10273.589056437659, 10360.067593916583, 10453.26827122094, 10474.842877356845, 10484.790304193873, 7197.640117994079, 9196.172344489029, 9485.193758530602, 9505.382150160218, 9505.857412138823, 8218.794530136794, 9205.849268841395, 9533.38033027865, 9616.807663846685, 9631.518424078768, 2734.7265273472494, 2754.4850332317146, 2759.310172456886, 2776.4447110577967, 2865.212066681679, 948.8244674735196, 962.1581116523042, 971.4171497101682, 975.3903810118676, 993.3692105513052, 20017.899910500644, 20076.39770806878, 20179.956934237318, 20455.181792728123, 20760.79239207619, 984.2372161574837, 1032.5560009195967, 1035.4201647077662, 1037.336104892854, 1040.6461802986869, 11126.0, 11594.47824847884, 11647.068234541217, 13981.930090349686, 14884.851151488563, 499969.0, 503850.0, 508921.0, 511223.0, 527931.0, 126806.0, 128288.0, 131579.0, 132414.33792831167, 134207.32896335455, 1210.449245593253, 1253.129075292663, 1279.0535004097087, 1301.0437328563498, 1302.8892544133855, 20661.690074649192, 21591.784082159607, 21837.468877390183, 21970.780292196872, 21981.450463738536, 61912.0, 63321.683391582745, 63823.6808815953, 64236.0, 64816.675916620115, 75854.0, 76868.0, 77173.61413192897, 77396.0, 77874.2212577867, 20917.686234706794, 21446.142154313653, 21519.784802152404, 21531.354059378245, 21595.676064858726, 23815.880920595286, 23865.284041478782, 23910.402239943443, 24134.75865241325, 24302.149424770047, 18584.907075464536, 18925.621487570446, 19014.334498292494, 19071.427857164308, 19082.61834763269, 17143.971361718337, 17180.742288865928, 17192.656146876743, 17594.0, 17971.640567188322, 19061.71407428862, 19357.348789417436, 19475.513112171742, 19561.804381955997, 19661.901690492028, 21015.264465743625, 21042.894785525976, 21047.684284735435, 21099.78900210978, 21104.366868993955, 18564.44306670802, 18858.151383188066, 18966.810331896504, 18973.0, 18996.0], "value": 12555.438108272829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.8423531293902, 1420.7442660321144, 1444.277861069465, 1450.0719539494726, 1457.1839769728958, 14089.295535223237, 14378.352974116164, 14688.632784180387, 14697.191654459, 14698.33857476412, 14932.029418087817, 15140.0, 15147.772783408258, 15155.772663410058, 15172.924135379335, 2729.495043416964, 2774.0290898185576, 2775.2090654163567, 2775.514285000127, 2778.3193117686196, 2681.209043332222, 2692.31346006768, 2731.8224315419434, 2737.767289780371, 2737.890484380622, 2672.706002339741, 2722.3738540135782, 2769.418422131355, 2782.3600571868483, 2783.8747256373413, 2556.5526032944254, 2557.6802899637546, 2570.768630823216, 2576.0468626608085, 2577.1108967406217, 2562.8077894158014, 2568.460623269116, 2570.768630823216, 2578.6647735794227, 2580.148550978173, 14111.435542578285, 14374.0, 14384.784228236585, 14403.0, 14410.85589144116, 7383.33549980499, 7626.885596716053, 7630.4658673892845, 7650.502717323412, 7655.157932627407, 4973.179425394806, 5114.195927053154, 5118.334616499868, 5191.532762051395, 5222.294990176316, 1727.637196188802, 1751.95620109497, 1759.8504127149079, 1791.1551102364585, 1797.4068557376036, 24092.397690057714, 24282.514349713085, 24284.87857560701, 24303.756962430503, 24329.878350608487, 6139.570230083851, 6332.303446620868, 6543.607383557001, 6570.342965703391, 6570.802875913635, 15690.76463853043, 15692.0, 15770.526884193263, 15779.447719329768, 15800.762988555181, 7029.3673569379, 7944.6027698614835, 7945.682172713143, 7958.562279074707, 7965.641546130438, 5860.560457965669, 6106.664133472613, 6316.147320111818, 6336.20797400325, 6914.965425172943, 5007.123753343223, 5037.370328708911, 5146.125158723026, 5167.974160129175, 5174.43081261061, 1469.5150600301874, 1498.0786816108232, 1514.8106486689164, 1517.2944580769995, 1527.5188315680748, 901.4230892228978, 923.5382308845577, 925.0934084596998, 935.6163972771132, 936.2743873497957, 7530.736424225126, 7581.962090189514, 7618.885716714254, 7637.694492220249, 7649.464537482434, 709.2092317066433, 727.2908913808994, 731.8682637125369, 736.4991805572263, 747.114669117098, 4658.697184682985, 5666.631668941505, 5826.126081087871, 5834.27071616048, 5945.970270148708, 20379.694304585442, 21127.683084753742, 21269.36191914245, 21294.25470108539, 21297.467563311042, 18212.908935455238, 20332.288369906983, 20729.170833166805, 20748.170073196903, 20796.480087997617, 10056.396616203052, 10252.794944101226, 10271.537780799881, 10315.123214526699, 10362.430066346273, 8133.371302388535, 8396.244338009608, 8520.446170998865, 8576.614052367784, 8790.956045219733, 17321.393751218646, 17832.19755111049, 17991.640167196845, 18170.545736356697, 18229.0, 17713.557161071076, 18089.0, 18141.81858181454, 18231.361902333887, 18315.54211144732, 11756.529738810694, 11940.641780746591, 11997.580084696994, 12012.279263244232, 12015.819762703391, 12899.871001289866, 13167.802482962572, 13340.466381344637, 13341.066125371131, 13617.659558511117, 10846.511906964364, 10847.945760271148, 10923.563057477611, 11054.834177487504, 11187.944060279646, 10430.947845260725, 10529.42088185157, 10645.574177032831, 10788.838167427339, 10803.621873234399, 9035.412698174598, 9195.0, 9237.261019118589, 9380.390274632127, 9410.200132988773, 7135.928640713734, 7202.603856787927, 7249.927500724925, 7319.304666056716, 7335.816604584928, 7232.240614735377, 7326.487145899736, 7327.487075904849, 7329.596872172082, 7464.514806537558], "value": 6426.267841550875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.7256994663608, 502.29427654145894, 523.6413057055917, 525.8317338451697, 531.9148936170211, 6241.001439769638, 6276.529260305484, 6285.779997700081, 6315.021171718386, 6323.9051414228825, 5958.165856780043, 6084.2090528231265, 6108.175396321495, 6137.539684523656, 6204.81385558434, 4946.3817022872145, 4949.0, 4953.281774142747, 4961.330220420233, 5014.749262536868, 4985.800567977277, 4986.975065124688, 4992.251162325662, 4997.600191984632, 5029.522195391451, 5143.094151804218, 5177.301064356301, 5199.610029247821, 5200.3759548854005, 5226.817061402851, 5158.458361871987, 5167.379914410276, 5181.689098654093, 5183.0, 5193.948060519384, 4818.469968303484, 4833.637477189225, 4837.572915989756, 4840.90182283339, 4844.806207751721, 6105.32841387447, 6136.969315153396, 6145.385461453819, 6154.661493617849, 6185.670080932576, 5987.670678112702, 6017.939820601781, 6030.4572588467245, 6043.365446628085, 6076.756929722806, 6631.403173714389, 6648.036034774979, 6653.634050127241, 6655.600663960178, 6667.533272670915, 5302.1781623848365, 5313.1764576490705, 5353.277307563468, 5356.68761153516, 5366.973165134188, 6936.4797640177185, 6986.720531178747, 6986.9650651746415, 7014.19336776267, 7041.366277035091, 5400.189971504227, 5441.2654291670115, 5444.183372494078, 5444.537214336747, 5488.725563721798, 5525.585581081435, 5537.342075803636, 5556.277683901067, 5592.245046918614, 5604.943950560524, 6010.7295171716505, 6028.186194863637, 6071.271447426248, 6080.635161890301, 6105.023196288573, 6507.154069970874, 6621.834454138685, 6626.271110177877, 6685.498587605949, 6689.364510371507, 1790.8209179082248, 1865.6455273498264, 1877.8122187781387, 1904.3715573860593, 1930.2568511123318, 1341.7920222365549, 1406.7702691234304, 1412.7880817877194, 1430.1919415530192, 1457.3077788050591, 5718.342390625048, 5733.799317023884, 5750.0, 5778.27771528559, 5792.391798861143, 6449.774257900951, 6618.7021584028835, 6629.86740265192, 6706.295838936939, 6795.728170873209, 5758.62568933018, 5787.826365209051, 5791.420857914259, 5798.681072540966, 5824.271966004249, 3523.612402635708, 3547.5388199533895, 3571.6428357164077, 3600.42393217084, 3620.420732682758, 6696.363845434676, 6708.161479815023, 6716.261211266757, 6719.563228390139, 6752.257251702309, 6910.827229319308, 6928.896066559006, 6981.162260528769, 6995.300469952964, 7016.7544135954995, 6508.479321654351, 6598.0, 6651.767188148391, 6668.533202675863, 6694.732210711614, 6760.391564759196, 6769.356911093439, 6790.42281406086, 6812.455003599799, 6820.283870193757, 6727.0982829959485, 6739.663016849236, 6742.157230346207, 6746.499410742598, 6773.017912402773, 6597.538172327891, 6643.269240383651, 6648.667566621552, 6666.133402657623, 6696.966515167393, 5016.874578135576, 5046.444891061907, 5063.113955057776, 5063.645544811975, 5070.847874563769, 6829.89755153683, 6835.0, 6846.0, 6853.0405743195, 6887.827804304932, 6581.901271481028, 6595.4393876521035, 6605.339466053356, 6614.867702646016, 6651.102101216274, 6539.738410463528, 6543.509236807164, 6568.343165683394, 6587.80236592903, 6608.966955165193, 6213.409726076015, 6334.303226644974, 6334.968325158345, 6488.0, 6507.316731743099, 6381.489480841428, 6521.217453905372, 6532.281449040697, 6620.536562440583, 6640.966795165993, 6367.968160159169, 6374.553781235269, 6377.298497165215, 6400.583962042452, 6402.583832050902], "value": 5192.0541195989945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.753667741371, 904.9728508144756, 923.8060007398446, 930.1070971867007, 933.1648174883479, 18010.81989180108, 18870.905645471772, 18906.243750249992, 18953.431397058077, 19755.40733777989, 20462.590748185026, 21811.454713632167, 22220.666689999623, 22237.777622223774, 22256.443588910286, 1028.7222449938492, 1061.0450594464967, 1062.054771253585, 1062.075993885321, 1062.2086545523596, 1054.1724746074333, 1059.8039362717884, 1059.89930956559, 1065.605725881421, 1067.8077945969721, 1105.778844231153, 1110.3448965110583, 1110.4114819145866, 1110.8333749937533, 1111.4887151910132, 1103.9006489415951, 1105.8728246251703, 1107.7618312062864, 1108.501174471487, 1110.0675432636624, 808.3896658023154, 809.6275713171948, 813.6175997281268, 814.1776805426503, 815.1929589706208, 19671.0, 19864.30474933385, 20076.39770806878, 20216.0, 20293.086811093537, 20767.5846483071, 21194.470138246514, 21379.0, 22150.22474213395, 22396.888015559816, 14723.558293251219, 14969.326380312803, 15024.248787560578, 15172.317245723969, 15250.771238431433, 3598.9100272493133, 3619.963800361989, 3648.6533779290926, 3651.379265524867, 3652.3973544365413, 124404.37797811044, 125421.0, 127369.0, 128416.0, 128529.35735321356, 14511.564653060424, 14921.925390372979, 14966.17686027279, 14982.62543436401, 15044.699106017819, 31077.223069423446, 31419.842900785807, 31420.214494637818, 31463.37073258522, 31663.20841978969, 6871.5189936703955, 7222.855542889113, 8162.6734930602115, 8264.256216940505, 8358.582070896431, 4023.376376661622, 4125.66994640428, 4150.066235097079, 4163.500379954425, 4166.895827604273, 5061.190209566452, 5154.768035438415, 5166.43169251382, 5228.477152284817, 5251.133562962144, 987.0770829274508, 1000.6097621927308, 1006.8590397344377, 1009.8737657792776, 1010.0354161775487, 681.0907438569466, 703.8873780195145, 708.2810946888912, 708.8972099045609, 718.8813845715503, 12154.270743755404, 12372.381380930918, 12709.300988445724, 12810.167339123114, 13441.932790335986, 694.9200841903246, 697.4978015828596, 705.206642527157, 706.8692291925908, 707.8265824872939, 5577.143998801243, 5718.714064296769, 5730.796532728091, 5960.374160713062, 5961.135635332939, 104379.0, 107436.0, 110520.0, 112036.0, 115388.42305788417, 92883.535582323, 93168.53415732877, 93822.5308873465, 97789.51105244429, 97954.51022744841, 82156.58921705354, 84957.72563411431, 86929.0, 87416.6887496688, 88367.0, 10626.681199564026, 10706.73233169177, 10807.729806754895, 10874.510647020745, 11042.785293617535, 38758.224835502566, 39948.201035978534, 40454.595454045084, 41329.58670413378, 41543.0, 69680.30319696738, 70859.29140708527, 72005.0, 72251.0, 73941.0, 19298.22807087701, 19468.513287167934, 19481.123349449026, 19553.511162221057, 19679.21283148658, 21077.78922210758, 21335.25326613561, 21643.567128657654, 21726.45683857853, 21924.342269731933, 18674.159662815477, 19203.90398048057, 19407.708884367028, 19440.2223911042, 19593.8040619592, 18787.96666183373, 19470.12384442675, 19841.80158198457, 19865.0, 20224.494387640425, 17001.0, 19059.90470047641, 19143.23427062902, 19756.703649444982, 19853.205871764967, 14442.0, 14513.274336282933, 14609.488667896572, 14635.34140963638, 14757.335919883846, 14433.134011959317, 14625.561233163022, 14846.628834279229, 15024.774628380801, 15341.079535227922], "value": 9274.253444330441, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 101.0, 107.0, 108.0, 108.0, 108.0, 98.0, 106.0, 109.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 154.0, 177.0, 117.0, 150.0, 143.0, 118.0, 170.0, 118.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 162.0, 164.0, 163.0, 164.0, 169.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 171.0, 77.0, 75.0, 76.0, 87.0, 98.0, 74.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 135.0, 79.0, 78.0, 79.0, 121.0, 80.0, 78.0, 130.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 118.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 152.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 57.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 76.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 126.0, 127.0, 129.0, 121.0, 126.0, 131.0, 124.0, 159.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 179.0, 182.0, 184.0, 175.0, 179.0, 176.0, 183.0, 178.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 67.0, 69.0, 67.0, 68.0, 69.0, 69.0], "value": 68.2, "unit": "score"}]}]} 20:03:18 INFO - Return code: 0 20:03:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:03:18 INFO - # TBPL SUCCESS # 20:03:18 INFO - Running post-action listener: _package_coverage_data 20:03:18 INFO - Running post-action listener: _resource_record_post_action 20:03:18 INFO - [mozharness: 2017-08-16 03:03:18.450627Z] Finished run-tests step (success) 20:03:18 INFO - Running post-run listener: _resource_record_post_run 20:03:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 436428800; Read time: 200; Write time: 338332 20:03:18 INFO - TinderboxPrint: CPU usage
13.1% 20:03:18 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 200 20:03:18 INFO - TinderboxPrint: I/O write bytes / time
436,428,800 / 338,332 20:03:18 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 20:03:18 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 20:03:18 INFO - TinderboxPrint: Swap in / out
0 / 0 20:03:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112766976; Read time: 0; Write time: 132568 20:03:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:03:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323661824; Read time: 188; Write time: 205764 20:03:19 INFO - Running post-run listener: _upload_blobber_files 20:03:19 INFO - Blob upload gear active. 20:03:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:03:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:03:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:20 INFO - (blobuploader) - INFO - Done attempting. 20:03:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:03:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:21 INFO - (blobuploader) - INFO - Done attempting. 20:03:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:03:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:28 INFO - (blobuploader) - INFO - Done attempting. 20:03:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:03:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:29 INFO - (blobuploader) - INFO - Done attempting. 20:03:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:29 INFO - Return code: 0 20:03:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84872edaf2eca1ccffcbfd6dc67fbdf7ab71bd79e9d147b0a01d50d362ac0ae3ea9c0d1e223f8889d4c59e698f5ff1193f08cc2edba4d2c650fb452ca363161b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dff4323ae171c755ac447bcc534467a7181cd11a570b6da3dfb099b6f4896a77716a1d79003c3a8b034dc9e06c5b95ad23f3efbcc65319fa29d14551b650cc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74b2267196adb1281e6ae2dfaa60b1ae801d3de69d972557cf968aa7a08dfd84118154d2d4e7bbb1cdd3f896bb6e5bfe524041295d412343fd00592092c6c18e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/575900eb0644cfdcf5be64edb52bcb1435940dc8869096571b9caa7001ef05ea9f24acf62de1b0521113aa403212b9d4585094cde79081d56882d57af62b6e9a"} 20:03:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:29 INFO - Contents: 20:03:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84872edaf2eca1ccffcbfd6dc67fbdf7ab71bd79e9d147b0a01d50d362ac0ae3ea9c0d1e223f8889d4c59e698f5ff1193f08cc2edba4d2c650fb452ca363161b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dff4323ae171c755ac447bcc534467a7181cd11a570b6da3dfb099b6f4896a77716a1d79003c3a8b034dc9e06c5b95ad23f3efbcc65319fa29d14551b650cc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74b2267196adb1281e6ae2dfaa60b1ae801d3de69d972557cf968aa7a08dfd84118154d2d4e7bbb1cdd3f896bb6e5bfe524041295d412343fd00592092c6c18e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/575900eb0644cfdcf5be64edb52bcb1435940dc8869096571b9caa7001ef05ea9f24acf62de1b0521113aa403212b9d4585094cde79081d56882d57af62b6e9a"} 20:03:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:29 INFO - Copying logs to upload dir... 20:03:29 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.526692 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 20:03:30.029680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:30.033583) ========= 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=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84872edaf2eca1ccffcbfd6dc67fbdf7ab71bd79e9d147b0a01d50d362ac0ae3ea9c0d1e223f8889d4c59e698f5ff1193f08cc2edba4d2c650fb452ca363161b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dff4323ae171c755ac447bcc534467a7181cd11a570b6da3dfb099b6f4896a77716a1d79003c3a8b034dc9e06c5b95ad23f3efbcc65319fa29d14551b650cc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74b2267196adb1281e6ae2dfaa60b1ae801d3de69d972557cf968aa7a08dfd84118154d2d4e7bbb1cdd3f896bb6e5bfe524041295d412343fd00592092c6c18e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/575900eb0644cfdcf5be64edb52bcb1435940dc8869096571b9caa7001ef05ea9f24acf62de1b0521113aa403212b9d4585094cde79081d56882d57af62b6e9a"} build_url:https://queue.taskcluster.net/v1/task/YvnAGiJcTqymla8mJLMVSg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 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-Non-PGO/sha512/84872edaf2eca1ccffcbfd6dc67fbdf7ab71bd79e9d147b0a01d50d362ac0ae3ea9c0d1e223f8889d4c59e698f5ff1193f08cc2edba4d2c650fb452ca363161b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dff4323ae171c755ac447bcc534467a7181cd11a570b6da3dfb099b6f4896a77716a1d79003c3a8b034dc9e06c5b95ad23f3efbcc65319fa29d14551b650cc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74b2267196adb1281e6ae2dfaa60b1ae801d3de69d972557cf968aa7a08dfd84118154d2d4e7bbb1cdd3f896bb6e5bfe524041295d412343fd00592092c6c18e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/575900eb0644cfdcf5be64edb52bcb1435940dc8869096571b9caa7001ef05ea9f24acf62de1b0521113aa403212b9d4585094cde79081d56882d57af62b6e9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:30.061601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:30.062030) ========= 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=d2a8c569965ab8367867b893000001a1-1502848456.909151-332348608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004769 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:03:30.112711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:30.113111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:03:30.113751) ========= ========= Total master_lag: 0.41 =========