builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1498926570.1 results: success (0) revision: 066a7a160677f90c034758b013a85ee27509392d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.103525) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.104006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.104330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.120470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.120832) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-01 09:29:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2017-07-01 09:29:30 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.261755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.262113) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:30.313631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-01 09:29:30.313995) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 066a7a160677f90c034758b013a85ee27509392d --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 066a7a160677f90c034758b013a85ee27509392d --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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-01 09:29:30,461 truncating revision to first 12 chars 2017-07-01 09:29:30,462 Setting DEBUG logging. 2017-07-01 09:29:30,462 attempt 1/10 2017-07-01 09:29:30,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/066a7a160677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-01 09:29:31,114 unpacking tar archive at: mozilla-central-066a7a160677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-01 09:29:31.353562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:31.353925) ========= script_repo_revision: 066a7a160677f90c034758b013a85ee27509392d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:31.354401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:31.354710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 09:29:31.362189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-01 09:29:31.362538) ========= /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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:31 INFO - MultiFileLogger online at 20170701 09:29:31 in /builds/slave/test 09:29:31 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 09:29:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:31 INFO - {'append_to_log': False, 09:29:31 INFO - 'base_work_dir': '/builds/slave/test', 09:29:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:29:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:31 INFO - 'branch': 'Firefox-Non-PGO', 09:29:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:31 INFO - 'code_coverage': False, 09:29:31 INFO - 'config_files': ('talos/linux_config.py',), 09:29:31 INFO - 'default_actions': ('clobber', 09:29:31 INFO - 'read-buildbot-config', 09:29:31 INFO - 'download-and-extract', 09:29:31 INFO - 'populate-webroot', 09:29:31 INFO - 'create-virtualenv', 09:29:31 INFO - 'install', 09:29:31 INFO - 'setup-mitmproxy', 09:29:31 INFO - 'run-tests'), 09:29:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:31 INFO - 'disable_ccov_upload': False, 09:29:31 INFO - 'download_minidump_stackwalk': True, 09:29:31 INFO - 'download_symbols': 'ondemand', 09:29:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:31 INFO - 'gecko_profile': False, 09:29:31 INFO - 'gecko_profile_interval': 0, 09:29:31 INFO - 'installer_path': 'installer.exe', 09:29:31 INFO - 'log_level': 'info', 09:29:31 INFO - 'log_name': 'talos', 09:29:31 INFO - 'log_to_console': True, 09:29:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:31 INFO - 'opt_config_files': (), 09:29:31 INFO - 'pip_index': False, 09:29:31 INFO - 'suite': 'dromaeojs-e10s', 09:29:31 INFO - 'system_bits': '32', 09:29:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:31 INFO - 'title': 'talos-linux64-ix-036', 09:29:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:31 INFO - 'use_talos_json': True, 09:29:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:31 INFO - 'work_dir': 'build'} 09:29:31 INFO - [mozharness: 2017-07-01 16:29:31.616250Z] Running clobber step. 09:29:31 INFO - Running pre-action listener: _resource_record_pre_action 09:29:31 INFO - Running main action method: clobber 09:29:31 INFO - rmtree: /builds/slave/test/build 09:29:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:32 INFO - Running post-action listener: _resource_record_post_action 09:29:32 INFO - [mozharness: 2017-07-01 16:29:32.653325Z] Finished clobber step (success) 09:29:32 INFO - [mozharness: 2017-07-01 16:29:32.653428Z] Running read-buildbot-config step. 09:29:32 INFO - Running pre-action listener: _resource_record_pre_action 09:29:32 INFO - Running main action method: read_buildbot_config 09:29:32 INFO - Using buildbot properties: 09:29:32 INFO - { 09:29:32 INFO - "project": "", 09:29:32 INFO - "product": "firefox", 09:29:32 INFO - "who": "ffxbld@noreply.mozilla.org", 09:29:32 INFO - "installer_path": "public/build/target.tar.bz2", 09:29:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:29:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:29:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:29:32 INFO - "stage_platform": "linux64", 09:29:32 INFO - "basedir": "/builds/slave/test", 09:29:32 INFO - "buildnumber": 988, 09:29:32 INFO - "platform": "ubuntu64_hw", 09:29:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:29:32 INFO - "slavebuilddir": "test", 09:29:32 INFO - "taskId": "SKeOufU7TmWXytH8VDVdhA", 09:29:32 INFO - "branch": "mozilla-central", 09:29:32 INFO - "script_repo_revision": "production", 09:29:32 INFO - "revision": "066a7a160677f90c034758b013a85ee27509392d", 09:29:32 INFO - "slavename": "talos-linux64-ix-036", 09:29:32 INFO - "repo_path": "mozilla-central" 09:29:32 INFO - } 09:29:32 INFO - Finding installer, test and symbols from parent task. 09:29:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKeOufU7TmWXytH8VDVdhA'}, attempt #1 09:29:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKeOufU7TmWXytH8VDVdhA'}, attempt #1 09:29:33 INFO - Task dependencies: GvrbrPCBQCaE_A-9lMGJhg 09:29:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg'}, attempt #1 09:29:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 09:29:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/test_packages.json 09:29:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.crashreporter-symbols.zip 09:29:34 INFO - Running post-action listener: _resource_record_post_action 09:29:34 INFO - [mozharness: 2017-07-01 16:29:34.174321Z] Finished read-buildbot-config step (success) 09:29:34 INFO - [mozharness: 2017-07-01 16:29:34.174543Z] Running download-and-extract step. 09:29:34 INFO - Running pre-action listener: _resource_record_pre_action 09:29:34 INFO - Running main action method: download_and_extract 09:29:34 INFO - mkdir: /builds/slave/test/build/tests 09:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:34 INFO - trying https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.test_packages.json 09:29:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:29:34 INFO - Downloaded 989 bytes. 09:29:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:29:34 INFO - Using the following test package requirements: 09:29:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:29:34 INFO - u'common': [u'target.common.tests.zip'], 09:29:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:29:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:29:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:29:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:29:34 INFO - u'mozbase': [u'target.common.tests.zip'], 09:29:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:29:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:29:34 INFO - u'web-platform': [u'target.common.tests.zip', 09:29:34 INFO - u'target.web-platform.tests.tar.gz'], 09:29:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:29:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:29:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip 09:29:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:29:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip into memory 09:29:36 INFO - Content-Length response header: 67758926 09:29:36 INFO - Bytes received: 67758926 09:29:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:29:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip 09:29:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:29:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.common.tests.zip into memory 09:29:48 INFO - Content-Length response header: 67758926 09:29:48 INFO - Bytes received: 67758926 09:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.talos.tests.zip 09:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:30:02 INFO - Fetch https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.talos.tests.zip into memory 09:30:03 INFO - Content-Length response header: 14442804 09:30:03 INFO - Bytes received: 14442804 09:30: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')]} 09:30:03 INFO - trying https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 09:30:03 INFO - Downloading https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:30:04 INFO - Downloaded 61886333 bytes. 09:30:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 09:30:04 INFO - mkdir: /builds/slave/test/properties 09:30:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:04 INFO - Contents: 09:30:04 INFO - build_url:https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 09:30:04 INFO - Running post-action listener: _resource_record_post_action 09:30:04 INFO - Running post-action listener: set_extra_try_arguments 09:30:04 INFO - [mozharness: 2017-07-01 16:30:04.537486Z] Finished download-and-extract step (success) 09:30:04 INFO - [mozharness: 2017-07-01 16:30:04.537583Z] Running populate-webroot step. 09:30:04 INFO - Running pre-action listener: _resource_record_pre_action 09:30:04 INFO - Running main action method: populate_webroot 09:30:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:04 INFO - '--tppagecycles', 09:30:04 INFO - '7'], 09:30:04 INFO - 'tests': ['tsvgm']}}, 09:30:04 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['damp', 'tps']}, 09:30:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'tests': ['damp', 'tps']}, 09:30:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['dromaeo_dom']}, 09:30:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:30:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:30:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:30:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['a11yr', 09:30:04 INFO - 'ts_paint', 09:30:04 INFO - 'tpaint', 09:30:04 INFO - 'sessionrestore', 09:30:04 INFO - 'sessionrestore_no_auto_restore', 09:30:04 INFO - 'tabpaint']}, 09:30:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:30:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:30:04 INFO - 'bloom_basic_ref']}, 09:30:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:30:04 INFO - 'talos_options': ['--mitmproxy', 09:30:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:30:04 INFO - '--firstNonBlankPaint'], 09:30:04 INFO - 'tests': ['quantum_pageload_google', 09:30:04 INFO - 'quantum_pageload_youtube', 09:30:04 INFO - 'quantum_pageload_amazon', 09:30:04 INFO - 'quantum_pageload_facebook']}, 09:30:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['tsvgx', 09:30:04 INFO - 'tsvgr_opacity', 09:30:04 INFO - 'tart', 09:30:04 INFO - 'tscrollx', 09:30:04 INFO - 'cart', 09:30:04 INFO - 'tsvg_static']}, 09:30:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:04 INFO - 'tsvgr_opacity', 09:30:04 INFO - 'tart', 09:30:04 INFO - 'tscrollx', 09:30:04 INFO - 'cart', 09:30:04 INFO - 'tsvg_static']}, 09:30:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'talos_options': ['--disable-e10s'], 09:30:04 INFO - 'tests': ['tp5o']}, 09:30:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:30:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'talos_options': ['--disable-e10s', 09:30:04 INFO - '--xperf_path', 09:30:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:04 INFO - 'tests': ['tp5n']}, 09:30:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:30:04 INFO - 'talos_options': ['--xperf_path', 09:30:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:04 INFO - 'tests': ['tp5n']}}, 09:30:04 INFO - 'talos.zip': {'path': '', 09:30:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:04 INFO - Running post-action listener: _resource_record_post_action 09:30:04 INFO - [mozharness: 2017-07-01 16:30:04.552458Z] Finished populate-webroot step (success) 09:30:04 INFO - [mozharness: 2017-07-01 16:30:04.552548Z] Running create-virtualenv step. 09:30:04 INFO - Running pre-action listener: _resource_record_pre_action 09:30:04 INFO - Running main action method: create_virtualenv 09:30:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:04 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 09:30:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:30:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:04 INFO - Using real prefix '/usr' 09:30:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:07 INFO - Installing pip.................done. 09:30:07 INFO - Return code: 0 09:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:30:07 INFO - Reading from file tmpfile_stdout 09:30:07 INFO - Output received: 09:30:07 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) 09:30:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:07 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')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 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')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:07 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 09:30:07 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 09:30:07 INFO - Using env: {'DISPLAY': ':0', 09:30:07 INFO - 'HOME': '/home/cltbld', 09:30:07 INFO - 'LANG': 'en_US.UTF-8', 09:30:07 INFO - 'LANGUAGE': 'en_US:en', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MAIL': '/var/mail/cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SHLVL': '1', 09:30:07 INFO - 'TERM': 'linux', 09:30:07 INFO - 'TMOUT': '86400', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - '_': '/tools/buildbot/bin/python'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 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 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:07 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')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 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')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:07 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 09:30:07 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 09:30:07 INFO - Using env: {'DISPLAY': ':0', 09:30:07 INFO - 'HOME': '/home/cltbld', 09:30:07 INFO - 'LANG': 'en_US.UTF-8', 09:30:07 INFO - 'LANGUAGE': 'en_US:en', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MAIL': '/var/mail/cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SHLVL': '1', 09:30:07 INFO - 'TERM': 'linux', 09:30:07 INFO - 'TMOUT': '86400', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - '_': '/tools/buildbot/bin/python'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 INFO - Downloading/unpacking psutil>=3.1.1 09:30:07 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 09:30:07 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 09:30:07 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 09:30:07 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 09:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:08 INFO - Installing collected packages: psutil 09:30:08 INFO - Running setup.py install for psutil 09:30:09 INFO - building 'psutil._psutil_linux' extension 09:30: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 09:30: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 09:30:09 INFO - building 'psutil._psutil_posix' extension 09:30: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 09:30: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:09 INFO - Successfully installed psutil 09:30:09 INFO - Cleaning up... 09:30:09 INFO - Return code: 0 09:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:09 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')]} 09:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:09 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')]} 09:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:09 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:09 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 09:30:09 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 09:30:09 INFO - Using env: {'DISPLAY': ':0', 09:30:09 INFO - 'HOME': '/home/cltbld', 09:30:09 INFO - 'LANG': 'en_US.UTF-8', 09:30:09 INFO - 'LANGUAGE': 'en_US:en', 09:30:09 INFO - 'LOGNAME': 'cltbld', 09:30:09 INFO - 'MAIL': '/var/mail/cltbld', 09:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:09 INFO - 'MOZ_NO_REMOTE': '1', 09:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:09 INFO - 'NO_EM_RESTART': '1', 09:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:09 INFO - 'PWD': '/builds/slave/test', 09:30:09 INFO - 'SHELL': '/bin/bash', 09:30:09 INFO - 'SHLVL': '1', 09:30:09 INFO - 'TERM': 'linux', 09:30:09 INFO - 'TMOUT': '86400', 09:30:09 INFO - 'USER': 'cltbld', 09:30:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:09 INFO - '_': '/tools/buildbot/bin/python'} 09:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30:09 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 09:30:09 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 09:30:09 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 09:30:09 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 09:30:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:10 INFO - Installing collected packages: mozsystemmonitor 09:30:10 INFO - Running setup.py install for mozsystemmonitor 09:30:10 INFO - Successfully installed mozsystemmonitor 09:30:10 INFO - Cleaning up... 09:30:10 INFO - Return code: 0 09:30:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30: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')]} 09:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30: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', '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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:30: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 jsonschema==2.5.1 09:30:10 INFO - Using env: {'DISPLAY': ':0', 09:30:10 INFO - 'HOME': '/home/cltbld', 09:30:10 INFO - 'LANG': 'en_US.UTF-8', 09:30:10 INFO - 'LANGUAGE': 'en_US:en', 09:30:10 INFO - 'LOGNAME': 'cltbld', 09:30:10 INFO - 'MAIL': '/var/mail/cltbld', 09:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:10 INFO - 'MOZ_NO_REMOTE': '1', 09:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:10 INFO - 'NO_EM_RESTART': '1', 09:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:10 INFO - 'PWD': '/builds/slave/test', 09:30:10 INFO - 'SHELL': '/bin/bash', 09:30:10 INFO - 'SHLVL': '1', 09:30:10 INFO - 'TERM': 'linux', 09:30:10 INFO - 'TMOUT': '86400', 09:30:10 INFO - 'USER': 'cltbld', 09:30:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:10 INFO - '_': '/tools/buildbot/bin/python'} 09:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:11 INFO - Downloading/unpacking jsonschema==2.5.1 09:30: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 09:30: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 09:30: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 09:30: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 09:30:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:12 INFO - warning: no files found matching '*.txt' 09:30:12 INFO - no previously-included directories found matching 'build' 09:30:12 INFO - no previously-included directories found matching 'dist' 09:30:12 INFO - no previously-included directories found matching '.git*' 09:30:12 INFO - Installing collected packages: jsonschema, functools32 09:30:12 INFO - Running setup.py install for functools32 09:30:12 INFO - warning: no files found matching '*.txt' 09:30:12 INFO - no previously-included directories found matching 'build' 09:30:12 INFO - no previously-included directories found matching 'dist' 09:30:12 INFO - no previously-included directories found matching '.git*' 09:30:12 INFO - Successfully installed jsonschema functools32 09:30:12 INFO - Cleaning up... 09:30:12 INFO - Return code: 0 09:30:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:30:12 INFO - Using env: {'DISPLAY': ':0', 09:30:12 INFO - 'HOME': '/home/cltbld', 09:30:12 INFO - 'LANG': 'en_US.UTF-8', 09:30:12 INFO - 'LANGUAGE': 'en_US:en', 09:30:12 INFO - 'LOGNAME': 'cltbld', 09:30:12 INFO - 'MAIL': '/var/mail/cltbld', 09:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:12 INFO - 'MOZ_NO_REMOTE': '1', 09:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:12 INFO - 'NO_EM_RESTART': '1', 09:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:12 INFO - 'PWD': '/builds/slave/test', 09:30:12 INFO - 'SHELL': '/bin/bash', 09:30:12 INFO - 'SHLVL': '1', 09:30:12 INFO - 'TERM': 'linux', 09:30:12 INFO - 'TMOUT': '86400', 09:30:12 INFO - 'USER': 'cltbld', 09:30:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:12 INFO - '_': '/tools/buildbot/bin/python'} 09:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:30:12 INFO - Cleaning up... 09:30:12 INFO - Return code: 0 09:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:30:12 INFO - Using env: {'DISPLAY': ':0', 09:30:12 INFO - 'HOME': '/home/cltbld', 09:30:12 INFO - 'LANG': 'en_US.UTF-8', 09:30:12 INFO - 'LANGUAGE': 'en_US:en', 09:30:12 INFO - 'LOGNAME': 'cltbld', 09:30:12 INFO - 'MAIL': '/var/mail/cltbld', 09:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:12 INFO - 'MOZ_NO_REMOTE': '1', 09:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:12 INFO - 'NO_EM_RESTART': '1', 09:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:12 INFO - 'PWD': '/builds/slave/test', 09:30:12 INFO - 'SHELL': '/bin/bash', 09:30:12 INFO - 'SHLVL': '1', 09:30:12 INFO - 'TERM': 'linux', 09:30:12 INFO - 'TMOUT': '86400', 09:30:12 INFO - 'USER': 'cltbld', 09:30:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:12 INFO - '_': '/tools/buildbot/bin/python'} 09:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:30: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 09:30: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 09:30: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 09:30: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 09:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:14 INFO - Downloading docopt-0.6.1.tar.gz 09:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:14 INFO - Running setup.py install for blobuploader 09:30:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:14 INFO - Running setup.py install for requests 09:30:15 INFO - Running setup.py install for docopt 09:30:15 INFO - Successfully installed blobuploader requests docopt 09:30:15 INFO - Cleaning up... 09:30:15 INFO - Return code: 0 09:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:15 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:15 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 09:30:15 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 09:30:15 INFO - Using env: {'DISPLAY': ':0', 09:30:15 INFO - 'HOME': '/home/cltbld', 09:30:15 INFO - 'LANG': 'en_US.UTF-8', 09:30:15 INFO - 'LANGUAGE': 'en_US:en', 09:30:15 INFO - 'LOGNAME': 'cltbld', 09:30:15 INFO - 'MAIL': '/var/mail/cltbld', 09:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:15 INFO - 'MOZ_NO_REMOTE': '1', 09:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:15 INFO - 'NO_EM_RESTART': '1', 09:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:15 INFO - 'PWD': '/builds/slave/test', 09:30:15 INFO - 'SHELL': '/bin/bash', 09:30:15 INFO - 'SHLVL': '1', 09:30:15 INFO - 'TERM': 'linux', 09:30:15 INFO - 'TMOUT': '86400', 09:30:15 INFO - 'USER': 'cltbld', 09:30:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:15 INFO - '_': '/tools/buildbot/bin/python'} 09:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:15 INFO - Running setup.py (path:/tmp/pip-7dAS_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:15 INFO - Running setup.py (path:/tmp/pip-ldi01v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:15 INFO - Running setup.py (path:/tmp/pip-bh4yLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:15 INFO - Running setup.py (path:/tmp/pip-etO2kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:15 INFO - Running setup.py (path:/tmp/pip-O8cBHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:15 INFO - Running setup.py (path:/tmp/pip-iOByT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:15 INFO - Running setup.py (path:/tmp/pip-V1YpwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:16 INFO - Running setup.py (path:/tmp/pip-yBnwZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:16 INFO - Running setup.py (path:/tmp/pip-93MgHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:16 INFO - Running setup.py (path:/tmp/pip-ql3rpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:16 INFO - Running setup.py (path:/tmp/pip-mfZK0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:16 INFO - Running setup.py (path:/tmp/pip-WcEowN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:16 INFO - Running setup.py (path:/tmp/pip-TvBLzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:16 INFO - Running setup.py (path:/tmp/pip-Edn9n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:16 INFO - Running setup.py (path:/tmp/pip-qq_7MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:16 INFO - Running setup.py (path:/tmp/pip-oMDibQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:16 INFO - Running setup.py (path:/tmp/pip-qVJQP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:16 INFO - Running setup.py install for manifestparser 09:30:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for mozcrash 09:30:16 INFO - Running setup.py install for mozdebug 09:30:17 INFO - Running setup.py install for mozdevice 09:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for mozfile 09:30:17 INFO - Running setup.py install for mozhttpd 09:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for mozinfo 09:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for mozInstall 09:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for mozleak 09:30:17 INFO - Running setup.py install for mozlog 09:30:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for moznetwork 09:30:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Running setup.py install for mozprocess 09:30:17 INFO - Running setup.py install for mozprofile 09:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Running setup.py install for mozrunner 09:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Running setup.py install for mozscreenshot 09:30:18 INFO - Running setup.py install for moztest 09:30:18 INFO - Running setup.py install for mozversion 09:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:18 INFO - Cleaning up... 09:30:18 INFO - Return code: 0 09:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:18 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')]} 09:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:18 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')]} 09:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:18 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:18 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 09:30:18 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 09:30:18 INFO - Using env: {'DISPLAY': ':0', 09:30:18 INFO - 'HOME': '/home/cltbld', 09:30:18 INFO - 'LANG': 'en_US.UTF-8', 09:30:18 INFO - 'LANGUAGE': 'en_US:en', 09:30:18 INFO - 'LOGNAME': 'cltbld', 09:30:18 INFO - 'MAIL': '/var/mail/cltbld', 09:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:18 INFO - 'MOZ_NO_REMOTE': '1', 09:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:18 INFO - 'NO_EM_RESTART': '1', 09:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:18 INFO - 'PWD': '/builds/slave/test', 09:30:18 INFO - 'SHELL': '/bin/bash', 09:30:18 INFO - 'SHLVL': '1', 09:30:18 INFO - 'TERM': 'linux', 09:30:18 INFO - 'TMOUT': '86400', 09:30:18 INFO - 'USER': 'cltbld', 09:30:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:18 INFO - '_': '/tools/buildbot/bin/python'} 09:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:18 INFO - Running setup.py (path:/tmp/pip-eySKrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:18 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)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:18 INFO - Running setup.py (path:/tmp/pip-fduCPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:18 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)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:18 INFO - Running setup.py (path:/tmp/pip-oB2leC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:18 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)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:18 INFO - Running setup.py (path:/tmp/pip-BPnlgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30: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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:19 INFO - Running setup.py (path:/tmp/pip-uf0yg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30: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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:19 INFO - Running setup.py (path:/tmp/pip-SKL8Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:19 INFO - Running setup.py (path:/tmp/pip-rrc0hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:19 INFO - Running setup.py (path:/tmp/pip-JEwbZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:19 INFO - Running setup.py (path:/tmp/pip-p1IBvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:19 INFO - Running setup.py (path:/tmp/pip-o7FjFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:19 INFO - Running setup.py (path:/tmp/pip-szyOEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:19 INFO - Running setup.py (path:/tmp/pip-jOYSFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:19 INFO - Running setup.py (path:/tmp/pip-nixCQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:19 INFO - Running setup.py (path:/tmp/pip-dTfZLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:19 INFO - Running setup.py (path:/tmp/pip-zwXEKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:19 INFO - Running setup.py (path:/tmp/pip-sbJPUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:19 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)) 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:19 INFO - Running setup.py (path:/tmp/pip-wQRtMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:19 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)) 09:30:19 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)) 09:30:19 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)) 09:30:19 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)) 09:30:19 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)) 09:30:19 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)) 09:30:19 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)) 09:30:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:21 INFO - Downloading blessings-1.6.tar.gz 09:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:21 INFO - Installing collected packages: blessings 09:30:21 INFO - Running setup.py install for blessings 09:30:21 INFO - Successfully installed blessings 09:30:21 INFO - Cleaning up... 09:30:21 INFO - Return code: 0 09:30:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:21 INFO - Reading from file tmpfile_stdout 09:30:21 INFO - Current package versions: 09:30:21 INFO - argparse == 1.2.1 09:30:21 INFO - blessings == 1.6 09:30:21 INFO - blobuploader == 1.2.4 09:30:21 INFO - docopt == 0.6.1 09:30:21 INFO - functools32 == 3.2.3-2 09:30:21 INFO - jsonschema == 2.5.1 09:30:21 INFO - manifestparser == 1.1 09:30:21 INFO - mozInstall == 1.13 09:30:21 INFO - mozcrash == 1.0 09:30:21 INFO - mozdebug == 0.1 09:30:21 INFO - mozdevice == 0.51 09:30:21 INFO - mozfile == 1.2 09:30:21 INFO - mozhttpd == 0.7 09:30:21 INFO - mozinfo == 0.10 09:30:21 INFO - mozleak == 0.1 09:30:21 INFO - mozlog == 3.5 09:30:21 INFO - moznetwork == 0.27 09:30:21 INFO - mozprocess == 0.25 09:30:21 INFO - mozprofile == 0.28 09:30:21 INFO - mozrunner == 6.13 09:30:21 INFO - mozscreenshot == 0.1 09:30:21 INFO - mozsystemmonitor == 0.3 09:30:21 INFO - moztest == 0.8 09:30:21 INFO - mozversion == 1.4 09:30:21 INFO - psutil == 3.1.1 09:30:21 INFO - requests == 1.2.3 09:30:21 INFO - wsgiref == 0.1.2 09:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:21 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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30:21 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 09:30:21 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 09:30:21 INFO - Using env: {'DISPLAY': ':0', 09:30:21 INFO - 'HOME': '/home/cltbld', 09:30:21 INFO - 'LANG': 'en_US.UTF-8', 09:30:21 INFO - 'LANGUAGE': 'en_US:en', 09:30:21 INFO - 'LOGNAME': 'cltbld', 09:30:21 INFO - 'MAIL': '/var/mail/cltbld', 09:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:21 INFO - 'MOZ_NO_REMOTE': '1', 09:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:21 INFO - 'NO_EM_RESTART': '1', 09:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:21 INFO - 'PWD': '/builds/slave/test', 09:30:21 INFO - 'SHELL': '/bin/bash', 09:30:21 INFO - 'SHLVL': '1', 09:30:21 INFO - 'TERM': 'linux', 09:30:21 INFO - 'TMOUT': '86400', 09:30:21 INFO - 'USER': 'cltbld', 09:30:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:21 INFO - '_': '/tools/buildbot/bin/python'} 09:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:22 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:30:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:30: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 09:30: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 09:30: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 09:30: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 09:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:30: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)) 09:30: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)) 09:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:30:23 INFO - Installing collected packages: marionette-driver, simplejson 09:30:23 INFO - Running setup.py install for marionette-driver 09:30:23 INFO - Running setup.py install for simplejson 09:30:23 INFO - building 'simplejson._speedups' extension 09:30: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 09:30: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 09:30:24 INFO - Successfully installed marionette-driver simplejson 09:30:24 INFO - Cleaning up... 09:30:24 INFO - Return code: 0 09:30:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30: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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30: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 0xbe21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf53ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', '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 09:30: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 09:30: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 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:24 INFO - Cleaning up... 09:30:24 INFO - Return code: 0 09:30:24 INFO - Running post-action listener: _resource_record_post_action 09:30:24 INFO - Running post-action listener: _start_resource_monitoring 09:30:24 INFO - Starting resource monitoring. 09:30:24 INFO - [mozharness: 2017-07-01 16:30:24.548429Z] Finished create-virtualenv step (success) 09:30:24 INFO - [mozharness: 2017-07-01 16:30:24.548934Z] Running install step. 09:30:24 INFO - Running pre-action listener: _resource_record_pre_action 09:30:24 INFO - Running main action method: install 09:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:24 INFO - Reading from file tmpfile_stdout 09:30:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:24 INFO - Reading from file tmpfile_stdout 09:30:24 INFO - Output received: 09:30:24 INFO - Usage: mozinstall [options] installer 09:30:24 INFO - Options: 09:30:24 INFO - -h, --help show this help message and exit 09:30:24 INFO - -d DEST, --destination=DEST 09:30:24 INFO - Directory to install application into. [default: 09:30:24 INFO - "/builds/slave/test"] 09:30:24 INFO - --app=APP Application being installed. [default: firefox] 09:30:24 INFO - mkdir: /builds/slave/test/build/application 09:30:24 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'] 09:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:30:42 INFO - Reading from file tmpfile_stdout 09:30:42 INFO - Output received: 09:30:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:42 INFO - Running post-action listener: _resource_record_post_action 09:30:42 INFO - [mozharness: 2017-07-01 16:30:42.888655Z] Finished install step (success) 09:30:42 INFO - [mozharness: 2017-07-01 16:30:42.888997Z] Running setup-mitmproxy step. 09:30:42 INFO - Running pre-action listener: _resource_record_pre_action 09:30:42 INFO - Running main action method: setup_mitmproxy 09:30:42 INFO - Skipping: mitmproxy is not required 09:30:42 INFO - Running post-action listener: _resource_record_post_action 09:30:42 INFO - [mozharness: 2017-07-01 16:30:42.890734Z] Finished setup-mitmproxy step (success) 09:30:42 INFO - [mozharness: 2017-07-01 16:30:42.891055Z] Running run-tests step. 09:30:42 INFO - Running pre-action listener: _resource_record_pre_action 09:30:42 INFO - Running pre-action listener: _set_gcov_prefix 09:30:42 INFO - Running main action method: run_tests 09:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:42 INFO - Python 2.7.3 09:30:42 INFO - Return code: 0 09:30:42 INFO - grabbing minidump binary from tooltool 09:30:42 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')]} 09:30:42 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 0xf50980>, '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 0xf51730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf51bc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:42 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 09:30:42 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 09:30:42 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 09:30:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:43 INFO - Return code: 0 09:30:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:43 INFO - ENV: RUST_BACKTRACE is now 1 09:30:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30: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/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:30: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/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 09:30:43 INFO - Using env: {'DISPLAY': ':0', 09:30:43 INFO - 'HOME': '/home/cltbld', 09:30:43 INFO - 'LANG': 'en_US.UTF-8', 09:30:43 INFO - 'LANGUAGE': 'en_US:en', 09:30:43 INFO - 'LOGNAME': 'cltbld', 09:30:43 INFO - 'MAIL': '/var/mail/cltbld', 09:30:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:43 INFO - 'MOZ_NO_REMOTE': '1', 09:30:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:43 INFO - 'NO_EM_RESTART': '1', 09:30:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:43 INFO - 'PWD': '/builds/slave/test', 09:30:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:43 INFO - 'RUST_BACKTRACE': '1', 09:30:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:30:43 INFO - 'SHELL': '/bin/bash', 09:30:43 INFO - 'SHLVL': '1', 09:30:43 INFO - 'TERM': 'linux', 09:30:43 INFO - 'TMOUT': '86400', 09:30:43 INFO - 'USER': 'cltbld', 09:30:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092', 09:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:43 INFO - '_': '/tools/buildbot/bin/python'} 09:30: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/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:30:43 INFO - mozversion application_buildid: 20170701154225 09:30:43 INFO - mozversion application_changeset: 066a7a160677f90c034758b013a85ee27509392d 09:30:43 INFO - mozversion application_display_name: Nightly 09:30:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:43 INFO - mozversion application_name: Firefox 09:30:43 INFO - mozversion application_remotingname: firefox 09:30:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:30:43 INFO - mozversion application_vendor: Mozilla 09:30:43 INFO - mozversion application_version: 56.0a1 09:30:43 INFO - mozversion platform_buildid: 20170701154225 09:30:43 INFO - mozversion platform_changeset: 066a7a160677f90c034758b013a85ee27509392d 09:30:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:30:43 INFO - mozversion platform_version: 56.0a1 09:30:43 INFO - using testdate: 1498926643 09:30:43 INFO - actual date: 1498926643 09:30:43 INFO - starting webserver on 'localhost:57941' 09:30:43 INFO - SUITE-START | Running 2 tests 09:30:43 INFO - TEST-START | dromaeo_css 09:30:43 INFO - operating with platform_type : linux_ 09:30:43 INFO - Initialising browser for dromaeo_css test... 09:30:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57941/getInfo.html -profile /tmp/tmpoOGOEI/profile 09:30:43 INFO - TEST-INFO | started process 5528 (/builds/slave/test/build/application/firefox/firefox http://localhost:57941/getInfo.html) 09:30:49 INFO - TEST-INFO | 5528: exit 0 09:30:49 INFO - Browser initialized. 09:30:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:49 INFO - TEST-INFO | started process 5734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoOGOEI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:01 INFO - PID 5734 | RSS: Main: 168792064 09:31:01 INFO - PID 5734 | 09:34:04 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57941/tests/dromaeo/cssquery-ext.html) 09:34:06 INFO - PID 5734 | RSS: Main: 175628288 09:34:06 INFO - PID 5734 | 09:37:08 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-ext.html (next: http://localhost:57941/tests/dromaeo/cssquery-jquery.html) 09:37:08 INFO - PID 5734 | RSS: Main: 173379584 09:37:08 INFO - PID 5734 | 09:40:10 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57941/tests/dromaeo/cssquery-mootools.html) 09:40:11 INFO - PID 5734 | RSS: Main: 177094656 09:40:11 INFO - PID 5734 | 09:43:12 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57941/tests/dromaeo/cssquery-prototype.html) 09:43:13 INFO - PID 5734 | RSS: Main: 176390144 09:43:13 INFO - PID 5734 | 09:46:15 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57941/tests/dromaeo/cssquery-yui.html) 09:46:16 INFO - PID 5734 | RSS: Main: 175079424 09:46:16 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | Cycle 1(1): loaded http://localhost:57941/tests/dromaeo/cssquery-yui.html (next: http://localhost:57941/tests/dromaeo/cssquery-dojo.html) 09:49:18 INFO - PID 5734 | RSS: Main: 178503680 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | __start_tp_report 09:49:18 INFO - PID 5734 | _x_x_mozilla_page_load 09:49:18 INFO - PID 5734 | _x_x_mozilla_page_load_details 09:49:18 INFO - PID 5734 | |i|pagename|runs| 09:49:18 INFO - PID 5734 | |0;dojo.html;3059.2046068022337;3081.876724931003;3109.0206584925745;3135.0751528299156;3140.2777361206936;6043.063325184592;6046.365131661173;6130.2567325581995;6146.016637338027;6179.382061793818;6167.845803854894;6178.567500274982;6179.629222246668;6195.039768835838;6210.906836397447;5678.148277758328;5693.487586117249;5713.114467257561;5736.541076713853;5782.797602083928;5692.57305702072;5700.515456186229;5774;5793.4785869271755;5797.478226959573;5528.198411230389;5586.329640443132;5597.608167428281;5613.354464236583;5679.772809087673;5655.66066036035;5683.232763576905;5706.629069110494;5739.626924249952;5755;5618.2415373924405;5640.351359593617;5649.802256921029;5669.971650141723;5682.005649011407;6082.148499210114;6106.694665266719;6135.32511423743;6135.87728245437;6143.815685529441;6463.450606698436;6490.3509649035195;6580.473562115019;6583.670816459158;6657.23441804189;6619.966900165517;6728.360805723449;6743.123393958803;6751.358620931003;6782.423494003016;6144.539159563051;6232.158658581124;6235.563510554309;6240.656763878031;6258.405451482102;6623.569467984566;6747.257801641816;6873.793786186322;6880.58716477013;6894.482913781487;6388.361163883575;6444.548881578338;6468.353164683588;6482.12491313676;6482.902756458657;6574.243961944342;6589.637569933604;6611.338866113447;6635.203775546869;6662.200535935622;6542.705578248895;6614.503912206604;6628.337166283333;6632.900506492407;6637.933620663828;6613.305602911625;6637.634930078795;6640.800775976729;6641.800745977628;6656.267810540837;5341.973290133525;5415.891682166334;5421.918671219935;5424.484673955968;5452.700101494456;4505.414296141481;4546.590806827401;4562.406887104655;4571.4514258288555;4579.335996280521;5804.506616937608;5855.151003104526;5855.677937713466;5874.970625146847;5884.382139875252;6716.790977623977;6738.258791532928;6739.022841687928;6742.393184613408;6746.595204287759;5821.79623713168;5833.883322333614;5838.036723940502;5839.328477225174;5844.94155058444;5771.192033115367;5815.709214539256;5856.941430585724;5919.940800591939;5940.70296485174;6299.811005669929;6326.8734625306315;6377.234731832024;6455.4190122887285;6480.70836812354;6650.9667451662435;6681.398674119353;6704.7988560343265;6750.763723269662;6753.358430949052;6448.871022579616;6450.709718062604;6457.5479716419395;6461.289258181502;6471.191101112361;6527.184101987252;6542.280349161683;6547.803565893031;6549.214094308713;6549.508786840911;6522.739090436329;6526.67366631676;6616.66916654175;6625.503087268377;6707.094542236736;6356.9046464304;6406.487481001415;6427.421532062137;6446.129772480655;6454.419102280817;6478.449331806849;6483.351664833479;6488.351164883474;6494.383033611799;6498.772542960974;6309.684515774285;6351.587146835441;6352.205974253218;6359.936400635935;6380.042993550819;6338.144350512622;6364.109024736448;6392.296847346695;6399;6418.646974416265;6200.100985357189;6222.377762223922;6310.305866354789;6340.9365906340345;6349.301576826453 09:49:18 INFO - PID 5734 | |1;ext.html;777.9260970207832;823.045267489712;832.0680837462043;859.2266959736237;873.9038705742367;38768.41847372288;39813.402798958035;40177.598224017755;40325.59674403255;40366;35856.462153067725;35886.2822743545;35892.82053589735;35935.64064359356;35972.64027359726;6719.361660642231;6791.151106111736;6853.554518956252;6865.4850886183485;6872.175338959332;6780.49146314026;6845.5892646441125;6879.415249703756;6888.311168883097;6910.654467276616;6850;6871.553349032297;6887.896681549781;6915.962605609148;6917.688704008332;6832.077669514601;6890.793276201722;6896.3793258606465;6921.48088893335;6932.410745086674;6274.749010039593;6309.337519560426;6325.9051114233325;6337.588056776341;6344.587601805868;33799.493007604906;33828.32343353119;33946.32107357839;33953.32093358119;34034.48948265778;3456.6716161964823;3487.5640544931885;3494.8951531454095;3613.3495970725257;3707.295613833363;31261.687383126104;31282;31314;31382.372352552822;31429.685703143132;4676.579107880273;4835.613150947951;4886.657933944625;4938.135826230431;4954.182559877616;189475;191535;192999.9999999986;195665;196126;41234.38148427776;47799.283010754865;48501.27248091281;48900.510994890305;49053;50603;50784.74607626938;50788.74605626948;50792.49207507951;50861.23708144381;16150.273237704332;16202.513924582281;16286;16381.508554743377;16413;13333;13354;13381.598552043455;13382.799258011137;13572.660683482993;14156.575302740934;14210.715785684228;14220.928895355457;14283.928580357031;14416.85583144176;5741.110127930177;5750.683712395775;5781.8554536136935;5859.121131830259;5905.379935106752;967.8354679704468;977.8998626545136;980.4215512847454;1008.4050410257983;1023.4371095897376;22622;22937.770622293898;22954.311370658907;23253.883730581576;23508.29475115715;1069.3638732738923;1070.1492313610697;1081.9459027048615;1106.0985296982933;1108.5621179634;12122.515099396102;12225.633231003085;12246;12314.13801033919;12514.482042267522;230989;232099;232188;233037;233267;51742.74128629333;51936;51983.22025169626;52446.737766311686;52458.21312680313;1414.70291238841;1463.978040329396;1467.0830730793255;1467.4570408948757;1474.6755713743173;21227.787722122583;22402.439939001004;22444.438889027904;22476;22691.432714181617;36046.459303111;36098.99999999895;36207.7327293554;36257.093572660895;36353.81823090868;190278;190636;191783;192215;192937;29495.410091797614;29682.703172967995;29903;29909.401811964075;32933.34133317368;36361.63638363582;36639;36708.632913670524;42442.78778606211;43138.352924706785;30639.846800765852;31517.212069698442;31636.683633163375;31704.524432133996;35290.82354588211;34413;35101.8244908784;35192.64807351996;35327.823360883034;35447.29105417929;39694;39711.40432893451;39738;39853.20293594054;40168.79915600403;39185.21629567336;40826.79586602048;41351.96620084522;41455.7927210362;41520;23348;24997.87501062483;25159.119430820567;25691.614625781003;26257.21228363152 09:49:18 INFO - PID 5734 | |2;jquery.html;561.3712641841139;562.5977426140308;566.1846940405818;566.8781212039412;591.5149577346575;21109.99999999998;21982.450438739;22016.8899155504;22041.33875983721;22182.112715491403;23949.401264968383;25180.37049073774;26334.6049809253;26607.86696066522;26651.200463986064;6240.937590624104;6379.298277189506;6393.488520918316;6400;6411.134496842937;6406.839829004289;6442.806715798533;6443.323451037644;6443.871122577569;6462;5834.824955251328;6294.307626161141;6339.746410143589;6402.903956440658;6421.8394540136405;6316.810495685114;6352.07894855248;6362.650054247015;6367.108604795286;6371.299157092693;5919.1713160157615;5951.196588460546;5957.225560677084;5960.821175364746;5968.343482216953;27309.726902730916;28616.85691571529;29005.854970725224;29023.41953160925;29071.70928290711;1920.6830872906094;1969.812867777559;1976.0811222781476;1979.3369221310734;1989.3733473955658;17355.13224338778;17660.646787064186;17800;17862.106894655215;17864.196111174897;2293.7247530296304;2328.5924963131383;2359.0681680736184;2362.598358279097;2370.502194539149;121229.39385303017;122803.77196228012;124996;128598.3570082153;129582;13936.651583710489;14352.856471435152;14596.927015365067;14668.266586670623;14913.105213687213;23079.15366770654;23181.188658397212;23206.53586928252;23228;23254.7674523256;10041.849372259421;10213.693589192337;10325.32885362449;10390.792184156275;10449.68650940473;9422.811543769087;9433.716988490356;9459.716208513755;9533.809323813624;9689.41863488193;8795.560221988875;8831.381803273709;8943.910560894437;8978.685745998859;9104.81790364189;2349.283468542077;2542.936426589313;2575.8068144888834;2626.8949242030485;2676.785857131425;915.5239275576663;962.8301613539443;964.5081008685621;967.2697113679268;974.8342781727123;19180.71228931567;19310;19549.120289587;19659.213631454866;19674.213031478866;970.3983530211173;1006.9949650251848;1030.5568605499557;1037.180627304421;1044.1333693034915;10426.843597346045;10502.947485262524;10544.578216871392;10741.624043158452;11043.392613406178;493056;503128;507232;509131;509411;105351;107087.39368909472;108452;110597;111806.44096779627;1203.7953547896702;1274.5921305182437;1277.0422183362477;1277.399622177575;1304.9673758156123;19988.700169497177;20072.89963550173;20588.58822823565;20713.689294660893;20964;50839.74580127076;53175.20237196523;53322.46677533175;54892;55576.16635750386;65438;65574.67212663907;68797.3120268791;69255;69378;12619.936900315439;12759.808602870778;13096.410661520446;13119.868801312246;13239.66900827487;14863.851361486246;15366.308516116578;15499.84500154984;19126.521836954187;19362.612747745246;12345.444454999726;12543.498260069495;12688.429020694275;14728.631784205052;15637.218139093227;13162.736745265232;13231.3384330785;14083.507077252656;14919.627009324853;14960.925195373953;15175.924120379328;16039.67920641604;16276.837231627533;16546.58633534171;16570.337186512887;12561.309127998047;12817.038722096067;12875.420606072936;13170.275634840176;13308.46766129344;15912.44306449315;15936;15936.840631593535;16027.599310017344;16136.273867676218 09:49:18 INFO - PID 5734 | |3;mootools.html;1328.2429015461184;1384.729977654357;1386.9514566990158;1401.5164768154982;1406.4936622815792;13657.521986730453;13684.11053281536;14368.994170408076;14378.352974116164;14384.712305753892;13734.381952812122;14543.490977815778;14558.272086395664;14568.12591244526;14686.265686715647;2413.203642797877;2458.1765108688523;2463.519613675334;2467.494163696447;2474.443250268684;2594.662693849806;2643.2598872315784;2692.932676683079;2697.2717366311085;2705.7700095491905;2479.504099180171;2623.213036089175;2660.3482146874044;2693.609426633137;2703.6620422447195;2516.584763514018;2609.1520255916807;2633.3679916820015;2633.473305338921;2646.338415396151;2495.6523477322226;2530.0765220694498;2532.4175439648798;2532.5821239495463;2544.0714139339193;13451.125676830974;13570.778629923354;13573.796393054112;13574.45702171912;13645.454181832714;7246.420286377077;7530.43521735872;7620.314171724572;7625.504342217738;7625.923740762577;4934.457209706965;5045.672031317952;5234.057869583474;5241.213817927303;5261.184516399964;1841.9631607367778;1881.8118188181209;1891.186789680437;1952.5021119614407;1972.1914015253676;22839.885800571057;22956.65565016526;23071.19250826213;23218.419539511477;23255.651165232535;6302.527310451735;6365.522585806083;6380.968095159495;6444.13004244421;6606.10817539626;15460.38158473671;15461.690766184613;15479.767803482957;15534.456294029655;15567.844321556866;7364.189939106694;7499.2500749924575;7562.130355009134;7578.393728501706;7592.962035189788;6870.31296870309;7038.049863268496;7040.5071644984355;7094.432445404355;7162.928370716226;4648.395708557933;4886.364772579542;4887.218045112765;4967.5777558907175;4985.875353116201;1354.552997510819;1386.6048176269917;1399.2649115097408;1406.8944829137856;1417.758980973237;862.8748831419409;864.148813418782;887.9556022198993;892.5983307511646;900.090908182727;6911.447084233249;6972.755953541602;7014.92985070153;7045.436365090781;7052.435805135577;691.7060249393987;713.8857782754734;718.48987219074;722.458156382713;722.819295176206;4860.246661767432;5500.889982200333;5545.584081193927;5767.250257466587;5819.505342045889;18519;18882.905585471985;18926.716099258523;19085.80914190868;19112.713309300372;18266.725999110025;18631.627367452576;18682.532936676693;18731.625367492576;19021.90489047546;9988.950055249677;10146.239032072624;10466.319689220176;10551.20865935058;10650.094741946867;7783.43146761556;7944.404169687181;8172.7956801080445;8216.014078310642;8617.48295102296;15364.692706146037;16447.25987330549;16844.747328789832;16865;17305.480835574952;16640.084795336374;16736.916315418344;16781.16094195261;16946.491605251864;17062.91468542699;11244.437778111225;11503.942480287546;11574.71063223426;11584.42077896085;11586.204138358567;12368.75262494727;12735.172213806072;12783.680407989874;12973.610791676265;13086.214827110403;10101;10377.292836904051;10416.895831041593;10595.470226488798;10828.945855270673;10194.490275486047;10357.63748268807;10497.370157790558;10700.090492307929;10839.783204335712;9301.395409298373;9336.906630933603;9378.249740020645;9403.106704863027;9442.622295108118;5992.340842507408;6247.812565623039;6713.093732346266;6842.144731908512;6875.346842049998;6933.306669333027;6969;7061.8940715888275;7078.256783037913;7111.573305601681 09:49:18 INFO - PID 5734 | |4;prototype.html;478.6027597094412;496.913040217962;514.9948500514995;517.3610590920215;520.2638266852404;6011.519078473722;6032;6149.295788721632;6156.56904016719;6201.441870231678;5681.176229446728;5875.970620146893;5898.675572843492;5908.379620139888;5965.1946987156725;4746.976265118678;4809.206480930642;4834.250691142861;4886.096072226632;4915.975420122894;4833.984863178736;4846.273059041137;4857.2714092886;4892.486288939664;4912.606991440676;4813.422389313288;4816.63875209359;4823.589994850442;4827.56551910328;4845.152098382769;4564.348521183057;4782.904341913177;4841.394825646794;4843.321934929113;4886.460764859058;4333.133373325316;4360.171567402215;4393.5606439356125;4401.691881568291;4409.382686423904;5781.277340332458;5801.82594522165;5818.476337129637;5910.408959104098;5911.970440147772;5490.286262785812;5540.058190107691;5554.111342185231;5555.972220138873;5576.275084239023;6265.968670156665;6280.466160376373;6280.748770049193;6338.714757835863;6343.904841427382;4655.162070827249;4690.390249267573;4693.507181745902;4775.355327030841;4780.972091000452;6709.496787740939;6712.463002959751;6720.462363010996;6733.158355205599;6768.864622707519;4860.659753817199;4902.970376221034;4908.2637604358915;4914.410270767531;4923.384576927884;4976.651634385558;4977.601791856643;4994.600431965434;5002.049610573979;5007.522780779679;5555.333359996826;5607.214989901417;5609.102543593087;5652.654148528397;5653.378128405872;6385.425311721968;6414.8717025659225;6452.516061295421;6485.643289619022;6517.152770139852;1604.3823128095767;1723.414039226669;1735.1671197825115;1742.830176430327;1753.9912300438416;1195.3724294745155;1199;1200.165884710118;1207.2394391533453;1208.2508844516456;5438.428964958623;5593.244911936918;5643;5652;5703.458171473703;6352.650604216812;6474.838129046811;6566.212054553484;6604.0093985902495;6664.900026499607;5562.833115006556;5571.192177134374;5607.971960140173;5683.715814209273;5716.685582293014;3465.3242617689307;3477.704395126392;3480.112571294304;3507.4563442666426;3514.2268700885766;6290.144407399828;6360.809175724736;6386.914224581832;6409.262934762562;6453.483721302285;6625.701843417058;6668.2324486664875;6681.298463661343;6688.498362622823;6721.092652491851;6211.3167551569295;6304.275008374096;6332.430081292706;6334.936650633527;6338.619682819046;6490.383413575892;6531.510136739668;6581.848176569177;6582.703778329891;6600.966995164993;6372.654356462894;6414.5189110815945;6421.486281097595;6457.288818463205;6486.578372405778;6176.629402235881;6311.368863113836;6343.097070878625;6368.949123394588;6390.648514331757;4629.425995161661;4735.952640473552;4771.284307353924;4835.709857408567;4844.491328410466;6369.172007638977;6492.805215843532;6527.379898909596;6604.966975165094;6612.404883560503;6185.2886918003205;6271.3728627136925;6319.96840015797;6324.968375158095;6342.175517182736;6278.246610406781;6319.715612797343;6340.461060809883;6340.65126418033;6346.873062538816;6149.907751383644;6163.291221509584;6182.752689892354;6249.96875015622;6268.937310626835;6310.6213627182515;6378;6381.308953127518;6396.520260980538;6406.135171751754;6168.753249869955;6171.444569988723;6174.413430724074;6256.468200202851;6283.120363149254 09:49:18 INFO - PID 5734 | |5;yui.html;915.3363811236854;922.8615707643849;940.8541676040212;941.8351788437021;944.9244060475163;18307.90846045768;18323;18778;19011.144498497568;19127.617447651057;16756.2459689314;16822.57943551412;16826.663466730657;16837.91581042093;18828.652253977983;1032.6334151376284;1068.4123731947436;1079.3362082319356;1079.6976846482996;1080.6811990462793;1050.76883085721;1058.6347710040025;1063.1972860490318;1063.4310643805566;1068.9251752377336;1118.2284223885533;1121.859767529059;1124.5951457475344;1129.774045190961;1131.0160160660196;1088.5645741703304;1089.6839916424228;1110.6723516562593;1127.0645364347572;1129.790988667095;801.046754362307;801.1667865419956;810.5947026486757;812.7480481050893;813.9552324622143;18923.24307027731;19170.904145479322;19179.041047947547;19197.712034319356;19215.80784192154;19078.618427631507;19890;20122.79877201224;20127.0942807574;20217.494562635904;15047;16102.436414725546;16125.113118778463;16246.837531624651;16356.591085222846;3519.278547897675;3559.76861504004;3562.982185089058;3564.108972756811;3572.624874388204;101826.49086754519;102513;104889;107811.46094269557;108017.45991270072;16152.757708634379;16488.17559122039;16741.079240641637;16778.496645100666;16783.328666853435;29075.85462072676;29511.55732664012;29672.40655186884;29779.40441191164;29976.25059373533;8602.139786021473;8603.5698215089;8687.739367818975;8702.608382622797;8715.869261961076;3992.740471869319;4034.253663072341;4044.6157615026527;4061.5329237137516;4075.4294398784195;4927.310176575283;5000.874978125576;5051.545360917462;5109.029284435946;5110.0801855665595;1029.0532709906904;1048.1719441641171;1056.1392465140887;1067.5196161727254;1068.1188019883627;666.2637785247232;677.9457643388517;682.757621044522;707.982300442493;714.5641158893071;11695.766084678258;11781;12146.939265303618;12155.270683759003;12877.356132193352;625.9436650701459;640.6124294801671;649.5420728386476;654.4829584628186;658.4600627485416;5342.706151161723;5863.648181109062;6047.818565443044;6052.273727152682;6596.215530745685;94048.52975735077;94897;98297.50851245697;101389.49305253426;102787;82921.17078829255;87251.56374218088;87562;88473;90469.54765226263;72692;74043.62978185074;76072;76499;78254.60872695714;11683.18217724751;11793.537129889564;12022.75954480888;12419.627411177678;12504.437300321326;33486.33027339488;34644.82677586596;34929.47605785966;35046.94859154229;36016.09959751027;41939.37090943699;43749.56250437582;44613.55386446094;44638.55361446474;45583.77208113938;18138.455846324632;18472.630547389246;18568.5357866049;18610.534736631693;18626.72059919075;19432.2227110914;20277;20551.280705175846;20605.896970515052;20895.164193432094;18121.818781812013;18375.54061148482;18551.53621159482;18883.05584720786;18884;18268.543286417946;18455.53861153482;18623.44129676112;18802.52993675169;19030.904845475685;16836.410725625035;18013.2794688211;18131.456056318333;18160.636787264444;18259.634807304046;12802.743945121232;12924.483020679443;12979.286139262054;13363.73044560765;13493.595192144252;13002.349882505649;13531.255780932142;13832.861671383158;13926.442942282196;13945.721085578029 09:49:18 INFO - PID 5734 | __end_tp_report 09:49:18 INFO - PID 5734 | __start_cc_report 09:49:18 INFO - PID 5734 | _x_x_mozilla_cycle_collect,345 09:49:18 INFO - PID 5734 | __end_cc_report 09:49:18 INFO - PID 5734 | __startTimestamp1498927758543__endTimestamp 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | ------- Summary: start ------- 09:49:18 INFO - PID 5734 | Number of tests: 6 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#0] dojo.html Cycles:165 Average:6104.62 Median:6340.94 stddev:717.19 (11.3%) stddev-sans-first:678.43 09:49:18 INFO - PID 5734 | Values: 3059.2 3081.9 3109.0 3135.1 3140.3 6043.1 6046.4 6130.3 6146.0 6179.4 6167.8 6178.6 6179.6 6195.0 6210.9 5678.1 5693.5 5713.1 5736.5 5782.8 5692.6 5700.5 5774.0 5793.5 5797.5 5528.2 5586.3 5597.6 5613.4 5679.8 5655.7 5683.2 5706.6 5739.6 5755.0 5618.2 5640.4 5649.8 5670.0 5682.0 6082.1 6106.7 6135.3 6135.9 6143.8 6463.5 6490.4 6580.5 6583.7 6657.2 6620.0 6728.4 6743.1 6751.4 6782.4 6144.5 6232.2 6235.6 6240.7 6258.4 6623.6 6747.3 6873.8 6880.6 6894.5 6388.4 6444.5 6468.4 6482.1 6482.9 6574.2 6589.6 6611.3 6635.2 6662.2 6542.7 6614.5 6628.3 6632.9 6637.9 6613.3 6637.6 6640.8 6641.8 6656.3 5342.0 5415.9 5421.9 5424.5 5452.7 4505.4 4546.6 4562.4 4571.5 4579.3 5804.5 5855.2 5855.7 5875.0 5884.4 6716.8 6738.3 6739.0 6742.4 6746.6 5821.8 5833.9 5838.0 5839.3 5844.9 5771.2 5815.7 5856.9 5919.9 5940.7 6299.8 6326.9 6377.2 6455.4 6480.7 6651.0 6681.4 6704.8 6750.8 6753.4 6448.9 6450.7 6457.5 6461.3 6471.2 6527.2 6542.3 6547.8 6549.2 6549.5 6522.7 6526.7 6616.7 6625.5 6707.1 6356.9 6406.5 6427.4 6446.1 6454.4 6478.4 6483.4 6488.4 6494.4 6498.8 6309.7 6351.6 6352.2 6359.9 6380.0 6338.1 6364.1 6392.3 6399.0 6418.6 6200.1 6222.4 6310.3 6340.9 6349.3 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#1] ext.html Cycles:180 Average:37240.50 Median:35871.37 stddev:53547.52 (149.3%) stddev-sans-first:53627.74 09:49:18 INFO - PID 5734 | Values: 777.9 823.0 832.1 859.2 873.9 38768.4 39813.4 40177.6 40325.6 40366.0 35856.5 35886.3 35892.8 35935.6 35972.6 6719.4 6791.2 6853.6 6865.5 6872.2 6780.5 6845.6 6879.4 6888.3 6910.7 6850.0 6871.6 6887.9 6916.0 6917.7 6832.1 6890.8 6896.4 6921.5 6932.4 6274.7 6309.3 6325.9 6337.6 6344.6 33799.5 33828.3 33946.3 33953.3 34034.5 3456.7 3487.6 3494.9 3613.3 3707.3 31261.7 31282.0 31314.0 31382.4 31429.7 4676.6 4835.6 4886.7 4938.1 4954.2 189475.0 191535.0 193000.0 195665.0 196126.0 41234.4 47799.3 48501.3 48900.5 49053.0 50603.0 50784.7 50788.7 50792.5 50861.2 16150.3 16202.5 16286.0 16381.5 16413.0 13333.0 13354.0 13381.6 13382.8 13572.7 14156.6 14210.7 14220.9 14283.9 14416.9 5741.1 5750.7 5781.9 5859.1 5905.4 967.8 977.9 980.4 1008.4 1023.4 22622.0 22937.8 22954.3 23253.9 23508.3 1069.4 1070.1 1081.9 1106.1 1108.6 12122.5 12225.6 12246.0 12314.1 12514.5 230989.0 232099.0 232188.0 233037.0 233267.0 51742.7 51936.0 51983.2 52446.7 52458.2 1414.7 1464.0 1467.1 1467.5 1474.7 21227.8 22402.4 22444.4 22476.0 22691.4 36046.5 36099.0 36207.7 36257.1 36353.8 190278.0 190636.0 191783.0 192215.0 192937.0 29495.4 29682.7 29903.0 29909.4 32933.3 36361.6 36639.0 36708.6 42442.8 43138.4 30639.8 31517.2 31636.7 31704.5 35290.8 34413.0 35101.8 35192.6 35327.8 35447.3 39694.0 39711.4 39738.0 39853.2 40168.8 39185.2 40826.8 41352.0 41455.8 41520.0 23348.0 24997.9 25159.1 25691.6 26257.2 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#2] jquery.html Cycles:180 Average:33756.68 Median:21999.67 stddev:84296.57 (383.2%) stddev-sans-first:84496.20 09:49:18 INFO - PID 5734 | Values: 561.4 562.6 566.2 566.9 591.5 21110.0 21982.5 22016.9 22041.3 22182.1 23949.4 25180.4 26334.6 26607.9 26651.2 6240.9 6379.3 6393.5 6400.0 6411.1 6406.8 6442.8 6443.3 6443.9 6462.0 5834.8 6294.3 6339.7 6402.9 6421.8 6316.8 6352.1 6362.7 6367.1 6371.3 5919.2 5951.2 5957.2 5960.8 5968.3 27309.7 28616.9 29005.9 29023.4 29071.7 1920.7 1969.8 1976.1 1979.3 1989.4 17355.1 17660.6 17800.0 17862.1 17864.2 2293.7 2328.6 2359.1 2362.6 2370.5 121229.4 122803.8 124996.0 128598.4 129582.0 13936.7 14352.9 14596.9 14668.3 14913.1 23079.2 23181.2 23206.5 23228.0 23254.8 10041.8 10213.7 10325.3 10390.8 10449.7 9422.8 9433.7 9459.7 9533.8 9689.4 8795.6 8831.4 8943.9 8978.7 9104.8 2349.3 2542.9 2575.8 2626.9 2676.8 915.5 962.8 964.5 967.3 974.8 19180.7 19310.0 19549.1 19659.2 19674.2 970.4 1007.0 1030.6 1037.2 1044.1 10426.8 10502.9 10544.6 10741.6 11043.4 493056.0 503128.0 507232.0 509131.0 509411.0 105351.0 107087.4 108452.0 110597.0 111806.4 1203.8 1274.6 1277.0 1277.4 1305.0 19988.7 20072.9 20588.6 20713.7 20964.0 50839.7 53175.2 53322.5 54892.0 55576.2 65438.0 65574.7 68797.3 69255.0 69378.0 12619.9 12759.8 13096.4 13119.9 13239.7 14863.9 15366.3 15499.8 19126.5 19362.6 12345.4 12543.5 12688.4 14728.6 15637.2 13162.7 13231.3 14083.5 14919.6 14960.9 15175.9 16039.7 16276.8 16546.6 16570.3 12561.3 12817.0 12875.4 13170.3 13308.5 15912.4 15936.0 15936.8 16027.6 16136.3 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#3] mootools.html Cycles:180 Average:8570.13 Median:2506.12 stddev:5859.36 (233.8%) stddev-sans-first:5850.53 09:49:18 INFO - PID 5734 | Values: 1328.2 1384.7 1387.0 1401.5 1406.5 13657.5 13684.1 14369.0 14378.4 14384.7 13734.4 14543.5 14558.3 14568.1 14686.3 2413.2 2458.2 2463.5 2467.5 2474.4 2594.7 2643.3 2692.9 2697.3 2705.8 2479.5 2623.2 2660.3 2693.6 2703.7 2516.6 2609.2 2633.4 2633.5 2646.3 2495.7 2530.1 2532.4 2532.6 2544.1 13451.1 13570.8 13573.8 13574.5 13645.5 7246.4 7530.4 7620.3 7625.5 7625.9 4934.5 5045.7 5234.1 5241.2 5261.2 1842.0 1881.8 1891.2 1952.5 1972.2 22839.9 22956.7 23071.2 23218.4 23255.7 6302.5 6365.5 6381.0 6444.1 6606.1 15460.4 15461.7 15479.8 15534.5 15567.8 7364.2 7499.3 7562.1 7578.4 7593.0 6870.3 7038.0 7040.5 7094.4 7162.9 4648.4 4886.4 4887.2 4967.6 4985.9 1354.6 1386.6 1399.3 1406.9 1417.8 862.9 864.1 888.0 892.6 900.1 6911.4 6972.8 7014.9 7045.4 7052.4 691.7 713.9 718.5 722.5 722.8 4860.2 5500.9 5545.6 5767.3 5819.5 18519.0 18882.9 18926.7 19085.8 19112.7 18266.7 18631.6 18682.5 18731.6 19021.9 9989.0 10146.2 10466.3 10551.2 10650.1 7783.4 7944.4 8172.8 8216.0 8617.5 15364.7 16447.3 16844.7 16865.0 17305.5 16640.1 16736.9 16781.2 16946.5 17062.9 11244.4 11503.9 11574.7 11584.4 11586.2 12368.8 12735.2 12783.7 12973.6 13086.2 10101.0 10377.3 10416.9 10595.5 10828.9 10194.5 10357.6 10497.4 10700.1 10839.8 9301.4 9336.9 9378.2 9403.1 9442.6 5992.3 6247.8 6713.1 6842.1 6875.3 6933.3 6969.0 7061.9 7078.3 7111.6 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#4] prototype.html Cycles:180 Average:5355.56 Median:5903.53 stddev:1498.25 (25.4%) stddev-sans-first:1457.05 09:49:18 INFO - PID 5734 | Values: 478.6 496.9 515.0 517.4 520.3 6011.5 6032.0 6149.3 6156.6 6201.4 5681.2 5876.0 5898.7 5908.4 5965.2 4747.0 4809.2 4834.3 4886.1 4916.0 4834.0 4846.3 4857.3 4892.5 4912.6 4813.4 4816.6 4823.6 4827.6 4845.2 4564.3 4782.9 4841.4 4843.3 4886.5 4333.1 4360.2 4393.6 4401.7 4409.4 5781.3 5801.8 5818.5 5910.4 5912.0 5490.3 5540.1 5554.1 5556.0 5576.3 6266.0 6280.5 6280.7 6338.7 6343.9 4655.2 4690.4 4693.5 4775.4 4781.0 6709.5 6712.5 6720.5 6733.2 6768.9 4860.7 4903.0 4908.3 4914.4 4923.4 4976.7 4977.6 4994.6 5002.0 5007.5 5555.3 5607.2 5609.1 5652.7 5653.4 6385.4 6414.9 6452.5 6485.6 6517.2 1604.4 1723.4 1735.2 1742.8 1754.0 1195.4 1199.0 1200.2 1207.2 1208.3 5438.4 5593.2 5643.0 5652.0 5703.5 6352.7 6474.8 6566.2 6604.0 6664.9 5562.8 5571.2 5608.0 5683.7 5716.7 3465.3 3477.7 3480.1 3507.5 3514.2 6290.1 6360.8 6386.9 6409.3 6453.5 6625.7 6668.2 6681.3 6688.5 6721.1 6211.3 6304.3 6332.4 6334.9 6338.6 6490.4 6531.5 6581.8 6582.7 6601.0 6372.7 6414.5 6421.5 6457.3 6486.6 6176.6 6311.4 6343.1 6368.9 6390.6 4629.4 4736.0 4771.3 4835.7 4844.5 6369.2 6492.8 6527.4 6605.0 6612.4 6185.3 6271.4 6320.0 6325.0 6342.2 6278.2 6319.7 6340.5 6340.7 6346.9 6149.9 6163.3 6182.8 6250.0 6268.9 6310.6 6378.0 6381.3 6396.5 6406.1 6168.8 6171.4 6174.4 6256.5 6283.1 09:49:18 INFO - PID 5734 | 09:49:18 INFO - PID 5734 | [#5] yui.html Cycles:180 Average:21190.41 Median:19021.02 stddev:27181.39 (142.9%) stddev-sans-first:27215.01 09:49:18 INFO - PID 5734 | Values: 915.3 922.9 940.9 941.8 944.9 18307.9 18323.0 18778.0 19011.1 19127.6 16756.2 16822.6 16826.7 16837.9 18828.7 1032.6 1068.4 1079.3 1079.7 1080.7 1050.8 1058.6 1063.2 1063.4 1068.9 1118.2 1121.9 1124.6 1129.8 1131.0 1088.6 1089.7 1110.7 1127.1 1129.8 801.0 801.2 810.6 812.7 814.0 18923.2 19170.9 19179.0 19197.7 19215.8 19078.6 19890.0 20122.8 20127.1 20217.5 15047.0 16102.4 16125.1 16246.8 16356.6 3519.3 3559.8 3563.0 3564.1 3572.6 101826.5 102513.0 104889.0 107811.5 108017.5 16152.8 16488.2 16741.1 16778.5 16783.3 29075.9 29511.6 29672.4 29779.4 29976.3 8602.1 8603.6 8687.7 8702.6 8715.9 3992.7 4034.3 4044.6 4061.5 4075.4 4927.3 5000.9 5051.5 5109.0 5110.1 1029.1 1048.2 1056.1 1067.5 1068.1 666.3 677.9 682.8 708.0 714.6 11695.8 11781.0 12146.9 12155.3 12877.4 625.9 640.6 649.5 654.5 658.5 5342.7 5863.6 6047.8 6052.3 6596.2 94048.5 94897.0 98297.5 101389.5 102787.0 82921.2 87251.6 87562.0 88473.0 90469.5 72692.0 74043.6 76072.0 76499.0 78254.6 11683.2 11793.5 12022.8 12419.6 12504.4 33486.3 34644.8 34929.5 35046.9 36016.1 41939.4 43749.6 44613.6 44638.6 45583.8 18138.5 18472.6 18568.5 18610.5 18626.7 19432.2 20277.0 20551.3 20605.9 20895.2 18121.8 18375.5 18551.5 18883.1 18884.0 18268.5 18455.5 18623.4 18802.5 19030.9 16836.4 18013.3 18131.5 18160.6 18259.6 12802.7 12924.5 12979.3 13363.7 13493.6 13002.3 13531.3 13832.9 13926.4 13945.7 09:49:18 INFO - PID 5734 | -------- Summary: end -------- 09:49:18 INFO - PID 5734 | 09:49:19 INFO - TEST-INFO | 5734: exit 0 09:49:19 INFO - TEST-OK | dromaeo_css | took 1115875ms 09:49:19 INFO - TEST-START | kraken 09:49:19 INFO - operating with platform_type : linux_ 09:49:19 INFO - Initialising browser for kraken test... 09:49:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57941/getInfo.html -profile /tmp/tmpRFkSBN/profile 09:49:19 INFO - TEST-INFO | started process 6137 (/builds/slave/test/build/application/firefox/firefox http://localhost:57941/getInfo.html) 09:49:25 INFO - TEST-INFO | 6137: exit 0 09:49:25 INFO - Browser initialized. 09:49:25 INFO - Running cycle 1/1 for kraken test... 09:49:25 INFO - TEST-INFO | started process 6344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFkSBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:37 INFO - PID 6344 | RSS: Main: 169373696 09:49:37 INFO - PID 6344 | 09:49:39 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57941/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:40 INFO - PID 6344 | RSS: Main: 173363200 09:49:40 INFO - PID 6344 | 09:49:43 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57941/tests/kraken/driver.html?testName=audio-dft) 09:49:43 INFO - PID 6344 | RSS: Main: 173772800 09:49:43 INFO - PID 6344 | 09:49:46 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57941/tests/kraken/driver.html?testName=audio-fft) 09:49:47 INFO - PID 6344 | RSS: Main: 169238528 09:49:47 INFO - PID 6344 | 09:49:49 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57941/tests/kraken/driver.html?testName=audio-oscillator) 09:49:50 INFO - PID 6344 | RSS: Main: 169934848 09:49:50 INFO - PID 6344 | 09:49:52 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:52 INFO - PID 6344 | RSS: Main: 169848832 09:49:52 INFO - PID 6344 | 09:49:55 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57941/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:56 INFO - PID 6344 | RSS: Main: 173318144 09:49:56 INFO - PID 6344 | 09:49:59 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57941/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:00 INFO - PID 6344 | RSS: Main: 174739456 09:50:00 INFO - PID 6344 | 09:50:03 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57941/tests/kraken/driver.html?testName=json-parse-financial) 09:50:03 INFO - PID 6344 | RSS: Main: 173375488 09:50:03 INFO - PID 6344 | 09:50:05 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:05 INFO - PID 6344 | RSS: Main: 173805568 09:50:05 INFO - PID 6344 | 09:50:07 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:08 INFO - PID 6344 | RSS: Main: 173707264 09:50:08 INFO - PID 6344 | 09:50:10 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:11 INFO - PID 6344 | RSS: Main: 174231552 09:50:11 INFO - PID 6344 | 09:50:13 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:14 INFO - PID 6344 | RSS: Main: 173858816 09:50:14 INFO - PID 6344 | 09:50:17 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:18 INFO - PID 6344 | RSS: Main: 174264320 09:50:18 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | Cycle 1(1): loaded http://localhost:57941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57941/tests/kraken/driver.html?testName=ai-astar) 09:50:19 INFO - PID 6344 | RSS: Main: 175783936 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | __start_tp_report 09:50:19 INFO - PID 6344 | _x_x_mozilla_page_load 09:50:19 INFO - PID 6344 | _x_x_mozilla_page_load_details 09:50:19 INFO - PID 6344 | |i|pagename|runs| 09:50:19 INFO - PID 6344 | |0;ai-astar;101;109;109;110;108;110;110;110;111;114 09:50:19 INFO - PID 6344 | |1;audio-beat-detection;148;127;153;175;126;144;158;127;184;129 09:50:19 INFO - PID 6344 | |2;audio-dft;163;162;165;161;162;170;164;169;170;163 09:50:19 INFO - PID 6344 | |3;audio-fft;74;75;75;159;74;75;74;74;96;74 09:50:19 INFO - PID 6344 | |4;audio-oscillator;82;82;131;82;84;83;130;82;82;139 09:50:19 INFO - PID 6344 | |5;imaging-gaussian-blur;114;113;114;113;114;114;114;114;114;114 09:50:19 INFO - PID 6344 | |6;imaging-darkroom;150;150;150;150;149;150;150;150;152;152 09:50:19 INFO - PID 6344 | |7;imaging-desaturate;94;95;95;94;94;95;94;93;95;94 09:50:19 INFO - PID 6344 | |8;json-parse-financial;55;55;56;55;57;55;55;56;54;55 09:50:19 INFO - PID 6344 | |9;json-stringify-tinderbox;55;55;54;54;54;55;55;54;55;55 09:50:19 INFO - PID 6344 | |10;stanford-crypto-aes;80;76;78;78;78;77;78;84;78;80 09:50:19 INFO - PID 6344 | |11;stanford-crypto-ccm;127;143;130;128;130;126;129;129;130;161 09:50:19 INFO - PID 6344 | |12;stanford-crypto-pbkdf2;186;179;182;182;189;179;186;184;176;185 09:50:19 INFO - PID 6344 | |13;stanford-crypto-sha256-iterative;71;68;71;70;66;70;71;70;66;68 09:50:19 INFO - PID 6344 | __end_tp_report 09:50:19 INFO - PID 6344 | __start_cc_report 09:50:19 INFO - PID 6344 | _x_x_mozilla_cycle_collect,944 09:50:19 INFO - PID 6344 | __end_cc_report 09:50:19 INFO - PID 6344 | __startTimestamp1498927819985__endTimestamp 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | ------- Summary: start ------- 09:50:19 INFO - PID 6344 | Number of tests: 14 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.29 (3.0%) stddev-sans-first:1.69 09:50:19 INFO - PID 6344 | Values: 101.0 109.0 109.0 110.0 108.0 110.0 110.0 110.0 111.0 114.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:150.50 stddev:20.78 (13.8%) stddev-sans-first:22.03 09:50:19 INFO - PID 6344 | Values: 148.0 127.0 153.0 175.0 126.0 144.0 158.0 127.0 184.0 129.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.48 (2.1%) stddev-sans-first:3.62 09:50:19 INFO - PID 6344 | Values: 163.0 162.0 165.0 161.0 162.0 170.0 164.0 169.0 170.0 163.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.50 stddev:26.88 (36.1%) stddev-sans-first:28.21 09:50:19 INFO - PID 6344 | Values: 74.0 75.0 75.0 159.0 74.0 75.0 74.0 74.0 96.0 74.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:82.00 stddev:24.71 (30.1%) stddev-sans-first:25.54 09:50:19 INFO - PID 6344 | Values: 82.0 82.0 131.0 82.0 84.0 83.0 130.0 82.0 82.0 139.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:50:19 INFO - PID 6344 | Values: 114.0 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:50:19 INFO - PID 6344 | Values: 150.0 150.0 150.0 150.0 149.0 150.0 150.0 150.0 152.0 152.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:50:19 INFO - PID 6344 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 94.0 93.0 95.0 94.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 09:50:19 INFO - PID 6344 | Values: 55.0 55.0 56.0 55.0 57.0 55.0 55.0 56.0 54.0 55.0 09:50:19 INFO - PID 6344 | 09:50:19 INFO - PID 6344 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:50:19 INFO - PID 6344 | Values: 55.0 55.0 54.0 54.0 54.0 55.0 55.0 54.0 55.0 55.0 09:50:19 INFO - PID 6344 | 09:50:20 INFO - PID 6344 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.21 (2.8%) stddev-sans-first:2.30 09:50:20 INFO - PID 6344 | Values: 80.0 76.0 78.0 78.0 78.0 77.0 78.0 84.0 78.0 80.0 09:50:20 INFO - PID 6344 | 09:50:20 INFO - PID 6344 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:130.00 stddev:10.81 (8.3%) stddev-sans-first:11.22 09:50:20 INFO - PID 6344 | Values: 127.0 143.0 130.0 128.0 130.0 126.0 129.0 129.0 130.0 161.0 09:50:20 INFO - PID 6344 | 09:50:20 INFO - PID 6344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:184.50 stddev:3.97 (2.1%) stddev-sans-first:4.03 09:50:20 INFO - PID 6344 | Values: 186.0 179.0 182.0 182.0 189.0 179.0 186.0 184.0 176.0 185.0 09:50:20 INFO - PID 6344 | 09:50:20 INFO - PID 6344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:1.96 09:50:20 INFO - PID 6344 | Values: 71.0 68.0 71.0 70.0 66.0 70.0 71.0 70.0 66.0 68.0 09:50:20 INFO - PID 6344 | -------- Summary: end -------- 09:50:20 INFO - PID 6344 | 09:50:20 INFO - TEST-INFO | 6344: exit 0 09:50:20 INFO - TEST-OK | kraken | took 61631ms 09:50:20 INFO - SUITE-END | took 1177s 09:50:21 INFO - Completed test suite (00:19:37) 09:50:21 INFO - javascript benchmark 09:50:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8232.003782695114, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.2046068022337, 3081.876724931003, 3109.0206584925745, 3135.0751528299156, 3140.2777361206936, 6043.063325184592, 6046.365131661173, 6130.2567325581995, 6146.016637338027, 6179.382061793818, 6167.845803854894, 6178.567500274982, 6179.629222246668, 6195.039768835838, 6210.906836397447, 5678.148277758328, 5693.487586117249, 5713.114467257561, 5736.541076713853, 5782.797602083928, 5692.57305702072, 5700.515456186229, 5774.0, 5793.4785869271755, 5797.478226959573, 5528.198411230389, 5586.329640443132, 5597.608167428281, 5613.354464236583, 5679.772809087673, 5655.66066036035, 5683.232763576905, 5706.629069110494, 5739.626924249952, 5755.0, 5618.2415373924405, 5640.351359593617, 5649.802256921029, 5669.971650141723, 5682.005649011407, 6082.148499210114, 6106.694665266719, 6135.32511423743, 6135.87728245437, 6143.815685529441, 6463.450606698436, 6490.3509649035195, 6580.473562115019, 6583.670816459158, 6657.23441804189, 6619.966900165517, 6728.360805723449, 6743.123393958803, 6751.358620931003, 6782.423494003016, 6144.539159563051, 6232.158658581124, 6235.563510554309, 6240.656763878031, 6258.405451482102, 6623.569467984566, 6747.257801641816, 6873.793786186322, 6880.58716477013, 6894.482913781487, 6388.361163883575, 6444.548881578338, 6468.353164683588, 6482.12491313676, 6482.902756458657, 6574.243961944342, 6589.637569933604, 6611.338866113447, 6635.203775546869, 6662.200535935622, 6542.705578248895, 6614.503912206604, 6628.337166283333, 6632.900506492407, 6637.933620663828, 6613.305602911625, 6637.634930078795, 6640.800775976729, 6641.800745977628, 6656.267810540837, 5341.973290133525, 5415.891682166334, 5421.918671219935, 5424.484673955968, 5452.700101494456, 4505.414296141481, 4546.590806827401, 4562.406887104655, 4571.4514258288555, 4579.335996280521, 5804.506616937608, 5855.151003104526, 5855.677937713466, 5874.970625146847, 5884.382139875252, 6716.790977623977, 6738.258791532928, 6739.022841687928, 6742.393184613408, 6746.595204287759, 5821.79623713168, 5833.883322333614, 5838.036723940502, 5839.328477225174, 5844.94155058444, 5771.192033115367, 5815.709214539256, 5856.941430585724, 5919.940800591939, 5940.70296485174, 6299.811005669929, 6326.8734625306315, 6377.234731832024, 6455.4190122887285, 6480.70836812354, 6650.9667451662435, 6681.398674119353, 6704.7988560343265, 6750.763723269662, 6753.358430949052, 6448.871022579616, 6450.709718062604, 6457.5479716419395, 6461.289258181502, 6471.191101112361, 6527.184101987252, 6542.280349161683, 6547.803565893031, 6549.214094308713, 6549.508786840911, 6522.739090436329, 6526.67366631676, 6616.66916654175, 6625.503087268377, 6707.094542236736, 6356.9046464304, 6406.487481001415, 6427.421532062137, 6446.129772480655, 6454.419102280817, 6478.449331806849, 6483.351664833479, 6488.351164883474, 6494.383033611799, 6498.772542960974, 6309.684515774285, 6351.587146835441, 6352.205974253218, 6359.936400635935, 6380.042993550819, 6338.144350512622, 6364.109024736448, 6392.296847346695, 6399.0, 6418.646974416265, 6200.100985357189, 6222.377762223922, 6310.305866354789, 6340.9365906340345, 6349.301576826453], "value": 6050.357519368418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.9260970207832, 823.045267489712, 832.0680837462043, 859.2266959736237, 873.9038705742367, 38768.41847372288, 39813.402798958035, 40177.598224017755, 40325.59674403255, 40366.0, 35856.462153067725, 35886.2822743545, 35892.82053589735, 35935.64064359356, 35972.64027359726, 6719.361660642231, 6791.151106111736, 6853.554518956252, 6865.4850886183485, 6872.175338959332, 6780.49146314026, 6845.5892646441125, 6879.415249703756, 6888.311168883097, 6910.654467276616, 6850.0, 6871.553349032297, 6887.896681549781, 6915.962605609148, 6917.688704008332, 6832.077669514601, 6890.793276201722, 6896.3793258606465, 6921.48088893335, 6932.410745086674, 6274.749010039593, 6309.337519560426, 6325.9051114233325, 6337.588056776341, 6344.587601805868, 33799.493007604906, 33828.32343353119, 33946.32107357839, 33953.32093358119, 34034.48948265778, 3456.6716161964823, 3487.5640544931885, 3494.8951531454095, 3613.3495970725257, 3707.295613833363, 31261.687383126104, 31282.0, 31314.0, 31382.372352552822, 31429.685703143132, 4676.579107880273, 4835.613150947951, 4886.657933944625, 4938.135826230431, 4954.182559877616, 189475.0, 191535.0, 192999.9999999986, 195665.0, 196126.0, 41234.38148427776, 47799.283010754865, 48501.27248091281, 48900.510994890305, 49053.0, 50603.0, 50784.74607626938, 50788.74605626948, 50792.49207507951, 50861.23708144381, 16150.273237704332, 16202.513924582281, 16286.0, 16381.508554743377, 16413.0, 13333.0, 13354.0, 13381.598552043455, 13382.799258011137, 13572.660683482993, 14156.575302740934, 14210.715785684228, 14220.928895355457, 14283.928580357031, 14416.85583144176, 5741.110127930177, 5750.683712395775, 5781.8554536136935, 5859.121131830259, 5905.379935106752, 967.8354679704468, 977.8998626545136, 980.4215512847454, 1008.4050410257983, 1023.4371095897376, 22622.0, 22937.770622293898, 22954.311370658907, 23253.883730581576, 23508.29475115715, 1069.3638732738923, 1070.1492313610697, 1081.9459027048615, 1106.0985296982933, 1108.5621179634, 12122.515099396102, 12225.633231003085, 12246.0, 12314.13801033919, 12514.482042267522, 230989.0, 232099.0, 232188.0, 233037.0, 233267.0, 51742.74128629333, 51936.0, 51983.22025169626, 52446.737766311686, 52458.21312680313, 1414.70291238841, 1463.978040329396, 1467.0830730793255, 1467.4570408948757, 1474.6755713743173, 21227.787722122583, 22402.439939001004, 22444.438889027904, 22476.0, 22691.432714181617, 36046.459303111, 36098.99999999895, 36207.7327293554, 36257.093572660895, 36353.81823090868, 190278.0, 190636.0, 191783.0, 192215.0, 192937.0, 29495.410091797614, 29682.703172967995, 29903.0, 29909.401811964075, 32933.34133317368, 36361.63638363582, 36639.0, 36708.632913670524, 42442.78778606211, 43138.352924706785, 30639.846800765852, 31517.212069698442, 31636.683633163375, 31704.524432133996, 35290.82354588211, 34413.0, 35101.8244908784, 35192.64807351996, 35327.823360883034, 35447.29105417929, 39694.0, 39711.40432893451, 39738.0, 39853.20293594054, 40168.79915600403, 39185.21629567336, 40826.79586602048, 41351.96620084522, 41455.7927210362, 41520.0, 23348.0, 24997.87501062483, 25159.119430820567, 25691.614625781003, 26257.21228363152], "value": 16754.419465146322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3712641841139, 562.5977426140308, 566.1846940405818, 566.8781212039412, 591.5149577346575, 21109.99999999998, 21982.450438739, 22016.8899155504, 22041.33875983721, 22182.112715491403, 23949.401264968383, 25180.37049073774, 26334.6049809253, 26607.86696066522, 26651.200463986064, 6240.937590624104, 6379.298277189506, 6393.488520918316, 6400.0, 6411.134496842937, 6406.839829004289, 6442.806715798533, 6443.323451037644, 6443.871122577569, 6462.0, 5834.824955251328, 6294.307626161141, 6339.746410143589, 6402.903956440658, 6421.8394540136405, 6316.810495685114, 6352.07894855248, 6362.650054247015, 6367.108604795286, 6371.299157092693, 5919.1713160157615, 5951.196588460546, 5957.225560677084, 5960.821175364746, 5968.343482216953, 27309.726902730916, 28616.85691571529, 29005.854970725224, 29023.41953160925, 29071.70928290711, 1920.6830872906094, 1969.812867777559, 1976.0811222781476, 1979.3369221310734, 1989.3733473955658, 17355.13224338778, 17660.646787064186, 17800.0, 17862.106894655215, 17864.196111174897, 2293.7247530296304, 2328.5924963131383, 2359.0681680736184, 2362.598358279097, 2370.502194539149, 121229.39385303017, 122803.77196228012, 124996.0, 128598.3570082153, 129582.0, 13936.651583710489, 14352.856471435152, 14596.927015365067, 14668.266586670623, 14913.105213687213, 23079.15366770654, 23181.188658397212, 23206.53586928252, 23228.0, 23254.7674523256, 10041.849372259421, 10213.693589192337, 10325.32885362449, 10390.792184156275, 10449.68650940473, 9422.811543769087, 9433.716988490356, 9459.716208513755, 9533.809323813624, 9689.41863488193, 8795.560221988875, 8831.381803273709, 8943.910560894437, 8978.685745998859, 9104.81790364189, 2349.283468542077, 2542.936426589313, 2575.8068144888834, 2626.8949242030485, 2676.785857131425, 915.5239275576663, 962.8301613539443, 964.5081008685621, 967.2697113679268, 974.8342781727123, 19180.71228931567, 19310.0, 19549.120289587, 19659.213631454866, 19674.213031478866, 970.3983530211173, 1006.9949650251848, 1030.5568605499557, 1037.180627304421, 1044.1333693034915, 10426.843597346045, 10502.947485262524, 10544.578216871392, 10741.624043158452, 11043.392613406178, 493056.0, 503128.0, 507232.0, 509131.0, 509411.0, 105351.0, 107087.39368909472, 108452.0, 110597.0, 111806.44096779627, 1203.7953547896702, 1274.5921305182437, 1277.0422183362477, 1277.399622177575, 1304.9673758156123, 19988.700169497177, 20072.89963550173, 20588.58822823565, 20713.689294660893, 20964.0, 50839.74580127076, 53175.20237196523, 53322.46677533175, 54892.0, 55576.16635750386, 65438.0, 65574.67212663907, 68797.3120268791, 69255.0, 69378.0, 12619.936900315439, 12759.808602870778, 13096.410661520446, 13119.868801312246, 13239.66900827487, 14863.851361486246, 15366.308516116578, 15499.84500154984, 19126.521836954187, 19362.612747745246, 12345.444454999726, 12543.498260069495, 12688.429020694275, 14728.631784205052, 15637.218139093227, 13162.736745265232, 13231.3384330785, 14083.507077252656, 14919.627009324853, 14960.925195373953, 15175.924120379328, 16039.67920641604, 16276.837231627533, 16546.58633534171, 16570.337186512887, 12561.309127998047, 12817.038722096067, 12875.420606072936, 13170.275634840176, 13308.46766129344, 15912.44306449315, 15936.0, 15936.840631593535, 16027.599310017344, 16136.273867676218], "value": 11363.53902510126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.2429015461184, 1384.729977654357, 1386.9514566990158, 1401.5164768154982, 1406.4936622815792, 13657.521986730453, 13684.11053281536, 14368.994170408076, 14378.352974116164, 14384.712305753892, 13734.381952812122, 14543.490977815778, 14558.272086395664, 14568.12591244526, 14686.265686715647, 2413.203642797877, 2458.1765108688523, 2463.519613675334, 2467.494163696447, 2474.443250268684, 2594.662693849806, 2643.2598872315784, 2692.932676683079, 2697.2717366311085, 2705.7700095491905, 2479.504099180171, 2623.213036089175, 2660.3482146874044, 2693.609426633137, 2703.6620422447195, 2516.584763514018, 2609.1520255916807, 2633.3679916820015, 2633.473305338921, 2646.338415396151, 2495.6523477322226, 2530.0765220694498, 2532.4175439648798, 2532.5821239495463, 2544.0714139339193, 13451.125676830974, 13570.778629923354, 13573.796393054112, 13574.45702171912, 13645.454181832714, 7246.420286377077, 7530.43521735872, 7620.314171724572, 7625.504342217738, 7625.923740762577, 4934.457209706965, 5045.672031317952, 5234.057869583474, 5241.213817927303, 5261.184516399964, 1841.9631607367778, 1881.8118188181209, 1891.186789680437, 1952.5021119614407, 1972.1914015253676, 22839.885800571057, 22956.65565016526, 23071.19250826213, 23218.419539511477, 23255.651165232535, 6302.527310451735, 6365.522585806083, 6380.968095159495, 6444.13004244421, 6606.10817539626, 15460.38158473671, 15461.690766184613, 15479.767803482957, 15534.456294029655, 15567.844321556866, 7364.189939106694, 7499.2500749924575, 7562.130355009134, 7578.393728501706, 7592.962035189788, 6870.31296870309, 7038.049863268496, 7040.5071644984355, 7094.432445404355, 7162.928370716226, 4648.395708557933, 4886.364772579542, 4887.218045112765, 4967.5777558907175, 4985.875353116201, 1354.552997510819, 1386.6048176269917, 1399.2649115097408, 1406.8944829137856, 1417.758980973237, 862.8748831419409, 864.148813418782, 887.9556022198993, 892.5983307511646, 900.090908182727, 6911.447084233249, 6972.755953541602, 7014.92985070153, 7045.436365090781, 7052.435805135577, 691.7060249393987, 713.8857782754734, 718.48987219074, 722.458156382713, 722.819295176206, 4860.246661767432, 5500.889982200333, 5545.584081193927, 5767.250257466587, 5819.505342045889, 18519.0, 18882.905585471985, 18926.716099258523, 19085.80914190868, 19112.713309300372, 18266.725999110025, 18631.627367452576, 18682.532936676693, 18731.625367492576, 19021.90489047546, 9988.950055249677, 10146.239032072624, 10466.319689220176, 10551.20865935058, 10650.094741946867, 7783.43146761556, 7944.404169687181, 8172.7956801080445, 8216.014078310642, 8617.48295102296, 15364.692706146037, 16447.25987330549, 16844.747328789832, 16865.0, 17305.480835574952, 16640.084795336374, 16736.916315418344, 16781.16094195261, 16946.491605251864, 17062.91468542699, 11244.437778111225, 11503.942480287546, 11574.71063223426, 11584.42077896085, 11586.204138358567, 12368.75262494727, 12735.172213806072, 12783.680407989874, 12973.610791676265, 13086.214827110403, 10101.0, 10377.292836904051, 10416.895831041593, 10595.470226488798, 10828.945855270673, 10194.490275486047, 10357.63748268807, 10497.370157790558, 10700.090492307929, 10839.783204335712, 9301.395409298373, 9336.906630933603, 9378.249740020645, 9403.106704863027, 9442.622295108118, 5992.340842507408, 6247.812565623039, 6713.093732346266, 6842.144731908512, 6875.346842049998, 6933.306669333027, 6969.0, 7061.8940715888275, 7078.256783037913, 7111.573305601681], "value": 6217.230027729777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.6027597094412, 496.913040217962, 514.9948500514995, 517.3610590920215, 520.2638266852404, 6011.519078473722, 6032.0, 6149.295788721632, 6156.56904016719, 6201.441870231678, 5681.176229446728, 5875.970620146893, 5898.675572843492, 5908.379620139888, 5965.1946987156725, 4746.976265118678, 4809.206480930642, 4834.250691142861, 4886.096072226632, 4915.975420122894, 4833.984863178736, 4846.273059041137, 4857.2714092886, 4892.486288939664, 4912.606991440676, 4813.422389313288, 4816.63875209359, 4823.589994850442, 4827.56551910328, 4845.152098382769, 4564.348521183057, 4782.904341913177, 4841.394825646794, 4843.321934929113, 4886.460764859058, 4333.133373325316, 4360.171567402215, 4393.5606439356125, 4401.691881568291, 4409.382686423904, 5781.277340332458, 5801.82594522165, 5818.476337129637, 5910.408959104098, 5911.970440147772, 5490.286262785812, 5540.058190107691, 5554.111342185231, 5555.972220138873, 5576.275084239023, 6265.968670156665, 6280.466160376373, 6280.748770049193, 6338.714757835863, 6343.904841427382, 4655.162070827249, 4690.390249267573, 4693.507181745902, 4775.355327030841, 4780.972091000452, 6709.496787740939, 6712.463002959751, 6720.462363010996, 6733.158355205599, 6768.864622707519, 4860.659753817199, 4902.970376221034, 4908.2637604358915, 4914.410270767531, 4923.384576927884, 4976.651634385558, 4977.601791856643, 4994.600431965434, 5002.049610573979, 5007.522780779679, 5555.333359996826, 5607.214989901417, 5609.102543593087, 5652.654148528397, 5653.378128405872, 6385.425311721968, 6414.8717025659225, 6452.516061295421, 6485.643289619022, 6517.152770139852, 1604.3823128095767, 1723.414039226669, 1735.1671197825115, 1742.830176430327, 1753.9912300438416, 1195.3724294745155, 1199.0, 1200.165884710118, 1207.2394391533453, 1208.2508844516456, 5438.428964958623, 5593.244911936918, 5643.0, 5652.0, 5703.458171473703, 6352.650604216812, 6474.838129046811, 6566.212054553484, 6604.0093985902495, 6664.900026499607, 5562.833115006556, 5571.192177134374, 5607.971960140173, 5683.715814209273, 5716.685582293014, 3465.3242617689307, 3477.704395126392, 3480.112571294304, 3507.4563442666426, 3514.2268700885766, 6290.144407399828, 6360.809175724736, 6386.914224581832, 6409.262934762562, 6453.483721302285, 6625.701843417058, 6668.2324486664875, 6681.298463661343, 6688.498362622823, 6721.092652491851, 6211.3167551569295, 6304.275008374096, 6332.430081292706, 6334.936650633527, 6338.619682819046, 6490.383413575892, 6531.510136739668, 6581.848176569177, 6582.703778329891, 6600.966995164993, 6372.654356462894, 6414.5189110815945, 6421.486281097595, 6457.288818463205, 6486.578372405778, 6176.629402235881, 6311.368863113836, 6343.097070878625, 6368.949123394588, 6390.648514331757, 4629.425995161661, 4735.952640473552, 4771.284307353924, 4835.709857408567, 4844.491328410466, 6369.172007638977, 6492.805215843532, 6527.379898909596, 6604.966975165094, 6612.404883560503, 6185.2886918003205, 6271.3728627136925, 6319.96840015797, 6324.968375158095, 6342.175517182736, 6278.246610406781, 6319.715612797343, 6340.461060809883, 6340.65126418033, 6346.873062538816, 6149.907751383644, 6163.291221509584, 6182.752689892354, 6249.96875015622, 6268.937310626835, 6310.6213627182515, 6378.0, 6381.308953127518, 6396.520260980538, 6406.135171751754, 6168.753249869955, 6171.444569988723, 6174.413430724074, 6256.468200202851, 6283.120363149254], "value": 4917.33677141914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.3363811236854, 922.8615707643849, 940.8541676040212, 941.8351788437021, 944.9244060475163, 18307.90846045768, 18323.0, 18778.0, 19011.144498497568, 19127.617447651057, 16756.2459689314, 16822.57943551412, 16826.663466730657, 16837.91581042093, 18828.652253977983, 1032.6334151376284, 1068.4123731947436, 1079.3362082319356, 1079.6976846482996, 1080.6811990462793, 1050.76883085721, 1058.6347710040025, 1063.1972860490318, 1063.4310643805566, 1068.9251752377336, 1118.2284223885533, 1121.859767529059, 1124.5951457475344, 1129.774045190961, 1131.0160160660196, 1088.5645741703304, 1089.6839916424228, 1110.6723516562593, 1127.0645364347572, 1129.790988667095, 801.046754362307, 801.1667865419956, 810.5947026486757, 812.7480481050893, 813.9552324622143, 18923.24307027731, 19170.904145479322, 19179.041047947547, 19197.712034319356, 19215.80784192154, 19078.618427631507, 19890.0, 20122.79877201224, 20127.0942807574, 20217.494562635904, 15047.0, 16102.436414725546, 16125.113118778463, 16246.837531624651, 16356.591085222846, 3519.278547897675, 3559.76861504004, 3562.982185089058, 3564.108972756811, 3572.624874388204, 101826.49086754519, 102513.0, 104889.0, 107811.46094269557, 108017.45991270072, 16152.757708634379, 16488.17559122039, 16741.079240641637, 16778.496645100666, 16783.328666853435, 29075.85462072676, 29511.55732664012, 29672.40655186884, 29779.40441191164, 29976.25059373533, 8602.139786021473, 8603.5698215089, 8687.739367818975, 8702.608382622797, 8715.869261961076, 3992.740471869319, 4034.253663072341, 4044.6157615026527, 4061.5329237137516, 4075.4294398784195, 4927.310176575283, 5000.874978125576, 5051.545360917462, 5109.029284435946, 5110.0801855665595, 1029.0532709906904, 1048.1719441641171, 1056.1392465140887, 1067.5196161727254, 1068.1188019883627, 666.2637785247232, 677.9457643388517, 682.757621044522, 707.982300442493, 714.5641158893071, 11695.766084678258, 11781.0, 12146.939265303618, 12155.270683759003, 12877.356132193352, 625.9436650701459, 640.6124294801671, 649.5420728386476, 654.4829584628186, 658.4600627485416, 5342.706151161723, 5863.648181109062, 6047.818565443044, 6052.273727152682, 6596.215530745685, 94048.52975735077, 94897.0, 98297.50851245697, 101389.49305253426, 102787.0, 82921.17078829255, 87251.56374218088, 87562.0, 88473.0, 90469.54765226263, 72692.0, 74043.62978185074, 76072.0, 76499.0, 78254.60872695714, 11683.18217724751, 11793.537129889564, 12022.75954480888, 12419.627411177678, 12504.437300321326, 33486.33027339488, 34644.82677586596, 34929.47605785966, 35046.94859154229, 36016.09959751027, 41939.37090943699, 43749.56250437582, 44613.55386446094, 44638.55361446474, 45583.77208113938, 18138.455846324632, 18472.630547389246, 18568.5357866049, 18610.534736631693, 18626.72059919075, 19432.2227110914, 20277.0, 20551.280705175846, 20605.896970515052, 20895.164193432094, 18121.818781812013, 18375.54061148482, 18551.53621159482, 18883.05584720786, 18884.0, 18268.543286417946, 18455.53861153482, 18623.44129676112, 18802.52993675169, 19030.904845475685, 16836.410725625035, 18013.2794688211, 18131.456056318333, 18160.636787264444, 18259.634807304046, 12802.743945121232, 12924.483020679443, 12979.286139262054, 13363.73044560765, 13493.595192144252, 13002.349882505649, 13531.255780932142, 13832.861671383158, 13926.442942282196, 13945.721085578029], "value": 8836.000960039064, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 110.0, 108.0, 110.0, 110.0, 110.0, 111.0, 114.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 153.0, 175.0, 126.0, 144.0, 158.0, 127.0, 184.0, 129.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 161.0, 162.0, 170.0, 164.0, 169.0, 170.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 159.0, 74.0, 75.0, 74.0, 74.0, 96.0, 74.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 131.0, 82.0, 84.0, 83.0, 130.0, 82.0, 82.0, 139.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 149.0, 150.0, 150.0, 150.0, 152.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 57.0, 55.0, 55.0, 56.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 78.0, 78.0, 78.0, 77.0, 78.0, 84.0, 78.0, 80.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 143.0, 130.0, 128.0, 130.0, 126.0, 129.0, 129.0, 130.0, 161.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 179.0, 182.0, 182.0, 189.0, 179.0, 186.0, 184.0, 176.0, 185.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 71.0, 70.0, 66.0, 70.0, 71.0, 70.0, 66.0, 68.0], "value": 69.1, "unit": "score"}]}]} 09:50:21 INFO - Return code: 0 09:50:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:21 INFO - # TBPL SUCCESS # 09:50:21 INFO - Running post-action listener: _package_coverage_data 09:50:21 INFO - Running post-action listener: _resource_record_post_action 09:50:21 INFO - [mozharness: 2017-07-01 16:50:21.254726Z] Finished run-tests step (success) 09:50:21 INFO - Running post-run listener: _resource_record_post_run 09:50:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 651264; Write bytes: 446930944; Read time: 208; Write time: 624360 09:50:21 INFO - TinderboxPrint: CPU usage
13.1% 09:50:21 INFO - TinderboxPrint: I/O read bytes / time
651,264 / 208 09:50:21 INFO - TinderboxPrint: I/O write bytes / time
446,930,944 / 624,360 09:50:21 INFO - TinderboxPrint: CPU idle
8,285.7 (86.9%) 09:50:21 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 09:50:21 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117321728; Read time: 0; Write time: 192436 09:50:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:50:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 647168; Write bytes: 328486912; Read time: 188; Write time: 431872 09:50:21 INFO - Running post-run listener: _upload_blobber_files 09:50:21 INFO - Blob upload gear active. 09:50:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:21 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 09:50:21 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'] 09:50:21 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 09:50:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:23 INFO - (blobuploader) - INFO - Done attempting. 09:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:24 INFO - (blobuploader) - INFO - Done attempting. 09:50:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:25 INFO - (blobuploader) - INFO - Done attempting. 09:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:29 INFO - (blobuploader) - INFO - Done attempting. 09:50:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:29 INFO - Return code: 0 09:50:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0e250e97f93fb68c2afa1365c30933179496e1c9e5605d5a7085930f8a6d7ca404da8f1fb8f3f7bf6cf18ac2430881e38d2d6b4c3a53fba24b4d75ab491d36", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad588a7619839c5f9b279ced954835ce44f6846c1238e8403b880f1a964c2e5b001ab4403a4ff11a1a789f58fc425990ae410a5a079fba47813c54965d77655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c57afc23933995493893952d6f09541c24b24dbceeae2300f4e9d791cb3bdbf9c5cc60916081b69b21e3f3a1dbb71f7c9103eea8015ca6581bbcedcaec5c000", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c29af615b3ca288b541fe44db6087617280fc936603f82a1aceb217b179f65b04a5c02196c2bae4c6c2fe74bcee00c0493e40c5770e5b16465473017e19328c4"} 09:50:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:29 INFO - Contents: 09:50:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0e250e97f93fb68c2afa1365c30933179496e1c9e5605d5a7085930f8a6d7ca404da8f1fb8f3f7bf6cf18ac2430881e38d2d6b4c3a53fba24b4d75ab491d36", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad588a7619839c5f9b279ced954835ce44f6846c1238e8403b880f1a964c2e5b001ab4403a4ff11a1a789f58fc425990ae410a5a079fba47813c54965d77655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c57afc23933995493893952d6f09541c24b24dbceeae2300f4e9d791cb3bdbf9c5cc60916081b69b21e3f3a1dbb71f7c9103eea8015ca6581bbcedcaec5c000", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c29af615b3ca288b541fe44db6087617280fc936603f82a1aceb217b179f65b04a5c02196c2bae4c6c2fe74bcee00c0493e40c5770e5b16465473017e19328c4"} 09:50:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:29 INFO - Copying logs to upload dir... 09:50:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.715675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-01 09:50:29.099293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 09:50:29.103169) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 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/3c0e250e97f93fb68c2afa1365c30933179496e1c9e5605d5a7085930f8a6d7ca404da8f1fb8f3f7bf6cf18ac2430881e38d2d6b4c3a53fba24b4d75ab491d36", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad588a7619839c5f9b279ced954835ce44f6846c1238e8403b880f1a964c2e5b001ab4403a4ff11a1a789f58fc425990ae410a5a079fba47813c54965d77655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c57afc23933995493893952d6f09541c24b24dbceeae2300f4e9d791cb3bdbf9c5cc60916081b69b21e3f3a1dbb71f7c9103eea8015ca6581bbcedcaec5c000", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c29af615b3ca288b541fe44db6087617280fc936603f82a1aceb217b179f65b04a5c02196c2bae4c6c2fe74bcee00c0493e40c5770e5b16465473017e19328c4"} build_url:https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/GvrbrPCBQCaE_A-9lMGJhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0e250e97f93fb68c2afa1365c30933179496e1c9e5605d5a7085930f8a6d7ca404da8f1fb8f3f7bf6cf18ac2430881e38d2d6b4c3a53fba24b4d75ab491d36", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad588a7619839c5f9b279ced954835ce44f6846c1238e8403b880f1a964c2e5b001ab4403a4ff11a1a789f58fc425990ae410a5a079fba47813c54965d77655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c57afc23933995493893952d6f09541c24b24dbceeae2300f4e9d791cb3bdbf9c5cc60916081b69b21e3f3a1dbb71f7c9103eea8015ca6581bbcedcaec5c000", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c29af615b3ca288b541fe44db6087617280fc936603f82a1aceb217b179f65b04a5c02196c2bae4c6c2fe74bcee00c0493e40c5770e5b16465473017e19328c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 09:50:29.127421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:50:29.127764) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498922749.887527-857192092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 09:50:29.209939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 09:50:29.210336) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 09:50:29.210671) ========= ========= Total master_lag: 0.17 =========