builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1495719907.73 results: success (0) revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:07.727216) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:07.727706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:07.727984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:07.785305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:07.785720) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 06:45:07-- 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% 94.7M=0s 2017-05-25 06:45:07 (94.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.203534 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:08.029062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:08.032453) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018240 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:08.085700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:08.086039) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --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 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 06:45:08,058 truncating revision to first 12 chars 2017-05-25 06:45:08,058 Setting DEBUG logging. 2017-05-25 06:45:08,058 attempt 1/10 2017-05-25 06:45:08,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23a341e9b53d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 06:45:08,733 unpacking tar archive at: mozilla-central-23a341e9b53d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:09.084800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:09.085129) ========= script_repo_revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:09.085549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:09.085821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:45:09.095063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-25 06:45:09.095456) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:45:09 INFO - MultiFileLogger online at 20170525 06:45:09 in /builds/slave/test 06:45:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:45:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:45:09 INFO - {'append_to_log': False, 06:45:09 INFO - 'base_work_dir': '/builds/slave/test', 06:45:09 INFO - 'blob_upload_branch': 'Firefox', 06:45:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:45:09 INFO - 'branch': 'Firefox', 06:45:09 INFO - 'buildbot_json_path': 'buildprops.json', 06:45:09 INFO - 'config_files': ('talos/linux_config.py',), 06:45:09 INFO - 'default_actions': ('clobber', 06:45:09 INFO - 'read-buildbot-config', 06:45:09 INFO - 'download-and-extract', 06:45:09 INFO - 'populate-webroot', 06:45:09 INFO - 'create-virtualenv', 06:45:09 INFO - 'install', 06:45:09 INFO - 'run-tests'), 06:45:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:45:09 INFO - 'download_minidump_stackwalk': True, 06:45:09 INFO - 'download_symbols': 'ondemand', 06:45:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:45:09 INFO - 'tooltool.py': '/tools/tooltool.py', 06:45:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:45:09 INFO - '/tools/misc-python/virtualenv.py')}, 06:45:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:45:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:45:09 INFO - 'gecko_profile': False, 06:45:09 INFO - 'gecko_profile_interval': 0, 06:45:09 INFO - 'installer_path': 'installer.exe', 06:45:09 INFO - 'log_level': 'info', 06:45:09 INFO - 'log_name': 'talos', 06:45:09 INFO - 'log_to_console': True, 06:45:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:45:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:45:09 INFO - 'opt_config_files': (), 06:45:09 INFO - 'pip_index': False, 06:45:09 INFO - 'suite': 'dromaeojs-e10s', 06:45:09 INFO - 'system_bits': '32', 06:45:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:45:09 INFO - 'title': 'talos-linux64-ix-037', 06:45:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:45:09 INFO - 'use_talos_json': True, 06:45:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:45:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:45:09 INFO - 'work_dir': 'build'} 06:45:09 INFO - [mozharness: 2017-05-25 13:45:09.229090Z] Running clobber step. 06:45:09 INFO - Running pre-action listener: _resource_record_pre_action 06:45:09 INFO - Running main action method: clobber 06:45:09 INFO - rmtree: /builds/slave/test/build 06:45:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:45:10 INFO - Running post-action listener: _resource_record_post_action 06:45:10 INFO - [mozharness: 2017-05-25 13:45:10.215996Z] Finished clobber step (success) 06:45:10 INFO - [mozharness: 2017-05-25 13:45:10.216096Z] Running read-buildbot-config step. 06:45:10 INFO - Running pre-action listener: _resource_record_pre_action 06:45:10 INFO - Running main action method: read_buildbot_config 06:45:10 INFO - Using buildbot properties: 06:45:10 INFO - { 06:45:10 INFO - "project": "", 06:45:10 INFO - "product": "firefox", 06:45:10 INFO - "who": "Callek@gmail.com", 06:45:10 INFO - "installer_path": "public/build/target.tar.bz2", 06:45:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 06:45:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:45:10 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 06:45:10 INFO - "stage_platform": "linux64-stylo", 06:45:10 INFO - "basedir": "/builds/slave/test", 06:45:10 INFO - "buildnumber": 118, 06:45:10 INFO - "platform": "ubuntu64_hw_stylo", 06:45:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:45:10 INFO - "slavebuilddir": "test", 06:45:10 INFO - "taskId": "bXv4mcf2SVWBtb5RiHb97w", 06:45:10 INFO - "branch": "mozilla-central", 06:45:10 INFO - "script_repo_revision": "production", 06:45:10 INFO - "revision": "23a341e9b53d04f80ea6a66ced2d72cdc17afffb", 06:45:10 INFO - "slavename": "talos-linux64-ix-037", 06:45:10 INFO - "repo_path": "mozilla-central" 06:45:10 INFO - } 06:45:10 INFO - Finding installer, test and symbols from parent task. 06:45:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bXv4mcf2SVWBtb5RiHb97w'}, attempt #1 06:45:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bXv4mcf2SVWBtb5RiHb97w'}, attempt #1 06:45:11 INFO - Task dependencies: SRns4UVsTaicCBZLhqaQ2w 06:45:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w'}, attempt #1 06:45:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:45:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/test_packages.json 06:45:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip 06:45:11 INFO - Running post-action listener: _resource_record_post_action 06:45:11 INFO - [mozharness: 2017-05-25 13:45:11.588128Z] Finished read-buildbot-config step (success) 06:45:11 INFO - [mozharness: 2017-05-25 13:45:11.588349Z] Running download-and-extract step. 06:45:11 INFO - Running pre-action listener: _resource_record_pre_action 06:45:11 INFO - Running main action method: download_and_extract 06:45:11 INFO - mkdir: /builds/slave/test/build/tests 06:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:11 INFO - trying https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json 06:45:11 INFO - Downloading https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:45:12 INFO - Downloaded 986 bytes. 06:45:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:45:12 INFO - Using the following test package requirements: 06:45:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:45:12 INFO - u'common': [u'target.common.tests.zip'], 06:45:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:45:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:45:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:45:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:45:12 INFO - u'mozbase': [u'target.common.tests.zip'], 06:45:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:45:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:45:12 INFO - u'web-platform': [u'target.common.tests.zip', 06:45:12 INFO - u'target.web-platform.tests.zip'], 06:45:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:45:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:45:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip 06:45:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:45:12 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip into memory 06:45:13 INFO - Content-Length response header: 63524836 06:45:13 INFO - Bytes received: 63524836 06:45:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:45:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip 06:45:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:45:24 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip into memory 06:45:25 INFO - Content-Length response header: 63524836 06:45:25 INFO - Bytes received: 63524836 06:45:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip 06:45:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:45:39 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip into memory 06:45:39 INFO - Content-Length response header: 14411859 06:45:39 INFO - Bytes received: 14411859 06:45:40 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')]} 06:45:40 INFO - trying https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:45:40 INFO - Downloading https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:45:41 INFO - Downloaded 55586350 bytes. 06:45:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:45:41 INFO - mkdir: /builds/slave/test/properties 06:45:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:45:41 INFO - Writing to file /builds/slave/test/properties/build_url 06:45:41 INFO - Contents: 06:45:41 INFO - build_url:https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:45:41 INFO - Running post-action listener: _resource_record_post_action 06:45:41 INFO - Running post-action listener: set_extra_try_arguments 06:45:41 INFO - [mozharness: 2017-05-25 13:45:41.146811Z] Finished download-and-extract step (success) 06:45:41 INFO - [mozharness: 2017-05-25 13:45:41.146919Z] Running populate-webroot step. 06:45:41 INFO - Running pre-action listener: _resource_record_pre_action 06:45:41 INFO - Running main action method: populate_webroot 06:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:45:41 INFO - '--tppagecycles', 06:45:41 INFO - '7'], 06:45:41 INFO - 'tests': ['tsvgm']}}, 06:45:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:45:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:45:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:45:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:45:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['damp', 'tps']}, 06:45:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'tests': ['damp', 'tps']}, 06:45:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['dromaeo_dom']}, 06:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:45:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:45:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:45:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:45:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'other-e10s': {'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['a11yr', 06:45:41 INFO - 'ts_paint', 06:45:41 INFO - 'tpaint', 06:45:41 INFO - 'sessionrestore', 06:45:41 INFO - 'sessionrestore_no_auto_restore', 06:45:41 INFO - 'tabpaint']}, 06:45:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:45:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:45:41 INFO - 'bloom_basic_ref']}, 06:45:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['tsvgx', 06:45:41 INFO - 'tsvgr_opacity', 06:45:41 INFO - 'tart', 06:45:41 INFO - 'tscrollx', 06:45:41 INFO - 'cart', 06:45:41 INFO - 'tsvg_static']}, 06:45:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:45:41 INFO - 'tsvgr_opacity', 06:45:41 INFO - 'tart', 06:45:41 INFO - 'tscrollx', 06:45:41 INFO - 'cart', 06:45:41 INFO - 'tsvg_static']}, 06:45:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'talos_options': ['--disable-e10s'], 06:45:41 INFO - 'tests': ['tp5o']}, 06:45:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:45:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'talos_options': ['--disable-e10s', 06:45:41 INFO - '--xperf_path', 06:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:41 INFO - 'tests': ['tp5n']}, 06:45:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:45:41 INFO - 'talos_options': ['--xperf_path', 06:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:41 INFO - 'tests': ['tp5n']}}, 06:45:41 INFO - 'talos.zip': {'path': '', 06:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:45:41 INFO - Running post-action listener: _resource_record_post_action 06:45:41 INFO - [mozharness: 2017-05-25 13:45:41.162067Z] Finished populate-webroot step (success) 06:45:41 INFO - [mozharness: 2017-05-25 13:45:41.162171Z] Running create-virtualenv step. 06:45:41 INFO - Running pre-action listener: _resource_record_pre_action 06:45:41 INFO - Running main action method: create_virtualenv 06:45:41 INFO - Creating virtualenv /builds/slave/test/build/venv 06:45:41 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 06:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:45:41 INFO - Using real prefix '/usr' 06:45:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:45:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:45:43 INFO - Installing pip.................done. 06:45:43 INFO - Return code: 0 06:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:45:44 INFO - Reading from file tmpfile_stdout 06:45:44 INFO - Output received: 06:45:44 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) 06:45:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:44 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:44 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 06:45:44 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 06:45:44 INFO - Using env: {'DISPLAY': ':0', 06:45:44 INFO - 'HOME': '/home/cltbld', 06:45:44 INFO - 'LANG': 'en_US.UTF-8', 06:45:44 INFO - 'LANGUAGE': 'en_US:en', 06:45:44 INFO - 'LOGNAME': 'cltbld', 06:45:44 INFO - 'MAIL': '/var/mail/cltbld', 06:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:44 INFO - 'MOZ_NO_REMOTE': '1', 06:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:44 INFO - 'NO_EM_RESTART': '1', 06:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:44 INFO - 'PWD': '/builds/slave/test', 06:45:44 INFO - 'SHELL': '/bin/bash', 06:45:44 INFO - 'SHLVL': '1', 06:45:44 INFO - 'TERM': 'linux', 06:45:44 INFO - 'TMOUT': '86400', 06:45:44 INFO - 'USER': 'cltbld', 06:45:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:44 INFO - '_': '/tools/buildbot/bin/python'} 06:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:44 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 06:45:44 INFO - Cleaning up... 06:45:44 INFO - Return code: 0 06:45:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:44 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:44 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 06:45:44 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 06:45:44 INFO - Using env: {'DISPLAY': ':0', 06:45:44 INFO - 'HOME': '/home/cltbld', 06:45:44 INFO - 'LANG': 'en_US.UTF-8', 06:45:44 INFO - 'LANGUAGE': 'en_US:en', 06:45:44 INFO - 'LOGNAME': 'cltbld', 06:45:44 INFO - 'MAIL': '/var/mail/cltbld', 06:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:44 INFO - 'MOZ_NO_REMOTE': '1', 06:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:44 INFO - 'NO_EM_RESTART': '1', 06:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:44 INFO - 'PWD': '/builds/slave/test', 06:45:44 INFO - 'SHELL': '/bin/bash', 06:45:44 INFO - 'SHLVL': '1', 06:45:44 INFO - 'TERM': 'linux', 06:45:44 INFO - 'TMOUT': '86400', 06:45:44 INFO - 'USER': 'cltbld', 06:45:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:44 INFO - '_': '/tools/buildbot/bin/python'} 06:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:44 INFO - Downloading/unpacking psutil>=3.1.1 06:45:44 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 06:45:44 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 06:45:44 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 06:45:44 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 06:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:45:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:45 INFO - Installing collected packages: psutil 06:45:45 INFO - Running setup.py install for psutil 06:45:45 INFO - building 'psutil._psutil_linux' extension 06:45:45 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 06:45:46 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 06:45:46 INFO - building 'psutil._psutil_posix' extension 06:45:46 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 06:45:47 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 06:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:47 INFO - Successfully installed psutil 06:45:47 INFO - Cleaning up... 06:45:47 INFO - Return code: 0 06:45:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:47 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:47 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 06:45:47 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 06:45:47 INFO - Using env: {'DISPLAY': ':0', 06:45:47 INFO - 'HOME': '/home/cltbld', 06:45:47 INFO - 'LANG': 'en_US.UTF-8', 06:45:47 INFO - 'LANGUAGE': 'en_US:en', 06:45:47 INFO - 'LOGNAME': 'cltbld', 06:45:47 INFO - 'MAIL': '/var/mail/cltbld', 06:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:47 INFO - 'MOZ_NO_REMOTE': '1', 06:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:47 INFO - 'NO_EM_RESTART': '1', 06:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:47 INFO - 'PWD': '/builds/slave/test', 06:45:47 INFO - 'SHELL': '/bin/bash', 06:45:47 INFO - 'SHLVL': '1', 06:45:47 INFO - 'TERM': 'linux', 06:45:47 INFO - 'TMOUT': '86400', 06:45:47 INFO - 'USER': 'cltbld', 06:45:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:47 INFO - '_': '/tools/buildbot/bin/python'} 06:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:45:47 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 06:45:47 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 06:45:47 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 06:45:47 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 06:45:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:45:48 INFO - Installing collected packages: mozsystemmonitor 06:45:48 INFO - Running setup.py install for mozsystemmonitor 06:45:48 INFO - Successfully installed mozsystemmonitor 06:45:48 INFO - Cleaning up... 06:45:48 INFO - Return code: 0 06:45:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:45:48 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')]} 06:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:48 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')]} 06:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:48 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:48 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 06:45:48 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 06:45:48 INFO - Using env: {'DISPLAY': ':0', 06:45:48 INFO - 'HOME': '/home/cltbld', 06:45:48 INFO - 'LANG': 'en_US.UTF-8', 06:45:48 INFO - 'LANGUAGE': 'en_US:en', 06:45:48 INFO - 'LOGNAME': 'cltbld', 06:45:48 INFO - 'MAIL': '/var/mail/cltbld', 06:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:48 INFO - 'MOZ_NO_REMOTE': '1', 06:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:48 INFO - 'NO_EM_RESTART': '1', 06:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:48 INFO - 'PWD': '/builds/slave/test', 06:45:48 INFO - 'SHELL': '/bin/bash', 06:45:48 INFO - 'SHLVL': '1', 06:45:48 INFO - 'TERM': 'linux', 06:45:48 INFO - 'TMOUT': '86400', 06:45:48 INFO - 'USER': 'cltbld', 06:45:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:48 INFO - '_': '/tools/buildbot/bin/python'} 06:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:48 INFO - Downloading/unpacking jsonschema==2.5.1 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:45:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:45:50 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 06:45:50 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 06:45:50 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 06:45:50 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 06:45:50 INFO - Downloading functools32-3.2.3-2.tar.gz 06:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:45:50 INFO - warning: no files found matching '*.txt' 06:45:50 INFO - no previously-included directories found matching 'build' 06:45:50 INFO - no previously-included directories found matching 'dist' 06:45:50 INFO - no previously-included directories found matching '.git*' 06:45:50 INFO - Installing collected packages: jsonschema, functools32 06:45:50 INFO - Running setup.py install for functools32 06:45:50 INFO - warning: no files found matching '*.txt' 06:45:50 INFO - no previously-included directories found matching 'build' 06:45:50 INFO - no previously-included directories found matching 'dist' 06:45:50 INFO - no previously-included directories found matching '.git*' 06:45:50 INFO - Successfully installed jsonschema functools32 06:45:50 INFO - Cleaning up... 06:45:50 INFO - Return code: 0 06:45:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:45:50 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')]} 06:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:50 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')]} 06:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:50 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:50 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 06:45:50 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 06:45:50 INFO - Using env: {'DISPLAY': ':0', 06:45:50 INFO - 'HOME': '/home/cltbld', 06:45:50 INFO - 'LANG': 'en_US.UTF-8', 06:45:50 INFO - 'LANGUAGE': 'en_US:en', 06:45:50 INFO - 'LOGNAME': 'cltbld', 06:45:50 INFO - 'MAIL': '/var/mail/cltbld', 06:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:50 INFO - 'MOZ_NO_REMOTE': '1', 06:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:50 INFO - 'NO_EM_RESTART': '1', 06:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:50 INFO - 'PWD': '/builds/slave/test', 06:45:50 INFO - 'SHELL': '/bin/bash', 06:45:50 INFO - 'SHLVL': '1', 06:45:50 INFO - 'TERM': 'linux', 06:45:50 INFO - 'TMOUT': '86400', 06:45:50 INFO - 'USER': 'cltbld', 06:45:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:50 INFO - '_': '/tools/buildbot/bin/python'} 06:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:45:50 INFO - Cleaning up... 06:45:50 INFO - Return code: 0 06:45:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:45:50 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')]} 06:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:50 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')]} 06:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:50 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:50 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 06:45:50 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 06:45:50 INFO - Using env: {'DISPLAY': ':0', 06:45:50 INFO - 'HOME': '/home/cltbld', 06:45:50 INFO - 'LANG': 'en_US.UTF-8', 06:45:50 INFO - 'LANGUAGE': 'en_US:en', 06:45:50 INFO - 'LOGNAME': 'cltbld', 06:45:50 INFO - 'MAIL': '/var/mail/cltbld', 06:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:50 INFO - 'MOZ_NO_REMOTE': '1', 06:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:50 INFO - 'NO_EM_RESTART': '1', 06:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:50 INFO - 'PWD': '/builds/slave/test', 06:45:50 INFO - 'SHELL': '/bin/bash', 06:45:50 INFO - 'SHLVL': '1', 06:45:50 INFO - 'TERM': 'linux', 06:45:50 INFO - 'TMOUT': '86400', 06:45:50 INFO - 'USER': 'cltbld', 06:45:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:50 INFO - '_': '/tools/buildbot/bin/python'} 06:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:45:50 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 06:45:50 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 06:45:50 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 06:45:50 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 06:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45:51 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 06:45:51 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 06:45:51 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 06:45:51 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 06:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45:52 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 06:45:52 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 06:45:52 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 06:45:52 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 06:45:52 INFO - Downloading docopt-0.6.1.tar.gz 06:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:52 INFO - Running setup.py install for blobuploader 06:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:52 INFO - Running setup.py install for requests 06:45:52 INFO - Running setup.py install for docopt 06:45:53 INFO - Successfully installed blobuploader requests docopt 06:45:53 INFO - Cleaning up... 06:45:53 INFO - Return code: 0 06:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:53 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')]} 06:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:53 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')]} 06:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:53 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:53 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 06:45:53 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 06:45:53 INFO - Using env: {'DISPLAY': ':0', 06:45:53 INFO - 'HOME': '/home/cltbld', 06:45:53 INFO - 'LANG': 'en_US.UTF-8', 06:45:53 INFO - 'LANGUAGE': 'en_US:en', 06:45:53 INFO - 'LOGNAME': 'cltbld', 06:45:53 INFO - 'MAIL': '/var/mail/cltbld', 06:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:53 INFO - 'MOZ_NO_REMOTE': '1', 06:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:53 INFO - 'NO_EM_RESTART': '1', 06:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:53 INFO - 'PWD': '/builds/slave/test', 06:45:53 INFO - 'SHELL': '/bin/bash', 06:45:53 INFO - 'SHLVL': '1', 06:45:53 INFO - 'TERM': 'linux', 06:45:53 INFO - 'TMOUT': '86400', 06:45:53 INFO - 'USER': 'cltbld', 06:45:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:53 INFO - '_': '/tools/buildbot/bin/python'} 06:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:53 INFO - Running setup.py (path:/tmp/pip-QBA1R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:53 INFO - Running setup.py (path:/tmp/pip-zP0iNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:53 INFO - Running setup.py (path:/tmp/pip-Ape5as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:53 INFO - Running setup.py (path:/tmp/pip-KiNNzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:53 INFO - Running setup.py (path:/tmp/pip-pjV3YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:53 INFO - Running setup.py (path:/tmp/pip-eLBNjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:53 INFO - Running setup.py (path:/tmp/pip-Z00Y0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:53 INFO - Running setup.py (path:/tmp/pip-BOAgTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:53 INFO - Running setup.py (path:/tmp/pip-e51k9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:53 INFO - Running setup.py (path:/tmp/pip-TPxCb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:54 INFO - Running setup.py (path:/tmp/pip-WJHBOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:54 INFO - Running setup.py (path:/tmp/pip-G6qMPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:54 INFO - Running setup.py (path:/tmp/pip-SxgkAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:54 INFO - Running setup.py (path:/tmp/pip-mQHy7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:54 INFO - Running setup.py (path:/tmp/pip-fYxIbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:54 INFO - Running setup.py (path:/tmp/pip-BDuv5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:54 INFO - Running setup.py (path:/tmp/pip-c_7tND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:54 INFO - Running setup.py install for manifestparser 06:45:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:54 INFO - Running setup.py install for mozcrash 06:45:54 INFO - Running setup.py install for mozdebug 06:45:54 INFO - Running setup.py install for mozdevice 06:45:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:54 INFO - Running setup.py install for mozfile 06:45:55 INFO - Running setup.py install for mozhttpd 06:45:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for mozinfo 06:45:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for mozInstall 06:45:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for mozleak 06:45:55 INFO - Running setup.py install for mozlog 06:45:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for moznetwork 06:45:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for mozprocess 06:45:55 INFO - Running setup.py install for mozprofile 06:45:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:55 INFO - Running setup.py install for mozrunner 06:45:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:56 INFO - Running setup.py install for mozscreenshot 06:45:56 INFO - Running setup.py install for moztest 06:45:56 INFO - Running setup.py install for mozversion 06:45:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:56 INFO - Cleaning up... 06:45:56 INFO - Return code: 0 06:45:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:56 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')]} 06:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:56 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')]} 06:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:56 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:56 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 06:45:56 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 06:45:56 INFO - Using env: {'DISPLAY': ':0', 06:45:56 INFO - 'HOME': '/home/cltbld', 06:45:56 INFO - 'LANG': 'en_US.UTF-8', 06:45:56 INFO - 'LANGUAGE': 'en_US:en', 06:45:56 INFO - 'LOGNAME': 'cltbld', 06:45:56 INFO - 'MAIL': '/var/mail/cltbld', 06:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:56 INFO - 'MOZ_NO_REMOTE': '1', 06:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:56 INFO - 'NO_EM_RESTART': '1', 06:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:56 INFO - 'PWD': '/builds/slave/test', 06:45:56 INFO - 'SHELL': '/bin/bash', 06:45:56 INFO - 'SHLVL': '1', 06:45:56 INFO - 'TERM': 'linux', 06:45:56 INFO - 'TMOUT': '86400', 06:45:56 INFO - 'USER': 'cltbld', 06:45:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:56 INFO - '_': '/tools/buildbot/bin/python'} 06:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:56 INFO - Running setup.py (path:/tmp/pip-d8Hdgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:56 INFO - Running setup.py (path:/tmp/pip-WRX2ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:56 INFO - Running setup.py (path:/tmp/pip-V8YQyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:56 INFO - Running setup.py (path:/tmp/pip-CWvM7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:56 INFO - Running setup.py (path:/tmp/pip-LeAlnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:56 INFO - Running setup.py (path:/tmp/pip-h3fPdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:56 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)) 06:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:56 INFO - Running setup.py (path:/tmp/pip-Va09Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:57 INFO - Running setup.py (path:/tmp/pip-ACxu3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:57 INFO - Running setup.py (path:/tmp/pip-NBtXUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:57 INFO - Running setup.py (path:/tmp/pip-YVqMzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:57 INFO - Running setup.py (path:/tmp/pip-zUq26E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:57 INFO - Running setup.py (path:/tmp/pip-ny7JwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:57 INFO - Running setup.py (path:/tmp/pip-056rfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:57 INFO - Running setup.py (path:/tmp/pip-34YffR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:57 INFO - Running setup.py (path:/tmp/pip-fJHs6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:57 INFO - Running setup.py (path:/tmp/pip-jT94sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:57 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)) 06:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:57 INFO - Running setup.py (path:/tmp/pip-crUrI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:57 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)) 06:45:57 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)) 06:45:57 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)) 06:45:57 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)) 06:45:57 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)) 06:45:57 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)) 06:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:57 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 06:45:57 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 06:45:57 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 06:45:57 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 06:45:58 INFO - Downloading blessings-1.6.tar.gz 06:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:58 INFO - Installing collected packages: blessings 06:45:58 INFO - Running setup.py install for blessings 06:45:59 INFO - Successfully installed blessings 06:45:59 INFO - Cleaning up... 06:45:59 INFO - Return code: 0 06:45:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:59 INFO - Reading from file tmpfile_stdout 06:45:59 INFO - Current package versions: 06:45:59 INFO - argparse == 1.2.1 06:45:59 INFO - blessings == 1.6 06:45:59 INFO - blobuploader == 1.2.4 06:45:59 INFO - docopt == 0.6.1 06:45:59 INFO - functools32 == 3.2.3-2 06:45:59 INFO - jsonschema == 2.5.1 06:45:59 INFO - manifestparser == 1.1 06:45:59 INFO - mozInstall == 1.12 06:45:59 INFO - mozcrash == 1.0 06:45:59 INFO - mozdebug == 0.1 06:45:59 INFO - mozdevice == 0.51 06:45:59 INFO - mozfile == 1.2 06:45:59 INFO - mozhttpd == 0.7 06:45:59 INFO - mozinfo == 0.9 06:45:59 INFO - mozleak == 0.1 06:45:59 INFO - mozlog == 3.4 06:45:59 INFO - moznetwork == 0.27 06:45:59 INFO - mozprocess == 0.25 06:45:59 INFO - mozprofile == 0.28 06:45:59 INFO - mozrunner == 6.13 06:45:59 INFO - mozscreenshot == 0.1 06:45:59 INFO - mozsystemmonitor == 0.3 06:45:59 INFO - moztest == 0.8 06:45:59 INFO - mozversion == 1.4 06:45:59 INFO - psutil == 3.1.1 06:45:59 INFO - requests == 1.2.3 06:45:59 INFO - wsgiref == 0.1.2 06:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:59 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')]} 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:59 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')]} 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:59 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:45:59 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 06:45:59 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 06:45:59 INFO - Using env: {'DISPLAY': ':0', 06:45:59 INFO - 'HOME': '/home/cltbld', 06:45:59 INFO - 'LANG': 'en_US.UTF-8', 06:45:59 INFO - 'LANGUAGE': 'en_US:en', 06:45:59 INFO - 'LOGNAME': 'cltbld', 06:45:59 INFO - 'MAIL': '/var/mail/cltbld', 06:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:59 INFO - 'MOZ_NO_REMOTE': '1', 06:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:59 INFO - 'NO_EM_RESTART': '1', 06:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:59 INFO - 'PWD': '/builds/slave/test', 06:45:59 INFO - 'SHELL': '/bin/bash', 06:45:59 INFO - 'SHLVL': '1', 06:45:59 INFO - 'TERM': 'linux', 06:45:59 INFO - 'TMOUT': '86400', 06:45:59 INFO - 'USER': 'cltbld', 06:45:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:59 INFO - '_': '/tools/buildbot/bin/python'} 06:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 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)) 06:45:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:45:59 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 06:45:59 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 06:45:59 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 06:45:59 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 06:46:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:46:00 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)) 06:46:00 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)) 06:46:00 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)) 06:46:00 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)) 06:46:00 INFO - Installing collected packages: marionette-driver 06:46:00 INFO - Running setup.py install for marionette-driver 06:46:00 INFO - Successfully installed marionette-driver 06:46:00 INFO - Cleaning up... 06:46:00 INFO - Return code: 0 06:46:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:46:00 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')]} 06:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:00 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')]} 06:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:00 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 0x279a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', '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 06:46:00 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 06:46:00 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 06:46:00 INFO - Using env: {'DISPLAY': ':0', 06:46:00 INFO - 'HOME': '/home/cltbld', 06:46:00 INFO - 'LANG': 'en_US.UTF-8', 06:46:00 INFO - 'LANGUAGE': 'en_US:en', 06:46:00 INFO - 'LOGNAME': 'cltbld', 06:46:00 INFO - 'MAIL': '/var/mail/cltbld', 06:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:00 INFO - 'MOZ_NO_REMOTE': '1', 06:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:00 INFO - 'NO_EM_RESTART': '1', 06:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:00 INFO - 'PWD': '/builds/slave/test', 06:46:00 INFO - 'SHELL': '/bin/bash', 06:46:00 INFO - 'SHLVL': '1', 06:46:00 INFO - 'TERM': 'linux', 06:46:00 INFO - 'TMOUT': '86400', 06:46:00 INFO - 'USER': 'cltbld', 06:46:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:00 INFO - '_': '/tools/buildbot/bin/python'} 06:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:46:01 INFO - Cleaning up... 06:46:01 INFO - Return code: 0 06:46:01 INFO - Running post-action listener: _resource_record_post_action 06:46:01 INFO - Running post-action listener: _start_resource_monitoring 06:46:01 INFO - Starting resource monitoring. 06:46:01 INFO - [mozharness: 2017-05-25 13:46:01.152177Z] Finished create-virtualenv step (success) 06:46:01 INFO - [mozharness: 2017-05-25 13:46:01.153176Z] Running install step. 06:46:01 INFO - Running pre-action listener: _resource_record_pre_action 06:46:01 INFO - Running main action method: install 06:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:01 INFO - Reading from file tmpfile_stdout 06:46:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:46:01 INFO - Reading from file tmpfile_stdout 06:46:01 INFO - Output received: 06:46:01 INFO - Usage: mozinstall [options] installer 06:46:01 INFO - Options: 06:46:01 INFO - -h, --help show this help message and exit 06:46:01 INFO - -d DEST, --destination=DEST 06:46:01 INFO - Directory to install application into. [default: 06:46:01 INFO - "/builds/slave/test"] 06:46:01 INFO - --app=APP Application being installed. [default: firefox] 06:46:01 INFO - mkdir: /builds/slave/test/build/application 06:46:01 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'] 06:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:46:17 INFO - Reading from file tmpfile_stdout 06:46:17 INFO - Output received: 06:46:17 INFO - /builds/slave/test/build/application/firefox/firefox 06:46:17 INFO - Running post-action listener: _resource_record_post_action 06:46:17 INFO - [mozharness: 2017-05-25 13:46:17.403448Z] Finished install step (success) 06:46:17 INFO - [mozharness: 2017-05-25 13:46:17.403727Z] Running run-tests step. 06:46:17 INFO - Running pre-action listener: _resource_record_pre_action 06:46:17 INFO - Running main action method: run_tests 06:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:46:17 INFO - Python 2.7.3 06:46:17 INFO - Return code: 0 06:46:17 INFO - grabbing minidump binary from tooltool 06:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:17 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 0x2b0a7a0>, '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 0x2b0b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0bb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:46:17 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 06:46:17 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 06:46:17 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 06:46:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:46:17 INFO - Return code: 0 06:46:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:46:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:46:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:46:17 INFO - ENV: RUST_BACKTRACE is now 1 06:46:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:46:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:46:17 INFO - Using env: {'DISPLAY': ':0', 06:46:17 INFO - 'HOME': '/home/cltbld', 06:46:17 INFO - 'LANG': 'en_US.UTF-8', 06:46:17 INFO - 'LANGUAGE': 'en_US:en', 06:46:17 INFO - 'LOGNAME': 'cltbld', 06:46:17 INFO - 'MAIL': '/var/mail/cltbld', 06:46:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:46:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:17 INFO - 'MOZ_NO_REMOTE': '1', 06:46:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:17 INFO - 'NO_EM_RESTART': '1', 06:46:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:17 INFO - 'PWD': '/builds/slave/test', 06:46:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:46:17 INFO - 'RUST_BACKTRACE': '1', 06:46:17 INFO - 'SHELL': '/bin/bash', 06:46:17 INFO - 'SHLVL': '1', 06:46:17 INFO - 'TERM': 'linux', 06:46:17 INFO - 'TMOUT': '86400', 06:46:17 INFO - 'USER': 'cltbld', 06:46:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832', 06:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:17 INFO - '_': '/tools/buildbot/bin/python'} 06:46:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:46:17 INFO - mozversion application_buildid: 20170525130908 06:46:17 INFO - mozversion application_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:46:17 INFO - mozversion application_display_name: Nightly 06:46:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:46:17 INFO - mozversion application_name: Firefox 06:46:17 INFO - mozversion application_remotingname: firefox 06:46:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:46:17 INFO - mozversion application_vendor: Mozilla 06:46:17 INFO - mozversion application_version: 55.0a1 06:46:17 INFO - mozversion platform_buildid: 20170525130908 06:46:17 INFO - mozversion platform_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:46:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:46:17 INFO - mozversion platform_version: 55.0a1 06:46:17 INFO - using testdate: 1495719977 06:46:17 INFO - actual date: 1495719977 06:46:17 INFO - starting webserver on 'localhost:39849' 06:46:17 INFO - SUITE-START | Running 2 tests 06:46:17 INFO - TEST-START | dromaeo_css 06:46:17 INFO - operating with platform_type : linux_ 06:46:17 INFO - Initialising browser for dromaeo_css test... 06:46:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39849/getInfo.html -profile /tmp/tmp16guHb/profile 06:46:17 INFO - TEST-INFO | started process 3323 (/builds/slave/test/build/application/firefox/firefox http://localhost:39849/getInfo.html) 06:46:54 INFO - TEST-INFO | 3323: killed by SIGTERM 06:46:54 INFO - Browser initialized. 06:46:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:46:54 INFO - TEST-INFO | started process 3559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16guHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:06 INFO - PID 3559 | RSS: Main: 176156672 06:47:06 INFO - PID 3559 | 06:50:10 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39849/tests/dromaeo/cssquery-ext.html) 06:50:12 INFO - PID 3559 | RSS: Main: 175632384 06:50:12 INFO - PID 3559 | 06:53:14 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-ext.html (next: http://localhost:39849/tests/dromaeo/cssquery-jquery.html) 06:53:15 INFO - PID 3559 | RSS: Main: 179929088 06:53:15 INFO - PID 3559 | 06:56:17 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39849/tests/dromaeo/cssquery-mootools.html) 06:56:17 INFO - PID 3559 | RSS: Main: 177831936 06:56:17 INFO - PID 3559 | 06:59:19 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39849/tests/dromaeo/cssquery-prototype.html) 06:59:20 INFO - PID 3559 | RSS: Main: 181919744 06:59:20 INFO - PID 3559 | 07:02:22 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39849/tests/dromaeo/cssquery-yui.html) 07:02:23 INFO - PID 3559 | RSS: Main: 179736576 07:02:23 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:39849/tests/dromaeo/cssquery-yui.html (next: http://localhost:39849/tests/dromaeo/cssquery-dojo.html) 07:05:25 INFO - PID 3559 | RSS: Main: 178262016 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | __start_tp_report 07:05:25 INFO - PID 3559 | _x_x_mozilla_page_load 07:05:25 INFO - PID 3559 | _x_x_mozilla_page_load_details 07:05:25 INFO - PID 3559 | |i|pagename|runs| 07:05:25 INFO - PID 3559 | |0;dojo.html;2719.918402447927;2732.617433559301;2753.435545713128;2764.917052488425;2771.528840097183;5261.053010458126;5359.705216213107;5374.978754036731;5389.73051347433;5399.379071406789;5368.46315368463;5369.5167434930845;5384.0847056000475;5424.321959755031;5437.918431223535;4635.072985402933;4711.104890070876;4734.739589322586;4753.619710423175;4758.928616070762;4677.555632214951;4828.97585512072;4847.0548243092435;4896.706197628136;4898.53463920927;4722;4823.155947709137;4824.758762061918;4894.045661096087;4947.579455746266;4772.069446457942;4797.18447863864;4803.471618122004;4829;4856.562909338177;4791.161546729343;4796.472388037348;4800.759962001886;4806.927896081562;4817.325574419584;5357.866053348658;5361.115415956362;5390.5418039466695;5395.29861118056;5403;5673.432656734335;5770.2210201622665;5777.942220577783;5811.099279611667;5829.09649004405;5874.3244526879525;5898.646081235097;5911.994960856665;5918.674472903988;5920.378360272152;5399;5409.7295135243085;5412.107002344608;5425.240466334716;5425.728713564306;5974.641521508724;5981.312149102909;6001.06983417571;6001.309849367379;6001.7599296027665;5515.972420137874;5591.8881622368135;5660.518855897295;5723.284589426322;5730.684812335278;5685.943140568541;5796.652200867961;5811.302643682785;5830.854228644318;5880.206172166702;5756.107803290497;5785.392533783976;5791.102379131242;5794.101914203306;5796.304443466811;5584.46947539983;5636.577256705764;5755.5683323750045;5796.507296879812;5811.854703632443;4772.141014617333;4778.474367819537;4781.641376896747;4810.59109975656;4819.987802561432;4079.673626109904;4091.4067460218102;4092.7135100542678;4103.548609652936;4135.028268356934;4795.880102997453;4830.372051633265;4861.343718597944;4877.756112194376;4892.951070489321;5844.211031510777;5846.41535846412;5853.473187413153;5872.588918775645;5903.793367232212;4890.486498917634;4891.04624598207;4894.975525122351;4896.265560165933;4951.405831300267;5007;5096.210087436453;5114.795408183631;5123.538881500683;5141.0232055909255;5253.028189784902;5259.8422047338645;5300.9734951325;5303.549198318186;5311.468853114658;5856.970715146397;5880.117982302689;5883.146943693055;5883.382244864399;5888.263967004124;5313.9468605315;5324.1747529133045;5408.323959505062;5413.918791218056;5432.972835135957;5618.943810562006;5775.075987841925;5781.306243250837;5817.185594016925;5817.970910145422;5715.571332150189;5796.101604251347;5796.101604251347;5798.913016304675;5885.646861188342;5634.126710359901;5690.317161940594;5702.8289151325525;5710.172025056427;5721.742521586455;5648.774049037993;5658.264425624807;5660.575456840671;5661.348944871393;5663.093904975349;5481.205225242397;5546.750396232099;5587.74855131512;5596.468335508121;5599.188117722826;5577.386487486455;5642.520385767256;5668;5699.031164701928;5704.401037890962;5578.079616863172;5579.74891129892;5580.107182850725;5595.832125036255;5639.407862174413 07:05:25 INFO - PID 3559 | |1;ext.html;645.2063961327567;700.4116542104631;722.241646271415;1059.4649701900544;1074.1728868771052;29812.85093574532;32940.17649558762;33001;33044.66955330446;33198;35219.295614087765;35577.46633800489;35691.10772230696;35713;35715.46426803593;6645.136132302818;6894.310568943103;6985.476089293324;7028.332308430717;7038.648067596625;6827.658617069127;6840.65796710165;6876.656167191621;6933.618650974195;6939.861202775942;6830.146231721035;6907.378335949764;6920.411764999981;6929.064576282213;6932.410745086674;6859.279775623562;6867.484938629573;6878.931210687904;6902.758403455855;6908.447324214051;6775.085363475966;6784;6808.080909077261;6820.215675197366;6839.0425340452375;30886.22784430385;31160.37679246425;31201;31384.37231255385;31470.84264578685;3074.3697542003833;3096.628404591441;3097.674744151854;3102.689731026902;3105.580746599203;24243.87878060616;24390.634140487906;24531.754682453306;24533;24604.384890377703;2755.738204870534;2767.1283545683045;2775.0426102994434;2779.5274803283287;2806.158152554246;145641;145777;146237;147981;153666.46333536634;38380.80809595934;38381.424278635845;38418.231635367134;38485.42271865924;38525.61474385276;39339.80330098331;39530;39605.20789584192;39638.405423918666;39649.80175099106;12643.557475488315;12688.87311126877;12714.936425317814;12759.234445933274;12772;10372.11836993864;10416.062554370143;10419.635312764018;10424.426656533964;10437.32157409766;12312.076594255466;12393.938030309972;12468.937655311665;12486.562970295996;12519.186252893533;5353.57171426285;5361.973190134025;5379.35447746273;5384.730763461811;5403.5136837684795;880.1946219209352;905.1943770044666;910.0671811393242;917.5320586500799;938.666773295484;20413.59172816565;21123;21177.470563235733;21396.358109256747;21403.464913376978;985.1626117799813;995.1690338567232;1005.2711783956719;1012.3571532077184;1015.94920253987;10697.946510267398;10975.396353200651;11059.889401105886;11158.734336897516;11229.66311010671;173421;174385;174885;174953;175214;39033.41449878254;39059;39384.80307598443;39545.40681889774;39551.40672889909;1197.389331440954;1240.9007279417624;1248.6378950104368;1252.6680429686141;1258.2199036597185;19231.711524327427;19821.20715171377;20520.897395512926;20660;20933.581328373653;28964.855175724828;28965.710342896302;28992.13023609295;29042;29048.12855614335;151087;151983;152391;152680.2365988163;153410;27701.30746731348;28029.57955630708;28777.136685899455;29864.25339366446;29928.401431970804;35561.82219088888;35683.46474802932;35698;35986.28027439489;36278.45582316215;25352.873235633702;26742;27154.1853744388;27268.72731272662;27695.861520692266;26329.341766455993;26998.190054298404;27734.306642333297;27736.445271094868;28356.43287134287;30525.847370763004;30594.08217753471;30618.234544135685;30653.54019689751;30679;26017.869910650326;26947.326316842235;27265.591016134378;27780.583291251052;27899.169709074686;21155.8942205288;22236.221732239293;22241.424690732605;22313.888430557745;22450.438739031655 07:05:25 INFO - PID 3559 | |2;jquery.html;397.97612143271425;399.8160846010835;406.80270069016524;416.8082681966295;421.69216471975454;17125.571860703487;17220.655586888253;17773.466795996126;17868.285268589258;19032.71450928237;17984.280628774864;18342.358017469393;18404.35584754534;18530.90734546329;18843.340483083095;5362.0616392131415;5461.563074954004;5485.780568777264;5640.971795141018;5650.180723795068;5150.407703114133;5164.328637277167;5186.118359878811;5191;5198.636095473318;5143.614228932826;5149.536541711245;5159.200323949775;5174.818881339153;5178.715170665612;5425.6202065855405;5487.368952570466;5488.1493368527945;5501.697406642633;5516.282883225175;4901.926471102936;4968.180250258703;4970.130227210224;4984.601231901439;5002.52476014778;21896.562068758536;21956.23153189647;22123.668144977837;22154.22460213901;22226.777732222632;1631.3556145322532;1659.5768079139864;1679.941202057922;1687.5949772054619;1689.6282817780068;14679.853201467955;14766.557003289918;14923.40306387754;15240.923795380952;15306.617334566725;2019.6667549854255;2106.1891171898774;2125.5855108253895;2137.0810551462864;2153.7415510138726;87313;91424.54287728519;91985.99999999933;92109.53945230298;94467;10804.351738895533;10836.241463097507;11021.944890275658;11158.1631377647;11177.824526667491;15367.61580960485;15424.768628470581;15449.227538623023;15465;15492.612684682974;7596.2023987481625;7642.312191902755;7722.6910923563555;7852.960735196401;7875.755409708206;6909.516333856683;7082.5396349237135;7100.893486597705;7245.275472452818;7261.6006119663925;7033.964830175919;7094.326039026284;7116.6551720691195;7219.241979592172;7250.347468727734;2002.479355367615;2017.1729590867967;2055.342290467036;2062.6390381683145;2077.0653206057336;852.2883392367443;876.9736907892774;879.1516186879692;886.5833058462513;920.6087412849646;16377.344906203856;16684.916575417286;16788.160591970598;16939;17394;872.3980453487073;882.7748924024332;886.3175354976761;889.9911000889908;907.8456662367413;9118.680846170351;9174.266058715286;9348.485833279236;9463.195628371666;9541.761455963657;394359;394841;396278;397919;402429;79572;80811.5959420199;81682;84174.57912710398;85662.14337856666;1083.8211695070383;1125.1954852280494;1128.4808987865674;1136.3011747775058;1137.6018393562188;16984.830151698327;17049.40327088546;17562.473125806246;17934.282628694706;18144.364947226783;38445.775063226785;39420.40869386904;39570.40644390394;40246.59753402429;40549.594504054585;48905;49174.262386064955;50015.49984500254;50411.495885042146;50912.490875092255;7593.075528400677;7754.495957762728;7784.9610751945875;7825.765227043198;7848.725294614661;10848.837267440837;11154.107671386108;11162.55349786032;11617.419129043683;11867.703307417038;9353.204977576983;9363.625454981724;9482;9726.951365243129;9741.220702343937;9133.721279021076;9133.954330228305;9231.76920576991;9254.35219534653;9523.428594284365;9958.850617240601;10038.146757525692;10287.22845786554;10318.329308594917;10319.122874555447;7900.920990790019;7917.941335252991;8041.396895232764;8060.758177254692;8076.87884681742;9821.901780982098;9847.212223022285;9984;10230.948845255725;10362.637307694195 07:05:25 INFO - PID 3559 | |3;mootools.html;1254.1910467748303;1301.759174552708;1312.165722040393;1317.5059352742721;1328.73425314937;10475.109615682666;10896.40069796161;10989.945050274748;11008.174386920982;11259.324440533554;10960.506777195025;11135.888641113586;11151.330920144777;11160.330380177194;11168.329900205974;2192.1560199323217;2224.8442609017375;2228.3649159989404;2237.798598126168;2247.921322753704;2108.641530939744;2179.498715295483;2181.1166477576608;2189.4526368407896;2193.056985496236;2126.2876936226385;2132.275026490993;2146.7209262795814;2154.235246487498;2158.4388059104667;2100.9264675736354;2102.810747032767;2105.52625659227;2110.113752224062;2116.9364919052455;2008.6284037453117;2015.4256037029522;2050.63088644044;2089.2791986764696;2090.905909234088;10524;10635.872825434944;10642.14862810981;10647.520861561248;10663.680089597325;5511.200875873016;5724.742386592572;5725.141228815669;5737.168110623978;5738.053221218535;3110.9222269443217;3222.742180625568;3308.4044871923284;3315.088350703552;3315.602127744662;1057.3814318623615;1062.8565143705578;1069.4919913041322;1079.94060326682;1106.0322218059198;15924.840751592452;16017.599560010976;16057.678846423123;16160.595985100348;16184.109873956928;4619.422572178478;4632.374629424984;4820.108279968217;4835.6131509479155;4862.489438608965;11110.333379997226;11124.276922000045;11130.38782866934;11135.387553684624;11153.498092585853;5437.782488700487;5555.472230138131;5567.526760225345;5577.721113944368;5584.6090773646265;5159.097157997336;5163.690178589221;5175.663581867167;5190.870228244324;5208.713520756319;3768.09565704229;3872.283627528916;3883.4174873768598;3958.346872766019;3998.4002399640285;1062.3041907550567;1068.1027936533194;1069.1126365116934;1087.7117563845586;1091.8362245663213;680.7617333933084;696;699.136566340569;713.4114355656604;716.4161208614962;5441.755121019563;6346.904796428057;6405.6797160141805;6441.1304473895425;6484.740610375532;807.9596020198967;822.2887202569854;855.5893171277821;856.9485830850169;862.9395942283979;3484.581850177995;3571.1072231942017;3658.122050707864;3691.224842782992;3720.5721342046013;14051.508197213048;14396.42414303437;14663.92668036653;14669.119852808866;14746;13905.86094139066;14161.929190354189;14381.92809035969;14585;14598.854011459962;7188.78433646981;7207.099112610924;7255.093113360725;7283.271672832674;7298.781036568911;5145.459726728789;5295.470452954673;5380.73096345189;5384.273123128328;5603.80386686464;12678.683032924251;12720.87279127197;12730.809037864625;12751.61745147647;12816.743665126833;13037.543685971325;13038.674033148867;13280;13311.134776239513;13407.581066827897;7532.209118042527;7685.5004424712215;7735.22647735222;7753.767386978399;7769.184235655175;9896.20830333586;10006.599736010769;10093.142082923034;10136.341137826017;10153.898461015295;8395.782611521417;8434.915650843413;8494.27798637098;8572.099929507562;8574;8044.235797599219;8129.349652027942;8135.105138434649;8148.796280093045;8165.510069395856;6588.868222635425;6654.933450665431;6670;6673.1992160941;6710.261871194067;4934.136526107845;5030.37120359955;5034.2951986721155;5073.315102461268;5334.879675268082;5054.59563234933;5078.187490001582;5143.768530416065;5177.767000485062;5190.792368305226 07:05:25 INFO - PID 3559 | |4;prototype.html;320.4600248581141;352.9947050794237;353.5192138691379;356.84833945573126;358.11902719310496;5498.615096943211;5665.8583535411635;5687.488126068653;5703.543716502681;5774;5463.590230732691;5496.285482887229;5505.642133261335;5510.1459273812525;5512.6968016759065;4007.779572123532;4106.938395924056;4122.278601244785;4140.544540100586;4148.087420767426;4140.772257525835;4163.188178305231;4164.771392439237;4168.145530166309;4170;4105.178964207155;4112.095339025424;4113.856015039474;4119.876403707894;4120.711550191488;4114.958850411487;4119.855805046824;4126.195391898581;4131.111810960628;4134.875953721393;3511.227529943434;3540.486629438717;3558.09268636496;3604.6936010439144;3606.2246616977477;5397.595180361449;5408.2698835657075;5423.48142520095;5430.972845135789;5467.972660136714;4821.204501257288;4845.861222612683;4853.199222128344;4869.318295438641;4874.220124780054;5781.335146458127;5810.448007439287;5825.359210486843;5889.499392551638;5904.202932604129;3995.3407687731487;4003.4395184674167;4003.819828107742;4006.819693113817;4007.5391329997133;6008.047384599979;6201.565890387629;6243.282022567418;6300;6310.179676642053;4011.7392369495888;4054;4064.837406503707;4067.8372865085657;4076.6942479313575;4104.42538044668;4133.173365326947;4138.213739389506;4138.441310423114;4152.43942067823;4688.531146885284;4760.45254795696;4763.214069678534;4814.229723244264;4816.5068828663225;5838.824835254949;5876.177335173079;5902.3507414184405;5911.556633252523;5962.284525856925;1414.335262426658;1428.6999730056596;1431.8067060946846;1434.5767998440485;1439.3810661415691;890.8841850559386;925.6898938855425;948.9810203796023;953.547065144051;953.756792018031;5046.419661738873;5067.391912970467;5075.187969924795;5098.388193416814;5109.3613298337705;6082.2701275847185;6094;6127.172831667668;6127.479164271087;6134.2332208473945;4795.304680821261;4975.651704380659;4993.925091123636;5002.89994200114;5065.39215294167;3202.647708752035;3218.6620404857154;3232.5474433578847;3235.4014507316224;3236.3041945981727;5475.178723191553;5638.577106717013;5648.915266271009;5649.68926709035;5665.348484924204;6248.343923888017;6251.624902505864;6297.307296197415;6300.810975670737;6358.491320694333;5631.352394474524;5652.943470565242;5672.823218997375;5677.489025987681;5708.885822283531;5930.644161350333;6021.819345419644;6039.78860739872;6071.332153463027;6084.695765211633;5977.581569290108;6001.399860013964;6004.489618382487;6020.939790602038;6061.393860613904;5530.695811730394;5665.405132461197;5683.431656834449;5695.145728140812;5705.144228365778;4059.573744756758;4098.036961314029;4098.815553300049;4109.835606575703;4115.691323150716;6015.187949626919;6127.295361033538;6148.9692551536955;6149.538784591084;6208.0998255253635;5876.382979787061;5896.70516474166;5898.35118136996;5965.701714914324;5977.671228082323;5942.168096466412;5965.552583556338;5968.552358573038;5982.7307771149535;5992.64044157352;5665.773369065191;5802.361740208489;5838.766449341979;5861.325947515919;5879.2944846618675;5982.760689572368;5983;5988.580799344004;5996.730147143477;6034.8793024138395;5641.887162256649;5791.681457519877;5810.7094645266725;5821.359650438533;5825.50483208932 07:05:25 INFO - PID 3559 | |5;yui.html;725.0574253470487;738.1105767550102;745.1951891956686;748.2928632442345;762.5615271219046;13642.386092625831;14518.927405362985;14584.052036617626;16247.350105995745;16694.749578756328;16306.42927497535;16403.917980410082;16463.588410289747;16465.25906334215;16542.338306467725;883.191879430322;899.1278459893892;906.7823722306632;909.1136142261308;911.293747345809;869.5478351257342;900.6712549919298;909.7270818754347;912.3704643795793;912.6486302773413;954.6324665003954;954.88063992001;955.0258736089185;958.7986522830214;960.5437417226797;950.7242899559119;951.4101257220499;954.4941181173989;957.966471173509;960.6973803252023;697.8953157026436;698.078536332042;699.3705664901578;700.58315302395;701.9996504980382;14043.578692639237;14168.433262669481;14208.857911420857;14242.430302787876;14310;16326;16711;16809.41167059159;16866.91566542172;16886.240119194543;12434;13070.738585228242;13103.279319637417;13134.146280491737;13217;2959.2306000439826;2977.895773647912;2979.2551862034493;2984.179350678559;2986.3877905029417;86441.13558864394;87882.5605871973;87922.56038719765;89567.10432895653;90707;11745.765084698258;11757.235779674294;11841.940790295994;11928.403579820973;11935.76128477443;22450.77549224487;22961.081556737878;23008.53982920332;23055.769442305696;23092.307230783103;5854.18041474194;5876.206712093813;5961.016432288624;6005.6997150142315;6034.668093254913;2933.339998500363;3002.084364268875;3030.272734543738;3043.1631301392295;3046.6191726034244;3518.331517011811;3599.892003239907;3610.6389361064207;3623.5108260385036;3623.9818800905828;615.5906322295623;617.4967401567798;619.5322531488697;620.4106099205773;624.0420953835841;503.76088677751676;518.6525028231094;586.7095787585173;603.285107148031;618.9381061893864;9474.478903660227;9492.667756628485;9804.803903921882;9903.702888913343;10494.842577361345;569.2770181869085;574.4628772098101;574.787328688388;578.0750798722095;589.5637228450915;4372.978135109368;4496.3705081288645;4554.88612784683;4561.657875659339;4670.7664616769025;86903.56548217218;87031;88289.8197126195;89321.55339223263;89948;79474.20525794668;79701.60149199217;79902.6004869972;80471.19528804754;82627;62893.685531572046;63566.36433635605;63811.680941595;64150.6792466044;64294.35705642977;10224.795504089729;10295.794084118126;10354;10758.085562726943;11026.283291586022;27858.721412785613;28128.71871281261;28519.714802852537;29444.411111777215;29499.852500738216;34688.82655586706;35008.47487287642;35057.474137888465;35586;35769.28461430809;13954.302284885513;14041.297935103408;14181.361838717075;14266.928665356607;14363.784543232068;15412.768808467657;15572;15594;15630.921845391154;15865.841341586436;14406.639834004234;14412;14589.781153282496;14614.342354593857;14662.486812961923;13090.476380944656;13455.730885382432;13506.527271545448;13616.18302901829;13685.247311397969;14327.283635818376;14497.78253326222;14545.200013999332;14554.708905821613;14654.047486913743;10512.526936288039;10802.837957430802;10876.238663293494;10877.51051202682;11207.887921121011;11102.2783519071;11134.554617815196;11533.88466115328;11535.76928461443;11733.941330293294 07:05:25 INFO - PID 3559 | __end_tp_report 07:05:25 INFO - PID 3559 | __start_cc_report 07:05:25 INFO - PID 3559 | _x_x_mozilla_cycle_collect,355 07:05:25 INFO - PID 3559 | __end_cc_report 07:05:25 INFO - PID 3559 | __startTimestamp1495721125420__endTimestamp 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | ------- Summary: start ------- 07:05:25 INFO - PID 3559 | Number of tests: 6 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#0] dojo.html Cycles:165 Average:5296.92 Median:5425.73 stddev:641.29 (11.8%) stddev-sans-first:610.56 07:05:25 INFO - PID 3559 | Values: 2719.9 2732.6 2753.4 2764.9 2771.5 5261.1 5359.7 5375.0 5389.7 5399.4 5368.5 5369.5 5384.1 5424.3 5437.9 4635.1 4711.1 4734.7 4753.6 4758.9 4677.6 4829.0 4847.1 4896.7 4898.5 4722.0 4823.2 4824.8 4894.0 4947.6 4772.1 4797.2 4803.5 4829.0 4856.6 4791.2 4796.5 4800.8 4806.9 4817.3 5357.9 5361.1 5390.5 5395.3 5403.0 5673.4 5770.2 5777.9 5811.1 5829.1 5874.3 5898.6 5912.0 5918.7 5920.4 5399.0 5409.7 5412.1 5425.2 5425.7 5974.6 5981.3 6001.1 6001.3 6001.8 5516.0 5591.9 5660.5 5723.3 5730.7 5685.9 5796.7 5811.3 5830.9 5880.2 5756.1 5785.4 5791.1 5794.1 5796.3 5584.5 5636.6 5755.6 5796.5 5811.9 4772.1 4778.5 4781.6 4810.6 4820.0 4079.7 4091.4 4092.7 4103.5 4135.0 4795.9 4830.4 4861.3 4877.8 4893.0 5844.2 5846.4 5853.5 5872.6 5903.8 4890.5 4891.0 4895.0 4896.3 4951.4 5007.0 5096.2 5114.8 5123.5 5141.0 5253.0 5259.8 5301.0 5303.5 5311.5 5857.0 5880.1 5883.1 5883.4 5888.3 5313.9 5324.2 5408.3 5413.9 5433.0 5618.9 5775.1 5781.3 5817.2 5818.0 5715.6 5796.1 5796.1 5798.9 5885.6 5634.1 5690.3 5702.8 5710.2 5721.7 5648.8 5658.3 5660.6 5661.3 5663.1 5481.2 5546.8 5587.7 5596.5 5599.2 5577.4 5642.5 5668.0 5699.0 5704.4 5578.1 5579.7 5580.1 5595.8 5639.4 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#1] ext.html Cycles:180 Average:30031.35 Median:29017.07 stddev:40885.33 (140.9%) stddev-sans-first:40940.48 07:05:25 INFO - PID 3559 | Values: 645.2 700.4 722.2 1059.5 1074.2 29812.9 32940.2 33001.0 33044.7 33198.0 35219.3 35577.5 35691.1 35713.0 35715.5 6645.1 6894.3 6985.5 7028.3 7038.6 6827.7 6840.7 6876.7 6933.6 6939.9 6830.1 6907.4 6920.4 6929.1 6932.4 6859.3 6867.5 6878.9 6902.8 6908.4 6775.1 6784.0 6808.1 6820.2 6839.0 30886.2 31160.4 31201.0 31384.4 31470.8 3074.4 3096.6 3097.7 3102.7 3105.6 24243.9 24390.6 24531.8 24533.0 24604.4 2755.7 2767.1 2775.0 2779.5 2806.2 145641.0 145777.0 146237.0 147981.0 153666.5 38380.8 38381.4 38418.2 38485.4 38525.6 39339.8 39530.0 39605.2 39638.4 39649.8 12643.6 12688.9 12714.9 12759.2 12772.0 10372.1 10416.1 10419.6 10424.4 10437.3 12312.1 12393.9 12468.9 12486.6 12519.2 5353.6 5362.0 5379.4 5384.7 5403.5 880.2 905.2 910.1 917.5 938.7 20413.6 21123.0 21177.5 21396.4 21403.5 985.2 995.2 1005.3 1012.4 1015.9 10697.9 10975.4 11059.9 11158.7 11229.7 173421.0 174385.0 174885.0 174953.0 175214.0 39033.4 39059.0 39384.8 39545.4 39551.4 1197.4 1240.9 1248.6 1252.7 1258.2 19231.7 19821.2 20520.9 20660.0 20933.6 28964.9 28965.7 28992.1 29042.0 29048.1 151087.0 151983.0 152391.0 152680.2 153410.0 27701.3 28029.6 28777.1 29864.3 29928.4 35561.8 35683.5 35698.0 35986.3 36278.5 25352.9 26742.0 27154.2 27268.7 27695.9 26329.3 26998.2 27734.3 27736.4 28356.4 30525.8 30594.1 30618.2 30653.5 30679.0 26017.9 26947.3 27265.6 27780.6 27899.2 21155.9 22236.2 22241.4 22313.9 22450.4 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#2] jquery.html Cycles:180 Average:25763.97 Median:4977.37 stddev:66102.77 (1328.1%) stddev-sans-first:66260.77 07:05:25 INFO - PID 3559 | Values: 398.0 399.8 406.8 416.8 421.7 17125.6 17220.7 17773.5 17868.3 19032.7 17984.3 18342.4 18404.4 18530.9 18843.3 5362.1 5461.6 5485.8 5641.0 5650.2 5150.4 5164.3 5186.1 5191.0 5198.6 5143.6 5149.5 5159.2 5174.8 5178.7 5425.6 5487.4 5488.1 5501.7 5516.3 4901.9 4968.2 4970.1 4984.6 5002.5 21896.6 21956.2 22123.7 22154.2 22226.8 1631.4 1659.6 1679.9 1687.6 1689.6 14679.9 14766.6 14923.4 15240.9 15306.6 2019.7 2106.2 2125.6 2137.1 2153.7 87313.0 91424.5 91986.0 92109.5 94467.0 10804.4 10836.2 11021.9 11158.2 11177.8 15367.6 15424.8 15449.2 15465.0 15492.6 7596.2 7642.3 7722.7 7853.0 7875.8 6909.5 7082.5 7100.9 7245.3 7261.6 7034.0 7094.3 7116.7 7219.2 7250.3 2002.5 2017.2 2055.3 2062.6 2077.1 852.3 877.0 879.2 886.6 920.6 16377.3 16684.9 16788.2 16939.0 17394.0 872.4 882.8 886.3 890.0 907.8 9118.7 9174.3 9348.5 9463.2 9541.8 394359.0 394841.0 396278.0 397919.0 402429.0 79572.0 80811.6 81682.0 84174.6 85662.1 1083.8 1125.2 1128.5 1136.3 1137.6 16984.8 17049.4 17562.5 17934.3 18144.4 38445.8 39420.4 39570.4 40246.6 40549.6 48905.0 49174.3 50015.5 50411.5 50912.5 7593.1 7754.5 7785.0 7825.8 7848.7 10848.8 11154.1 11162.6 11617.4 11867.7 9353.2 9363.6 9482.0 9727.0 9741.2 9133.7 9134.0 9231.8 9254.4 9523.4 9958.9 10038.1 10287.2 10318.3 10319.1 7900.9 7917.9 8041.4 8060.8 8076.9 9821.9 9847.2 9984.0 10230.9 10362.6 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#3] mootools.html Cycles:180 Average:6454.44 Median:3265.57 stddev:4376.74 (134.0%) stddev-sans-first:4371.58 07:05:25 INFO - PID 3559 | Values: 1254.2 1301.8 1312.2 1317.5 1328.7 10475.1 10896.4 10989.9 11008.2 11259.3 10960.5 11135.9 11151.3 11160.3 11168.3 2192.2 2224.8 2228.4 2237.8 2247.9 2108.6 2179.5 2181.1 2189.5 2193.1 2126.3 2132.3 2146.7 2154.2 2158.4 2100.9 2102.8 2105.5 2110.1 2116.9 2008.6 2015.4 2050.6 2089.3 2090.9 10524.0 10635.9 10642.1 10647.5 10663.7 5511.2 5724.7 5725.1 5737.2 5738.1 3110.9 3222.7 3308.4 3315.1 3315.6 1057.4 1062.9 1069.5 1079.9 1106.0 15924.8 16017.6 16057.7 16160.6 16184.1 4619.4 4632.4 4820.1 4835.6 4862.5 11110.3 11124.3 11130.4 11135.4 11153.5 5437.8 5555.5 5567.5 5577.7 5584.6 5159.1 5163.7 5175.7 5190.9 5208.7 3768.1 3872.3 3883.4 3958.3 3998.4 1062.3 1068.1 1069.1 1087.7 1091.8 680.8 696.0 699.1 713.4 716.4 5441.8 6346.9 6405.7 6441.1 6484.7 808.0 822.3 855.6 856.9 862.9 3484.6 3571.1 3658.1 3691.2 3720.6 14051.5 14396.4 14663.9 14669.1 14746.0 13905.9 14161.9 14381.9 14585.0 14598.9 7188.8 7207.1 7255.1 7283.3 7298.8 5145.5 5295.5 5380.7 5384.3 5603.8 12678.7 12720.9 12730.8 12751.6 12816.7 13037.5 13038.7 13280.0 13311.1 13407.6 7532.2 7685.5 7735.2 7753.8 7769.2 9896.2 10006.6 10093.1 10136.3 10153.9 8395.8 8434.9 8494.3 8572.1 8574.0 8044.2 8129.3 8135.1 8148.8 8165.5 6588.9 6654.9 6670.0 6673.2 6710.3 4934.1 5030.4 5034.3 5073.3 5334.9 5054.6 5078.2 5143.8 5177.8 5190.8 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#4] prototype.html Cycles:180 Average:4819.48 Median:5511.42 stddev:1467.04 (26.6%) stddev-sans-first:1431.76 07:05:25 INFO - PID 3559 | Values: 320.5 353.0 353.5 356.8 358.1 5498.6 5665.9 5687.5 5703.5 5774.0 5463.6 5496.3 5505.6 5510.1 5512.7 4007.8 4106.9 4122.3 4140.5 4148.1 4140.8 4163.2 4164.8 4168.1 4170.0 4105.2 4112.1 4113.9 4119.9 4120.7 4115.0 4119.9 4126.2 4131.1 4134.9 3511.2 3540.5 3558.1 3604.7 3606.2 5397.6 5408.3 5423.5 5431.0 5468.0 4821.2 4845.9 4853.2 4869.3 4874.2 5781.3 5810.4 5825.4 5889.5 5904.2 3995.3 4003.4 4003.8 4006.8 4007.5 6008.0 6201.6 6243.3 6300.0 6310.2 4011.7 4054.0 4064.8 4067.8 4076.7 4104.4 4133.2 4138.2 4138.4 4152.4 4688.5 4760.5 4763.2 4814.2 4816.5 5838.8 5876.2 5902.4 5911.6 5962.3 1414.3 1428.7 1431.8 1434.6 1439.4 890.9 925.7 949.0 953.5 953.8 5046.4 5067.4 5075.2 5098.4 5109.4 6082.3 6094.0 6127.2 6127.5 6134.2 4795.3 4975.7 4993.9 5002.9 5065.4 3202.6 3218.7 3232.5 3235.4 3236.3 5475.2 5638.6 5648.9 5649.7 5665.3 6248.3 6251.6 6297.3 6300.8 6358.5 5631.4 5652.9 5672.8 5677.5 5708.9 5930.6 6021.8 6039.8 6071.3 6084.7 5977.6 6001.4 6004.5 6020.9 6061.4 5530.7 5665.4 5683.4 5695.1 5705.1 4059.6 4098.0 4098.8 4109.8 4115.7 6015.2 6127.3 6149.0 6149.5 6208.1 5876.4 5896.7 5898.4 5965.7 5977.7 5942.2 5965.6 5968.6 5982.7 5992.6 5665.8 5802.4 5838.8 5861.3 5879.3 5982.8 5983.0 5988.6 5996.7 6034.9 5641.9 5791.7 5810.7 5821.4 5825.5 07:05:25 INFO - PID 3559 | 07:05:25 INFO - PID 3559 | [#5] yui.html Cycles:180 Average:17695.60 Median:18867.72 stddev:23854.52 (126.4%) stddev-sans-first:23887.40 07:05:25 INFO - PID 3559 | Values: 725.1 738.1 745.2 748.3 762.6 13642.4 14518.9 14584.1 16247.4 16694.7 16306.4 16403.9 16463.6 16465.3 16542.3 883.2 899.1 906.8 909.1 911.3 869.5 900.7 909.7 912.4 912.6 954.6 954.9 955.0 958.8 960.5 950.7 951.4 954.5 958.0 960.7 697.9 698.1 699.4 700.6 702.0 14043.6 14168.4 14208.9 14242.4 14310.0 16326.0 16711.0 16809.4 16866.9 16886.2 12434.0 13070.7 13103.3 13134.1 13217.0 2959.2 2977.9 2979.3 2984.2 2986.4 86441.1 87882.6 87922.6 89567.1 90707.0 11745.8 11757.2 11841.9 11928.4 11935.8 22450.8 22961.1 23008.5 23055.8 23092.3 5854.2 5876.2 5961.0 6005.7 6034.7 2933.3 3002.1 3030.3 3043.2 3046.6 3518.3 3599.9 3610.6 3623.5 3624.0 615.6 617.5 619.5 620.4 624.0 503.8 518.7 586.7 603.3 618.9 9474.5 9492.7 9804.8 9903.7 10494.8 569.3 574.5 574.8 578.1 589.6 4373.0 4496.4 4554.9 4561.7 4670.8 86903.6 87031.0 88289.8 89321.6 89948.0 79474.2 79701.6 79902.6 80471.2 82627.0 62893.7 63566.4 63811.7 64150.7 64294.4 10224.8 10295.8 10354.0 10758.1 11026.3 27858.7 28128.7 28519.7 29444.4 29499.9 34688.8 35008.5 35057.5 35586.0 35769.3 13954.3 14041.3 14181.4 14266.9 14363.8 15412.8 15572.0 15594.0 15630.9 15865.8 14406.6 14412.0 14589.8 14614.3 14662.5 13090.5 13455.7 13506.5 13616.2 13685.2 14327.3 14497.8 14545.2 14554.7 14654.0 10512.5 10802.8 10876.2 10877.5 11207.9 11102.3 11134.6 11533.9 11535.8 11733.9 07:05:25 INFO - PID 3559 | -------- Summary: end -------- 07:05:25 INFO - PID 3559 | 07:05:26 INFO - TEST-INFO | 3559: exit 0 07:05:26 INFO - TEST-OK | dromaeo_css | took 1148310ms 07:05:26 INFO - TEST-START | kraken 07:05:26 INFO - operating with platform_type : linux_ 07:05:26 INFO - Initialising browser for kraken test... 07:05:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39849/getInfo.html -profile /tmp/tmpavo61M/profile 07:05:26 INFO - TEST-INFO | started process 4013 (/builds/slave/test/build/application/firefox/firefox http://localhost:39849/getInfo.html) 07:06:00 INFO - TEST-INFO | 4013: killed by SIGTERM 07:06:00 INFO - Browser initialized. 07:06:00 INFO - Running cycle 1/1 for kraken test... 07:06:00 INFO - TEST-INFO | started process 4233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavo61M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:12 INFO - PID 4233 | RSS: Main: 176107520 07:06:12 INFO - PID 4233 | 07:06:15 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39849/tests/kraken/driver.html?testName=audio-beat-detection) 07:06:16 INFO - PID 4233 | RSS: Main: 181673984 07:06:16 INFO - PID 4233 | 07:06:19 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39849/tests/kraken/driver.html?testName=audio-dft) 07:06:19 INFO - PID 4233 | RSS: Main: 180662272 07:06:19 INFO - PID 4233 | 07:06:22 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39849/tests/kraken/driver.html?testName=audio-fft) 07:06:23 INFO - PID 4233 | RSS: Main: 178421760 07:06:23 INFO - PID 4233 | 07:06:25 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39849/tests/kraken/driver.html?testName=audio-oscillator) 07:06:26 INFO - PID 4233 | RSS: Main: 178814976 07:06:26 INFO - PID 4233 | 07:06:28 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:29 INFO - PID 4233 | RSS: Main: 179843072 07:06:29 INFO - PID 4233 | 07:06:32 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39849/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:32 INFO - PID 4233 | RSS: Main: 182796288 07:06:32 INFO - PID 4233 | 07:06:36 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39849/tests/kraken/driver.html?testName=imaging-desaturate) 07:06:36 INFO - PID 4233 | RSS: Main: 178991104 07:06:36 INFO - PID 4233 | 07:06:39 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39849/tests/kraken/driver.html?testName=json-parse-financial) 07:06:40 INFO - PID 4233 | RSS: Main: 179933184 07:06:40 INFO - PID 4233 | 07:06:42 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:06:42 INFO - PID 4233 | RSS: Main: 180822016 07:06:42 INFO - PID 4233 | 07:06:44 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:06:45 INFO - PID 4233 | RSS: Main: 180224000 07:06:45 INFO - PID 4233 | 07:06:47 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:06:48 INFO - PID 4233 | RSS: Main: 180142080 07:06:48 INFO - PID 4233 | 07:06:51 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:06:51 INFO - PID 4233 | RSS: Main: 180396032 07:06:51 INFO - PID 4233 | 07:06:54 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:06:55 INFO - PID 4233 | RSS: Main: 180293632 07:06:55 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | Cycle 1(1): loaded http://localhost:39849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39849/tests/kraken/driver.html?testName=ai-astar) 07:06:57 INFO - PID 4233 | RSS: Main: 181604352 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | __start_tp_report 07:06:57 INFO - PID 4233 | _x_x_mozilla_page_load 07:06:57 INFO - PID 4233 | _x_x_mozilla_page_load_details 07:06:57 INFO - PID 4233 | |i|pagename|runs| 07:06:57 INFO - PID 4233 | |0;ai-astar;104;111;112;115;115;113;112;112;112;111 07:06:57 INFO - PID 4233 | |1;audio-beat-detection;153;131;126;175;127;124;126;129;147;124 07:06:57 INFO - PID 4233 | |2;audio-dft;165;165;164;166;168;167;171;169;165;163 07:06:57 INFO - PID 4233 | |3;audio-fft;82;75;75;101;76;78;76;81;100;76 07:06:57 INFO - PID 4233 | |4;audio-oscillator;83;86;110;84;84;83;96;83;83;112 07:06:57 INFO - PID 4233 | |5;imaging-gaussian-blur;114;114;114;114;114;114;115;115;114;113 07:06:57 INFO - PID 4233 | |6;imaging-darkroom;151;150;150;151;152;151;150;151;150;151 07:06:57 INFO - PID 4233 | |7;imaging-desaturate;94;96;95;94;94;95;94;95;94;95 07:06:57 INFO - PID 4233 | |8;json-parse-financial;55;62;54;55;56;58;61;62;55;55 07:06:57 INFO - PID 4233 | |9;json-stringify-tinderbox;57;57;56;57;58;56;56;57;57;61 07:06:57 INFO - PID 4233 | |10;stanford-crypto-aes;87;86;88;89;87;94;88;89;122;87 07:06:57 INFO - PID 4233 | |11;stanford-crypto-ccm;147;143;145;134;134;142;137;135;137;139 07:06:57 INFO - PID 4233 | |12;stanford-crypto-pbkdf2;190;202;199;197;197;207;202;200;193;188 07:06:57 INFO - PID 4233 | |13;stanford-crypto-sha256-iterative;73;74;71;76;79;74;81;77;76;73 07:06:57 INFO - PID 4233 | __end_tp_report 07:06:57 INFO - PID 4233 | __start_cc_report 07:06:57 INFO - PID 4233 | _x_x_mozilla_cycle_collect,933 07:06:57 INFO - PID 4233 | __end_cc_report 07:06:57 INFO - PID 4233 | __startTimestamp1495721217635__endTimestamp 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | ------- Summary: start ------- 07:06:57 INFO - PID 4233 | Number of tests: 14 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:1.51 07:06:57 INFO - PID 4233 | Values: 104.0 111.0 112.0 115.0 115.0 113.0 112.0 112.0 112.0 111.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.00 stddev:16.91 (13.0%) stddev-sans-first:16.81 07:06:57 INFO - PID 4233 | Values: 153.0 131.0 126.0 175.0 127.0 124.0 126.0 129.0 147.0 124.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.50 stddev:2.45 (1.5%) stddev-sans-first:2.55 07:06:57 INFO - PID 4233 | Values: 165.0 165.0 164.0 166.0 168.0 167.0 171.0 169.0 165.0 163.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:10.04 (13.2%) stddev-sans-first:10.65 07:06:57 INFO - PID 4233 | Values: 82.0 75.0 75.0 101.0 76.0 78.0 76.0 81.0 100.0 76.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:11.56 (13.8%) stddev-sans-first:11.95 07:06:57 INFO - PID 4233 | Values: 83.0 86.0 110.0 84.0 84.0 83.0 96.0 83.0 83.0 112.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:06:57 INFO - PID 4233 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 113.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:06:57 INFO - PID 4233 | Values: 151.0 150.0 150.0 151.0 152.0 151.0 150.0 151.0 150.0 151.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:06:57 INFO - PID 4233 | Values: 94.0 96.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:3.20 (5.6%) stddev-sans-first:3.28 07:06:57 INFO - PID 4233 | Values: 55.0 62.0 54.0 55.0 56.0 58.0 61.0 62.0 55.0 55.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:1.48 (2.6%) stddev-sans-first:1.56 07:06:57 INFO - PID 4233 | Values: 57.0 57.0 56.0 57.0 58.0 56.0 56.0 57.0 57.0 61.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.00 stddev:10.87 (12.4%) stddev-sans-first:11.40 07:06:57 INFO - PID 4233 | Values: 87.0 86.0 88.0 89.0 87.0 94.0 88.0 89.0 122.0 87.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:140.50 stddev:4.69 (3.3%) stddev-sans-first:4.07 07:06:57 INFO - PID 4233 | Values: 147.0 143.0 145.0 134.0 134.0 142.0 137.0 135.0 137.0 139.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.50 Median:199.50 stddev:5.84 (2.9%) stddev-sans-first:5.52 07:06:57 INFO - PID 4233 | Values: 190.0 202.0 199.0 197.0 197.0 207.0 202.0 200.0 193.0 188.0 07:06:57 INFO - PID 4233 | 07:06:57 INFO - PID 4233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:76.00 stddev:3.03 (4.0%) stddev-sans-first:3.08 07:06:57 INFO - PID 4233 | Values: 73.0 74.0 71.0 76.0 79.0 74.0 81.0 77.0 76.0 73.0 07:06:57 INFO - PID 4233 | -------- Summary: end -------- 07:06:57 INFO - PID 4233 | 07:06:58 INFO - TEST-INFO | 4233: exit 0 07:06:58 INFO - TEST-OK | kraken | took 92618ms 07:06:58 INFO - SUITE-END | took 1240s 07:06:58 INFO - Completed test suite (00:20:40) 07:06:58 INFO - javascript benchmark 07:06:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6779.5331708075155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2719.918402447927, 2732.617433559301, 2753.435545713128, 2764.917052488425, 2771.528840097183, 5261.053010458126, 5359.705216213107, 5374.978754036731, 5389.73051347433, 5399.379071406789, 5368.46315368463, 5369.5167434930845, 5384.0847056000475, 5424.321959755031, 5437.918431223535, 4635.072985402933, 4711.104890070876, 4734.739589322586, 4753.619710423175, 4758.928616070762, 4677.555632214951, 4828.97585512072, 4847.0548243092435, 4896.706197628136, 4898.53463920927, 4722.0, 4823.155947709137, 4824.758762061918, 4894.045661096087, 4947.579455746266, 4772.069446457942, 4797.18447863864, 4803.471618122004, 4829.0, 4856.562909338177, 4791.161546729343, 4796.472388037348, 4800.759962001886, 4806.927896081562, 4817.325574419584, 5357.866053348658, 5361.115415956362, 5390.5418039466695, 5395.29861118056, 5403.0, 5673.432656734335, 5770.2210201622665, 5777.942220577783, 5811.099279611667, 5829.09649004405, 5874.3244526879525, 5898.646081235097, 5911.994960856665, 5918.674472903988, 5920.378360272152, 5399.0, 5409.7295135243085, 5412.107002344608, 5425.240466334716, 5425.728713564306, 5974.641521508724, 5981.312149102909, 6001.06983417571, 6001.309849367379, 6001.7599296027665, 5515.972420137874, 5591.8881622368135, 5660.518855897295, 5723.284589426322, 5730.684812335278, 5685.943140568541, 5796.652200867961, 5811.302643682785, 5830.854228644318, 5880.206172166702, 5756.107803290497, 5785.392533783976, 5791.102379131242, 5794.101914203306, 5796.304443466811, 5584.46947539983, 5636.577256705764, 5755.5683323750045, 5796.507296879812, 5811.854703632443, 4772.141014617333, 4778.474367819537, 4781.641376896747, 4810.59109975656, 4819.987802561432, 4079.673626109904, 4091.4067460218102, 4092.7135100542678, 4103.548609652936, 4135.028268356934, 4795.880102997453, 4830.372051633265, 4861.343718597944, 4877.756112194376, 4892.951070489321, 5844.211031510777, 5846.41535846412, 5853.473187413153, 5872.588918775645, 5903.793367232212, 4890.486498917634, 4891.04624598207, 4894.975525122351, 4896.265560165933, 4951.405831300267, 5007.0, 5096.210087436453, 5114.795408183631, 5123.538881500683, 5141.0232055909255, 5253.028189784902, 5259.8422047338645, 5300.9734951325, 5303.549198318186, 5311.468853114658, 5856.970715146397, 5880.117982302689, 5883.146943693055, 5883.382244864399, 5888.263967004124, 5313.9468605315, 5324.1747529133045, 5408.323959505062, 5413.918791218056, 5432.972835135957, 5618.943810562006, 5775.075987841925, 5781.306243250837, 5817.185594016925, 5817.970910145422, 5715.571332150189, 5796.101604251347, 5796.101604251347, 5798.913016304675, 5885.646861188342, 5634.126710359901, 5690.317161940594, 5702.8289151325525, 5710.172025056427, 5721.742521586455, 5648.774049037993, 5658.264425624807, 5660.575456840671, 5661.348944871393, 5663.093904975349, 5481.205225242397, 5546.750396232099, 5587.74855131512, 5596.468335508121, 5599.188117722826, 5577.386487486455, 5642.520385767256, 5668.0, 5699.031164701928, 5704.401037890962, 5578.079616863172, 5579.74891129892, 5580.107182850725, 5595.832125036255, 5639.407862174413], "value": 5248.765234444228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.2063961327567, 700.4116542104631, 722.241646271415, 1059.4649701900544, 1074.1728868771052, 29812.85093574532, 32940.17649558762, 33001.0, 33044.66955330446, 33198.0, 35219.295614087765, 35577.46633800489, 35691.10772230696, 35713.0, 35715.46426803593, 6645.136132302818, 6894.310568943103, 6985.476089293324, 7028.332308430717, 7038.648067596625, 6827.658617069127, 6840.65796710165, 6876.656167191621, 6933.618650974195, 6939.861202775942, 6830.146231721035, 6907.378335949764, 6920.411764999981, 6929.064576282213, 6932.410745086674, 6859.279775623562, 6867.484938629573, 6878.931210687904, 6902.758403455855, 6908.447324214051, 6775.085363475966, 6784.0, 6808.080909077261, 6820.215675197366, 6839.0425340452375, 30886.22784430385, 31160.37679246425, 31201.0, 31384.37231255385, 31470.84264578685, 3074.3697542003833, 3096.628404591441, 3097.674744151854, 3102.689731026902, 3105.580746599203, 24243.87878060616, 24390.634140487906, 24531.754682453306, 24533.0, 24604.384890377703, 2755.738204870534, 2767.1283545683045, 2775.0426102994434, 2779.5274803283287, 2806.158152554246, 145641.0, 145777.0, 146237.0, 147981.0, 153666.46333536634, 38380.80809595934, 38381.424278635845, 38418.231635367134, 38485.42271865924, 38525.61474385276, 39339.80330098331, 39530.0, 39605.20789584192, 39638.405423918666, 39649.80175099106, 12643.557475488315, 12688.87311126877, 12714.936425317814, 12759.234445933274, 12772.0, 10372.11836993864, 10416.062554370143, 10419.635312764018, 10424.426656533964, 10437.32157409766, 12312.076594255466, 12393.938030309972, 12468.937655311665, 12486.562970295996, 12519.186252893533, 5353.57171426285, 5361.973190134025, 5379.35447746273, 5384.730763461811, 5403.5136837684795, 880.1946219209352, 905.1943770044666, 910.0671811393242, 917.5320586500799, 938.666773295484, 20413.59172816565, 21123.0, 21177.470563235733, 21396.358109256747, 21403.464913376978, 985.1626117799813, 995.1690338567232, 1005.2711783956719, 1012.3571532077184, 1015.94920253987, 10697.946510267398, 10975.396353200651, 11059.889401105886, 11158.734336897516, 11229.66311010671, 173421.0, 174385.0, 174885.0, 174953.0, 175214.0, 39033.41449878254, 39059.0, 39384.80307598443, 39545.40681889774, 39551.40672889909, 1197.389331440954, 1240.9007279417624, 1248.6378950104368, 1252.6680429686141, 1258.2199036597185, 19231.711524327427, 19821.20715171377, 20520.897395512926, 20660.0, 20933.581328373653, 28964.855175724828, 28965.710342896302, 28992.13023609295, 29042.0, 29048.12855614335, 151087.0, 151983.0, 152391.0, 152680.2365988163, 153410.0, 27701.30746731348, 28029.57955630708, 28777.136685899455, 29864.25339366446, 29928.401431970804, 35561.82219088888, 35683.46474802932, 35698.0, 35986.28027439489, 36278.45582316215, 25352.873235633702, 26742.0, 27154.1853744388, 27268.72731272662, 27695.861520692266, 26329.341766455993, 26998.190054298404, 27734.306642333297, 27736.445271094868, 28356.43287134287, 30525.847370763004, 30594.08217753471, 30618.234544135685, 30653.54019689751, 30679.0, 26017.869910650326, 26947.326316842235, 27265.591016134378, 27780.583291251052, 27899.169709074686, 21155.8942205288, 22236.221732239293, 22241.424690732605, 22313.888430557745, 22450.438739031655], "value": 14349.16543101591, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.97612143271425, 399.8160846010835, 406.80270069016524, 416.8082681966295, 421.69216471975454, 17125.571860703487, 17220.655586888253, 17773.466795996126, 17868.285268589258, 19032.71450928237, 17984.280628774864, 18342.358017469393, 18404.35584754534, 18530.90734546329, 18843.340483083095, 5362.0616392131415, 5461.563074954004, 5485.780568777264, 5640.971795141018, 5650.180723795068, 5150.407703114133, 5164.328637277167, 5186.118359878811, 5191.0, 5198.636095473318, 5143.614228932826, 5149.536541711245, 5159.200323949775, 5174.818881339153, 5178.715170665612, 5425.6202065855405, 5487.368952570466, 5488.1493368527945, 5501.697406642633, 5516.282883225175, 4901.926471102936, 4968.180250258703, 4970.130227210224, 4984.601231901439, 5002.52476014778, 21896.562068758536, 21956.23153189647, 22123.668144977837, 22154.22460213901, 22226.777732222632, 1631.3556145322532, 1659.5768079139864, 1679.941202057922, 1687.5949772054619, 1689.6282817780068, 14679.853201467955, 14766.557003289918, 14923.40306387754, 15240.923795380952, 15306.617334566725, 2019.6667549854255, 2106.1891171898774, 2125.5855108253895, 2137.0810551462864, 2153.7415510138726, 87313.0, 91424.54287728519, 91985.99999999933, 92109.53945230298, 94467.0, 10804.351738895533, 10836.241463097507, 11021.944890275658, 11158.1631377647, 11177.824526667491, 15367.61580960485, 15424.768628470581, 15449.227538623023, 15465.0, 15492.612684682974, 7596.2023987481625, 7642.312191902755, 7722.6910923563555, 7852.960735196401, 7875.755409708206, 6909.516333856683, 7082.5396349237135, 7100.893486597705, 7245.275472452818, 7261.6006119663925, 7033.964830175919, 7094.326039026284, 7116.6551720691195, 7219.241979592172, 7250.347468727734, 2002.479355367615, 2017.1729590867967, 2055.342290467036, 2062.6390381683145, 2077.0653206057336, 852.2883392367443, 876.9736907892774, 879.1516186879692, 886.5833058462513, 920.6087412849646, 16377.344906203856, 16684.916575417286, 16788.160591970598, 16939.0, 17394.0, 872.3980453487073, 882.7748924024332, 886.3175354976761, 889.9911000889908, 907.8456662367413, 9118.680846170351, 9174.266058715286, 9348.485833279236, 9463.195628371666, 9541.761455963657, 394359.0, 394841.0, 396278.0, 397919.0, 402429.0, 79572.0, 80811.5959420199, 81682.0, 84174.57912710398, 85662.14337856666, 1083.8211695070383, 1125.1954852280494, 1128.4808987865674, 1136.3011747775058, 1137.6018393562188, 16984.830151698327, 17049.40327088546, 17562.473125806246, 17934.282628694706, 18144.364947226783, 38445.775063226785, 39420.40869386904, 39570.40644390394, 40246.59753402429, 40549.594504054585, 48905.0, 49174.262386064955, 50015.49984500254, 50411.495885042146, 50912.490875092255, 7593.075528400677, 7754.495957762728, 7784.9610751945875, 7825.765227043198, 7848.725294614661, 10848.837267440837, 11154.107671386108, 11162.55349786032, 11617.419129043683, 11867.703307417038, 9353.204977576983, 9363.625454981724, 9482.0, 9726.951365243129, 9741.220702343937, 9133.721279021076, 9133.954330228305, 9231.76920576991, 9254.35219534653, 9523.428594284365, 9958.850617240601, 10038.146757525692, 10287.22845786554, 10318.329308594917, 10319.122874555447, 7900.920990790019, 7917.941335252991, 8041.396895232764, 8060.758177254692, 8076.87884681742, 9821.901780982098, 9847.212223022285, 9984.0, 10230.948845255725, 10362.637307694195], "value": 8740.054455037993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.1910467748303, 1301.759174552708, 1312.165722040393, 1317.5059352742721, 1328.73425314937, 10475.109615682666, 10896.40069796161, 10989.945050274748, 11008.174386920982, 11259.324440533554, 10960.506777195025, 11135.888641113586, 11151.330920144777, 11160.330380177194, 11168.329900205974, 2192.1560199323217, 2224.8442609017375, 2228.3649159989404, 2237.798598126168, 2247.921322753704, 2108.641530939744, 2179.498715295483, 2181.1166477576608, 2189.4526368407896, 2193.056985496236, 2126.2876936226385, 2132.275026490993, 2146.7209262795814, 2154.235246487498, 2158.4388059104667, 2100.9264675736354, 2102.810747032767, 2105.52625659227, 2110.113752224062, 2116.9364919052455, 2008.6284037453117, 2015.4256037029522, 2050.63088644044, 2089.2791986764696, 2090.905909234088, 10524.0, 10635.872825434944, 10642.14862810981, 10647.520861561248, 10663.680089597325, 5511.200875873016, 5724.742386592572, 5725.141228815669, 5737.168110623978, 5738.053221218535, 3110.9222269443217, 3222.742180625568, 3308.4044871923284, 3315.088350703552, 3315.602127744662, 1057.3814318623615, 1062.8565143705578, 1069.4919913041322, 1079.94060326682, 1106.0322218059198, 15924.840751592452, 16017.599560010976, 16057.678846423123, 16160.595985100348, 16184.109873956928, 4619.422572178478, 4632.374629424984, 4820.108279968217, 4835.6131509479155, 4862.489438608965, 11110.333379997226, 11124.276922000045, 11130.38782866934, 11135.387553684624, 11153.498092585853, 5437.782488700487, 5555.472230138131, 5567.526760225345, 5577.721113944368, 5584.6090773646265, 5159.097157997336, 5163.690178589221, 5175.663581867167, 5190.870228244324, 5208.713520756319, 3768.09565704229, 3872.283627528916, 3883.4174873768598, 3958.346872766019, 3998.4002399640285, 1062.3041907550567, 1068.1027936533194, 1069.1126365116934, 1087.7117563845586, 1091.8362245663213, 680.7617333933084, 696.0, 699.136566340569, 713.4114355656604, 716.4161208614962, 5441.755121019563, 6346.904796428057, 6405.6797160141805, 6441.1304473895425, 6484.740610375532, 807.9596020198967, 822.2887202569854, 855.5893171277821, 856.9485830850169, 862.9395942283979, 3484.581850177995, 3571.1072231942017, 3658.122050707864, 3691.224842782992, 3720.5721342046013, 14051.508197213048, 14396.42414303437, 14663.92668036653, 14669.119852808866, 14746.0, 13905.86094139066, 14161.929190354189, 14381.92809035969, 14585.0, 14598.854011459962, 7188.78433646981, 7207.099112610924, 7255.093113360725, 7283.271672832674, 7298.781036568911, 5145.459726728789, 5295.470452954673, 5380.73096345189, 5384.273123128328, 5603.80386686464, 12678.683032924251, 12720.87279127197, 12730.809037864625, 12751.61745147647, 12816.743665126833, 13037.543685971325, 13038.674033148867, 13280.0, 13311.134776239513, 13407.581066827897, 7532.209118042527, 7685.5004424712215, 7735.22647735222, 7753.767386978399, 7769.184235655175, 9896.20830333586, 10006.599736010769, 10093.142082923034, 10136.341137826017, 10153.898461015295, 8395.782611521417, 8434.915650843413, 8494.27798637098, 8572.099929507562, 8574.0, 8044.235797599219, 8129.349652027942, 8135.105138434649, 8148.796280093045, 8165.510069395856, 6588.868222635425, 6654.933450665431, 6670.0, 6673.1992160941, 6710.261871194067, 4934.136526107845, 5030.37120359955, 5034.2951986721155, 5073.315102461268, 5334.879675268082, 5054.59563234933, 5078.187490001582, 5143.768530416065, 5177.767000485062, 5190.792368305226], "value": 4765.400068578566, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.4600248581141, 352.9947050794237, 353.5192138691379, 356.84833945573126, 358.11902719310496, 5498.615096943211, 5665.8583535411635, 5687.488126068653, 5703.543716502681, 5774.0, 5463.590230732691, 5496.285482887229, 5505.642133261335, 5510.1459273812525, 5512.6968016759065, 4007.779572123532, 4106.938395924056, 4122.278601244785, 4140.544540100586, 4148.087420767426, 4140.772257525835, 4163.188178305231, 4164.771392439237, 4168.145530166309, 4170.0, 4105.178964207155, 4112.095339025424, 4113.856015039474, 4119.876403707894, 4120.711550191488, 4114.958850411487, 4119.855805046824, 4126.195391898581, 4131.111810960628, 4134.875953721393, 3511.227529943434, 3540.486629438717, 3558.09268636496, 3604.6936010439144, 3606.2246616977477, 5397.595180361449, 5408.2698835657075, 5423.48142520095, 5430.972845135789, 5467.972660136714, 4821.204501257288, 4845.861222612683, 4853.199222128344, 4869.318295438641, 4874.220124780054, 5781.335146458127, 5810.448007439287, 5825.359210486843, 5889.499392551638, 5904.202932604129, 3995.3407687731487, 4003.4395184674167, 4003.819828107742, 4006.819693113817, 4007.5391329997133, 6008.047384599979, 6201.565890387629, 6243.282022567418, 6300.0, 6310.179676642053, 4011.7392369495888, 4054.0, 4064.837406503707, 4067.8372865085657, 4076.6942479313575, 4104.42538044668, 4133.173365326947, 4138.213739389506, 4138.441310423114, 4152.43942067823, 4688.531146885284, 4760.45254795696, 4763.214069678534, 4814.229723244264, 4816.5068828663225, 5838.824835254949, 5876.177335173079, 5902.3507414184405, 5911.556633252523, 5962.284525856925, 1414.335262426658, 1428.6999730056596, 1431.8067060946846, 1434.5767998440485, 1439.3810661415691, 890.8841850559386, 925.6898938855425, 948.9810203796023, 953.547065144051, 953.756792018031, 5046.419661738873, 5067.391912970467, 5075.187969924795, 5098.388193416814, 5109.3613298337705, 6082.2701275847185, 6094.0, 6127.172831667668, 6127.479164271087, 6134.2332208473945, 4795.304680821261, 4975.651704380659, 4993.925091123636, 5002.89994200114, 5065.39215294167, 3202.647708752035, 3218.6620404857154, 3232.5474433578847, 3235.4014507316224, 3236.3041945981727, 5475.178723191553, 5638.577106717013, 5648.915266271009, 5649.68926709035, 5665.348484924204, 6248.343923888017, 6251.624902505864, 6297.307296197415, 6300.810975670737, 6358.491320694333, 5631.352394474524, 5652.943470565242, 5672.823218997375, 5677.489025987681, 5708.885822283531, 5930.644161350333, 6021.819345419644, 6039.78860739872, 6071.332153463027, 6084.695765211633, 5977.581569290108, 6001.399860013964, 6004.489618382487, 6020.939790602038, 6061.393860613904, 5530.695811730394, 5665.405132461197, 5683.431656834449, 5695.145728140812, 5705.144228365778, 4059.573744756758, 4098.036961314029, 4098.815553300049, 4109.835606575703, 4115.691323150716, 6015.187949626919, 6127.295361033538, 6148.9692551536955, 6149.538784591084, 6208.0998255253635, 5876.382979787061, 5896.70516474166, 5898.35118136996, 5965.701714914324, 5977.671228082323, 5942.168096466412, 5965.552583556338, 5968.552358573038, 5982.7307771149535, 5992.64044157352, 5665.773369065191, 5802.361740208489, 5838.766449341979, 5861.325947515919, 5879.2944846618675, 5982.760689572368, 5983.0, 5988.580799344004, 5996.730147143477, 6034.8793024138395, 5641.887162256649, 5791.681457519877, 5810.7094645266725, 5821.359650438533, 5825.50483208932], "value": 4352.763208207108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.0574253470487, 738.1105767550102, 745.1951891956686, 748.2928632442345, 762.5615271219046, 13642.386092625831, 14518.927405362985, 14584.052036617626, 16247.350105995745, 16694.749578756328, 16306.42927497535, 16403.917980410082, 16463.588410289747, 16465.25906334215, 16542.338306467725, 883.191879430322, 899.1278459893892, 906.7823722306632, 909.1136142261308, 911.293747345809, 869.5478351257342, 900.6712549919298, 909.7270818754347, 912.3704643795793, 912.6486302773413, 954.6324665003954, 954.88063992001, 955.0258736089185, 958.7986522830214, 960.5437417226797, 950.7242899559119, 951.4101257220499, 954.4941181173989, 957.966471173509, 960.6973803252023, 697.8953157026436, 698.078536332042, 699.3705664901578, 700.58315302395, 701.9996504980382, 14043.578692639237, 14168.433262669481, 14208.857911420857, 14242.430302787876, 14310.0, 16326.0, 16711.0, 16809.41167059159, 16866.91566542172, 16886.240119194543, 12434.0, 13070.738585228242, 13103.279319637417, 13134.146280491737, 13217.0, 2959.2306000439826, 2977.895773647912, 2979.2551862034493, 2984.179350678559, 2986.3877905029417, 86441.13558864394, 87882.5605871973, 87922.56038719765, 89567.10432895653, 90707.0, 11745.765084698258, 11757.235779674294, 11841.940790295994, 11928.403579820973, 11935.76128477443, 22450.77549224487, 22961.081556737878, 23008.53982920332, 23055.769442305696, 23092.307230783103, 5854.18041474194, 5876.206712093813, 5961.016432288624, 6005.6997150142315, 6034.668093254913, 2933.339998500363, 3002.084364268875, 3030.272734543738, 3043.1631301392295, 3046.6191726034244, 3518.331517011811, 3599.892003239907, 3610.6389361064207, 3623.5108260385036, 3623.9818800905828, 615.5906322295623, 617.4967401567798, 619.5322531488697, 620.4106099205773, 624.0420953835841, 503.76088677751676, 518.6525028231094, 586.7095787585173, 603.285107148031, 618.9381061893864, 9474.478903660227, 9492.667756628485, 9804.803903921882, 9903.702888913343, 10494.842577361345, 569.2770181869085, 574.4628772098101, 574.787328688388, 578.0750798722095, 589.5637228450915, 4372.978135109368, 4496.3705081288645, 4554.88612784683, 4561.657875659339, 4670.7664616769025, 86903.56548217218, 87031.0, 88289.8197126195, 89321.55339223263, 89948.0, 79474.20525794668, 79701.60149199217, 79902.6004869972, 80471.19528804754, 82627.0, 62893.685531572046, 63566.36433635605, 63811.680941595, 64150.6792466044, 64294.35705642977, 10224.795504089729, 10295.794084118126, 10354.0, 10758.085562726943, 11026.283291586022, 27858.721412785613, 28128.71871281261, 28519.714802852537, 29444.411111777215, 29499.852500738216, 34688.82655586706, 35008.47487287642, 35057.474137888465, 35586.0, 35769.28461430809, 13954.302284885513, 14041.297935103408, 14181.361838717075, 14266.928665356607, 14363.784543232068, 15412.768808467657, 15572.0, 15594.0, 15630.921845391154, 15865.841341586436, 14406.639834004234, 14412.0, 14589.781153282496, 14614.342354593857, 14662.486812961923, 13090.476380944656, 13455.730885382432, 13506.527271545448, 13616.18302901829, 13685.247311397969, 14327.283635818376, 14497.78253326222, 14545.200013999332, 14554.708905821613, 14654.047486913743, 10512.526936288039, 10802.837957430802, 10876.238663293494, 10877.51051202682, 11207.887921121011, 11102.2783519071, 11134.554617815196, 11533.88466115328, 11535.76928461443, 11733.941330293294], "value": 7110.597297985941, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 115.0, 115.0, 113.0, 112.0, 112.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 126.0, 175.0, 127.0, 124.0, 126.0, 129.0, 147.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 168.0, 167.0, 171.0, 169.0, 165.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 101.0, 76.0, 78.0, 76.0, 81.0, 100.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 110.0, 84.0, 84.0, 83.0, 96.0, 83.0, 83.0, 112.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 152.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 54.0, 55.0, 56.0, 58.0, 61.0, 62.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 57.0, 61.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 89.0, 87.0, 94.0, 88.0, 89.0, 122.0, 87.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 143.0, 145.0, 134.0, 134.0, 142.0, 137.0, 135.0, 137.0, 139.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 202.0, 199.0, 197.0, 197.0, 207.0, 202.0, 200.0, 193.0, 188.0], "value": 197.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 71.0, 76.0, 79.0, 74.0, 81.0, 77.0, 76.0, 73.0], "value": 75.4, "unit": "score"}]}]} 07:06:58 INFO - Return code: 0 07:06:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:06:58 INFO - # TBPL SUCCESS # 07:06:58 INFO - Running post-action listener: _resource_record_post_action 07:06:58 INFO - [mozharness: 2017-05-25 14:06:58.946660Z] Finished run-tests step (success) 07:06:58 INFO - Running post-run listener: _resource_record_post_run 07:06:59 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 13164544; Write bytes: 421289984; Read time: 3216; Write time: 232696 07:06:59 INFO - TinderboxPrint: CPU usage
12.8% 07:06:59 INFO - TinderboxPrint: I/O read bytes / time
13,164,544 / 3,216 07:06:59 INFO - TinderboxPrint: I/O write bytes / time
421,289,984 / 232,696 07:06:59 INFO - TinderboxPrint: CPU idle
8,745.9 (87.1%) 07:06:59 INFO - TinderboxPrint: CPU user
1,231.2 (12.3%) 07:06:59 INFO - TinderboxPrint: Swap in / out
0 / 0 07:06:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111419392; Read time: 116; Write time: 87892 07:06:59 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 10919936; Write bytes: 309870592; Read time: 2892; Write time: 144804 07:06:59 INFO - Running post-run listener: _upload_blobber_files 07:06:59 INFO - Blob upload gear active. 07:06:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:06:59 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 07:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:07:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:01 INFO - (blobuploader) - INFO - Done attempting. 07:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:07 INFO - (blobuploader) - INFO - Done attempting. 07:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:08 INFO - (blobuploader) - INFO - Done attempting. 07:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:09 INFO - (blobuploader) - INFO - Done attempting. 07:07:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:09 INFO - Return code: 0 07:07:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beae083c100ff53d3fbbbf5b21deab92c55e9fe4cd3417de0f9d39ac9d7cc05fc416bc1f447fcaf7efc35857d6cf1f5fd3d726efeb0de6fdec8a58da4a699851", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a68ba23ca594e89dc381256af3647b85b866e57f3bc2641fd72c44f136f7129af05e6bdd6ac39b0f164aaad60dc14d3d06b147685240ff6ace14b8ca34d1dc3f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a241a5cc72151f7925e6ab6915b53ee7d0d9fd852b1744772cd6bedb892189d54c74a115b52388b0e0fb8b0235d04e80cfff2640543d1f49ff430221fcb2fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2b16efb1ebf6d29b7f0e33e10537985d8677ad9f5e024e0ebb285012a54db5cf31d5b1d41644896c7b13d7b6f607a77eb72e44980611776e98d2b506bcf9a5"} 07:07:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:09 INFO - Contents: 07:07:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beae083c100ff53d3fbbbf5b21deab92c55e9fe4cd3417de0f9d39ac9d7cc05fc416bc1f447fcaf7efc35857d6cf1f5fd3d726efeb0de6fdec8a58da4a699851", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a68ba23ca594e89dc381256af3647b85b866e57f3bc2641fd72c44f136f7129af05e6bdd6ac39b0f164aaad60dc14d3d06b147685240ff6ace14b8ca34d1dc3f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a241a5cc72151f7925e6ab6915b53ee7d0d9fd852b1744772cd6bedb892189d54c74a115b52388b0e0fb8b0235d04e80cfff2640543d1f49ff430221fcb2fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2b16efb1ebf6d29b7f0e33e10537985d8677ad9f5e024e0ebb285012a54db5cf31d5b1d41644896c7b13d7b6f607a77eb72e44980611776e98d2b506bcf9a5"} 07:07:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:09 INFO - Copying logs to upload dir... 07:07:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.881727 ========= master_lag: -0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-25 07:07:09.767104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:09.771788) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beae083c100ff53d3fbbbf5b21deab92c55e9fe4cd3417de0f9d39ac9d7cc05fc416bc1f447fcaf7efc35857d6cf1f5fd3d726efeb0de6fdec8a58da4a699851", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a68ba23ca594e89dc381256af3647b85b866e57f3bc2641fd72c44f136f7129af05e6bdd6ac39b0f164aaad60dc14d3d06b147685240ff6ace14b8ca34d1dc3f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a241a5cc72151f7925e6ab6915b53ee7d0d9fd852b1744772cd6bedb892189d54c74a115b52388b0e0fb8b0235d04e80cfff2640543d1f49ff430221fcb2fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2b16efb1ebf6d29b7f0e33e10537985d8677ad9f5e024e0ebb285012a54db5cf31d5b1d41644896c7b13d7b6f607a77eb72e44980611776e98d2b506bcf9a5"} build_url:https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beae083c100ff53d3fbbbf5b21deab92c55e9fe4cd3417de0f9d39ac9d7cc05fc416bc1f447fcaf7efc35857d6cf1f5fd3d726efeb0de6fdec8a58da4a699851", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a68ba23ca594e89dc381256af3647b85b866e57f3bc2641fd72c44f136f7129af05e6bdd6ac39b0f164aaad60dc14d3d06b147685240ff6ace14b8ca34d1dc3f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a241a5cc72151f7925e6ab6915b53ee7d0d9fd852b1744772cd6bedb892189d54c74a115b52388b0e0fb8b0235d04e80cfff2640543d1f49ff430221fcb2fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2b16efb1ebf6d29b7f0e33e10537985d8677ad9f5e024e0ebb285012a54db5cf31d5b1d41644896c7b13d7b6f607a77eb72e44980611776e98d2b506bcf9a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:09.795237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:09.798551) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1495719904.199266-180708832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:09.878041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:07:09.878340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:07:09.881659) ========= ========= Total master_lag: -0.03 =========