builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1497921518.12 results: success (0) revision: 416c3c8c4b3db9ba96a103ce7820c9a140a3051d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.121434) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.122107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.122415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.138203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.138482) ========= 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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-19 18:18:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.8M=0s 2017-06-19 18:18:38 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.227976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.228638) ========= 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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016704 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:38.280400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 18:18:38.280719) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 416c3c8c4b3db9ba96a103ce7820c9a140a3051d --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 416c3c8c4b3db9ba96a103ce7820c9a140a3051d --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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-19 18:18:38,914 truncating revision to first 12 chars 2017-06-19 18:18:38,915 Setting DEBUG logging. 2017-06-19 18:18:38,915 attempt 1/10 2017-06-19 18:18:38,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/416c3c8c4b3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-19 18:18:40,327 unpacking tar archive at: mozilla-central-416c3c8c4b3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.764862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 18:18:40.058973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:40.059282) ========= script_repo_revision: 416c3c8c4b3db9ba96a103ce7820c9a140a3051d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:40.059675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:40.059965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 18:18:40.067900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-19 18:18:40.068179) ========= /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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:40 INFO - MultiFileLogger online at 20170619 18:18:40 in /builds/slave/test 18:18:40 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 18:18:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:40 INFO - {'append_to_log': False, 18:18:40 INFO - 'base_work_dir': '/builds/slave/test', 18:18:40 INFO - 'blob_upload_branch': 'Firefox', 18:18:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:40 INFO - 'branch': 'Firefox', 18:18:40 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:40 INFO - 'config_files': ('talos/linux_config.py',), 18:18:40 INFO - 'default_actions': ('clobber', 18:18:40 INFO - 'read-buildbot-config', 18:18:40 INFO - 'download-and-extract', 18:18:40 INFO - 'populate-webroot', 18:18:40 INFO - 'create-virtualenv', 18:18:40 INFO - 'install', 18:18:40 INFO - 'setup-mitmproxy', 18:18:40 INFO - 'run-tests'), 18:18:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:40 INFO - 'download_minidump_stackwalk': True, 18:18:40 INFO - 'download_symbols': 'ondemand', 18:18:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:40 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:40 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:40 INFO - 'gecko_profile': False, 18:18:40 INFO - 'gecko_profile_interval': 0, 18:18:40 INFO - 'installer_path': 'installer.exe', 18:18:40 INFO - 'log_level': 'info', 18:18:40 INFO - 'log_name': 'talos', 18:18:40 INFO - 'log_to_console': True, 18:18:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:40 INFO - 'opt_config_files': (), 18:18:40 INFO - 'pip_index': False, 18:18:40 INFO - 'suite': 'dromaeojs-e10s', 18:18:40 INFO - 'system_bits': '32', 18:18:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:40 INFO - 'title': 'talos-linux64-ix-026', 18:18:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:40 INFO - 'use_talos_json': True, 18:18:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:40 INFO - 'work_dir': 'build'} 18:18:40 INFO - [mozharness: 2017-06-20 01:18:40.794891Z] Running clobber step. 18:18:40 INFO - Running pre-action listener: _resource_record_pre_action 18:18:40 INFO - Running main action method: clobber 18:18:40 INFO - rmtree: /builds/slave/test/build 18:18:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:42 INFO - Running post-action listener: _resource_record_post_action 18:18:42 INFO - [mozharness: 2017-06-20 01:18:42.373339Z] Finished clobber step (success) 18:18:42 INFO - [mozharness: 2017-06-20 01:18:42.373449Z] Running read-buildbot-config step. 18:18:42 INFO - Running pre-action listener: _resource_record_pre_action 18:18:42 INFO - Running main action method: read_buildbot_config 18:18:42 INFO - Using buildbot properties: 18:18:42 INFO - { 18:18:42 INFO - "project": "", 18:18:42 INFO - "product": "firefox", 18:18:42 INFO - "who": "kwierso@gmail.com", 18:18:42 INFO - "installer_path": "public/build/target.tar.bz2", 18:18:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:18:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:18:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:18:42 INFO - "stage_platform": "linux64-stylo", 18:18:42 INFO - "basedir": "/builds/slave/test", 18:18:42 INFO - "buildnumber": 161, 18:18:42 INFO - "platform": "ubuntu64_hw_stylo", 18:18:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:18:42 INFO - "slavebuilddir": "test", 18:18:42 INFO - "taskId": "cTTMmlJ5RKust_yGx2qnqg", 18:18:42 INFO - "branch": "mozilla-central", 18:18:42 INFO - "script_repo_revision": "production", 18:18:42 INFO - "revision": "416c3c8c4b3db9ba96a103ce7820c9a140a3051d", 18:18:42 INFO - "slavename": "talos-linux64-ix-026", 18:18:42 INFO - "repo_path": "mozilla-central" 18:18:42 INFO - } 18:18:42 INFO - Finding installer, test and symbols from parent task. 18:18:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTTMmlJ5RKust_yGx2qnqg'}, attempt #1 18:18:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTTMmlJ5RKust_yGx2qnqg'}, attempt #1 18:18:43 INFO - Task dependencies: GbRLkPRzQh25xFCIGVtBgw 18:18:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw'}, attempt #1 18:18:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 18:18:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/test_packages.json 18:18:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.crashreporter-symbols.zip 18:18:43 INFO - Running post-action listener: _resource_record_post_action 18:18:43 INFO - [mozharness: 2017-06-20 01:18:43.714912Z] Finished read-buildbot-config step (success) 18:18:43 INFO - [mozharness: 2017-06-20 01:18:43.715223Z] Running download-and-extract step. 18:18:43 INFO - Running pre-action listener: _resource_record_pre_action 18:18:43 INFO - Running main action method: download_and_extract 18:18:43 INFO - mkdir: /builds/slave/test/build/tests 18:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:43 INFO - trying https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.test_packages.json 18:18:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:18:44 INFO - Downloaded 989 bytes. 18:18:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:18:44 INFO - Using the following test package requirements: 18:18:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:18:44 INFO - u'common': [u'target.common.tests.zip'], 18:18:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:18:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:18:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:18:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:18:44 INFO - u'mozbase': [u'target.common.tests.zip'], 18:18:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:18:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:18:44 INFO - u'web-platform': [u'target.common.tests.zip', 18:18:44 INFO - u'target.web-platform.tests.tar.gz'], 18:18:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:18:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:18:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip 18:18:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:18:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip into memory 18:18:45 INFO - Content-Length response header: 67986971 18:18:45 INFO - Bytes received: 67986971 18:18:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:18:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip 18:18:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:18:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.common.tests.zip into memory 18:18:57 INFO - Content-Length response header: 67986971 18:18:57 INFO - Bytes received: 67986971 18:19:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.talos.tests.zip 18:19:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:19:09 INFO - Fetch https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.talos.tests.zip into memory 18:19:10 INFO - Content-Length response header: 14454970 18:19:10 INFO - Bytes received: 14454970 18:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:10 INFO - trying https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 18:19:10 INFO - Downloading https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:19:11 INFO - Downloaded 61508763 bytes. 18:19:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 18:19:11 INFO - mkdir: /builds/slave/test/properties 18:19:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:19:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:19:11 INFO - Contents: 18:19:11 INFO - build_url:https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 18:19:11 INFO - Running post-action listener: _resource_record_post_action 18:19:11 INFO - Running post-action listener: set_extra_try_arguments 18:19:11 INFO - [mozharness: 2017-06-20 01:19:11.978822Z] Finished download-and-extract step (success) 18:19:11 INFO - [mozharness: 2017-06-20 01:19:11.978919Z] Running populate-webroot step. 18:19:11 INFO - Running pre-action listener: _resource_record_pre_action 18:19:11 INFO - Running main action method: populate_webroot 18:19:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:19:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:19:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:19:11 INFO - '--tppagecycles', 18:19:11 INFO - '7'], 18:19:11 INFO - 'tests': ['tsvgm']}}, 18:19:11 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:19:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:19:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:19:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['damp', 'tps']}, 18:19:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'tests': ['damp', 'tps']}, 18:19:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['dromaeo_dom']}, 18:19:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:19:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:19:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:19:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:19:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'other-e10s': {'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['a11yr', 18:19:11 INFO - 'ts_paint', 18:19:11 INFO - 'tpaint', 18:19:11 INFO - 'sessionrestore', 18:19:11 INFO - 'sessionrestore_no_auto_restore', 18:19:11 INFO - 'tabpaint']}, 18:19:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:19:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:19:11 INFO - 'bloom_basic_ref']}, 18:19:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:19:11 INFO - 'talos_options': ['--mitmproxy', 18:19:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:19:11 INFO - '--firstNonBlankPaint'], 18:19:11 INFO - 'tests': ['quantum_pageload_google', 18:19:11 INFO - 'quantum_pageload_youtube', 18:19:11 INFO - 'quantum_pageload_amazon', 18:19:11 INFO - 'quantum_pageload_facebook']}, 18:19:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['tsvgx', 18:19:11 INFO - 'tsvgr_opacity', 18:19:11 INFO - 'tart', 18:19:11 INFO - 'tscrollx', 18:19:11 INFO - 'cart', 18:19:11 INFO - 'tsvg_static']}, 18:19:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:19:11 INFO - 'tsvgr_opacity', 18:19:11 INFO - 'tart', 18:19:11 INFO - 'tscrollx', 18:19:11 INFO - 'cart', 18:19:11 INFO - 'tsvg_static']}, 18:19:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'talos_options': ['--disable-e10s'], 18:19:11 INFO - 'tests': ['tp5o']}, 18:19:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:19:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'talos_options': ['--disable-e10s', 18:19:11 INFO - '--xperf_path', 18:19:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:11 INFO - 'tests': ['tp5n']}, 18:19:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:19:11 INFO - 'talos_options': ['--xperf_path', 18:19:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:11 INFO - 'tests': ['tp5n']}}, 18:19:11 INFO - 'talos.zip': {'path': '', 18:19:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:19:11 INFO - Running post-action listener: _resource_record_post_action 18:19:11 INFO - [mozharness: 2017-06-20 01:19:11.994288Z] Finished populate-webroot step (success) 18:19:11 INFO - [mozharness: 2017-06-20 01:19:11.994378Z] Running create-virtualenv step. 18:19:11 INFO - Running pre-action listener: _resource_record_pre_action 18:19:11 INFO - Running main action method: create_virtualenv 18:19:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:19:11 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 18:19:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:19:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:19:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:19:12 INFO - Using real prefix '/usr' 18:19:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:19:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:19:14 INFO - Installing pip.................done. 18:19:14 INFO - Return code: 0 18:19:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:19:14 INFO - Reading from file tmpfile_stdout 18:19:14 INFO - Output received: 18:19:14 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) 18:19:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:19:14 INFO - Using env: {'DISPLAY': ':0', 18:19:14 INFO - 'HOME': '/home/cltbld', 18:19:14 INFO - 'LANG': 'en_US.UTF-8', 18:19:14 INFO - 'LANGUAGE': 'en_US:en', 18:19:14 INFO - 'LOGNAME': 'cltbld', 18:19:14 INFO - 'MAIL': '/var/mail/cltbld', 18:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:14 INFO - 'MOZ_NO_REMOTE': '1', 18:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:14 INFO - 'NO_EM_RESTART': '1', 18:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:14 INFO - 'PWD': '/builds/slave/test', 18:19:14 INFO - 'SHELL': '/bin/bash', 18:19:14 INFO - 'SHLVL': '1', 18:19:14 INFO - 'TERM': 'linux', 18:19:14 INFO - 'TMOUT': '86400', 18:19:14 INFO - 'USER': 'cltbld', 18:19:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:14 INFO - '_': '/tools/buildbot/bin/python'} 18:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:14 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 18:19:14 INFO - Cleaning up... 18:19:15 INFO - Return code: 0 18:19:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:19:15 INFO - Using env: {'DISPLAY': ':0', 18:19:15 INFO - 'HOME': '/home/cltbld', 18:19:15 INFO - 'LANG': 'en_US.UTF-8', 18:19:15 INFO - 'LANGUAGE': 'en_US:en', 18:19:15 INFO - 'LOGNAME': 'cltbld', 18:19:15 INFO - 'MAIL': '/var/mail/cltbld', 18:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:15 INFO - 'MOZ_NO_REMOTE': '1', 18:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:15 INFO - 'NO_EM_RESTART': '1', 18:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:15 INFO - 'PWD': '/builds/slave/test', 18:19:15 INFO - 'SHELL': '/bin/bash', 18:19:15 INFO - 'SHLVL': '1', 18:19:15 INFO - 'TERM': 'linux', 18:19:15 INFO - 'TMOUT': '86400', 18:19:15 INFO - 'USER': 'cltbld', 18:19:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:15 INFO - '_': '/tools/buildbot/bin/python'} 18:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:15 INFO - Downloading/unpacking psutil>=3.1.1 18:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:16 INFO - Installing collected packages: psutil 18:19:16 INFO - Running setup.py install for psutil 18:19:16 INFO - building 'psutil._psutil_linux' extension 18:19:16 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 18:19:16 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 18:19:16 INFO - building 'psutil._psutil_posix' extension 18:19:16 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 18:19:16 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 18:19:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:16 INFO - Successfully installed psutil 18:19:16 INFO - Cleaning up... 18:19:16 INFO - Return code: 0 18:19:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:16 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:16 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 18:19:16 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 18:19:16 INFO - Using env: {'DISPLAY': ':0', 18:19:16 INFO - 'HOME': '/home/cltbld', 18:19:16 INFO - 'LANG': 'en_US.UTF-8', 18:19:16 INFO - 'LANGUAGE': 'en_US:en', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MAIL': '/var/mail/cltbld', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SHLVL': '1', 18:19:16 INFO - 'TERM': 'linux', 18:19:16 INFO - 'TMOUT': '86400', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - '_': '/tools/buildbot/bin/python'} 18:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:19:18 INFO - Installing collected packages: mozsystemmonitor 18:19:18 INFO - Running setup.py install for mozsystemmonitor 18:19:18 INFO - Successfully installed mozsystemmonitor 18:19:18 INFO - Cleaning up... 18:19:18 INFO - Return code: 0 18:19:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:18 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:18 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 18:19:18 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 18:19:18 INFO - Using env: {'DISPLAY': ':0', 18:19:18 INFO - 'HOME': '/home/cltbld', 18:19:18 INFO - 'LANG': 'en_US.UTF-8', 18:19:18 INFO - 'LANGUAGE': 'en_US:en', 18:19:18 INFO - 'LOGNAME': 'cltbld', 18:19:18 INFO - 'MAIL': '/var/mail/cltbld', 18:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:18 INFO - 'MOZ_NO_REMOTE': '1', 18:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:18 INFO - 'NO_EM_RESTART': '1', 18:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:18 INFO - 'PWD': '/builds/slave/test', 18:19:18 INFO - 'SHELL': '/bin/bash', 18:19:18 INFO - 'SHLVL': '1', 18:19:18 INFO - 'TERM': 'linux', 18:19:18 INFO - 'TMOUT': '86400', 18:19:18 INFO - 'USER': 'cltbld', 18:19:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:18 INFO - '_': '/tools/buildbot/bin/python'} 18:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:19 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:19 INFO - warning: no files found matching '*.txt' 18:19:19 INFO - no previously-included directories found matching 'build' 18:19:19 INFO - no previously-included directories found matching 'dist' 18:19:19 INFO - no previously-included directories found matching '.git*' 18:19:19 INFO - Installing collected packages: jsonschema, functools32 18:19:19 INFO - Running setup.py install for functools32 18:19:20 INFO - warning: no files found matching '*.txt' 18:19:20 INFO - no previously-included directories found matching 'build' 18:19:20 INFO - no previously-included directories found matching 'dist' 18:19:20 INFO - no previously-included directories found matching '.git*' 18:19:20 INFO - Successfully installed jsonschema functools32 18:19:20 INFO - Cleaning up... 18:19:20 INFO - Return code: 0 18:19:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:20 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:20 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 18:19:20 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 18:19:20 INFO - Using env: {'DISPLAY': ':0', 18:19:20 INFO - 'HOME': '/home/cltbld', 18:19:20 INFO - 'LANG': 'en_US.UTF-8', 18:19:20 INFO - 'LANGUAGE': 'en_US:en', 18:19:20 INFO - 'LOGNAME': 'cltbld', 18:19:20 INFO - 'MAIL': '/var/mail/cltbld', 18:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:20 INFO - 'MOZ_NO_REMOTE': '1', 18:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:20 INFO - 'NO_EM_RESTART': '1', 18:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:20 INFO - 'PWD': '/builds/slave/test', 18:19:20 INFO - 'SHELL': '/bin/bash', 18:19:20 INFO - 'SHLVL': '1', 18:19:20 INFO - 'TERM': 'linux', 18:19:20 INFO - 'TMOUT': '86400', 18:19:20 INFO - 'USER': 'cltbld', 18:19:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:20 INFO - '_': '/tools/buildbot/bin/python'} 18:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:19:20 INFO - Cleaning up... 18:19:20 INFO - Return code: 0 18:19:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:20 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:20 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 18:19:20 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 18:19:20 INFO - Using env: {'DISPLAY': ':0', 18:19:20 INFO - 'HOME': '/home/cltbld', 18:19:20 INFO - 'LANG': 'en_US.UTF-8', 18:19:20 INFO - 'LANGUAGE': 'en_US:en', 18:19:20 INFO - 'LOGNAME': 'cltbld', 18:19:20 INFO - 'MAIL': '/var/mail/cltbld', 18:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:20 INFO - 'MOZ_NO_REMOTE': '1', 18:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:20 INFO - 'NO_EM_RESTART': '1', 18:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:20 INFO - 'PWD': '/builds/slave/test', 18:19:20 INFO - 'SHELL': '/bin/bash', 18:19:20 INFO - 'SHLVL': '1', 18:19:20 INFO - 'TERM': 'linux', 18:19:20 INFO - 'TMOUT': '86400', 18:19:20 INFO - 'USER': 'cltbld', 18:19:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:20 INFO - '_': '/tools/buildbot/bin/python'} 18:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:19:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:22 INFO - Downloading docopt-0.6.1.tar.gz 18:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:22 INFO - Running setup.py install for blobuploader 18:19:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:19:22 INFO - Running setup.py install for requests 18:19:22 INFO - Running setup.py install for docopt 18:19:22 INFO - Successfully installed blobuploader requests docopt 18:19:22 INFO - Cleaning up... 18:19:22 INFO - Return code: 0 18:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:22 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:22 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 18:19:22 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 18:19:22 INFO - Using env: {'DISPLAY': ':0', 18:19:22 INFO - 'HOME': '/home/cltbld', 18:19:22 INFO - 'LANG': 'en_US.UTF-8', 18:19:22 INFO - 'LANGUAGE': 'en_US:en', 18:19:22 INFO - 'LOGNAME': 'cltbld', 18:19:22 INFO - 'MAIL': '/var/mail/cltbld', 18:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:22 INFO - 'MOZ_NO_REMOTE': '1', 18:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:22 INFO - 'NO_EM_RESTART': '1', 18:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:22 INFO - 'PWD': '/builds/slave/test', 18:19:22 INFO - 'SHELL': '/bin/bash', 18:19:22 INFO - 'SHLVL': '1', 18:19:22 INFO - 'TERM': 'linux', 18:19:22 INFO - 'TMOUT': '86400', 18:19:22 INFO - 'USER': 'cltbld', 18:19:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:22 INFO - '_': '/tools/buildbot/bin/python'} 18:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:23 INFO - Running setup.py (path:/tmp/pip-tQzeah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:23 INFO - Running setup.py (path:/tmp/pip-el8eIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:23 INFO - Running setup.py (path:/tmp/pip-OGfN18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:23 INFO - Running setup.py (path:/tmp/pip-ZFaR5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:23 INFO - Running setup.py (path:/tmp/pip-hoR1iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:23 INFO - Running setup.py (path:/tmp/pip-XkAnFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:23 INFO - Running setup.py (path:/tmp/pip-FSQ0Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:23 INFO - Running setup.py (path:/tmp/pip-kiFQow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:23 INFO - Running setup.py (path:/tmp/pip-hiIBRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:23 INFO - Running setup.py (path:/tmp/pip-fmVO3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:23 INFO - Running setup.py (path:/tmp/pip-ZVEslC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:23 INFO - Running setup.py (path:/tmp/pip-SoVCD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:23 INFO - Running setup.py (path:/tmp/pip-d7AByO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:23 INFO - Running setup.py (path:/tmp/pip-lN5LL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:24 INFO - Running setup.py (path:/tmp/pip-KKiE8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:24 INFO - Running setup.py (path:/tmp/pip-b5UqzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:24 INFO - Running setup.py (path:/tmp/pip-XCyO5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:24 INFO - Running setup.py install for manifestparser 18:19:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:19:24 INFO - Running setup.py install for mozcrash 18:19:24 INFO - Running setup.py install for mozdebug 18:19:24 INFO - Running setup.py install for mozdevice 18:19:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:19:24 INFO - Running setup.py install for mozfile 18:19:24 INFO - Running setup.py install for mozhttpd 18:19:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:19:24 INFO - Running setup.py install for mozinfo 18:19:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:24 INFO - Running setup.py install for mozInstall 18:19:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Running setup.py install for mozleak 18:19:25 INFO - Running setup.py install for mozlog 18:19:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Running setup.py install for moznetwork 18:19:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Running setup.py install for mozprocess 18:19:25 INFO - Running setup.py install for mozprofile 18:19:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Running setup.py install for mozrunner 18:19:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:25 INFO - Running setup.py install for mozscreenshot 18:19:25 INFO - Running setup.py install for moztest 18:19:25 INFO - Running setup.py install for mozversion 18:19:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:26 INFO - Cleaning up... 18:19:26 INFO - Return code: 0 18:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:26 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:26 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 18:19:26 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 18:19:26 INFO - Using env: {'DISPLAY': ':0', 18:19:26 INFO - 'HOME': '/home/cltbld', 18:19:26 INFO - 'LANG': 'en_US.UTF-8', 18:19:26 INFO - 'LANGUAGE': 'en_US:en', 18:19:26 INFO - 'LOGNAME': 'cltbld', 18:19:26 INFO - 'MAIL': '/var/mail/cltbld', 18:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:26 INFO - 'MOZ_NO_REMOTE': '1', 18:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:26 INFO - 'NO_EM_RESTART': '1', 18:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:26 INFO - 'PWD': '/builds/slave/test', 18:19:26 INFO - 'SHELL': '/bin/bash', 18:19:26 INFO - 'SHLVL': '1', 18:19:26 INFO - 'TERM': 'linux', 18:19:26 INFO - 'TMOUT': '86400', 18:19:26 INFO - 'USER': 'cltbld', 18:19:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:26 INFO - '_': '/tools/buildbot/bin/python'} 18:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:26 INFO - Running setup.py (path:/tmp/pip-WIABee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:26 INFO - Running setup.py (path:/tmp/pip-51830v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:26 INFO - Running setup.py (path:/tmp/pip-T6fOTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:26 INFO - Running setup.py (path:/tmp/pip-jUc9qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:26 INFO - Running setup.py (path:/tmp/pip-Mfa8zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:26 INFO - Running setup.py (path:/tmp/pip-1zOw_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:26 INFO - Running setup.py (path:/tmp/pip-sUTuYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:26 INFO - Running setup.py (path:/tmp/pip-_2SlJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:26 INFO - Running setup.py (path:/tmp/pip-iOfIoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:26 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)) 18:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:26 INFO - Running setup.py (path:/tmp/pip-1VOKy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:27 INFO - Running setup.py (path:/tmp/pip-KdjE48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:27 INFO - Running setup.py (path:/tmp/pip-RAqHoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:27 INFO - Running setup.py (path:/tmp/pip-ZV8T1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:27 INFO - Running setup.py (path:/tmp/pip-QjGRft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:27 INFO - Running setup.py (path:/tmp/pip-_5c4xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:27 INFO - Running setup.py (path:/tmp/pip-3Ic4YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:27 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)) 18:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:27 INFO - Running setup.py (path:/tmp/pip-9eR1kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:27 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)) 18:19:27 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)) 18:19:27 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)) 18:19:27 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)) 18:19:27 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)) 18:19:27 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)) 18:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:19:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:27 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 18:19:27 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 18:19:27 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 18:19:27 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 18:19:28 INFO - Downloading blessings-1.6.tar.gz 18:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:28 INFO - Installing collected packages: blessings 18:19:28 INFO - Running setup.py install for blessings 18:19:28 INFO - Successfully installed blessings 18:19:28 INFO - Cleaning up... 18:19:28 INFO - Return code: 0 18:19:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:29 INFO - Reading from file tmpfile_stdout 18:19:29 INFO - Current package versions: 18:19:29 INFO - argparse == 1.2.1 18:19:29 INFO - blessings == 1.6 18:19:29 INFO - blobuploader == 1.2.4 18:19:29 INFO - docopt == 0.6.1 18:19:29 INFO - functools32 == 3.2.3-2 18:19:29 INFO - jsonschema == 2.5.1 18:19:29 INFO - manifestparser == 1.1 18:19:29 INFO - mozInstall == 1.13 18:19:29 INFO - mozcrash == 1.0 18:19:29 INFO - mozdebug == 0.1 18:19:29 INFO - mozdevice == 0.51 18:19:29 INFO - mozfile == 1.2 18:19:29 INFO - mozhttpd == 0.7 18:19:29 INFO - mozinfo == 0.10 18:19:29 INFO - mozleak == 0.1 18:19:29 INFO - mozlog == 3.4 18:19:29 INFO - moznetwork == 0.27 18:19:29 INFO - mozprocess == 0.25 18:19:29 INFO - mozprofile == 0.28 18:19:29 INFO - mozrunner == 6.13 18:19:29 INFO - mozscreenshot == 0.1 18:19:29 INFO - mozsystemmonitor == 0.3 18:19:29 INFO - moztest == 0.8 18:19:29 INFO - mozversion == 1.4 18:19:29 INFO - psutil == 3.1.1 18:19:29 INFO - requests == 1.2.3 18:19:29 INFO - wsgiref == 0.1.2 18:19:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:29 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')]} 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:29 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')]} 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:29 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:29 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 18:19:29 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 18:19:29 INFO - Using env: {'DISPLAY': ':0', 18:19:29 INFO - 'HOME': '/home/cltbld', 18:19:29 INFO - 'LANG': 'en_US.UTF-8', 18:19:29 INFO - 'LANGUAGE': 'en_US:en', 18:19:29 INFO - 'LOGNAME': 'cltbld', 18:19:29 INFO - 'MAIL': '/var/mail/cltbld', 18:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:29 INFO - 'MOZ_NO_REMOTE': '1', 18:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:29 INFO - 'NO_EM_RESTART': '1', 18:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:29 INFO - 'PWD': '/builds/slave/test', 18:19:29 INFO - 'SHELL': '/bin/bash', 18:19:29 INFO - 'SHLVL': '1', 18:19:29 INFO - 'TERM': 'linux', 18:19:29 INFO - 'TMOUT': '86400', 18:19:29 INFO - 'USER': 'cltbld', 18:19:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:29 INFO - '_': '/tools/buildbot/bin/python'} 18:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 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)) 18:19:29 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:19:29 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 18:19:29 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 18:19:29 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 18:19:29 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 18:19:30 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:19:30 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)) 18:19:30 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)) 18:19:30 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)) 18:19:30 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)) 18:19:30 INFO - Installing collected packages: marionette-driver 18:19:30 INFO - Running setup.py install for marionette-driver 18:19:30 INFO - Successfully installed marionette-driver 18:19:30 INFO - Cleaning up... 18:19:30 INFO - Return code: 0 18:19:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:30 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')]} 18:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:30 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')]} 18:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:30 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 0x11113b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, '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': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', '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 18:19:30 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 18:19:30 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 18:19:30 INFO - Using env: {'DISPLAY': ':0', 18:19:30 INFO - 'HOME': '/home/cltbld', 18:19:30 INFO - 'LANG': 'en_US.UTF-8', 18:19:30 INFO - 'LANGUAGE': 'en_US:en', 18:19:30 INFO - 'LOGNAME': 'cltbld', 18:19:30 INFO - 'MAIL': '/var/mail/cltbld', 18:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:30 INFO - 'MOZ_NO_REMOTE': '1', 18:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:30 INFO - 'NO_EM_RESTART': '1', 18:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:30 INFO - 'PWD': '/builds/slave/test', 18:19:30 INFO - 'SHELL': '/bin/bash', 18:19:30 INFO - 'SHLVL': '1', 18:19:30 INFO - 'TERM': 'linux', 18:19:30 INFO - 'TMOUT': '86400', 18:19:30 INFO - 'USER': 'cltbld', 18:19:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:30 INFO - '_': '/tools/buildbot/bin/python'} 18:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:30 INFO - Cleaning up... 18:19:30 INFO - Return code: 0 18:19:30 INFO - Running post-action listener: _resource_record_post_action 18:19:30 INFO - Running post-action listener: _start_resource_monitoring 18:19:30 INFO - Starting resource monitoring. 18:19:30 INFO - [mozharness: 2017-06-20 01:19:30.849574Z] Finished create-virtualenv step (success) 18:19:30 INFO - [mozharness: 2017-06-20 01:19:30.850031Z] Running install step. 18:19:30 INFO - Running pre-action listener: _resource_record_pre_action 18:19:30 INFO - Running main action method: install 18:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:31 INFO - Reading from file tmpfile_stdout 18:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:31 INFO - Reading from file tmpfile_stdout 18:19:31 INFO - Output received: 18:19:31 INFO - Usage: mozinstall [options] installer 18:19:31 INFO - Options: 18:19:31 INFO - -h, --help show this help message and exit 18:19:31 INFO - -d DEST, --destination=DEST 18:19:31 INFO - Directory to install application into. [default: 18:19:31 INFO - "/builds/slave/test"] 18:19:31 INFO - --app=APP Application being installed. [default: firefox] 18:19:31 INFO - mkdir: /builds/slave/test/build/application 18:19:31 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'] 18:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:19:49 INFO - Reading from file tmpfile_stdout 18:19:49 INFO - Output received: 18:19:49 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:49 INFO - Running post-action listener: _resource_record_post_action 18:19:49 INFO - [mozharness: 2017-06-20 01:19:49.012721Z] Finished install step (success) 18:19:49 INFO - [mozharness: 2017-06-20 01:19:49.012868Z] Running setup-mitmproxy step. 18:19:49 INFO - Running pre-action listener: _resource_record_pre_action 18:19:49 INFO - Running main action method: setup_mitmproxy 18:19:49 INFO - Skipping: mitmproxy is not required 18:19:49 INFO - Running post-action listener: _resource_record_post_action 18:19:49 INFO - [mozharness: 2017-06-20 01:19:49.013852Z] Finished setup-mitmproxy step (success) 18:19:49 INFO - [mozharness: 2017-06-20 01:19:49.014174Z] Running run-tests step. 18:19:49 INFO - Running pre-action listener: _resource_record_pre_action 18:19:49 INFO - Running main action method: run_tests 18:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:49 INFO - Python 2.7.3 18:19:49 INFO - Return code: 0 18:19:49 INFO - grabbing minidump binary from tooltool 18:19:49 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')]} 18:19:49 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 0x148d140>, '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 0x148da40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148ded0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:49 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 18:19:49 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 18:19:49 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 18:19:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:49 INFO - Return code: 0 18:19:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:49 INFO - ENV: RUST_BACKTRACE is now 1 18:19:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:49 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/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:19:49 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/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 18:19:49 INFO - Using env: {'DISPLAY': ':0', 18:19:49 INFO - 'HOME': '/home/cltbld', 18:19:49 INFO - 'LANG': 'en_US.UTF-8', 18:19:49 INFO - 'LANGUAGE': 'en_US:en', 18:19:49 INFO - 'LOGNAME': 'cltbld', 18:19:49 INFO - 'MAIL': '/var/mail/cltbld', 18:19:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:49 INFO - 'MOZ_NO_REMOTE': '1', 18:19:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:49 INFO - 'NO_EM_RESTART': '1', 18:19:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:49 INFO - 'PWD': '/builds/slave/test', 18:19:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:49 INFO - 'RUST_BACKTRACE': '1', 18:19:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:19:49 INFO - 'SHELL': '/bin/bash', 18:19:49 INFO - 'SHLVL': '1', 18:19:49 INFO - 'TERM': 'linux', 18:19:49 INFO - 'TMOUT': '86400', 18:19:49 INFO - 'USER': 'cltbld', 18:19:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654', 18:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:49 INFO - '_': '/tools/buildbot/bin/python'} 18:19:49 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/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:19:49 INFO - mozversion application_buildid: 20170620003011 18:19:49 INFO - mozversion application_changeset: 416c3c8c4b3db9ba96a103ce7820c9a140a3051d 18:19:49 INFO - mozversion application_display_name: Nightly 18:19:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:49 INFO - mozversion application_name: Firefox 18:19:49 INFO - mozversion application_remotingname: firefox 18:19:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:49 INFO - mozversion application_vendor: Mozilla 18:19:49 INFO - mozversion application_version: 56.0a1 18:19:49 INFO - mozversion platform_buildid: 20170620003011 18:19:49 INFO - mozversion platform_changeset: 416c3c8c4b3db9ba96a103ce7820c9a140a3051d 18:19:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:49 INFO - mozversion platform_version: 56.0a1 18:19:49 INFO - using testdate: 1497921589 18:19:49 INFO - actual date: 1497921589 18:19:49 INFO - starting webserver on 'localhost:59409' 18:19:49 INFO - SUITE-START | Running 2 tests 18:19:49 INFO - TEST-START | dromaeo_css 18:19:49 INFO - operating with platform_type : linux_ 18:19:49 INFO - Initialising browser for dromaeo_css test... 18:19:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59409/getInfo.html -profile /tmp/tmpkvsBPc/profile 18:19:49 INFO - TEST-INFO | started process 2910 (/builds/slave/test/build/application/firefox/firefox http://localhost:59409/getInfo.html) 18:19:55 INFO - TEST-INFO | 2910: exit 0 18:19:56 INFO - Browser initialized. 18:19:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:56 INFO - TEST-INFO | started process 3160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvsBPc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:07 INFO - PID 3160 | RSS: Main: 180338688 18:20:07 INFO - PID 3160 | 18:23:12 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59409/tests/dromaeo/cssquery-ext.html) 18:23:13 INFO - PID 3160 | RSS: Main: 186159104 18:23:13 INFO - PID 3160 | 18:26:15 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-ext.html (next: http://localhost:59409/tests/dromaeo/cssquery-jquery.html) 18:26:16 INFO - PID 3160 | RSS: Main: 183844864 18:26:16 INFO - PID 3160 | 18:29:17 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59409/tests/dromaeo/cssquery-mootools.html) 18:29:18 INFO - PID 3160 | RSS: Main: 184946688 18:29:18 INFO - PID 3160 | 18:32:20 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59409/tests/dromaeo/cssquery-prototype.html) 18:32:20 INFO - PID 3160 | RSS: Main: 183877632 18:32:20 INFO - PID 3160 | 18:35:23 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59409/tests/dromaeo/cssquery-yui.html) 18:35:24 INFO - PID 3160 | RSS: Main: 185589760 18:35:24 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | Cycle 1(1): loaded http://localhost:59409/tests/dromaeo/cssquery-yui.html (next: http://localhost:59409/tests/dromaeo/cssquery-dojo.html) 18:38:26 INFO - PID 3160 | RSS: Main: 184012800 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | __start_tp_report 18:38:26 INFO - PID 3160 | _x_x_mozilla_page_load 18:38:26 INFO - PID 3160 | _x_x_mozilla_page_load_details 18:38:26 INFO - PID 3160 | |i|pagename|runs| 18:38:26 INFO - PID 3160 | |0;dojo.html;3097.829619370934;3140.8429578521072;3159.7314228290593;3177.507486339618;3185.9522107168395;5918.34898161203;5950.791722289726;5965.9701701491485;6039.788607398742;6081.847953801157;6154;6162.876742465148;6206.844828879269;6212.534059945499;6245.313015568284;5692.003899317623;5703.201551782754;5726.799562015331;5764.5676574257095;5798.65208087514;5776.162456443813;5843.532517398619;5848.181254624356;5849.619774714652;5859.7070146492715;5572.080606699889;5690.061139911951;5693.202951586781;5733.913991290134;5734.111212761987;5591.552675785927;5617.80337688183;5637.43625637433;5663.603547751659;5681.289838770153;5580.497755202011;5605.495505404492;5668.206451096849;5675.659460432346;5683.318001839806;6053.273607167124;6092.573519853612;6109.114178444101;6114.11345354921;6131.110988906628;6553.344665533408;6578.539502234846;6585.111010013635;6616.603003819786;6622.8344291393105;6495.447886929616;6670.266270710218;6671.766488172891;6701.93298067018;6731.831704207385;6137.202163718777;6157.1072194532435;6225.8132256032395;6234.781782637586;6277.1525844010475;6871.312868713188;6982.2319544850025;6986;6987.965060174666;6993.790186294317;6350.206224221973;6441.67791610427;6442.48460123189;6451.838704032343;6637.037629543689;6516.641584712792;6579.407853293226;6590.176227971504;6664.666766661744;6733.091032710619;6662.0340050692375;6667.899981500282;6678;6688.297728738413;6702.899456508157;6689.665516724144;6708.765193218312;6711.697973591103;6727.29363416844;6731.764388246388;5320.627556071116;5365.892682146413;5368.651037682538;5399.379071406838;5407.567394608422;4598.816047358135;4627.768611569408;4631.166390049756;4643.930341044887;4694.037722266995;5704.800331988444;5734.971325143348;5742.224799652077;5752.07966725322;5755.251817263813;6743.865122697519;6746.257911629717;6754.223264324567;6776;6783.966080169567;5741.942580574141;5750.993576124161;5752.539796816244;5762.337331206881;5777.740001699934;5805.303363596311;5814.476697097281;5816.854578635483;5867.178594996704;5931.13998470228;6352.650604216812;6430.7749228776765;6434.8391290218115;6438.452731517874;6439.259485159079;6727.730890764315;6736.259011508632;6745.763898263734;6752.324767523209;6754.324567543403;6481.546291759531;6483.157189565326;6503.674816259263;6503.739850405931;6507.577007494498;6485.351464853666;6533.869322613426;6561.475081993333;6562.343765623399;6569.37590928861;6548.3124271950755;6595.538312318092;6628.5691430056895;6642.634655094016;6681.198256209286;6381.776637817654;6429.8714025720155;6491;6497.09040734307;6502.739890404331;6509.349065093453;6540.117084193763;6544.934550654623;6549;6571.5399922005;6219.129321895029;6330.841728956629;6333.398327158912;6394.808155755335;6413;6439.130717353098;6442.194725659293;6447.4197322241225;6491.318411566906;6497.610143391412;6340.270868850142;6367.458766004941;6371.872562548816;6390.073439351361;6455.128557644845 18:38:26 INFO - PID 3160 | |1;ext.html;774.4462709162948;788.2866006264333;828.2462958707576;857.4683696108411;862.1637012098263;39523;39981.8000909995;40041.1991760165;40246.39630405546;40297;36226.275474490496;36673.81663091681;36729;36779.816100919525;36837.26325473489;6698.430633396155;6779.423748981342;6820.693068811891;6829.078074459959;6835.453163746888;6810.080639113706;6873.140857392826;6885.380315771579;6890.44876409886;6902.75840345588;6799.320067993211;6855.348741869514;6871.828204294908;6878.1058462399815;6885.690143943534;6734.797956061301;6796.354346337115;6829.863402731968;6835.521513494057;6845.931540684579;5965.582409231356;5967.701614919237;6003.6697981611;6012.368701286389;6070.2412198475195;32398.190045248823;32804.179895502566;32879;32967.50548741771;33011.174720631934;3488.773229740059;3503.8423270952867;3525.94711079334;3550.5206797082324;3552.946705799415;30317.545236821465;30596.847015765;30625.540616890765;30687.693123068708;30707.692923070706;3580.874669386559;3584.211473475831;3605.2248766515327;3608.386574282378;3684.097396137963;186936;190003;190063;191358;191818;43147.78426107912;47523;48646.75676621665;48882;49117.50882491201;51788.74105629523;51920.74039629778;51957.22064169041;51961.48038519567;51962;14643.267836608127;14677.633059173393;14760.926195368955;14815;14881.553553393416;12217.69455763613;12270.754584908253;12322.507099716091;12409.255444673348;12424.316662583464;14233.28833558318;14258.287085645676;14369.64075898111;14472.131672099707;14593.635159120895;5459.099248623933;5468.863278417992;5489.725513724298;5535.861603459945;5538.0585300499015;993.4436715439377;995.7162208770466;1002.6791426743372;1041.4116024446164;1042.0829669890447;22480.325590232318;23045.53908921812;23138.190163344203;23466.413339666644;23869.045238190625;1057.9523921423554;1071.8606581144402;1106.4965440724452;1115.3029356652091;1117.4803716271972;12311.138220324492;12731.427085781163;12830.422630981628;12893.871061289454;12978.545750898862;224268;224517;224691;225855;226877;50956;51214.74392628088;51325.48674513282;51459;51746;1363.3932899859665;1450.2168828832312;1454.185656032625;1468.686818261264;1470.3309993952726;20962;22698.319050428512;23251.76748232564;23306.883465582563;23522.882385587964;37236.81381593075;37292.440613391365;37315.440268395454;37344;37437.43843842399;177584;177884;178043;178317;178407;31368.68631313749;31444.327232185522;31865.522017170224;31929;34738.305233895684;37890.62109378871;41310.586894130676;42740;42867.356989644555;43976;30226;30881.69118308788;31211.37577248397;31842.84078579592;32734.836325818218;30081.398372032876;30624.540631890093;31054.534181986837;31804.68195318017;32524.83737581297;35092.82453587716;35130.47304290489;35219.47170792492;35396.29207415889;35421.291574168885;30258.24354391158;31693;32841.17897052593;32846.507302390964;33378;25005.374865628506;25866.741332587186;25947;25959.48081038331;26205 18:38:26 INFO - PID 3160 | |2;jquery.html;565.2058857305487;569.362314208087;574.8160588611646;576.593501581385;584.859633687915;21532.89233553832;22302.553948921053;22558.323250302477;22616.43458913528;22638.547229055428;17521.21154548045;18101.90949045253;18210.089495525237;22626.20808271711;23887.28338149854;6146;6227.346128656493;6265.467435268008;6288.685565721718;6294.653794041325;6093.329733729286;6148.1392605035335;6203.100550420187;6213.378662133796;6224.128621992924;6180.505559555248;6184.536159788011;6185.4433101020895;6185.845353866167;6192.287886892997;5661.631993920402;6151.6001459904965;6184.226971628546;6220.7511699532415;6285.842853928642;5851.093080572518;5851.4148585141575;5852.385499522574;5879.441453061995;5880.911786323209;26459;26585.601215981776;26717.732822671915;26761.866190668923;26791;1869.5326168457887;1892.8958907260096;1903.2387045182038;1909.102721720789;1919.7888232294436;16353.83646163535;17209.483715488554;17346.739798903025;17448.953062816272;17487.82512174875;2280.646499792535;2290.4731911660247;2338.6024375856146;2341.672165896776;2372.41875740443;119344.40327798306;120860.39569802095;121181;122060.38969805095;122538;12719.80920286178;13316.334183290797;13496.86503134956;13934.23361715095;14362;22082;22145.778542214695;22170;22336.888315558645;22381.88809055944;9351.672691455766;9528.094830991045;9556.617735290649;9590.136887680143;9627.56675949584;8627.654893804178;8641.481511109354;8641.740747777576;8705.216530512158;8745.994210665727;8571.52856592881;8591.65633374658;8634.22291993711;8661.956690216635;8750.95624521886;2545.9618105728428;2586.2241327601646;2613.1899111275566;2723.416995159954;2850.073726039004;933.4026223217146;949.1410273702311;961.3654987708079;989.4656885281867;997.2022382094441;18139.637207256044;18841.717374239397;18943.43169704911;19032.61934761297;19428.8057119427;963.937344072633;980.8185485685171;987.5605355616682;1013.3210748798323;1022.6420752736632;9850.80298394028;9904.900950990543;10159.898401015895;10285.125764309967;10338.638147664795;503746;512990;525495;529379;529814;95816;95943.52028239814;96438;104530;106855.4657226709;1170.1925671286785;1184.1592469346688;1196.3898411809867;1199.9340036297913;1222.1078612612664;15076.321565529797;15672.216389180723;15975;16146.838531614534;16460.34158633689;42864.78567607142;45298.32052519281;45983;47837.76081119572;51243;62154.68922655358;63912.68043659752;64357.35642643514;64571.03143452946;64874;12366.19619724715;12429.384180056535;12534.435950382072;12541.749165016467;12586.056045796786;17185.882917610314;17862.106894655477;18116.184771685043;18327.175277112296;18692.43922682322;12236.143469957373;12858.807117893051;12859.549915752903;14422;15361.231938402812;11433.428328583372;13567.728645427234;13755.518556850462;14028.579142625738;14356.35396407185;15545.455909043128;15550.611234719223;15646.530604081896;15647.765283520985;15683.372665093268;12304;12512.937435312766;12557.24656520575;12576.056795740173;12602.747945040865;13555.59333220005;14168.291585420893;14424.567262982127;14468.421263149778;14848.554543363716 18:38:26 INFO - PID 3160 | |3;mootools.html;1336.411978729359;1396.706691594765;1398.4965412451522;1398.9510367137152;1408.7252985667792;12880.355982200888;13438.328083595818;13509;13572.592822215349;13628.182309061463;13385.66535836602;13731.58805235842;13752.724945501084;13754.656133596665;13787.93106034471;2525.734797846227;2530.101813856082;2554.067765265674;2559.654446649697;2564.1538292363475;2474.5669507836146;2544.643749875019;2548.528522223385;2559.4241295708503;2564.384547708555;2477.950440991179;2510.2092840755104;2536.5053814506177;2544.707358653751;2547.439563296072;2378.8096952243777;2422.4307287787356;2424.248482970276;2431.5380077785253;2433.1362366359863;2353.329301149164;2364.598018336887;2381.392744850052;2386.2483317755027;2432.902683892642;12940.900023498014;13010.869891301061;13017.544385946447;13162.736745265136;13180.275084870329;7029.578225306498;7317.59753213573;7335.706571737124;7343.77968660941;7355;3857.3828187489867;4032.1532478179615;4067.1052368478886;4094.9181016379803;4116.75299482032;1519.7416439205363;1529.2812378182236;1549.2795849929723;1565.7494800831812;1569.7959265295437;19165.80834191654;19722.999999999858;21044.684329735068;21345.039473223587;21419.14323427061;5470.288862447856;5570.551656569241;6121.296050954108;6371.649559274284;6375.075614036032;14480.058796178215;14487.275636218146;14526.346314415876;14553.927230363992;14563;7201.667691477093;7259;7295.8540829184185;7299.963500182465;7338;6622.304658010936;6728;6756.324367563205;6767.0526126341365;6802.183737951477;4648.790804413809;4765.237561990065;4868.634852386085;4897.510248975145;4941.50584941503;1397.6715471864104;1399.244408019658;1409.9647508812157;1418.723348946966;1427.0367501936153;876.2070326354532;877.6533269358695;880.6213328268777;897.4570384917162;928.095107270406;7519.360854327334;7896.407769417317;7928.8810667840025;7982.401319901031;8035.437519373588;960.3613596958085;977.359829311802;978.1783302026332;1006.2654262388351;1038.7039693687263;4610.585047345688;4702.435707715028;4895.674554586614;4912.656114072052;4964.205727083649;17249.741253881202;17730.11349432549;17948.820511794976;18086.638267234583;18172.727409088875;16997.999999999753;17442;17639.559011024572;17681.38115165963;17831;9460.90539094614;9913.950430247947;10031;10070.395776253301;10122.291439599305;7110.928890711027;7171.641417929187;7383.483156179016;7532.363672714506;7597.164311925573;14738.336774844944;15727.449539266529;15874;15987.44043958456;16023.679526409172;15497.612559686098;16034.679306413573;16304.673906521566;16363.672726545641;16435.67128657396;11051.281666691639;11065.889341106486;11251.606193783506;11369.715757106138;11407.201495895208;12461.314627695563;12719.618411447671;12733.745325093261;12791.104622676323;12822.487100515875;9716.174125199155;10328.690139295833;10496.632617858644;10686.679399618024;10815.891841081802;9703.432255009935;9847.409155450696;9973.700788976343;10034.448105354275;10088.798224035625;9270.258379329773;9290.1174388433;9321;9335.85996210071;9337;6653.401193892573;6890.138732658418;6987.371136597731;7143.1428228612895;7165.211826698955;6707.960266158753;6758.155230596176;6946.16646002483;7037.79519696432;7122.679479423335 18:38:26 INFO - PID 3160 | |4;prototype.html;484.5638924967531;496.19616221720815;512.5950499105707;519.8232600915688;528.6590149353667;6284.340144284847;6388.584741991767;6436.163298771165;6450;6468.967655161718;5990.854801229357;6078.149059131725;6184.907226391608;6227.844303892405;6297.905531417033;5220.895582088366;5253.7373131343475;5255.106631872572;5261.184516399964;5269.578433725293;5235.842924712246;5252.71110088945;5253.57971362292;5270.183121616155;5279.472052794709;5193.948060519403;5194.68831870089;5206;5207.947920520804;5226.863881670986;4824.105536678;5066.620003499752;5235.324696097231;5235.6596821206695;5238.60710446718;4500.212462819027;4527.004059106991;4530.728156310599;4536.911141326058;4544.2047641662575;6116.296625887991;6141.293751218623;6154.907676384858;6179.104029915637;6235.501159907197;5753.510951569122;5770.538356931435;5770.971145144289;5787.102999035156;5787.33445653751;6656.93343066568;6675.833104172386;6680.131582894242;6707.228668703064;6714.294999025081;4932.506749325074;4955.677880937727;4958.603311735053;4959.107360675113;4978.6763860348965;7060.611666358348;7068.0104785330095;7071.646417679147;7079.185893622196;7148.606826624534;5101.132807422747;5116.974415127975;5117.616178786606;5123.0266249413235;5134.383873935151;5178.870528236825;5180.300659411007;5199.922001169985;5200.453952335026;5212.661177023481;5843.620164689281;5852.268466441695;5858.736356863951;5866.325372582208;5881.735321910524;6768.69540870662;6795.252522222551;6836.931630683729;6838.931610683929;6847.691853866588;1730.7230843065302;1787.5709829640793;1797.191263931236;1813.1478205243513;1813.3018787766541;1228.42264135856;1235.3823088455772;1238.0253495674565;1238.8575313838844;1244.5519612939336;5801.564882633819;5838.824835254949;5848.052564518933;5850.4149585042005;5875.29496460419;6643.80754351063;6732.932670673328;6830.829229269308;6940.889457686746;6984.603079384042;5787.392323806024;5809.535237181015;5828.154917537018;5831.154482599999;5832.50423713989;3592.8203589820405;3657.6159503252306;3689.9151979131707;3694.9445758313645;3697.6672099511175;6668.365995431777;6670.433013193933;6680.265170831205;6694.430973367221;6724.611618962006;6967.756128535477;6977.546459480118;7067;7077.5399599025895;7090.787276381717;6615.933840661532;6659.134312539532;6677.532572719863;6684.498662600325;6693.129893113962;6787.5588086774205;6822.829429264109;6870.931290687229;6875.140607424072;6894.655267236518;6827;6871.347222013901;6877.65611719402;6891.4486841053595;6896.689648965909;6679;6689.1972963244725;6696.933030669631;6697.665116744241;6701.3298670134545;5035.874103147451;5065.949340506548;5076.2740668173;5079.847604571869;5092.6435149539175;6852.554583952027;6867.3476019778045;6923.89614155778;6939.514234003571;6966.582005079711;6703.195616526048;6718.193816742022;6724.562903411263;6747.291534388818;6761.3238676132;6318.842028949313;6700.83247918806;6726.8990965136545;6750.291219422086;6756.9188929771;6189.319174890668;6540.738370465128;6584.851543527547;6600.273969863407;6636.705842360693;6628.900566491603;6660.966695166493;6679.198496180489;6722.294159113223;6735.743525918872;6269.937300626935;6424.4860411166055;6530.706118224596;6548.476121910331;6569.146011018537 18:38:26 INFO - PID 3160 | |5;yui.html;845.2392846438208;854.9316054715622;860.7718954477061;868.4875923205308;879.235065493021;18018.369357072504;18030.639387212264;18432.99999999998;18564.443066708005;19928.302509412173;19455.124519396624;20091.799082009176;20137.194512219492;20242.595148097065;20414.387568372935;946.7159852044393;1051.7633532455213;1059.782744537368;1062.5484169228087;1063.2663462211087;1065.211743309949;1068.9679309620724;1077.455884778186;1078.3314345106005;1083.2309060567006;1127.486993417997;1128.266626692648;1129.5199540195424;1132.3885102044926;1135.8807325230855;1043.186314674555;1127.5827943660815;1127.7406196574752;1130.9660710178666;1132.0830127596673;795.550513959611;798.5528104261632;801.6512816924599;805.0741647105816;806.2944923192207;17352.305907763675;17413.738793918103;17470.737938930924;17481.562960925952;17491.825081749146;17776.55558611032;17969.7304540432;18480.630387392175;18547.814521854743;18701.81298187028;15552.766708499381;15736.527904162893;15966.840331596652;16049.598760031093;16105.758413623806;3569;3594.02961200477;3595.1012246938267;3595.388783906742;3602.1174812170925;90352.54823725905;94246.52876735642;95679;97060.51469742677;100174.49912750389;15203.923980380026;15256.618584535476;15426.228688565527;16252.75620865688;16306.10316432584;27567;28369;28399.858000709864;28415;28507.287317816805;8750;8867.467951922905;8947.463152210888;8969.372143949991;9016.504092274856;3707.5180226570915;3844.1350696093714;3965.088029753173;4220.641245494167;4236.195122926634;4572.245579479349;4655.650826188049;4667.883302917454;4678.719276843401;4703.811847526129;962.1725316228038;1003.1673710820148;1006.572206812102;1007.5818535307765;1007.7027276953316;641.6503005861816;645.7191121862005;662.536224642752;664.3821246241042;678.4436761855231;10969.616063437741;12332.32172230518;12399;12411.255324680367;12618.116731828684;691.1878542712393;709.2234003765868;712.8859382498775;724.221461928429;725.7677543186236;5181.35233095863;5292.52367286946;5297.417284098746;5520.227168196456;5587.189857470644;95521.52239238759;99759.50120249353;100257;100396;100415.48545800862;84851;86578.56710716407;87795.56102219576;88510.55744721236;88894.55552722325;74095;75195;75277.62361188268;75566.62216688882;80213.59893200497;10180.49097545105;10996.725081872697;11000.119990400908;11098.334099954029;11266.605668801552;35398.115047123;36363.27273454569;36530.452043219906;37142.62857371392;37844;44416;44500.33249501196;44768.55231447644;44947.32579011383;45836;14908.403663853758;15295.847041529441;15560.766588501408;15582.84417155814;15850.682986339978;16197.4330898418;16302.510924672279;16838.158092095593;16957.915210423867;17065.40271090506;15647.921760391126;15653.921730391276;16232.513024609281;17152.399666011628;17473.864198827036;17291.308347665952;17704.91147544254;17908.194131263863;18034.458966230508;18781.342653007625;16801.831981680025;17152.914235428743;17175.742363864803;17599.384021559184;18694;12269.38653067361;12964.02712331928;13037.15258508194;13211.933940330237;13590.86409135896;12863.807042894552;12878.291693956922;13408.396622152222;13433.462661493822;13630.93184534071 18:38:26 INFO - PID 3160 | __end_tp_report 18:38:26 INFO - PID 3160 | __start_cc_report 18:38:26 INFO - PID 3160 | _x_x_mozilla_cycle_collect,371 18:38:26 INFO - PID 3160 | __end_cc_report 18:38:26 INFO - PID 3160 | __startTimestamp1497922706254__endTimestamp 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | ------- Summary: start ------- 18:38:26 INFO - PID 3160 | Number of tests: 6 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#0] dojo.html Cycles:165 Average:6121.04 Median:6371.87 stddev:722.45 (11.3%) stddev-sans-first:684.63 18:38:26 INFO - PID 3160 | Values: 3097.8 3140.8 3159.7 3177.5 3186.0 5918.3 5950.8 5966.0 6039.8 6081.8 6154.0 6162.9 6206.8 6212.5 6245.3 5692.0 5703.2 5726.8 5764.6 5798.7 5776.2 5843.5 5848.2 5849.6 5859.7 5572.1 5690.1 5693.2 5733.9 5734.1 5591.6 5617.8 5637.4 5663.6 5681.3 5580.5 5605.5 5668.2 5675.7 5683.3 6053.3 6092.6 6109.1 6114.1 6131.1 6553.3 6578.5 6585.1 6616.6 6622.8 6495.4 6670.3 6671.8 6701.9 6731.8 6137.2 6157.1 6225.8 6234.8 6277.2 6871.3 6982.2 6986.0 6988.0 6993.8 6350.2 6441.7 6442.5 6451.8 6637.0 6516.6 6579.4 6590.2 6664.7 6733.1 6662.0 6667.9 6678.0 6688.3 6702.9 6689.7 6708.8 6711.7 6727.3 6731.8 5320.6 5365.9 5368.7 5399.4 5407.6 4598.8 4627.8 4631.2 4643.9 4694.0 5704.8 5735.0 5742.2 5752.1 5755.3 6743.9 6746.3 6754.2 6776.0 6784.0 5741.9 5751.0 5752.5 5762.3 5777.7 5805.3 5814.5 5816.9 5867.2 5931.1 6352.7 6430.8 6434.8 6438.5 6439.3 6727.7 6736.3 6745.8 6752.3 6754.3 6481.5 6483.2 6503.7 6503.7 6507.6 6485.4 6533.9 6561.5 6562.3 6569.4 6548.3 6595.5 6628.6 6642.6 6681.2 6381.8 6429.9 6491.0 6497.1 6502.7 6509.3 6540.1 6544.9 6549.0 6571.5 6219.1 6330.8 6333.4 6394.8 6413.0 6439.1 6442.2 6447.4 6491.3 6497.6 6340.3 6367.5 6371.9 6390.1 6455.1 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#1] ext.html Cycles:180 Average:36161.76 Median:33194.59 stddev:51565.71 (155.3%) stddev-sans-first:51641.90 18:38:26 INFO - PID 3160 | Values: 774.4 788.3 828.2 857.5 862.2 39523.0 39981.8 40041.2 40246.4 40297.0 36226.3 36673.8 36729.0 36779.8 36837.3 6698.4 6779.4 6820.7 6829.1 6835.5 6810.1 6873.1 6885.4 6890.4 6902.8 6799.3 6855.3 6871.8 6878.1 6885.7 6734.8 6796.4 6829.9 6835.5 6845.9 5965.6 5967.7 6003.7 6012.4 6070.2 32398.2 32804.2 32879.0 32967.5 33011.2 3488.8 3503.8 3525.9 3550.5 3552.9 30317.5 30596.8 30625.5 30687.7 30707.7 3580.9 3584.2 3605.2 3608.4 3684.1 186936.0 190003.0 190063.0 191358.0 191818.0 43147.8 47523.0 48646.8 48882.0 49117.5 51788.7 51920.7 51957.2 51961.5 51962.0 14643.3 14677.6 14760.9 14815.0 14881.6 12217.7 12270.8 12322.5 12409.3 12424.3 14233.3 14258.3 14369.6 14472.1 14593.6 5459.1 5468.9 5489.7 5535.9 5538.1 993.4 995.7 1002.7 1041.4 1042.1 22480.3 23045.5 23138.2 23466.4 23869.0 1058.0 1071.9 1106.5 1115.3 1117.5 12311.1 12731.4 12830.4 12893.9 12978.5 224268.0 224517.0 224691.0 225855.0 226877.0 50956.0 51214.7 51325.5 51459.0 51746.0 1363.4 1450.2 1454.2 1468.7 1470.3 20962.0 22698.3 23251.8 23306.9 23522.9 37236.8 37292.4 37315.4 37344.0 37437.4 177584.0 177884.0 178043.0 178317.0 178407.0 31368.7 31444.3 31865.5 31929.0 34738.3 37890.6 41310.6 42740.0 42867.4 43976.0 30226.0 30881.7 31211.4 31842.8 32734.8 30081.4 30624.5 31054.5 31804.7 32524.8 35092.8 35130.5 35219.5 35396.3 35421.3 30258.2 31693.0 32841.2 32846.5 33378.0 25005.4 25866.7 25947.0 25959.5 26205.0 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#2] jquery.html Cycles:180 Average:32967.88 Median:12459.60 stddev:86497.81 (694.2%) stddev-sans-first:86706.24 18:38:26 INFO - PID 3160 | Values: 565.2 569.4 574.8 576.6 584.9 21532.9 22302.6 22558.3 22616.4 22638.5 17521.2 18101.9 18210.1 22626.2 23887.3 6146.0 6227.3 6265.5 6288.7 6294.7 6093.3 6148.1 6203.1 6213.4 6224.1 6180.5 6184.5 6185.4 6185.8 6192.3 5661.6 6151.6 6184.2 6220.8 6285.8 5851.1 5851.4 5852.4 5879.4 5880.9 26459.0 26585.6 26717.7 26761.9 26791.0 1869.5 1892.9 1903.2 1909.1 1919.8 16353.8 17209.5 17346.7 17449.0 17487.8 2280.6 2290.5 2338.6 2341.7 2372.4 119344.4 120860.4 121181.0 122060.4 122538.0 12719.8 13316.3 13496.9 13934.2 14362.0 22082.0 22145.8 22170.0 22336.9 22381.9 9351.7 9528.1 9556.6 9590.1 9627.6 8627.7 8641.5 8641.7 8705.2 8746.0 8571.5 8591.7 8634.2 8662.0 8751.0 2546.0 2586.2 2613.2 2723.4 2850.1 933.4 949.1 961.4 989.5 997.2 18139.6 18841.7 18943.4 19032.6 19428.8 963.9 980.8 987.6 1013.3 1022.6 9850.8 9904.9 10159.9 10285.1 10338.6 503746.0 512990.0 525495.0 529379.0 529814.0 95816.0 95943.5 96438.0 104530.0 106855.5 1170.2 1184.2 1196.4 1199.9 1222.1 15076.3 15672.2 15975.0 16146.8 16460.3 42864.8 45298.3 45983.0 47837.8 51243.0 62154.7 63912.7 64357.4 64571.0 64874.0 12366.2 12429.4 12534.4 12541.7 12586.1 17185.9 17862.1 18116.2 18327.2 18692.4 12236.1 12858.8 12859.5 14422.0 15361.2 11433.4 13567.7 13755.5 14028.6 14356.4 15545.5 15550.6 15646.5 15647.8 15683.4 12304.0 12512.9 12557.2 12576.1 12602.7 13555.6 14168.3 14424.6 14468.4 14848.6 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#3] mootools.html Cycles:180 Average:8182.51 Median:2453.85 stddev:5476.20 (223.2%) stddev-sans-first:5467.40 18:38:26 INFO - PID 3160 | Values: 1336.4 1396.7 1398.5 1399.0 1408.7 12880.4 13438.3 13509.0 13572.6 13628.2 13385.7 13731.6 13752.7 13754.7 13787.9 2525.7 2530.1 2554.1 2559.7 2564.2 2474.6 2544.6 2548.5 2559.4 2564.4 2478.0 2510.2 2536.5 2544.7 2547.4 2378.8 2422.4 2424.2 2431.5 2433.1 2353.3 2364.6 2381.4 2386.2 2432.9 12940.9 13010.9 13017.5 13162.7 13180.3 7029.6 7317.6 7335.7 7343.8 7355.0 3857.4 4032.2 4067.1 4094.9 4116.8 1519.7 1529.3 1549.3 1565.7 1569.8 19165.8 19723.0 21044.7 21345.0 21419.1 5470.3 5570.6 6121.3 6371.6 6375.1 14480.1 14487.3 14526.3 14553.9 14563.0 7201.7 7259.0 7295.9 7300.0 7338.0 6622.3 6728.0 6756.3 6767.1 6802.2 4648.8 4765.2 4868.6 4897.5 4941.5 1397.7 1399.2 1410.0 1418.7 1427.0 876.2 877.7 880.6 897.5 928.1 7519.4 7896.4 7928.9 7982.4 8035.4 960.4 977.4 978.2 1006.3 1038.7 4610.6 4702.4 4895.7 4912.7 4964.2 17249.7 17730.1 17948.8 18086.6 18172.7 16998.0 17442.0 17639.6 17681.4 17831.0 9460.9 9914.0 10031.0 10070.4 10122.3 7110.9 7171.6 7383.5 7532.4 7597.2 14738.3 15727.4 15874.0 15987.4 16023.7 15497.6 16034.7 16304.7 16363.7 16435.7 11051.3 11065.9 11251.6 11369.7 11407.2 12461.3 12719.6 12733.7 12791.1 12822.5 9716.2 10328.7 10496.6 10686.7 10815.9 9703.4 9847.4 9973.7 10034.4 10088.8 9270.3 9290.1 9321.0 9335.9 9337.0 6653.4 6890.1 6987.4 7143.1 7165.2 6708.0 6758.2 6946.2 7037.8 7122.7 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#4] prototype.html Cycles:180 Average:5641.80 Median:6182.01 stddev:1582.46 (25.6%) stddev-sans-first:1538.83 18:38:26 INFO - PID 3160 | Values: 484.6 496.2 512.6 519.8 528.7 6284.3 6388.6 6436.2 6450.0 6469.0 5990.9 6078.1 6184.9 6227.8 6297.9 5220.9 5253.7 5255.1 5261.2 5269.6 5235.8 5252.7 5253.6 5270.2 5279.5 5193.9 5194.7 5206.0 5207.9 5226.9 4824.1 5066.6 5235.3 5235.7 5238.6 4500.2 4527.0 4530.7 4536.9 4544.2 6116.3 6141.3 6154.9 6179.1 6235.5 5753.5 5770.5 5771.0 5787.1 5787.3 6656.9 6675.8 6680.1 6707.2 6714.3 4932.5 4955.7 4958.6 4959.1 4978.7 7060.6 7068.0 7071.6 7079.2 7148.6 5101.1 5117.0 5117.6 5123.0 5134.4 5178.9 5180.3 5199.9 5200.5 5212.7 5843.6 5852.3 5858.7 5866.3 5881.7 6768.7 6795.3 6836.9 6838.9 6847.7 1730.7 1787.6 1797.2 1813.1 1813.3 1228.4 1235.4 1238.0 1238.9 1244.6 5801.6 5838.8 5848.1 5850.4 5875.3 6643.8 6732.9 6830.8 6940.9 6984.6 5787.4 5809.5 5828.2 5831.2 5832.5 3592.8 3657.6 3689.9 3694.9 3697.7 6668.4 6670.4 6680.3 6694.4 6724.6 6967.8 6977.5 7067.0 7077.5 7090.8 6615.9 6659.1 6677.5 6684.5 6693.1 6787.6 6822.8 6870.9 6875.1 6894.7 6827.0 6871.3 6877.7 6891.4 6896.7 6679.0 6689.2 6696.9 6697.7 6701.3 5035.9 5065.9 5076.3 5079.8 5092.6 6852.6 6867.3 6923.9 6939.5 6966.6 6703.2 6718.2 6724.6 6747.3 6761.3 6318.8 6700.8 6726.9 6750.3 6756.9 6189.3 6540.7 6584.9 6600.3 6636.7 6628.9 6661.0 6679.2 6722.3 6735.7 6269.9 6424.5 6530.7 6548.5 6569.1 18:38:26 INFO - PID 3160 | 18:38:26 INFO - PID 3160 | [#5] yui.html Cycles:180 Average:20615.00 Median:18514.22 stddev:26609.59 (143.7%) stddev-sans-first:26642.82 18:38:26 INFO - PID 3160 | Values: 845.2 854.9 860.8 868.5 879.2 18018.4 18030.6 18433.0 18564.4 19928.3 19455.1 20091.8 20137.2 20242.6 20414.4 946.7 1051.8 1059.8 1062.5 1063.3 1065.2 1069.0 1077.5 1078.3 1083.2 1127.5 1128.3 1129.5 1132.4 1135.9 1043.2 1127.6 1127.7 1131.0 1132.1 795.6 798.6 801.7 805.1 806.3 17352.3 17413.7 17470.7 17481.6 17491.8 17776.6 17969.7 18480.6 18547.8 18701.8 15552.8 15736.5 15966.8 16049.6 16105.8 3569.0 3594.0 3595.1 3595.4 3602.1 90352.5 94246.5 95679.0 97060.5 100174.5 15203.9 15256.6 15426.2 16252.8 16306.1 27567.0 28369.0 28399.9 28415.0 28507.3 8750.0 8867.5 8947.5 8969.4 9016.5 3707.5 3844.1 3965.1 4220.6 4236.2 4572.2 4655.7 4667.9 4678.7 4703.8 962.2 1003.2 1006.6 1007.6 1007.7 641.7 645.7 662.5 664.4 678.4 10969.6 12332.3 12399.0 12411.3 12618.1 691.2 709.2 712.9 724.2 725.8 5181.4 5292.5 5297.4 5520.2 5587.2 95521.5 99759.5 100257.0 100396.0 100415.5 84851.0 86578.6 87795.6 88510.6 88894.6 74095.0 75195.0 75277.6 75566.6 80213.6 10180.5 10996.7 11000.1 11098.3 11266.6 35398.1 36363.3 36530.5 37142.6 37844.0 44416.0 44500.3 44768.6 44947.3 45836.0 14908.4 15295.8 15560.8 15582.8 15850.7 16197.4 16302.5 16838.2 16957.9 17065.4 15647.9 15653.9 16232.5 17152.4 17473.9 17291.3 17704.9 17908.2 18034.5 18781.3 16801.8 17152.9 17175.7 17599.4 18694.0 12269.4 12964.0 13037.2 13211.9 13590.9 12863.8 12878.3 13408.4 13433.5 13630.9 18:38:26 INFO - PID 3160 | -------- Summary: end -------- 18:38:26 INFO - PID 3160 | 18:38:26 INFO - TEST-INFO | 3160: exit 0 18:38:26 INFO - TEST-OK | dromaeo_css | took 1117598ms 18:38:26 INFO - TEST-START | kraken 18:38:26 INFO - operating with platform_type : linux_ 18:38:26 INFO - Initialising browser for kraken test... 18:38:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59409/getInfo.html -profile /tmp/tmp5iW3QR/profile 18:38:26 INFO - TEST-INFO | started process 3586 (/builds/slave/test/build/application/firefox/firefox http://localhost:59409/getInfo.html) 18:38:33 INFO - TEST-INFO | 3586: exit 0 18:38:33 INFO - Browser initialized. 18:38:33 INFO - Running cycle 1/1 for kraken test... 18:38:33 INFO - TEST-INFO | started process 3818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5iW3QR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:44 INFO - PID 3818 | RSS: Main: 179400704 18:38:44 INFO - PID 3818 | 18:38:47 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59409/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:48 INFO - PID 3818 | RSS: Main: 182702080 18:38:48 INFO - PID 3818 | 18:38:50 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59409/tests/kraken/driver.html?testName=audio-dft) 18:38:51 INFO - PID 3818 | RSS: Main: 183267328 18:38:51 INFO - PID 3818 | 18:38:54 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59409/tests/kraken/driver.html?testName=audio-fft) 18:38:55 INFO - PID 3818 | RSS: Main: 179478528 18:38:55 INFO - PID 3818 | 18:38:57 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59409/tests/kraken/driver.html?testName=audio-oscillator) 18:38:57 INFO - PID 3818 | RSS: Main: 180424704 18:38:57 INFO - PID 3818 | 18:39:00 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:39:00 INFO - PID 3818 | RSS: Main: 180674560 18:39:00 INFO - PID 3818 | 18:39:03 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59409/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:04 INFO - PID 3818 | RSS: Main: 183820288 18:39:04 INFO - PID 3818 | 18:39:07 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59409/tests/kraken/driver.html?testName=imaging-desaturate) 18:39:08 INFO - PID 3818 | RSS: Main: 185511936 18:39:08 INFO - PID 3818 | 18:39:11 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59409/tests/kraken/driver.html?testName=json-parse-financial) 18:39:11 INFO - PID 3818 | RSS: Main: 184852480 18:39:11 INFO - PID 3818 | 18:39:13 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:14 INFO - PID 3818 | RSS: Main: 185044992 18:39:14 INFO - PID 3818 | 18:39:15 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:16 INFO - PID 3818 | RSS: Main: 184561664 18:39:16 INFO - PID 3818 | 18:39:18 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:19 INFO - PID 3818 | RSS: Main: 184303616 18:39:19 INFO - PID 3818 | 18:39:21 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:22 INFO - PID 3818 | RSS: Main: 184520704 18:39:22 INFO - PID 3818 | 18:39:25 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:26 INFO - PID 3818 | RSS: Main: 184107008 18:39:26 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | Cycle 1(1): loaded http://localhost:59409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59409/tests/kraken/driver.html?testName=ai-astar) 18:39:28 INFO - PID 3818 | RSS: Main: 185585664 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | __start_tp_report 18:39:28 INFO - PID 3818 | _x_x_mozilla_page_load 18:39:28 INFO - PID 3818 | _x_x_mozilla_page_load_details 18:39:28 INFO - PID 3818 | |i|pagename|runs| 18:39:28 INFO - PID 3818 | |0;ai-astar;102;107;108;106;112;108;108;112;108;108 18:39:28 INFO - PID 3818 | |1;audio-beat-detection;153;120;151;184;127;158;152;128;180;121 18:39:28 INFO - PID 3818 | |2;audio-dft;165;163;164;165;162;173;174;170;168;164 18:39:28 INFO - PID 3818 | |3;audio-fft;76;75;74;173;74;75;76;75;104;74 18:39:28 INFO - PID 3818 | |4;audio-oscillator;83;83;142;83;81;83;136;81;83;135 18:39:28 INFO - PID 3818 | |5;imaging-gaussian-blur;113;113;115;114;115;116;114;115;114;116 18:39:28 INFO - PID 3818 | |6;imaging-darkroom;151;151;153;151;153;154;151;150;150;153 18:39:28 INFO - PID 3818 | |7;imaging-desaturate;95;95;94;94;95;95;95;94;95;94 18:39:28 INFO - PID 3818 | |8;json-parse-financial;58;53;54;53;54;56;58;54;52;55 18:39:28 INFO - PID 3818 | |9;json-stringify-tinderbox;54;54;54;54;54;56;56;55;55;57 18:39:28 INFO - PID 3818 | |10;stanford-crypto-aes;78;77;79;80;78;80;80;78;77;77 18:39:28 INFO - PID 3818 | |11;stanford-crypto-ccm;128;127;133;134;127;130;125;128;129;147 18:39:28 INFO - PID 3818 | |12;stanford-crypto-pbkdf2;188;185;192;174;185;183;185;176;194;181 18:39:28 INFO - PID 3818 | |13;stanford-crypto-sha256-iterative;70;72;70;70;69;70;68;74;68;69 18:39:28 INFO - PID 3818 | __end_tp_report 18:39:28 INFO - PID 3818 | __start_cc_report 18:39:28 INFO - PID 3818 | _x_x_mozilla_cycle_collect,971 18:39:28 INFO - PID 3818 | __end_cc_report 18:39:28 INFO - PID 3818 | __startTimestamp1497922768412__endTimestamp 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | ------- Summary: start ------- 18:39:28 INFO - PID 3818 | Number of tests: 14 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:2.85 (2.6%) stddev-sans-first:2.07 18:39:28 INFO - PID 3818 | Values: 102.0 107.0 108.0 106.0 112.0 108.0 108.0 112.0 108.0 108.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:152.50 stddev:23.14 (15.2%) stddev-sans-first:24.46 18:39:28 INFO - PID 3818 | Values: 153.0 120.0 151.0 184.0 127.0 158.0 152.0 128.0 180.0 121.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#2] audio-dft Cycles:10 Average:166.80 Median:166.50 stddev:4.24 (2.5%) stddev-sans-first:4.44 18:39:28 INFO - PID 3818 | Values: 165.0 163.0 164.0 165.0 162.0 173.0 174.0 170.0 168.0 164.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:31.38 (41.8%) stddev-sans-first:33.00 18:39:28 INFO - PID 3818 | Values: 76.0 75.0 74.0 173.0 74.0 75.0 76.0 75.0 104.0 74.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:83.00 stddev:26.75 (32.2%) stddev-sans-first:27.74 18:39:28 INFO - PID 3818 | Values: 83.0 83.0 142.0 83.0 81.0 83.0 136.0 81.0 83.0 135.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 18:39:28 INFO - PID 3818 | Values: 113.0 113.0 115.0 114.0 115.0 116.0 114.0 115.0 114.0 116.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 18:39:28 INFO - PID 3818 | Values: 151.0 151.0 153.0 151.0 153.0 154.0 151.0 150.0 150.0 153.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:39:28 INFO - PID 3818 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:2.06 (3.8%) stddev-sans-first:1.80 18:39:28 INFO - PID 3818 | Values: 58.0 53.0 54.0 53.0 54.0 56.0 58.0 54.0 52.0 55.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:1.10 (2.0%) stddev-sans-first:1.12 18:39:28 INFO - PID 3818 | Values: 54.0 54.0 54.0 54.0 54.0 56.0 56.0 55.0 55.0 57.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:1.26 (1.6%) stddev-sans-first:1.33 18:39:28 INFO - PID 3818 | Values: 78.0 77.0 79.0 80.0 78.0 80.0 80.0 78.0 77.0 77.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:129.50 stddev:6.32 (4.9%) stddev-sans-first:6.62 18:39:28 INFO - PID 3818 | Values: 128.0 127.0 133.0 134.0 127.0 130.0 125.0 128.0 129.0 147.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:185.00 stddev:6.29 (3.4%) stddev-sans-first:6.53 18:39:28 INFO - PID 3818 | Values: 188.0 185.0 192.0 174.0 185.0 183.0 185.0 176.0 194.0 181.0 18:39:28 INFO - PID 3818 | 18:39:28 INFO - PID 3818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.94 18:39:28 INFO - PID 3818 | Values: 70.0 72.0 70.0 70.0 69.0 70.0 68.0 74.0 68.0 69.0 18:39:28 INFO - PID 3818 | -------- Summary: end -------- 18:39:28 INFO - PID 3818 | 18:39:29 INFO - TEST-INFO | 3818: exit 0 18:39:29 INFO - TEST-OK | kraken | took 62338ms 18:39:29 INFO - SUITE-END | took 1179s 18:39:29 INFO - Completed test suite (00:19:40) 18:39:29 INFO - javascript benchmark 18:39:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8116.021212078972, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.829619370934, 3140.8429578521072, 3159.7314228290593, 3177.507486339618, 3185.9522107168395, 5918.34898161203, 5950.791722289726, 5965.9701701491485, 6039.788607398742, 6081.847953801157, 6154.0, 6162.876742465148, 6206.844828879269, 6212.534059945499, 6245.313015568284, 5692.003899317623, 5703.201551782754, 5726.799562015331, 5764.5676574257095, 5798.65208087514, 5776.162456443813, 5843.532517398619, 5848.181254624356, 5849.619774714652, 5859.7070146492715, 5572.080606699889, 5690.061139911951, 5693.202951586781, 5733.913991290134, 5734.111212761987, 5591.552675785927, 5617.80337688183, 5637.43625637433, 5663.603547751659, 5681.289838770153, 5580.497755202011, 5605.495505404492, 5668.206451096849, 5675.659460432346, 5683.318001839806, 6053.273607167124, 6092.573519853612, 6109.114178444101, 6114.11345354921, 6131.110988906628, 6553.344665533408, 6578.539502234846, 6585.111010013635, 6616.603003819786, 6622.8344291393105, 6495.447886929616, 6670.266270710218, 6671.766488172891, 6701.93298067018, 6731.831704207385, 6137.202163718777, 6157.1072194532435, 6225.8132256032395, 6234.781782637586, 6277.1525844010475, 6871.312868713188, 6982.2319544850025, 6986.0, 6987.965060174666, 6993.790186294317, 6350.206224221973, 6441.67791610427, 6442.48460123189, 6451.838704032343, 6637.037629543689, 6516.641584712792, 6579.407853293226, 6590.176227971504, 6664.666766661744, 6733.091032710619, 6662.0340050692375, 6667.899981500282, 6678.0, 6688.297728738413, 6702.899456508157, 6689.665516724144, 6708.765193218312, 6711.697973591103, 6727.29363416844, 6731.764388246388, 5320.627556071116, 5365.892682146413, 5368.651037682538, 5399.379071406838, 5407.567394608422, 4598.816047358135, 4627.768611569408, 4631.166390049756, 4643.930341044887, 4694.037722266995, 5704.800331988444, 5734.971325143348, 5742.224799652077, 5752.07966725322, 5755.251817263813, 6743.865122697519, 6746.257911629717, 6754.223264324567, 6776.0, 6783.966080169567, 5741.942580574141, 5750.993576124161, 5752.539796816244, 5762.337331206881, 5777.740001699934, 5805.303363596311, 5814.476697097281, 5816.854578635483, 5867.178594996704, 5931.13998470228, 6352.650604216812, 6430.7749228776765, 6434.8391290218115, 6438.452731517874, 6439.259485159079, 6727.730890764315, 6736.259011508632, 6745.763898263734, 6752.324767523209, 6754.324567543403, 6481.546291759531, 6483.157189565326, 6503.674816259263, 6503.739850405931, 6507.577007494498, 6485.351464853666, 6533.869322613426, 6561.475081993333, 6562.343765623399, 6569.37590928861, 6548.3124271950755, 6595.538312318092, 6628.5691430056895, 6642.634655094016, 6681.198256209286, 6381.776637817654, 6429.8714025720155, 6491.0, 6497.09040734307, 6502.739890404331, 6509.349065093453, 6540.117084193763, 6544.934550654623, 6549.0, 6571.5399922005, 6219.129321895029, 6330.841728956629, 6333.398327158912, 6394.808155755335, 6413.0, 6439.130717353098, 6442.194725659293, 6447.4197322241225, 6491.318411566906, 6497.610143391412, 6340.270868850142, 6367.458766004941, 6371.872562548816, 6390.073439351361, 6455.128557644845], "value": 6067.004148110505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.4462709162948, 788.2866006264333, 828.2462958707576, 857.4683696108411, 862.1637012098263, 39523.0, 39981.8000909995, 40041.1991760165, 40246.39630405546, 40297.0, 36226.275474490496, 36673.81663091681, 36729.0, 36779.816100919525, 36837.26325473489, 6698.430633396155, 6779.423748981342, 6820.693068811891, 6829.078074459959, 6835.453163746888, 6810.080639113706, 6873.140857392826, 6885.380315771579, 6890.44876409886, 6902.75840345588, 6799.320067993211, 6855.348741869514, 6871.828204294908, 6878.1058462399815, 6885.690143943534, 6734.797956061301, 6796.354346337115, 6829.863402731968, 6835.521513494057, 6845.931540684579, 5965.582409231356, 5967.701614919237, 6003.6697981611, 6012.368701286389, 6070.2412198475195, 32398.190045248823, 32804.179895502566, 32879.0, 32967.50548741771, 33011.174720631934, 3488.773229740059, 3503.8423270952867, 3525.94711079334, 3550.5206797082324, 3552.946705799415, 30317.545236821465, 30596.847015765, 30625.540616890765, 30687.693123068708, 30707.692923070706, 3580.874669386559, 3584.211473475831, 3605.2248766515327, 3608.386574282378, 3684.097396137963, 186936.0, 190003.0, 190063.0, 191358.0, 191818.0, 43147.78426107912, 47523.0, 48646.75676621665, 48882.0, 49117.50882491201, 51788.74105629523, 51920.74039629778, 51957.22064169041, 51961.48038519567, 51962.0, 14643.267836608127, 14677.633059173393, 14760.926195368955, 14815.0, 14881.553553393416, 12217.69455763613, 12270.754584908253, 12322.507099716091, 12409.255444673348, 12424.316662583464, 14233.28833558318, 14258.287085645676, 14369.64075898111, 14472.131672099707, 14593.635159120895, 5459.099248623933, 5468.863278417992, 5489.725513724298, 5535.861603459945, 5538.0585300499015, 993.4436715439377, 995.7162208770466, 1002.6791426743372, 1041.4116024446164, 1042.0829669890447, 22480.325590232318, 23045.53908921812, 23138.190163344203, 23466.413339666644, 23869.045238190625, 1057.9523921423554, 1071.8606581144402, 1106.4965440724452, 1115.3029356652091, 1117.4803716271972, 12311.138220324492, 12731.427085781163, 12830.422630981628, 12893.871061289454, 12978.545750898862, 224268.0, 224517.0, 224691.0, 225855.0, 226877.0, 50956.0, 51214.74392628088, 51325.48674513282, 51459.0, 51746.0, 1363.3932899859665, 1450.2168828832312, 1454.185656032625, 1468.686818261264, 1470.3309993952726, 20962.0, 22698.319050428512, 23251.76748232564, 23306.883465582563, 23522.882385587964, 37236.81381593075, 37292.440613391365, 37315.440268395454, 37344.0, 37437.43843842399, 177584.0, 177884.0, 178043.0, 178317.0, 178407.0, 31368.68631313749, 31444.327232185522, 31865.522017170224, 31929.0, 34738.305233895684, 37890.62109378871, 41310.586894130676, 42740.0, 42867.356989644555, 43976.0, 30226.0, 30881.69118308788, 31211.37577248397, 31842.84078579592, 32734.836325818218, 30081.398372032876, 30624.540631890093, 31054.534181986837, 31804.68195318017, 32524.83737581297, 35092.82453587716, 35130.47304290489, 35219.47170792492, 35396.29207415889, 35421.291574168885, 30258.24354391158, 31693.0, 32841.17897052593, 32846.507302390964, 33378.0, 25005.374865628506, 25866.741332587186, 25947.0, 25959.48081038331, 26205.0], "value": 16301.081590565018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2058857305487, 569.362314208087, 574.8160588611646, 576.593501581385, 584.859633687915, 21532.89233553832, 22302.553948921053, 22558.323250302477, 22616.43458913528, 22638.547229055428, 17521.21154548045, 18101.90949045253, 18210.089495525237, 22626.20808271711, 23887.28338149854, 6146.0, 6227.346128656493, 6265.467435268008, 6288.685565721718, 6294.653794041325, 6093.329733729286, 6148.1392605035335, 6203.100550420187, 6213.378662133796, 6224.128621992924, 6180.505559555248, 6184.536159788011, 6185.4433101020895, 6185.845353866167, 6192.287886892997, 5661.631993920402, 6151.6001459904965, 6184.226971628546, 6220.7511699532415, 6285.842853928642, 5851.093080572518, 5851.4148585141575, 5852.385499522574, 5879.441453061995, 5880.911786323209, 26459.0, 26585.601215981776, 26717.732822671915, 26761.866190668923, 26791.0, 1869.5326168457887, 1892.8958907260096, 1903.2387045182038, 1909.102721720789, 1919.7888232294436, 16353.83646163535, 17209.483715488554, 17346.739798903025, 17448.953062816272, 17487.82512174875, 2280.646499792535, 2290.4731911660247, 2338.6024375856146, 2341.672165896776, 2372.41875740443, 119344.40327798306, 120860.39569802095, 121181.0, 122060.38969805095, 122538.0, 12719.80920286178, 13316.334183290797, 13496.86503134956, 13934.23361715095, 14362.0, 22082.0, 22145.778542214695, 22170.0, 22336.888315558645, 22381.88809055944, 9351.672691455766, 9528.094830991045, 9556.617735290649, 9590.136887680143, 9627.56675949584, 8627.654893804178, 8641.481511109354, 8641.740747777576, 8705.216530512158, 8745.994210665727, 8571.52856592881, 8591.65633374658, 8634.22291993711, 8661.956690216635, 8750.95624521886, 2545.9618105728428, 2586.2241327601646, 2613.1899111275566, 2723.416995159954, 2850.073726039004, 933.4026223217146, 949.1410273702311, 961.3654987708079, 989.4656885281867, 997.2022382094441, 18139.637207256044, 18841.717374239397, 18943.43169704911, 19032.61934761297, 19428.8057119427, 963.937344072633, 980.8185485685171, 987.5605355616682, 1013.3210748798323, 1022.6420752736632, 9850.80298394028, 9904.900950990543, 10159.898401015895, 10285.125764309967, 10338.638147664795, 503746.0, 512990.0, 525495.0, 529379.0, 529814.0, 95816.0, 95943.52028239814, 96438.0, 104530.0, 106855.4657226709, 1170.1925671286785, 1184.1592469346688, 1196.3898411809867, 1199.9340036297913, 1222.1078612612664, 15076.321565529797, 15672.216389180723, 15975.0, 16146.838531614534, 16460.34158633689, 42864.78567607142, 45298.32052519281, 45983.0, 47837.76081119572, 51243.0, 62154.68922655358, 63912.68043659752, 64357.35642643514, 64571.03143452946, 64874.0, 12366.19619724715, 12429.384180056535, 12534.435950382072, 12541.749165016467, 12586.056045796786, 17185.882917610314, 17862.106894655477, 18116.184771685043, 18327.175277112296, 18692.43922682322, 12236.143469957373, 12858.807117893051, 12859.549915752903, 14422.0, 15361.231938402812, 11433.428328583372, 13567.728645427234, 13755.518556850462, 14028.579142625738, 14356.35396407185, 15545.455909043128, 15550.611234719223, 15646.530604081896, 15647.765283520985, 15683.372665093268, 12304.0, 12512.937435312766, 12557.24656520575, 12576.056795740173, 12602.747945040865, 13555.59333220005, 14168.291585420893, 14424.567262982127, 14468.421263149778, 14848.554543363716], "value": 10853.982221966451, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.411978729359, 1396.706691594765, 1398.4965412451522, 1398.9510367137152, 1408.7252985667792, 12880.355982200888, 13438.328083595818, 13509.0, 13572.592822215349, 13628.182309061463, 13385.66535836602, 13731.58805235842, 13752.724945501084, 13754.656133596665, 13787.93106034471, 2525.734797846227, 2530.101813856082, 2554.067765265674, 2559.654446649697, 2564.1538292363475, 2474.5669507836146, 2544.643749875019, 2548.528522223385, 2559.4241295708503, 2564.384547708555, 2477.950440991179, 2510.2092840755104, 2536.5053814506177, 2544.707358653751, 2547.439563296072, 2378.8096952243777, 2422.4307287787356, 2424.248482970276, 2431.5380077785253, 2433.1362366359863, 2353.329301149164, 2364.598018336887, 2381.392744850052, 2386.2483317755027, 2432.902683892642, 12940.900023498014, 13010.869891301061, 13017.544385946447, 13162.736745265136, 13180.275084870329, 7029.578225306498, 7317.59753213573, 7335.706571737124, 7343.77968660941, 7355.0, 3857.3828187489867, 4032.1532478179615, 4067.1052368478886, 4094.9181016379803, 4116.75299482032, 1519.7416439205363, 1529.2812378182236, 1549.2795849929723, 1565.7494800831812, 1569.7959265295437, 19165.80834191654, 19722.999999999858, 21044.684329735068, 21345.039473223587, 21419.14323427061, 5470.288862447856, 5570.551656569241, 6121.296050954108, 6371.649559274284, 6375.075614036032, 14480.058796178215, 14487.275636218146, 14526.346314415876, 14553.927230363992, 14563.0, 7201.667691477093, 7259.0, 7295.8540829184185, 7299.963500182465, 7338.0, 6622.304658010936, 6728.0, 6756.324367563205, 6767.0526126341365, 6802.183737951477, 4648.790804413809, 4765.237561990065, 4868.634852386085, 4897.510248975145, 4941.50584941503, 1397.6715471864104, 1399.244408019658, 1409.9647508812157, 1418.723348946966, 1427.0367501936153, 876.2070326354532, 877.6533269358695, 880.6213328268777, 897.4570384917162, 928.095107270406, 7519.360854327334, 7896.407769417317, 7928.8810667840025, 7982.401319901031, 8035.437519373588, 960.3613596958085, 977.359829311802, 978.1783302026332, 1006.2654262388351, 1038.7039693687263, 4610.585047345688, 4702.435707715028, 4895.674554586614, 4912.656114072052, 4964.205727083649, 17249.741253881202, 17730.11349432549, 17948.820511794976, 18086.638267234583, 18172.727409088875, 16997.999999999753, 17442.0, 17639.559011024572, 17681.38115165963, 17831.0, 9460.90539094614, 9913.950430247947, 10031.0, 10070.395776253301, 10122.291439599305, 7110.928890711027, 7171.641417929187, 7383.483156179016, 7532.363672714506, 7597.164311925573, 14738.336774844944, 15727.449539266529, 15874.0, 15987.44043958456, 16023.679526409172, 15497.612559686098, 16034.679306413573, 16304.673906521566, 16363.672726545641, 16435.67128657396, 11051.281666691639, 11065.889341106486, 11251.606193783506, 11369.715757106138, 11407.201495895208, 12461.314627695563, 12719.618411447671, 12733.745325093261, 12791.104622676323, 12822.487100515875, 9716.174125199155, 10328.690139295833, 10496.632617858644, 10686.679399618024, 10815.891841081802, 9703.432255009935, 9847.409155450696, 9973.700788976343, 10034.448105354275, 10088.798224035625, 9270.258379329773, 9290.1174388433, 9321.0, 9335.85996210071, 9337.0, 6653.401193892573, 6890.138732658418, 6987.371136597731, 7143.1428228612895, 7165.211826698955, 6707.960266158753, 6758.155230596176, 6946.16646002483, 7037.79519696432, 7122.679479423335], "value": 6008.402435425826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.5638924967531, 496.19616221720815, 512.5950499105707, 519.8232600915688, 528.6590149353667, 6284.340144284847, 6388.584741991767, 6436.163298771165, 6450.0, 6468.967655161718, 5990.854801229357, 6078.149059131725, 6184.907226391608, 6227.844303892405, 6297.905531417033, 5220.895582088366, 5253.7373131343475, 5255.106631872572, 5261.184516399964, 5269.578433725293, 5235.842924712246, 5252.71110088945, 5253.57971362292, 5270.183121616155, 5279.472052794709, 5193.948060519403, 5194.68831870089, 5206.0, 5207.947920520804, 5226.863881670986, 4824.105536678, 5066.620003499752, 5235.324696097231, 5235.6596821206695, 5238.60710446718, 4500.212462819027, 4527.004059106991, 4530.728156310599, 4536.911141326058, 4544.2047641662575, 6116.296625887991, 6141.293751218623, 6154.907676384858, 6179.104029915637, 6235.501159907197, 5753.510951569122, 5770.538356931435, 5770.971145144289, 5787.102999035156, 5787.33445653751, 6656.93343066568, 6675.833104172386, 6680.131582894242, 6707.228668703064, 6714.294999025081, 4932.506749325074, 4955.677880937727, 4958.603311735053, 4959.107360675113, 4978.6763860348965, 7060.611666358348, 7068.0104785330095, 7071.646417679147, 7079.185893622196, 7148.606826624534, 5101.132807422747, 5116.974415127975, 5117.616178786606, 5123.0266249413235, 5134.383873935151, 5178.870528236825, 5180.300659411007, 5199.922001169985, 5200.453952335026, 5212.661177023481, 5843.620164689281, 5852.268466441695, 5858.736356863951, 5866.325372582208, 5881.735321910524, 6768.69540870662, 6795.252522222551, 6836.931630683729, 6838.931610683929, 6847.691853866588, 1730.7230843065302, 1787.5709829640793, 1797.191263931236, 1813.1478205243513, 1813.3018787766541, 1228.42264135856, 1235.3823088455772, 1238.0253495674565, 1238.8575313838844, 1244.5519612939336, 5801.564882633819, 5838.824835254949, 5848.052564518933, 5850.4149585042005, 5875.29496460419, 6643.80754351063, 6732.932670673328, 6830.829229269308, 6940.889457686746, 6984.603079384042, 5787.392323806024, 5809.535237181015, 5828.154917537018, 5831.154482599999, 5832.50423713989, 3592.8203589820405, 3657.6159503252306, 3689.9151979131707, 3694.9445758313645, 3697.6672099511175, 6668.365995431777, 6670.433013193933, 6680.265170831205, 6694.430973367221, 6724.611618962006, 6967.756128535477, 6977.546459480118, 7067.0, 7077.5399599025895, 7090.787276381717, 6615.933840661532, 6659.134312539532, 6677.532572719863, 6684.498662600325, 6693.129893113962, 6787.5588086774205, 6822.829429264109, 6870.931290687229, 6875.140607424072, 6894.655267236518, 6827.0, 6871.347222013901, 6877.65611719402, 6891.4486841053595, 6896.689648965909, 6679.0, 6689.1972963244725, 6696.933030669631, 6697.665116744241, 6701.3298670134545, 5035.874103147451, 5065.949340506548, 5076.2740668173, 5079.847604571869, 5092.6435149539175, 6852.554583952027, 6867.3476019778045, 6923.89614155778, 6939.514234003571, 6966.582005079711, 6703.195616526048, 6718.193816742022, 6724.562903411263, 6747.291534388818, 6761.3238676132, 6318.842028949313, 6700.83247918806, 6726.8990965136545, 6750.291219422086, 6756.9188929771, 6189.319174890668, 6540.738370465128, 6584.851543527547, 6600.273969863407, 6636.705842360693, 6628.900566491603, 6660.966695166493, 6679.198496180489, 6722.294159113223, 6735.743525918872, 6269.937300626935, 6424.4860411166055, 6530.706118224596, 6548.476121910331, 6569.146011018537], "value": 5171.045472967943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.2392846438208, 854.9316054715622, 860.7718954477061, 868.4875923205308, 879.235065493021, 18018.369357072504, 18030.639387212264, 18432.99999999998, 18564.443066708005, 19928.302509412173, 19455.124519396624, 20091.799082009176, 20137.194512219492, 20242.595148097065, 20414.387568372935, 946.7159852044393, 1051.7633532455213, 1059.782744537368, 1062.5484169228087, 1063.2663462211087, 1065.211743309949, 1068.9679309620724, 1077.455884778186, 1078.3314345106005, 1083.2309060567006, 1127.486993417997, 1128.266626692648, 1129.5199540195424, 1132.3885102044926, 1135.8807325230855, 1043.186314674555, 1127.5827943660815, 1127.7406196574752, 1130.9660710178666, 1132.0830127596673, 795.550513959611, 798.5528104261632, 801.6512816924599, 805.0741647105816, 806.2944923192207, 17352.305907763675, 17413.738793918103, 17470.737938930924, 17481.562960925952, 17491.825081749146, 17776.55558611032, 17969.7304540432, 18480.630387392175, 18547.814521854743, 18701.81298187028, 15552.766708499381, 15736.527904162893, 15966.840331596652, 16049.598760031093, 16105.758413623806, 3569.0, 3594.02961200477, 3595.1012246938267, 3595.388783906742, 3602.1174812170925, 90352.54823725905, 94246.52876735642, 95679.0, 97060.51469742677, 100174.49912750389, 15203.923980380026, 15256.618584535476, 15426.228688565527, 16252.75620865688, 16306.10316432584, 27567.0, 28369.0, 28399.858000709864, 28415.0, 28507.287317816805, 8750.0, 8867.467951922905, 8947.463152210888, 8969.372143949991, 9016.504092274856, 3707.5180226570915, 3844.1350696093714, 3965.088029753173, 4220.641245494167, 4236.195122926634, 4572.245579479349, 4655.650826188049, 4667.883302917454, 4678.719276843401, 4703.811847526129, 962.1725316228038, 1003.1673710820148, 1006.572206812102, 1007.5818535307765, 1007.7027276953316, 641.6503005861816, 645.7191121862005, 662.536224642752, 664.3821246241042, 678.4436761855231, 10969.616063437741, 12332.32172230518, 12399.0, 12411.255324680367, 12618.116731828684, 691.1878542712393, 709.2234003765868, 712.8859382498775, 724.221461928429, 725.7677543186236, 5181.35233095863, 5292.52367286946, 5297.417284098746, 5520.227168196456, 5587.189857470644, 95521.52239238759, 99759.50120249353, 100257.0, 100396.0, 100415.48545800862, 84851.0, 86578.56710716407, 87795.56102219576, 88510.55744721236, 88894.55552722325, 74095.0, 75195.0, 75277.62361188268, 75566.62216688882, 80213.59893200497, 10180.49097545105, 10996.725081872697, 11000.119990400908, 11098.334099954029, 11266.605668801552, 35398.115047123, 36363.27273454569, 36530.452043219906, 37142.62857371392, 37844.0, 44416.0, 44500.33249501196, 44768.55231447644, 44947.32579011383, 45836.0, 14908.403663853758, 15295.847041529441, 15560.766588501408, 15582.84417155814, 15850.682986339978, 16197.4330898418, 16302.510924672279, 16838.158092095593, 16957.915210423867, 17065.40271090506, 15647.921760391126, 15653.921730391276, 16232.513024609281, 17152.399666011628, 17473.864198827036, 17291.308347665952, 17704.91147544254, 17908.194131263863, 18034.458966230508, 18781.342653007625, 16801.831981680025, 17152.914235428743, 17175.742363864803, 17599.384021559184, 18694.0, 12269.38653067361, 12964.02712331928, 13037.15258508194, 13211.933940330237, 13590.86409135896, 12863.807042894552, 12878.291693956922, 13408.396622152222, 13433.462661493822, 13630.93184534071], "value": 8568.755161193414, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 108.0, 106.0, 112.0, 108.0, 108.0, 112.0, 108.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 151.0, 184.0, 127.0, 158.0, 152.0, 128.0, 180.0, 121.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 165.0, 162.0, 173.0, 174.0, 170.0, 168.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 173.0, 74.0, 75.0, 76.0, 75.0, 104.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 142.0, 83.0, 81.0, 83.0, 136.0, 81.0, 83.0, 135.0], "value": 99.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 114.0, 115.0, 116.0, 114.0, 115.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 153.0, 151.0, 153.0, 154.0, 151.0, 150.0, 150.0, 153.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 53.0, 54.0, 56.0, 58.0, 54.0, 52.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 56.0, 55.0, 55.0, 57.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 80.0, 78.0, 80.0, 80.0, 78.0, 77.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 133.0, 134.0, 127.0, 130.0, 125.0, 128.0, 129.0, 147.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 192.0, 174.0, 185.0, 183.0, 185.0, 176.0, 194.0, 181.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 70.0, 69.0, 70.0, 68.0, 74.0, 68.0, 69.0], "value": 70.0, "unit": "score"}]}]} 18:39:29 INFO - Return code: 0 18:39:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:29 INFO - # TBPL SUCCESS # 18:39:29 INFO - Running post-action listener: _resource_record_post_action 18:39:29 INFO - [mozharness: 2017-06-20 01:39:29.810180Z] Finished run-tests step (success) 18:39:29 INFO - Running post-run listener: _resource_record_post_run 18:39:29 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 435744768; Read time: 104; Write time: 300068 18:39:29 INFO - TinderboxPrint: CPU usage
13.3% 18:39:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 18:39:29 INFO - TinderboxPrint: I/O write bytes / time
435,744,768 / 300,068 18:39:29 INFO - TinderboxPrint: CPU idle
8,283.7 (86.7%) 18:39:29 INFO - TinderboxPrint: CPU user
1,217.2 (12.7%) 18:39:29 INFO - TinderboxPrint: Swap in / out
0 / 0 18:39:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105017344; Read time: 0; Write time: 87092 18:39:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:39:29 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329916416; Read time: 92; Write time: 212916 18:39:30 INFO - Running post-run listener: _upload_blobber_files 18:39:30 INFO - Blob upload gear active. 18:39:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:30 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 18:39:30 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'] 18:39:30 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 18:39:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:31 INFO - (blobuploader) - INFO - Done attempting. 18:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:32 INFO - (blobuploader) - INFO - Done attempting. 18:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:38 INFO - (blobuploader) - INFO - Done attempting. 18:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:39 INFO - (blobuploader) - INFO - Done attempting. 18:39:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:39 INFO - Return code: 0 18:39:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a71cf5738c413b1fee69846f8ccd9303d3768aa6897ef45bfbb00fb94fa3e5f22b797d5f54ba2eb716887cd5fe8ef51d93562dfa0b852118a86d5b1e3ec7ccf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499154ae94566258d522af57d24ec008105bee45e6e849a8bfb15e7ba4c216a88c2320c5ea6f9f5eddab64f01497da5bb99f5b598dcdbc8b745c9f1e94c6c32c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7994c39739705da4d01b0a84b9a6fca6238eb840ea9333b36b9f69f17e372c91ba66879b790ca49ea1acbe35951d227baf027c59ad1aa19700745cf6ab8cef6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247808738007d7326ba32129e43ff1c8caf36cb60128ba7b921724309ef703f4cee3ae9ef61d623cce7e545f0fee854d0f4baca8abf86c1b01955a8a9ed7108"} 18:39:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:39 INFO - Contents: 18:39:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a71cf5738c413b1fee69846f8ccd9303d3768aa6897ef45bfbb00fb94fa3e5f22b797d5f54ba2eb716887cd5fe8ef51d93562dfa0b852118a86d5b1e3ec7ccf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499154ae94566258d522af57d24ec008105bee45e6e849a8bfb15e7ba4c216a88c2320c5ea6f9f5eddab64f01497da5bb99f5b598dcdbc8b745c9f1e94c6c32c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7994c39739705da4d01b0a84b9a6fca6238eb840ea9333b36b9f69f17e372c91ba66879b790ca49ea1acbe35951d227baf027c59ad1aa19700745cf6ab8cef6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247808738007d7326ba32129e43ff1c8caf36cb60128ba7b921724309ef703f4cee3ae9ef61d623cce7e545f0fee854d0f4baca8abf86c1b01955a8a9ed7108"} 18:39:39 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:39 INFO - Copying logs to upload dir... 18:39:39 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.188813 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-19 18:39:39.294948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 18:39:39.299310) ========= 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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a71cf5738c413b1fee69846f8ccd9303d3768aa6897ef45bfbb00fb94fa3e5f22b797d5f54ba2eb716887cd5fe8ef51d93562dfa0b852118a86d5b1e3ec7ccf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499154ae94566258d522af57d24ec008105bee45e6e849a8bfb15e7ba4c216a88c2320c5ea6f9f5eddab64f01497da5bb99f5b598dcdbc8b745c9f1e94c6c32c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7994c39739705da4d01b0a84b9a6fca6238eb840ea9333b36b9f69f17e372c91ba66879b790ca49ea1acbe35951d227baf027c59ad1aa19700745cf6ab8cef6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247808738007d7326ba32129e43ff1c8caf36cb60128ba7b921724309ef703f4cee3ae9ef61d623cce7e545f0fee854d0f4baca8abf86c1b01955a8a9ed7108"} build_url:https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/GbRLkPRzQh25xFCIGVtBgw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a71cf5738c413b1fee69846f8ccd9303d3768aa6897ef45bfbb00fb94fa3e5f22b797d5f54ba2eb716887cd5fe8ef51d93562dfa0b852118a86d5b1e3ec7ccf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499154ae94566258d522af57d24ec008105bee45e6e849a8bfb15e7ba4c216a88c2320c5ea6f9f5eddab64f01497da5bb99f5b598dcdbc8b745c9f1e94c6c32c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7994c39739705da4d01b0a84b9a6fca6238eb840ea9333b36b9f69f17e372c91ba66879b790ca49ea1acbe35951d227baf027c59ad1aa19700745cf6ab8cef6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247808738007d7326ba32129e43ff1c8caf36cb60128ba7b921724309ef703f4cee3ae9ef61d623cce7e545f0fee854d0f4baca8abf86c1b01955a8a9ed7108"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 18:39:39.326606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:39:39.327006) ========= 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=41bf3e9aed84707956354da8000001c5-1497919309.457116-539661654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 18:39:39.410918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 18:39:39.411295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 18:39:39.411634) ========= ========= Total master_lag: 0.20 =========