builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1496257647.61 results: success (0) revision: 94906c37940c6b1c371dc7c22ed2098face96d8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.614581) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.614980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.615246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.634800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.635071) ========= 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=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 12:07:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-05-31 12:07:28 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.784070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.787391) ========= 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=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014960 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:27.837821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 12:07:27.841649) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 94906c37940c6b1c371dc7c22ed2098face96d8b --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 94906c37940c6b1c371dc7c22ed2098face96d8b --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=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 12:07:28,140 truncating revision to first 12 chars 2017-05-31 12:07:28,140 Setting DEBUG logging. 2017-05-31 12:07:28,140 attempt 1/10 2017-05-31 12:07:28,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/94906c37940c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 12:07:29,434 unpacking tar archive at: mozilla-central-94906c37940c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.591132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 12:07:29.444886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:29.445181) ========= script_repo_revision: 94906c37940c6b1c371dc7c22ed2098face96d8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:29.448571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:29.448835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 12:07:29.457127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-31 12:07:29.457438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:07:29 INFO - MultiFileLogger online at 20170531 12:07:29 in /builds/slave/test 12:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:07:29 INFO - {'append_to_log': False, 12:07:29 INFO - 'base_work_dir': '/builds/slave/test', 12:07:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:07:29 INFO - 'branch': 'Firefox-Non-PGO', 12:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 12:07:29 INFO - 'config_files': ('talos/linux_config.py',), 12:07:29 INFO - 'default_actions': ('clobber', 12:07:29 INFO - 'read-buildbot-config', 12:07:29 INFO - 'download-and-extract', 12:07:29 INFO - 'populate-webroot', 12:07:29 INFO - 'create-virtualenv', 12:07:29 INFO - 'install', 12:07:29 INFO - 'setup-mitmproxy', 12:07:29 INFO - 'run-tests'), 12:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:07:29 INFO - 'download_minidump_stackwalk': True, 12:07:29 INFO - 'download_symbols': 'ondemand', 12:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 12:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 12:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:07:29 INFO - 'gecko_profile': False, 12:07:29 INFO - 'gecko_profile_interval': 0, 12:07:29 INFO - 'installer_path': 'installer.exe', 12:07:29 INFO - 'log_level': 'info', 12:07:29 INFO - 'log_name': 'talos', 12:07:29 INFO - 'log_to_console': True, 12:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:07:29 INFO - 'opt_config_files': (), 12:07:29 INFO - 'pip_index': False, 12:07:29 INFO - 'suite': 'dromaeojs-e10s', 12:07:29 INFO - 'system_bits': '32', 12:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:07:29 INFO - 'title': 'talos-linux64-ix-025', 12:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:07:29 INFO - 'use_talos_json': True, 12:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:07:29 INFO - 'work_dir': 'build'} 12:07:29 INFO - [mozharness: 2017-05-31 19:07:29.850151Z] Running clobber step. 12:07:29 INFO - Running pre-action listener: _resource_record_pre_action 12:07:29 INFO - Running main action method: clobber 12:07:29 INFO - rmtree: /builds/slave/test/build 12:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:07:30 INFO - Running post-action listener: _resource_record_post_action 12:07:30 INFO - [mozharness: 2017-05-31 19:07:30.860338Z] Finished clobber step (success) 12:07:30 INFO - [mozharness: 2017-05-31 19:07:30.860440Z] Running read-buildbot-config step. 12:07:30 INFO - Running pre-action listener: _resource_record_pre_action 12:07:30 INFO - Running main action method: read_buildbot_config 12:07:30 INFO - Using buildbot properties: 12:07:30 INFO - { 12:07:30 INFO - "project": "", 12:07:30 INFO - "product": "firefox", 12:07:30 INFO - "who": "ryanvm@gmail.com", 12:07:30 INFO - "installer_path": "public/build/target.tar.bz2", 12:07:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:07:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:07:30 INFO - "stage_platform": "linux64", 12:07:30 INFO - "basedir": "/builds/slave/test", 12:07:30 INFO - "buildnumber": 872, 12:07:30 INFO - "platform": "ubuntu64_hw", 12:07:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:07:30 INFO - "slavebuilddir": "test", 12:07:30 INFO - "taskId": "Og6q7z8DTYGiRfn_ZThe4Q", 12:07:30 INFO - "branch": "mozilla-central", 12:07:30 INFO - "script_repo_revision": "production", 12:07:30 INFO - "revision": "94906c37940c6b1c371dc7c22ed2098face96d8b", 12:07:30 INFO - "slavename": "talos-linux64-ix-025", 12:07:30 INFO - "repo_path": "mozilla-central" 12:07:30 INFO - } 12:07:30 INFO - Finding installer, test and symbols from parent task. 12:07:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og6q7z8DTYGiRfn_ZThe4Q'}, attempt #1 12:07:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og6q7z8DTYGiRfn_ZThe4Q'}, attempt #1 12:07:38 INFO - Task dependencies: DmOUqfT5QfqiXzH8KK_TFg 12:07:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg'}, attempt #1 12:07:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 12:07:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/test_packages.json 12:07:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.crashreporter-symbols.zip 12:07:39 INFO - Running post-action listener: _resource_record_post_action 12:07:39 INFO - [mozharness: 2017-05-31 19:07:39.235436Z] Finished read-buildbot-config step (success) 12:07:39 INFO - [mozharness: 2017-05-31 19:07:39.235662Z] Running download-and-extract step. 12:07:39 INFO - Running pre-action listener: _resource_record_pre_action 12:07:39 INFO - Running main action method: download_and_extract 12:07:39 INFO - mkdir: /builds/slave/test/build/tests 12:07:39 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')]} 12:07:39 INFO - trying https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.test_packages.json 12:07:39 INFO - Downloading https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:07:39 INFO - Downloaded 986 bytes. 12:07:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:07:39 INFO - Using the following test package requirements: 12:07:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:07:39 INFO - u'common': [u'target.common.tests.zip'], 12:07:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:07:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:07:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:07:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:07:39 INFO - u'mozbase': [u'target.common.tests.zip'], 12:07:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:07:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:07:39 INFO - u'web-platform': [u'target.common.tests.zip', 12:07:39 INFO - u'target.web-platform.tests.zip'], 12:07:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:07:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:07:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip 12:07:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:07:39 INFO - Fetch https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip into memory 12:07:40 INFO - Content-Length response header: 63529215 12:07:40 INFO - Bytes received: 63529215 12:07:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:07:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip 12:07:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:07:51 INFO - Fetch https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.common.tests.zip into memory 12:07:52 INFO - Content-Length response header: 63529215 12:07:52 INFO - Bytes received: 63529215 12:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.talos.tests.zip 12:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.talos.tests.zip into memory 12:08:07 INFO - Content-Length response header: 14447425 12:08:07 INFO - Bytes received: 14447425 12:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:08 INFO - trying https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 12:08:08 INFO - Downloading https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:08:09 INFO - Downloaded 54202783 bytes. 12:08:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 12:08:09 INFO - mkdir: /builds/slave/test/properties 12:08:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:08:09 INFO - Writing to file /builds/slave/test/properties/build_url 12:08:09 INFO - Contents: 12:08:09 INFO - build_url:https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 12:08:09 INFO - Running post-action listener: _resource_record_post_action 12:08:09 INFO - Running post-action listener: set_extra_try_arguments 12:08:09 INFO - [mozharness: 2017-05-31 19:08:09.242460Z] Finished download-and-extract step (success) 12:08:09 INFO - [mozharness: 2017-05-31 19:08:09.242557Z] Running populate-webroot step. 12:08:09 INFO - Running pre-action listener: _resource_record_pre_action 12:08:09 INFO - Running main action method: populate_webroot 12:08:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:08:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:08:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:08:09 INFO - '--tppagecycles', 12:08:09 INFO - '7'], 12:08:09 INFO - 'tests': ['tsvgm']}}, 12:08:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:08:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:08:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:08:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['damp', 'tps']}, 12:08:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'tests': ['damp', 'tps']}, 12:08:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['dromaeo_dom']}, 12:08:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:08:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:08:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:08:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:08:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'other-e10s': {'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['a11yr', 12:08:09 INFO - 'ts_paint', 12:08:09 INFO - 'tpaint', 12:08:09 INFO - 'sessionrestore', 12:08:09 INFO - 'sessionrestore_no_auto_restore', 12:08:09 INFO - 'tabpaint']}, 12:08:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:08:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:08:09 INFO - 'bloom_basic_ref']}, 12:08:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 12:08:09 INFO - 'talos_options': ['--mitmproxy', 12:08:09 INFO - 'mitmproxy-recording-1.mp', 12:08:09 INFO - '--firstNonBlankPaint'], 12:08:09 INFO - 'tests': ['Quantum_1']}, 12:08:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['tsvgx', 12:08:09 INFO - 'tsvgr_opacity', 12:08:09 INFO - 'tart', 12:08:09 INFO - 'tscrollx', 12:08:09 INFO - 'cart', 12:08:09 INFO - 'tsvg_static']}, 12:08:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:08:09 INFO - 'tsvgr_opacity', 12:08:09 INFO - 'tart', 12:08:09 INFO - 'tscrollx', 12:08:09 INFO - 'cart', 12:08:09 INFO - 'tsvg_static']}, 12:08:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'talos_options': ['--disable-e10s'], 12:08:09 INFO - 'tests': ['tp5o']}, 12:08:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:08:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'talos_options': ['--disable-e10s', 12:08:09 INFO - '--xperf_path', 12:08:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:09 INFO - 'tests': ['tp5n']}, 12:08:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:08:09 INFO - 'talos_options': ['--xperf_path', 12:08:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:09 INFO - 'tests': ['tp5n']}}, 12:08:09 INFO - 'talos.zip': {'path': '', 12:08:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:08:09 INFO - Running post-action listener: _resource_record_post_action 12:08:09 INFO - [mozharness: 2017-05-31 19:08:09.257023Z] Finished populate-webroot step (success) 12:08:09 INFO - [mozharness: 2017-05-31 19:08:09.257118Z] Running create-virtualenv step. 12:08:09 INFO - Running pre-action listener: _resource_record_pre_action 12:08:09 INFO - Running main action method: create_virtualenv 12:08:09 INFO - Creating virtualenv /builds/slave/test/build/venv 12:08:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:08:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:08:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:08:09 INFO - Using real prefix '/usr' 12:08:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:08:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:08:11 INFO - Installing pip.................done. 12:08:11 INFO - Return code: 0 12:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:08:12 INFO - Reading from file tmpfile_stdout 12:08:12 INFO - Output received: 12:08:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:08:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:08:12 INFO - Using env: {'DISPLAY': ':0', 12:08:12 INFO - 'HOME': '/home/cltbld', 12:08:12 INFO - 'LANG': 'en_US.UTF-8', 12:08:12 INFO - 'LANGUAGE': 'en_US:en', 12:08:12 INFO - 'LOGNAME': 'cltbld', 12:08:12 INFO - 'MAIL': '/var/mail/cltbld', 12:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:12 INFO - 'MOZ_NO_REMOTE': '1', 12:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:12 INFO - 'NO_EM_RESTART': '1', 12:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:12 INFO - 'PWD': '/builds/slave/test', 12:08:12 INFO - 'SHELL': '/bin/bash', 12:08:12 INFO - 'SHLVL': '1', 12:08:12 INFO - 'TERM': 'linux', 12:08:12 INFO - 'TMOUT': '86400', 12:08:12 INFO - 'USER': 'cltbld', 12:08:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:12 INFO - '_': '/tools/buildbot/bin/python'} 12:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:08:12 INFO - Cleaning up... 12:08:12 INFO - Return code: 0 12:08:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:08:12 INFO - Using env: {'DISPLAY': ':0', 12:08:12 INFO - 'HOME': '/home/cltbld', 12:08:12 INFO - 'LANG': 'en_US.UTF-8', 12:08:12 INFO - 'LANGUAGE': 'en_US:en', 12:08:12 INFO - 'LOGNAME': 'cltbld', 12:08:12 INFO - 'MAIL': '/var/mail/cltbld', 12:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:12 INFO - 'MOZ_NO_REMOTE': '1', 12:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:12 INFO - 'NO_EM_RESTART': '1', 12:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:12 INFO - 'PWD': '/builds/slave/test', 12:08:12 INFO - 'SHELL': '/bin/bash', 12:08:12 INFO - 'SHLVL': '1', 12:08:12 INFO - 'TERM': 'linux', 12:08:12 INFO - 'TMOUT': '86400', 12:08:12 INFO - 'USER': 'cltbld', 12:08:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:12 INFO - '_': '/tools/buildbot/bin/python'} 12:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:12 INFO - Downloading/unpacking psutil>=3.1.1 12:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:08:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:13 INFO - Installing collected packages: psutil 12:08:13 INFO - Running setup.py install for psutil 12:08:13 INFO - building 'psutil._psutil_linux' extension 12:08:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:08:13 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 12:08:13 INFO - building 'psutil._psutil_posix' extension 12:08:13 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 12:08:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:08:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:14 INFO - Successfully installed psutil 12:08:14 INFO - Cleaning up... 12:08:14 INFO - Return code: 0 12:08:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08: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')]} 12:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:08:14 INFO - Using env: {'DISPLAY': ':0', 12:08:14 INFO - 'HOME': '/home/cltbld', 12:08:14 INFO - 'LANG': 'en_US.UTF-8', 12:08:14 INFO - 'LANGUAGE': 'en_US:en', 12:08:14 INFO - 'LOGNAME': 'cltbld', 12:08:14 INFO - 'MAIL': '/var/mail/cltbld', 12:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:14 INFO - 'MOZ_NO_REMOTE': '1', 12:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:14 INFO - 'NO_EM_RESTART': '1', 12:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:14 INFO - 'PWD': '/builds/slave/test', 12:08:14 INFO - 'SHELL': '/bin/bash', 12:08:14 INFO - 'SHLVL': '1', 12:08:14 INFO - 'TERM': 'linux', 12:08:14 INFO - 'TMOUT': '86400', 12:08:14 INFO - 'USER': 'cltbld', 12:08:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:14 INFO - '_': '/tools/buildbot/bin/python'} 12:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:08:15 INFO - Installing collected packages: mozsystemmonitor 12:08:15 INFO - Running setup.py install for mozsystemmonitor 12:08:15 INFO - Successfully installed mozsystemmonitor 12:08:15 INFO - Cleaning up... 12:08:15 INFO - Return code: 0 12:08:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08: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')]} 12:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:08:15 INFO - Using env: {'DISPLAY': ':0', 12:08:15 INFO - 'HOME': '/home/cltbld', 12:08:15 INFO - 'LANG': 'en_US.UTF-8', 12:08:15 INFO - 'LANGUAGE': 'en_US:en', 12:08:15 INFO - 'LOGNAME': 'cltbld', 12:08:15 INFO - 'MAIL': '/var/mail/cltbld', 12:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:15 INFO - 'MOZ_NO_REMOTE': '1', 12:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:15 INFO - 'NO_EM_RESTART': '1', 12:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:15 INFO - 'PWD': '/builds/slave/test', 12:08:15 INFO - 'SHELL': '/bin/bash', 12:08:15 INFO - 'SHLVL': '1', 12:08:15 INFO - 'TERM': 'linux', 12:08:15 INFO - 'TMOUT': '86400', 12:08:15 INFO - 'USER': 'cltbld', 12:08:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:15 INFO - '_': '/tools/buildbot/bin/python'} 12:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:08: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 12:08: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 12:08: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 12:08: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 12:08:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:08:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:08:17 INFO - warning: no files found matching '*.txt' 12:08:17 INFO - no previously-included directories found matching 'build' 12:08:17 INFO - no previously-included directories found matching 'dist' 12:08:17 INFO - no previously-included directories found matching '.git*' 12:08:17 INFO - Installing collected packages: jsonschema, functools32 12:08:17 INFO - Running setup.py install for functools32 12:08:17 INFO - warning: no files found matching '*.txt' 12:08:17 INFO - no previously-included directories found matching 'build' 12:08:17 INFO - no previously-included directories found matching 'dist' 12:08:17 INFO - no previously-included directories found matching '.git*' 12:08:17 INFO - Successfully installed jsonschema functools32 12:08:17 INFO - Cleaning up... 12:08:17 INFO - Return code: 0 12:08:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:08:17 INFO - Using env: {'DISPLAY': ':0', 12:08:17 INFO - 'HOME': '/home/cltbld', 12:08:17 INFO - 'LANG': 'en_US.UTF-8', 12:08:17 INFO - 'LANGUAGE': 'en_US:en', 12:08:17 INFO - 'LOGNAME': 'cltbld', 12:08:17 INFO - 'MAIL': '/var/mail/cltbld', 12:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:17 INFO - 'MOZ_NO_REMOTE': '1', 12:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:17 INFO - 'NO_EM_RESTART': '1', 12:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:17 INFO - 'PWD': '/builds/slave/test', 12:08:17 INFO - 'SHELL': '/bin/bash', 12:08:17 INFO - 'SHLVL': '1', 12:08:17 INFO - 'TERM': 'linux', 12:08:17 INFO - 'TMOUT': '86400', 12:08:17 INFO - 'USER': 'cltbld', 12:08:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:17 INFO - '_': '/tools/buildbot/bin/python'} 12:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:08:17 INFO - Cleaning up... 12:08:17 INFO - Return code: 0 12:08:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:08:17 INFO - Using env: {'DISPLAY': ':0', 12:08:17 INFO - 'HOME': '/home/cltbld', 12:08:17 INFO - 'LANG': 'en_US.UTF-8', 12:08:17 INFO - 'LANGUAGE': 'en_US:en', 12:08:17 INFO - 'LOGNAME': 'cltbld', 12:08:17 INFO - 'MAIL': '/var/mail/cltbld', 12:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:17 INFO - 'MOZ_NO_REMOTE': '1', 12:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:17 INFO - 'NO_EM_RESTART': '1', 12:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:17 INFO - 'PWD': '/builds/slave/test', 12:08:17 INFO - 'SHELL': '/bin/bash', 12:08:17 INFO - 'SHLVL': '1', 12:08:17 INFO - 'TERM': 'linux', 12:08:17 INFO - 'TMOUT': '86400', 12:08:17 INFO - 'USER': 'cltbld', 12:08:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:17 INFO - '_': '/tools/buildbot/bin/python'} 12:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:17 INFO - Downloading/unpacking blobuploader==1.2.4 12:08: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 12:08: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 12:08: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 12:08: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 12:08:18 INFO - Downloading blobuploader-1.2.4.tar.gz 12:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:08:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:08: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 12:08: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 12:08: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 12:08: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 12:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:08:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:08: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 12:08: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 12:08: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 12:08: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 12:08:19 INFO - Downloading docopt-0.6.1.tar.gz 12:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:08:19 INFO - Installing collected packages: blobuploader, requests, docopt 12:08:19 INFO - Running setup.py install for blobuploader 12:08:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:08:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:08:19 INFO - Running setup.py install for requests 12:08:19 INFO - Running setup.py install for docopt 12:08:19 INFO - Successfully installed blobuploader requests docopt 12:08:19 INFO - Cleaning up... 12:08:19 INFO - Return code: 0 12:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:08:20 INFO - Using env: {'DISPLAY': ':0', 12:08:20 INFO - 'HOME': '/home/cltbld', 12:08:20 INFO - 'LANG': 'en_US.UTF-8', 12:08:20 INFO - 'LANGUAGE': 'en_US:en', 12:08:20 INFO - 'LOGNAME': 'cltbld', 12:08:20 INFO - 'MAIL': '/var/mail/cltbld', 12:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:20 INFO - 'MOZ_NO_REMOTE': '1', 12:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:20 INFO - 'NO_EM_RESTART': '1', 12:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:20 INFO - 'PWD': '/builds/slave/test', 12:08:20 INFO - 'SHELL': '/bin/bash', 12:08:20 INFO - 'SHLVL': '1', 12:08:20 INFO - 'TERM': 'linux', 12:08:20 INFO - 'TMOUT': '86400', 12:08:20 INFO - 'USER': 'cltbld', 12:08:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:20 INFO - '_': '/tools/buildbot/bin/python'} 12:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:20 INFO - Running setup.py (path:/tmp/pip-8k1mrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:20 INFO - Running setup.py (path:/tmp/pip-HfYj4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:20 INFO - Running setup.py (path:/tmp/pip-G55NCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:20 INFO - Running setup.py (path:/tmp/pip-19G0ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:20 INFO - Running setup.py (path:/tmp/pip-dXzYBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:20 INFO - Running setup.py (path:/tmp/pip-sLYJzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:20 INFO - Running setup.py (path:/tmp/pip-zzmCtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:20 INFO - Running setup.py (path:/tmp/pip-hMJTNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:20 INFO - Running setup.py (path:/tmp/pip-JwDE_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:20 INFO - Running setup.py (path:/tmp/pip-gDRff3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:20 INFO - Running setup.py (path:/tmp/pip-u0Efj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:21 INFO - Running setup.py (path:/tmp/pip-X1RRal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:21 INFO - Running setup.py (path:/tmp/pip-FuE_mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:21 INFO - Running setup.py (path:/tmp/pip-0chKwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:21 INFO - Running setup.py (path:/tmp/pip-mjAzWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:21 INFO - Running setup.py (path:/tmp/pip-CreMyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:21 INFO - Running setup.py (path:/tmp/pip-Z1nCkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:08:21 INFO - Running setup.py install for manifestparser 12:08:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:08:21 INFO - Running setup.py install for mozcrash 12:08:21 INFO - Running setup.py install for mozdebug 12:08:21 INFO - Running setup.py install for mozdevice 12:08:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:08:21 INFO - Running setup.py install for mozfile 12:08:21 INFO - Running setup.py install for mozhttpd 12:08:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozinfo 12:08:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozInstall 12:08:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozleak 12:08:22 INFO - Running setup.py install for mozlog 12:08:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for moznetwork 12:08:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozprocess 12:08:22 INFO - Running setup.py install for mozprofile 12:08:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozrunner 12:08:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:08:22 INFO - Running setup.py install for mozscreenshot 12:08:23 INFO - Running setup.py install for moztest 12:08:23 INFO - Running setup.py install for mozversion 12:08:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:08:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:08:23 INFO - Cleaning up... 12:08:23 INFO - Return code: 0 12:08:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:08:23 INFO - Using env: {'DISPLAY': ':0', 12:08:23 INFO - 'HOME': '/home/cltbld', 12:08:23 INFO - 'LANG': 'en_US.UTF-8', 12:08:23 INFO - 'LANGUAGE': 'en_US:en', 12:08:23 INFO - 'LOGNAME': 'cltbld', 12:08:23 INFO - 'MAIL': '/var/mail/cltbld', 12:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:23 INFO - 'MOZ_NO_REMOTE': '1', 12:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:23 INFO - 'NO_EM_RESTART': '1', 12:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:23 INFO - 'PWD': '/builds/slave/test', 12:08:23 INFO - 'SHELL': '/bin/bash', 12:08:23 INFO - 'SHLVL': '1', 12:08:23 INFO - 'TERM': 'linux', 12:08:23 INFO - 'TMOUT': '86400', 12:08:23 INFO - 'USER': 'cltbld', 12:08:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:23 INFO - '_': '/tools/buildbot/bin/python'} 12:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:23 INFO - Running setup.py (path:/tmp/pip-rgouYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:23 INFO - Running setup.py (path:/tmp/pip-Dg6uZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:23 INFO - Running setup.py (path:/tmp/pip-H44f4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:23 INFO - Running setup.py (path:/tmp/pip-zB_mMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:23 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)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:23 INFO - Running setup.py (path:/tmp/pip-lo7MKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:23 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)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:23 INFO - Running setup.py (path:/tmp/pip-5c4825-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:23 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)) 12:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:23 INFO - Running setup.py (path:/tmp/pip-YcFR1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:24 INFO - Running setup.py (path:/tmp/pip-W2KbYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:24 INFO - Running setup.py (path:/tmp/pip-rSDFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:24 INFO - Running setup.py (path:/tmp/pip-2XdXp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:24 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)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:24 INFO - Running setup.py (path:/tmp/pip-P0QD1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:24 INFO - Running setup.py (path:/tmp/pip-63Ulln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:24 INFO - Running setup.py (path:/tmp/pip-yZG27z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:24 INFO - Running setup.py (path:/tmp/pip-D1Ij_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:24 INFO - Running setup.py (path:/tmp/pip-4TppQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:24 INFO - Running setup.py (path:/tmp/pip-z0Lb5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:24 INFO - Running setup.py (path:/tmp/pip-ILH8yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:08:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:25 INFO - Downloading blessings-1.6.tar.gz 12:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:08:25 INFO - Installing collected packages: blessings 12:08:25 INFO - Running setup.py install for blessings 12:08:26 INFO - Successfully installed blessings 12:08:26 INFO - Cleaning up... 12:08:26 INFO - Return code: 0 12:08:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:26 INFO - Reading from file tmpfile_stdout 12:08:26 INFO - Current package versions: 12:08:26 INFO - argparse == 1.2.1 12:08:26 INFO - blessings == 1.6 12:08:26 INFO - blobuploader == 1.2.4 12:08:26 INFO - docopt == 0.6.1 12:08:26 INFO - functools32 == 3.2.3-2 12:08:26 INFO - jsonschema == 2.5.1 12:08:26 INFO - manifestparser == 1.1 12:08:26 INFO - mozInstall == 1.12 12:08:26 INFO - mozcrash == 1.0 12:08:26 INFO - mozdebug == 0.1 12:08:26 INFO - mozdevice == 0.51 12:08:26 INFO - mozfile == 1.2 12:08:26 INFO - mozhttpd == 0.7 12:08:26 INFO - mozinfo == 0.9 12:08:26 INFO - mozleak == 0.1 12:08:26 INFO - mozlog == 3.4 12:08:26 INFO - moznetwork == 0.27 12:08:26 INFO - mozprocess == 0.25 12:08:26 INFO - mozprofile == 0.28 12:08:26 INFO - mozrunner == 6.13 12:08:26 INFO - mozscreenshot == 0.1 12:08:26 INFO - mozsystemmonitor == 0.3 12:08:26 INFO - moztest == 0.8 12:08:26 INFO - mozversion == 1.4 12:08:26 INFO - psutil == 3.1.1 12:08:26 INFO - requests == 1.2.3 12:08:26 INFO - wsgiref == 0.1.2 12:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08: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')]} 12:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:08:26 INFO - Using env: {'DISPLAY': ':0', 12:08:26 INFO - 'HOME': '/home/cltbld', 12:08:26 INFO - 'LANG': 'en_US.UTF-8', 12:08:26 INFO - 'LANGUAGE': 'en_US:en', 12:08:26 INFO - 'LOGNAME': 'cltbld', 12:08:26 INFO - 'MAIL': '/var/mail/cltbld', 12:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:26 INFO - 'MOZ_NO_REMOTE': '1', 12:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:26 INFO - 'NO_EM_RESTART': '1', 12:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:26 INFO - 'PWD': '/builds/slave/test', 12:08:26 INFO - 'SHELL': '/bin/bash', 12:08:26 INFO - 'SHLVL': '1', 12:08:26 INFO - 'TERM': 'linux', 12:08:26 INFO - 'TMOUT': '86400', 12:08:26 INFO - 'USER': 'cltbld', 12:08:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:26 INFO - '_': '/tools/buildbot/bin/python'} 12:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:08:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 12:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 12:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:08:27 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)) 12:08:27 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)) 12:08:27 INFO - Installing collected packages: marionette-driver 12:08:27 INFO - Running setup.py install for marionette-driver 12:08:27 INFO - Successfully installed marionette-driver 12:08:27 INFO - Cleaning up... 12:08:27 INFO - Return code: 0 12:08:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:08:27 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')]} 12:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:27 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')]} 12:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:27 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 0x232d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26abdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, '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': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', '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 12:08:27 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 12:08:27 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 12:08:27 INFO - Using env: {'DISPLAY': ':0', 12:08:27 INFO - 'HOME': '/home/cltbld', 12:08:27 INFO - 'LANG': 'en_US.UTF-8', 12:08:27 INFO - 'LANGUAGE': 'en_US:en', 12:08:27 INFO - 'LOGNAME': 'cltbld', 12:08:27 INFO - 'MAIL': '/var/mail/cltbld', 12:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:27 INFO - 'MOZ_NO_REMOTE': '1', 12:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:27 INFO - 'NO_EM_RESTART': '1', 12:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:27 INFO - 'PWD': '/builds/slave/test', 12:08:27 INFO - 'SHELL': '/bin/bash', 12:08:27 INFO - 'SHLVL': '1', 12:08:27 INFO - 'TERM': 'linux', 12:08:27 INFO - 'TMOUT': '86400', 12:08:27 INFO - 'USER': 'cltbld', 12:08:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:27 INFO - '_': '/tools/buildbot/bin/python'} 12:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:08:28 INFO - Cleaning up... 12:08:28 INFO - Return code: 0 12:08:28 INFO - Running post-action listener: _resource_record_post_action 12:08:28 INFO - Running post-action listener: _start_resource_monitoring 12:08:28 INFO - Starting resource monitoring. 12:08:28 INFO - [mozharness: 2017-05-31 19:08:28.076133Z] Finished create-virtualenv step (success) 12:08:28 INFO - [mozharness: 2017-05-31 19:08:28.076603Z] Running install step. 12:08:28 INFO - Running pre-action listener: _resource_record_pre_action 12:08:28 INFO - Running main action method: install 12:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:28 INFO - Reading from file tmpfile_stdout 12:08:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:08:28 INFO - Reading from file tmpfile_stdout 12:08:28 INFO - Output received: 12:08:28 INFO - Usage: mozinstall [options] installer 12:08:28 INFO - Options: 12:08:28 INFO - -h, --help show this help message and exit 12:08:28 INFO - -d DEST, --destination=DEST 12:08:28 INFO - Directory to install application into. [default: 12:08:28 INFO - "/builds/slave/test"] 12:08:28 INFO - --app=APP Application being installed. [default: firefox] 12:08:28 INFO - mkdir: /builds/slave/test/build/application 12:08:28 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'] 12:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:08:43 INFO - Reading from file tmpfile_stdout 12:08:43 INFO - Output received: 12:08:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:08:43 INFO - Running post-action listener: _resource_record_post_action 12:08:43 INFO - [mozharness: 2017-05-31 19:08:43.937317Z] Finished install step (success) 12:08:43 INFO - [mozharness: 2017-05-31 19:08:43.937468Z] Running setup-mitmproxy step. 12:08:43 INFO - Running pre-action listener: _resource_record_pre_action 12:08:43 INFO - Running main action method: setup_mitmproxy 12:08:43 INFO - Skipping: mitmproxy is not required 12:08:43 INFO - Running post-action listener: _resource_record_post_action 12:08:43 INFO - [mozharness: 2017-05-31 19:08:43.938449Z] Finished setup-mitmproxy step (success) 12:08:43 INFO - [mozharness: 2017-05-31 19:08:43.938669Z] Running run-tests step. 12:08:43 INFO - Running pre-action listener: _resource_record_pre_action 12:08:43 INFO - Running main action method: run_tests 12:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:08:43 INFO - Python 2.7.3 12:08:43 INFO - Return code: 0 12:08:43 INFO - grabbing minidump binary from tooltool 12:08: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')]} 12:08:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8840>, '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 0x26a9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a9bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:08:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:08:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:08:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:08:44 INFO - Return code: 0 12:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:08:44 INFO - ENV: RUST_BACKTRACE is now 1 12:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 12:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 12:08:44 INFO - Using env: {'DISPLAY': ':0', 12:08:44 INFO - 'HOME': '/home/cltbld', 12:08:44 INFO - 'LANG': 'en_US.UTF-8', 12:08:44 INFO - 'LANGUAGE': 'en_US:en', 12:08:44 INFO - 'LOGNAME': 'cltbld', 12:08:44 INFO - 'MAIL': '/var/mail/cltbld', 12:08:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:08:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:44 INFO - 'MOZ_NO_REMOTE': '1', 12:08:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:44 INFO - 'NO_EM_RESTART': '1', 12:08:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:44 INFO - 'PWD': '/builds/slave/test', 12:08:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:08:44 INFO - 'RUST_BACKTRACE': '1', 12:08:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:08:44 INFO - 'SHELL': '/bin/bash', 12:08:44 INFO - 'SHLVL': '1', 12:08:44 INFO - 'TERM': 'linux', 12:08:44 INFO - 'TMOUT': '86400', 12:08:44 INFO - 'USER': 'cltbld', 12:08:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1496257353.305364-495468115', 12:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:44 INFO - '_': '/tools/buildbot/bin/python'} 12:08:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 12:08:44 INFO - mozversion application_buildid: 20170531183305 12:08:44 INFO - mozversion application_changeset: 94906c37940c6b1c371dc7c22ed2098face96d8b 12:08:44 INFO - mozversion application_display_name: Nightly 12:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:08:44 INFO - mozversion application_name: Firefox 12:08:44 INFO - mozversion application_remotingname: firefox 12:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:08:44 INFO - mozversion application_vendor: Mozilla 12:08:44 INFO - mozversion application_version: 55.0a1 12:08:44 INFO - mozversion platform_buildid: 20170531183305 12:08:44 INFO - mozversion platform_changeset: 94906c37940c6b1c371dc7c22ed2098face96d8b 12:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:08:44 INFO - mozversion platform_version: 55.0a1 12:08:44 INFO - using testdate: 1496257724 12:08:44 INFO - actual date: 1496257724 12:08:44 INFO - starting webserver on 'localhost:41065' 12:08:44 INFO - SUITE-START | Running 2 tests 12:08:44 INFO - TEST-START | dromaeo_css 12:08:44 INFO - operating with platform_type : linux_ 12:08:44 INFO - Initialising browser for dromaeo_css test... 12:08:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41065/getInfo.html -profile /tmp/tmpqjPFsf/profile 12:08:44 INFO - TEST-INFO | started process 4152 (/builds/slave/test/build/application/firefox/firefox http://localhost:41065/getInfo.html) 12:09:19 INFO - TEST-INFO | 4152: killed by SIGTERM 12:09:19 INFO - Browser initialized. 12:09:19 INFO - Running cycle 1/1 for dromaeo_css test... 12:09:19 INFO - TEST-INFO | started process 4359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjPFsf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:31 INFO - PID 4359 | RSS: Main: 184307712 12:09:31 INFO - PID 4359 | 12:12:35 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41065/tests/dromaeo/cssquery-ext.html) 12:12:37 INFO - PID 4359 | RSS: Main: 179044352 12:12:37 INFO - PID 4359 | 12:15:39 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-ext.html (next: http://localhost:41065/tests/dromaeo/cssquery-jquery.html) 12:15:40 INFO - PID 4359 | RSS: Main: 184037376 12:15:40 INFO - PID 4359 | 12:18:41 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41065/tests/dromaeo/cssquery-mootools.html) 12:18:42 INFO - PID 4359 | RSS: Main: 180371456 12:18:42 INFO - PID 4359 | 12:21:44 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41065/tests/dromaeo/cssquery-prototype.html) 12:21:44 INFO - PID 4359 | RSS: Main: 184356864 12:21:44 INFO - PID 4359 | 12:24:47 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41065/tests/dromaeo/cssquery-yui.html) 12:24:48 INFO - PID 4359 | RSS: Main: 183050240 12:24:48 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:41065/tests/dromaeo/cssquery-yui.html (next: http://localhost:41065/tests/dromaeo/cssquery-dojo.html) 12:27:50 INFO - PID 4359 | RSS: Main: 181788672 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | __start_tp_report 12:27:50 INFO - PID 4359 | _x_x_mozilla_page_load 12:27:50 INFO - PID 4359 | _x_x_mozilla_page_load_details 12:27:50 INFO - PID 4359 | |i|pagename|runs| 12:27:50 INFO - PID 4359 | |0;dojo.html;2751.972480275197;2765.5022096022735;2784.7076057014015;2789.958150627741;2800.915972520825;5299.019681358946;5311.62818602697;5328.733563321833;5339.305890234265;5350.143976963686;5294.100002999489;5305.336832895888;5345.1714984177415;5404.054290499157;5411.783528658859;4483.125790470859;4672.906541869161;4740.525947405266;4763.26169443735;4788.760561971905;4793.945332026949;4835.05716385305;4847.854564363075;4867.318575399447;4869.561739443449;4665.370175026362;4708.835190768306;4739.502352252998;4743.881402964954;4764.404449443819;4805.3753012108555;4808.615310775164;4820.542048505386;4850.490698476679;4872.074305881871;4748.5251474852585;4754.66717329787;4776.8566942991765;4801.927971080437;4823.397075365579;5299.231611416323;5385.5960802939935;5406.729663516848;5408.756605952742;5485.451454854522;5711;5798.971005144989;5816.447437493432;5829.825105246807;5837.970810145965;5824.30108386992;5831.88336233273;5836.766529338822;5837.09525023622;5851.531877449794;5379.757910894019;5398.703071331114;5405.324334458192;5406.08096623575;5412;5876.294844618673;5886.735096920649;5966.373530779292;5975.671338076448;5994.220751302303;5693.146028095736;5699.116636921284;5709.200711900337;5727.4845263926445;5754.251947246915;5595.104783234663;5787.768489260467;5794.420557944256;5795.246617939725;5803.767849285981;5585;5685.431456854281;5773.5958482906635;5780.393058728857;5790.276215473066;5646.774129034792;5699.5155411790465;5709.800156994568;5811.389804070512;5820.126980952807;4814.20565606671;4818.7108773473;4826.251930950708;4834.8791280218275;4865.537773911473;4092.856750013735;4134.855280065183;4137.710360274752;4140.91718165635;4208;4764.094821983812;4809.78355973982;4823.03539292143;4871.464138944713;4872.9512704873205;5772.855678607984;5832.9708351457975;5834.591578589543;5838.5037271831525;5863.237779088691;4859.538343857328;4872.610191184696;4872.634552408584;4873.926891096637;4913.361263035854;5119.846404607868;5125.205593133071;5136.43499215086;5138.3577052868395;5140.023395554907;5220.686758794484;5296.073187192149;5301.443348448357;5320.388155362183;5409.215663728816;5630.493255607015;5704.885902282014;5716.456936591017;5831.591788574929;5876.265466816648;5237.659552129099;5238.004779091961;5329.333833270841;5353.116735738559;5365.892682146413;5657.60396772222;5690.5163061140265;5705.343885453226;5706.971465142814;5708.828735137952;5656.660600363992;5810.68041257718;5814.331351894586;5821.446962538552;5823.301203855564;5570.3315602128005;5583.246261754611;5595.720213989365;5628.4090170533145;5656.660600363992;5590.664560126405;5606.411326810626;5608.327000759935;5616.606837521498;5662.462066103713;5492.423295554069;5501.724913754216;5512.118061110203;5532.612717109763;5542.418046105262;5483.75323110469;5567.359753628384;5606.327240730975;5638.097904335286;5638.323401191883;5494.423085576117;5496.1755736639825;5522.723863806874;5530.170474428707;5546.36216835053 12:27:50 INFO - PID 4359 | |1;ext.html;707.3386383731212;764.6826566974706;786.5202226641748;1106.9557217711297;1113.0817075912373;33389.83305083477;34472.82763586182;34479.4828077579;34494.482582761244;34583.504144461185;35919.82040089796;36406;36579.4513082304;36579.81710091446;36680.81659591705;6637.535372523926;6891.035255064307;6938.09804725385;7035.542689725177;7046.4010559102535;6884.655767211644;6977.33715297046;6990.720371185172;6991.825204369906;7005.754798582051;6966.442684585247;6998.895016574756;7026;7028.718851245944;7039.612821294827;6937.514373993822;6954.339337762955;6955.8956615650295;6968.989496522976;6969.128858892638;6826.283240259801;6873.793786186422;6888.070110535064;6890.379865812101;6892.414144797698;33688.32623347544;33943.4908476373;33995.83002084974;33997.47011384494;34004.31991360184;3018.894338698135;3051.465993451159;3052.664206937235;3053.618297712786;3054.144839444959;25945.091921782834;25977.74022259791;25980.74019259802;26005.73994260071;26007.739922600722;3036.149878034154;3055.7013269360655;3074.6925307469296;3088.90733278002;3126.9687303126907;125861.37069314686;128580;142700.99999999895;150931;151345;41149;41397.793011035355;41423.7928810354;41457.378139327935;41548.584514155074;43315;43324.783376082916;43407.13185736268;43425.565744342784;43486.565134348886;13013.934930325477;13141.802872956914;13150.868491315156;13166.275854827885;13174.802377964339;10642;10660.573577056832;10667.359958402521;10672.146228301717;10673.946630266953;13200.537981170804;13206.669833254246;13227.73544529104;13232.73534529304;13346.933265333806;5246.921296180561;5398.784048638089;5400.351957765093;5524;5546.084895992116;864.5547543015352;890.9064548222473;900.3292547052488;923.3121324613072;939.1547607153616;21332.253371131937;21779.67330490044;22022.128119109733;22109.11563537473;22159.667604985938;996.277698668474;999.3154689038032;1011;1014.7666036811574;1019.1184625299211;10967.780644387067;11728.296302221894;11729.765404691858;11767.705807354885;11779.823302650468;175470;177138;177475;177494;177684;42096;42395.7880210597;42402.36396454056;42419.363709544385;42471.150576988286;1189.8318046610132;1231.7967535356745;1235.740494496148;1241.993790031044;1246.1214843535286;20109.59780804405;20896.582068358242;21431.785682142978;21727.34817955464;21751.564968700855;31019.224519387197;31138.221544460663;31143.22141946379;31166.844165779024;31188;160987;162095;162208.18895905445;162854;162934;29158;30033;30162.69837301599;30632.234194145323;30772.538411924288;37501.43747843839;37800.243995120494;37932.43101353427;38105;38167.80916095402;27061.323466912698;27926.581101283904;28012.85993570019;28645.856770716848;29576.408471830873;27619.58570621402;28310.15069547917;28614;28816.855915720287;29567.852160739058;31655;31673.20816979594;31768.682313176574;31775.205619859687;31785.04644860658;27253.31866703269;27411.31471713223;27686.86156569204;27913.720862791113;29718.702812971595;20396.592068158257;22970.885145574164;23336.299911002698;23497;23557.764422356242 12:27:50 INFO - PID 4359 | |2;jquery.html;400.6894656641101;430.14589280050745;432;432.6322625768099;443.815816436179;13382.598522044329;13997.370118344674;18151.820131691446;18768.343107991222;18919.337823176174;18383.54041148972;19174.616507669838;19250.326238581652;19269.903650481727;19314.32399866005;5395.59533035022;5562.360328562207;5568.1091025435935;5575.832725018236;5601.80393686221;5496.1755736639425;5497.065498865182;5524.309461317335;5533.142362933751;5557.694326812024;5464.371597266326;5482.2873026506495;5498.560115190775;5499.587530935176;5569.860753481175;5264.710440925747;5440.91838622421;5456.645318054314;5471.480209380143;5485.040117979338;4938.777755000998;4946.5795407390415;4947.50524947506;4950.653454258203;4954.331165292675;22268.9978950946;22532;22607.434814129778;22675.773242267533;22709;1665.6835201311833;1700.6938751024811;1701.3789966662202;1701.574606348413;1710.2816816936916;14335.283235838166;14444.133351998913;14548.636284092876;14687.412503499847;15269.236538173047;2095.3609149209483;2099.8320134389364;2106.9367918962457;2133.0934352899953;2136.9252076177413;109922.45038774755;111888;111909;112106.43946780213;112726;10677.359358438363;10771.730706732395;10792.46037698112;10980.121590272758;11051.889481105247;15593.532194034196;15609.921950390402;15750.9212453937;15757.842421575866;15765;7343.88984165238;7449.627518624047;7449.925500745032;7636.350910172698;8010.118886922434;6735.663216839139;6778.423833974168;6803.149606299213;6808.8297792554595;6900.689468973908;6921.238663746984;7045.753398631024;7055.173545336546;7124.643767811589;7171.247019062923;2051.200031987526;2061.196133507933;2104.5475222827167;2153.1710291537556;2220.822334213259;816.3754727633366;841.3773807382615;844.1178967978477;873.9038705742363;892.4689809563299;17419.77734119192;17811.910940445214;17832.55418614519;18023.639527209645;18242.817571824377;871.333429926107;875.7153924974409;886.0474989386436;886.1802832380023;889.4174315823146;9247;9260.305477089245;9802.509874506246;9834.311598188058;9882.110610044987;347393;382398;383988;386567;390191.1471327932;88367;90319.54840225757;90512;90642.54678726564;91301;1039.428314427062;1057.0856209378985;1075.8386242063752;1083.6423980086552;1086.4676308608725;14850.331735071732;15263.618409539851;15476.613084672974;15676.137812420426;16004.679906401574;41258;42085;42273.15453690848;42460.363094554225;42682.146357072066;55528.167077494676;55583;56213.15680264881;56321.71839140778;56434.71782641225;9473.336866419284;9536.57085431171;9577.138057574852;9594.280428967715;9649.565769540528;12077.758444830879;12559.434825432694;15002.849971500145;15234.542963711106;15274;12285.631431057083;12945.158564693265;13118.097875807764;13133.671658208621;13215.339233038501;11680.94159529231;11805.82291265649;12210.938945305572;12252.019838413084;12593.496260149492;13334.666633334244;13487;13545.932270338586;13579.45682172702;13610.659733506742;9068.319876009195;9137.269018478639;9152;9160.862587061067;9229.169374756304;12039.157258992136;12395;12575.87424125747;12689.619311420673;12693.936530317289 12:27:50 INFO - PID 4359 | |3;mootools.html;1294.8575656677765;1351.6012776231012;1353.1272329347578;1359.5921223632913;1366.801813737008;10390.948045259773;10882.782344353109;10887.510062047197;10900.12798976082;11215.551377944872;10837.241393102486;11053.336799792018;11069.667909962694;11110.277831940919;11141.331520108799;2189.1681161158735;2218.5895609312247;2221.922232721855;2223.0552015393473;2235.2065016919005;2039.0620314655275;2075.844311676623;2084.5726626041624;2086.499240182353;2094.0576740466777;2018.3944816555047;2021.282444732121;2034.1863254698164;2050.538628808521;2055.9177632894666;2037.4498885300886;2039.3372154049846;2040;2047.7747447780732;2049.6822992436196;1848.0851978270707;1915.9042047897549;2040;2056.506438454775;2084.6247675418417;10879.184061195441;10947.50736216872;10954.835677464844;10961.780764384748;10987.945060274647;5528.281323427928;5747.712614369307;5749.913751293692;5751.1085781703905;5756.136579513065;3115.1589070950945;3219.388316219911;3286.819224942627;3306.6197387300285;3314.287428202948;1037.6057098302672;1062.4900047976937;1083.063150374928;1085.1698450685153;1088.2382332367295;15866.206689665585;15920.681586368324;16054.839451605569;16072.116033618146;16104;4647.209974304376;4783.856484305476;4827.61379089679;4899.559039686445;5033.974830125826;12067.698307542381;12073.094517911017;12080.516779328904;12081.939590301992;12119.939400302943;5580.386157522669;5671;5672.858178545569;5672.914906276409;5702.258706368146;5131.97434012835;5189.351331083614;5190.143626301618;5206.687598744087;5328.547073498796;3889.416587511839;3977.9204415911518;3998.8800335989968;4053.6083710610883;4080.714349995472;1134.4157758754247;1140.9657710268705;1155.9537618495335;1156.2311063142915;1158.09089864456;662.1458318768734;683.6445048574714;684.3088480634495;702.7154002628944;703.3458883238535;5133.563647089964;5285.68285902847;5320.17537281722;5422.5119739223655;5496.31296087989;504.43755212938044;516.8216466456486;517.5549027836058;519.3819354967577;519.4571672602065;3222.6132864056462;3245.9350812983607;3257.3485302939507;3270.689284517967;3341.4820702791108;13471.259080750457;13729.519466818614;13966.790498142536;14084.197924979926;14222.431102755774;13803.447862085604;13805.723885522233;13818.309084545732;13836.584902452943;13879.791803122962;7300.342969132804;7481.625918704043;7517;7531.736389226351;7532.887006694904;5471.644343117685;5651.491365777099;5740.942590574041;5831.533477321719;6015.909761353671;12480.188787728768;12634.747305054032;12762.29807360604;12806.935965320487;12845.807312890502;12921.806172907225;12938.61184164439;12977.675558110745;13059.281739504038;13091.803622945474;8494.745157645033;8579.313654907468;8586.91413085886;8588.484690918565;8598.011228708778;9936.304458687822;9992.350497217658;10063.094321511098;10083.14293285079;10179.338343007681;8253.917460825314;8263.876041859497;8317.708880189164;8325.209105135002;8423.957880210559;8540.188682075193;8547.444416112932;8564.443311185003;8567.700130495403;8602.956985215034;7585.089789225328;7639.809004774703;7661.387089032975;7666.348360389429;7666.884996725165;5005.099082165099;5082.847514574569;5092.159793634157;5092.8472145835685;5171.095058364846;5030.220315851049;5066.44269130388;5125.4362020177;5170.948290517197;5214.426413094632 12:27:50 INFO - PID 4359 | |4;prototype.html;375.2401387190937;378.2680513206945;379.7930128080196;386.3104358719684;388.469738806529;5574.944250557498;5588.441155884409;5619.775208991646;5620.747066382012;5645.209670646108;5386.380566234874;5433.945660543393;5454.4545545445435;5467.808626698066;5481.725913704318;4206.284931561627;4236.449261595996;4259.7231179973205;4261.78691065447;4277.786110694468;4255.085156691311;4260.659147268227;4270.786460676969;4274.337477690963;4291.806868690916;4221.219074471217;4231.370922194962;4237.2203674456805;4240.342746874239;4245.10852720929;4213.705040647156;4224.936920732475;4231.196072746184;4239.59723826236;4253.680973926967;3743.082944678571;3754.3242216401036;3769.038895081764;3775.263823554408;3776.603456637041;5499.450054994509;5500.28496295483;5503.944960550383;5508;5545.639533430314;5050.116229659795;5052.747362631853;5060.84817455477;5067.569256613156;5070.340855688773;5938.8218353449465;5953.166556682068;5958.970205148947;5963.373845746178;5979.910301345483;4238.512571054337;4248.745075295461;4250.747104034866;4269.359596060584;4280.379344994958;6001.459868611846;6198.3801619838105;6278.874422511524;6344.809655710336;6347.619142851444;4200.4038465382955;4245.724027938174;4282.935755963663;4288.978555107205;4312.310030395184;4382.627476664456;4398.868033958986;4404.317330813665;4406.1187762447635;4422.137683151755;4821.807127714852;4997.9500204997485;5006.173981293119;5013.24801279811;5019.222020586815;5873.823785286449;5890.970545147246;5899.46904778572;5901.144334071536;5909.704514774244;1500.3473489032306;1514.1142431677592;1518.0132913606244;1523.0633160606149;1526.5115163147686;1002.0830939690102;1019.8215312320315;1042.2183362478142;1042.7914417116608;1044.9634262800766;5125.436202017775;5134.409542902539;5139.58883289336;5144.485551444825;5148.176291793295;6114.908276375858;6138.232720909887;6140.894638965029;6145.231846019247;6204.627722336674;5089.923651145235;5091.1854103343285;5093;5104.1578139606545;5110.361204849394;3243.68630704565;3243.951340729891;3261.59230096238;3263.6246831614194;3263.7715359924578;5671.461211184931;5674.517665998354;5701.287339082614;5716.1997320375185;5722.341930677942;6310.873782524323;6353.459955903708;6358.427741503287;6365.458935990493;6379.234491861006;5682.232898558725;5706.144078388192;5713.74288157034;5717.828465146053;5739.770409183586;6113.694315284307;6145;6150.692465376803;6156.199694039746;6181.474574661204;6033.758649653964;6034.396560344106;6051.909221361595;6085.391460854056;6090.573659843769;5334.399680096033;5422.15956526739;5590.329160500603;5668.858278543069;5691.430856914441;4233.767142807175;4241.809118589609;4293.359583855969;4314.180305741899;4320.546342634104;6119.204503414528;6128.785492507741;6155.692215389302;6156.260464093435;6169.81490555284;5748.913766293425;5953.285605727167;5960.731767070405;5967.283925928917;5975.880482390415;5951.166836642787;5953.970230148821;5970.731317090655;5978.850528736816;5984.13230081627;5905.793297234576;5909.804039132092;5930.28836539618;5931.7627294907725;5933.258342707161;6020.819375418744;6035.668038257938;6043.40984589262;6058.818235452944;6061.272647282354;5858.443447872445;5874.5887787856145;5874.706264686663;5885.205497257986;5896.410358964069 12:27:50 INFO - PID 4359 | |5;yui.html;746.4513582516853;751.0574229342175;762.1349768013304;766.0692258905428;775.3022279948048;14314.498992535264;14564.635884102903;14575.708485830277;15752.212389380515;16687.415940442086;16289.266982985764;16471.258793354296;16473.505794826146;16555;16583.66832663346;865.9523726195057;872.1278721278721;895.6014573514789;902.7562558109306;917.0554329041065;877.3376101043704;926.2080920812709;927.5825878354734;929.3494553812325;930.7393929699662;964.609333220047;975.6000039983608;976.199516396555;979.0111986893218;980.6959842448828;971.00957023836;971.0192705367559;971.6259240192542;971.7182017214999;971.7182017214999;707.1302298173224;713.3936154268882;713.9428845692332;713.9857202855966;714.0253553898942;14647.780283295759;14707.926460367737;14924.403023879031;14990.62523436912;14993.17537535435;16447.342106315733;17013.91493042539;17077.231524581424;17080.914595427068;17085.48743537696;12267.447964841604;12893;12906.419211135522;12942.935285323512;12947.41736621845;3047.740942019931;3053.755699544053;3059.908202753921;3062.2344413896526;3066.6626671066388;86029;87700;87769.12230877737;88914.55542722245;90060.04069369324;12587.244765313928;12665;12679.492820287269;12844.165129266754;12921.160124591872;23794.286171414886;24160.637590436156;24272.757272427403;24364.87817560901;24380;6247.125402443661;6292.244930608356;6433.163688720437;6496.610203387811;6537.411632952962;3075.261937135116;3159.936801263962;3160.0361889623427;3169.6037995250595;3173.809571425722;3608.9458658120147;3698.2603479303707;3703.2778608171147;3704.833282502294;3705.4071348584635;726.785598248518;749.6589051981335;758.211460081509;760.3347071312602;761.7317166917131;598.064029793372;610.8350745298744;614.7540983606503;621.0745988477137;633.3065293503606;9744.415335079917;9798.363106398205;10089.611352429814;10577.682669519927;10874.510647020903;575.6689903305617;583.1340459417761;587.2424572301768;589.4635881347953;593.0274350065895;4417.558244175557;4421.42521472213;4475.239209334421;4561.384213131251;4585.128825523207;83955;84726.57636711777;84969;85041;86470;70307.29692703008;71121.64439177874;71334.64332678303;72179.63910180416;72446;66543.34196606191;67403.3259667397;67418.66290668515;67702;68085;8563.443376180529;8900.42147260426;8917;9128;9191.402558833923;29512;29643.258918526346;29793.70206297996;29862.701372985994;30098;37583.43624845684;37622.81188594149;37810.62189378181;37968.24063518769;38409.615903841725;13039.804402933774;13223.206607603575;13275.734485310433;13276.402561884544;13440.126391784503;14577.635559111108;14805.111693298437;14812.185329806964;14871.851281487046;14884.255787210812;13117.964756961122;13130.212187268795;13327.66680832987;13398.665033374244;13500.122492037986;13509.527166549124;13605.115667481581;13760.729479636148;13785.172889626654;13955.232462214675;12461.626151215478;12622.053345999271;12631.747365052832;12797;12823.679408014874;9035.864462032943;9101.499417531835;9270.351075424926;9305.069493050642;9468.715938521855;9796.559154837907;9950.154236889946;10019.398836069859;10055;10430.843537346795 12:27:50 INFO - PID 4359 | __end_tp_report 12:27:50 INFO - PID 4359 | __start_cc_report 12:27:50 INFO - PID 4359 | _x_x_mozilla_cycle_collect,392 12:27:50 INFO - PID 4359 | __end_cc_report 12:27:50 INFO - PID 4359 | __startTimestamp1496258870565__endTimestamp 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | ------- Summary: start ------- 12:27:50 INFO - PID 4359 | Number of tests: 6 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#0] dojo.html Cycles:165 Average:5271.60 Median:5411.78 stddev:623.68 (11.5%) stddev-sans-first:593.44 12:27:50 INFO - PID 4359 | Values: 2752.0 2765.5 2784.7 2790.0 2800.9 5299.0 5311.6 5328.7 5339.3 5350.1 5294.1 5305.3 5345.2 5404.1 5411.8 4483.1 4672.9 4740.5 4763.3 4788.8 4793.9 4835.1 4847.9 4867.3 4869.6 4665.4 4708.8 4739.5 4743.9 4764.4 4805.4 4808.6 4820.5 4850.5 4872.1 4748.5 4754.7 4776.9 4801.9 4823.4 5299.2 5385.6 5406.7 5408.8 5485.5 5711.0 5799.0 5816.4 5829.8 5838.0 5824.3 5831.9 5836.8 5837.1 5851.5 5379.8 5398.7 5405.3 5406.1 5412.0 5876.3 5886.7 5966.4 5975.7 5994.2 5693.1 5699.1 5709.2 5727.5 5754.3 5595.1 5787.8 5794.4 5795.2 5803.8 5585.0 5685.4 5773.6 5780.4 5790.3 5646.8 5699.5 5709.8 5811.4 5820.1 4814.2 4818.7 4826.3 4834.9 4865.5 4092.9 4134.9 4137.7 4140.9 4208.0 4764.1 4809.8 4823.0 4871.5 4873.0 5772.9 5833.0 5834.6 5838.5 5863.2 4859.5 4872.6 4872.6 4873.9 4913.4 5119.8 5125.2 5136.4 5138.4 5140.0 5220.7 5296.1 5301.4 5320.4 5409.2 5630.5 5704.9 5716.5 5831.6 5876.3 5237.7 5238.0 5329.3 5353.1 5365.9 5657.6 5690.5 5705.3 5707.0 5708.8 5656.7 5810.7 5814.3 5821.4 5823.3 5570.3 5583.2 5595.7 5628.4 5656.7 5590.7 5606.4 5608.3 5616.6 5662.5 5492.4 5501.7 5512.1 5532.6 5542.4 5483.8 5567.4 5606.3 5638.1 5638.3 5494.4 5496.2 5522.7 5530.2 5546.4 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#1] ext.html Cycles:180 Average:31039.34 Median:16853.46 stddev:41427.81 (245.8%) stddev-sans-first:41481.42 12:27:50 INFO - PID 4359 | Values: 707.3 764.7 786.5 1107.0 1113.1 33389.8 34472.8 34479.5 34494.5 34583.5 35919.8 36406.0 36579.5 36579.8 36680.8 6637.5 6891.0 6938.1 7035.5 7046.4 6884.7 6977.3 6990.7 6991.8 7005.8 6966.4 6998.9 7026.0 7028.7 7039.6 6937.5 6954.3 6955.9 6969.0 6969.1 6826.3 6873.8 6888.1 6890.4 6892.4 33688.3 33943.5 33995.8 33997.5 34004.3 3018.9 3051.5 3052.7 3053.6 3054.1 25945.1 25977.7 25980.7 26005.7 26007.7 3036.1 3055.7 3074.7 3088.9 3127.0 125861.4 128580.0 142701.0 150931.0 151345.0 41149.0 41397.8 41423.8 41457.4 41548.6 43315.0 43324.8 43407.1 43425.6 43486.6 13013.9 13141.8 13150.9 13166.3 13174.8 10642.0 10660.6 10667.4 10672.1 10673.9 13200.5 13206.7 13227.7 13232.7 13346.9 5246.9 5398.8 5400.4 5524.0 5546.1 864.6 890.9 900.3 923.3 939.2 21332.3 21779.7 22022.1 22109.1 22159.7 996.3 999.3 1011.0 1014.8 1019.1 10967.8 11728.3 11729.8 11767.7 11779.8 175470.0 177138.0 177475.0 177494.0 177684.0 42096.0 42395.8 42402.4 42419.4 42471.2 1189.8 1231.8 1235.7 1242.0 1246.1 20109.6 20896.6 21431.8 21727.3 21751.6 31019.2 31138.2 31143.2 31166.8 31188.0 160987.0 162095.0 162208.2 162854.0 162934.0 29158.0 30033.0 30162.7 30632.2 30772.5 37501.4 37800.2 37932.4 38105.0 38167.8 27061.3 27926.6 28012.9 28645.9 29576.4 27619.6 28310.2 28614.0 28816.9 29567.9 31655.0 31673.2 31768.7 31775.2 31785.0 27253.3 27411.3 27686.9 27913.7 29718.7 20396.6 22970.9 23336.3 23497.0 23557.8 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#2] jquery.html Cycles:180 Average:26720.99 Median:364895.50 stddev:64028.39 (17.5%) stddev-sans-first:64177.51 12:27:50 INFO - PID 4359 | Values: 400.7 430.1 432.0 432.6 443.8 13382.6 13997.4 18151.8 18768.3 18919.3 18383.5 19174.6 19250.3 19269.9 19314.3 5395.6 5562.4 5568.1 5575.8 5601.8 5496.2 5497.1 5524.3 5533.1 5557.7 5464.4 5482.3 5498.6 5499.6 5569.9 5264.7 5440.9 5456.6 5471.5 5485.0 4938.8 4946.6 4947.5 4950.7 4954.3 22269.0 22532.0 22607.4 22675.8 22709.0 1665.7 1700.7 1701.4 1701.6 1710.3 14335.3 14444.1 14548.6 14687.4 15269.2 2095.4 2099.8 2106.9 2133.1 2136.9 109922.5 111888.0 111909.0 112106.4 112726.0 10677.4 10771.7 10792.5 10980.1 11051.9 15593.5 15609.9 15750.9 15757.8 15765.0 7343.9 7449.6 7449.9 7636.4 8010.1 6735.7 6778.4 6803.1 6808.8 6900.7 6921.2 7045.8 7055.2 7124.6 7171.2 2051.2 2061.2 2104.5 2153.2 2220.8 816.4 841.4 844.1 873.9 892.5 17419.8 17811.9 17832.6 18023.6 18242.8 871.3 875.7 886.0 886.2 889.4 9247.0 9260.3 9802.5 9834.3 9882.1 347393.0 382398.0 383988.0 386567.0 390191.1 88367.0 90319.5 90512.0 90642.5 91301.0 1039.4 1057.1 1075.8 1083.6 1086.5 14850.3 15263.6 15476.6 15676.1 16004.7 41258.0 42085.0 42273.2 42460.4 42682.1 55528.2 55583.0 56213.2 56321.7 56434.7 9473.3 9536.6 9577.1 9594.3 9649.6 12077.8 12559.4 15002.8 15234.5 15274.0 12285.6 12945.2 13118.1 13133.7 13215.3 11680.9 11805.8 12210.9 12252.0 12593.5 13334.7 13487.0 13545.9 13579.5 13610.7 9068.3 9137.3 9152.0 9160.9 9229.2 12039.2 12395.0 12575.9 12689.6 12693.9 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#3] mootools.html Cycles:180 Average:6481.19 Median:3234.27 stddev:4384.50 (135.6%) stddev-sans-first:4379.48 12:27:50 INFO - PID 4359 | Values: 1294.9 1351.6 1353.1 1359.6 1366.8 10390.9 10882.8 10887.5 10900.1 11215.6 10837.2 11053.3 11069.7 11110.3 11141.3 2189.2 2218.6 2221.9 2223.1 2235.2 2039.1 2075.8 2084.6 2086.5 2094.1 2018.4 2021.3 2034.2 2050.5 2055.9 2037.4 2039.3 2040.0 2047.8 2049.7 1848.1 1915.9 2040.0 2056.5 2084.6 10879.2 10947.5 10954.8 10961.8 10987.9 5528.3 5747.7 5749.9 5751.1 5756.1 3115.2 3219.4 3286.8 3306.6 3314.3 1037.6 1062.5 1083.1 1085.2 1088.2 15866.2 15920.7 16054.8 16072.1 16104.0 4647.2 4783.9 4827.6 4899.6 5034.0 12067.7 12073.1 12080.5 12081.9 12119.9 5580.4 5671.0 5672.9 5672.9 5702.3 5132.0 5189.4 5190.1 5206.7 5328.5 3889.4 3977.9 3998.9 4053.6 4080.7 1134.4 1141.0 1156.0 1156.2 1158.1 662.1 683.6 684.3 702.7 703.3 5133.6 5285.7 5320.2 5422.5 5496.3 504.4 516.8 517.6 519.4 519.5 3222.6 3245.9 3257.3 3270.7 3341.5 13471.3 13729.5 13966.8 14084.2 14222.4 13803.4 13805.7 13818.3 13836.6 13879.8 7300.3 7481.6 7517.0 7531.7 7532.9 5471.6 5651.5 5740.9 5831.5 6015.9 12480.2 12634.7 12762.3 12806.9 12845.8 12921.8 12938.6 12977.7 13059.3 13091.8 8494.7 8579.3 8586.9 8588.5 8598.0 9936.3 9992.4 10063.1 10083.1 10179.3 8253.9 8263.9 8317.7 8325.2 8424.0 8540.2 8547.4 8564.4 8567.7 8603.0 7585.1 7639.8 7661.4 7666.3 7666.9 5005.1 5082.8 5092.2 5092.8 5171.1 5030.2 5066.4 5125.4 5170.9 5214.4 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#4] prototype.html Cycles:180 Average:4905.67 Median:5474.77 stddev:1443.24 (26.4%) stddev-sans-first:1406.66 12:27:50 INFO - PID 4359 | Values: 375.2 378.3 379.8 386.3 388.5 5574.9 5588.4 5619.8 5620.7 5645.2 5386.4 5433.9 5454.5 5467.8 5481.7 4206.3 4236.4 4259.7 4261.8 4277.8 4255.1 4260.7 4270.8 4274.3 4291.8 4221.2 4231.4 4237.2 4240.3 4245.1 4213.7 4224.9 4231.2 4239.6 4253.7 3743.1 3754.3 3769.0 3775.3 3776.6 5499.5 5500.3 5503.9 5508.0 5545.6 5050.1 5052.7 5060.8 5067.6 5070.3 5938.8 5953.2 5959.0 5963.4 5979.9 4238.5 4248.7 4250.7 4269.4 4280.4 6001.5 6198.4 6278.9 6344.8 6347.6 4200.4 4245.7 4282.9 4289.0 4312.3 4382.6 4398.9 4404.3 4406.1 4422.1 4821.8 4998.0 5006.2 5013.2 5019.2 5873.8 5891.0 5899.5 5901.1 5909.7 1500.3 1514.1 1518.0 1523.1 1526.5 1002.1 1019.8 1042.2 1042.8 1045.0 5125.4 5134.4 5139.6 5144.5 5148.2 6114.9 6138.2 6140.9 6145.2 6204.6 5089.9 5091.2 5093.0 5104.2 5110.4 3243.7 3244.0 3261.6 3263.6 3263.8 5671.5 5674.5 5701.3 5716.2 5722.3 6310.9 6353.5 6358.4 6365.5 6379.2 5682.2 5706.1 5713.7 5717.8 5739.8 6113.7 6145.0 6150.7 6156.2 6181.5 6033.8 6034.4 6051.9 6085.4 6090.6 5334.4 5422.2 5590.3 5668.9 5691.4 4233.8 4241.8 4293.4 4314.2 4320.5 6119.2 6128.8 6155.7 6156.3 6169.8 5748.9 5953.3 5960.7 5967.3 5975.9 5951.2 5954.0 5970.7 5978.9 5984.1 5905.8 5909.8 5930.3 5931.8 5933.3 6020.8 6035.7 6043.4 6058.8 6061.3 5858.4 5874.6 5874.7 5885.2 5896.4 12:27:50 INFO - PID 4359 | 12:27:50 INFO - PID 4359 | [#5] yui.html Cycles:180 Average:17416.75 Median:21413.59 stddev:23257.45 (108.6%) stddev-sans-first:23289.00 12:27:50 INFO - PID 4359 | Values: 746.5 751.1 762.1 766.1 775.3 14314.5 14564.6 14575.7 15752.2 16687.4 16289.3 16471.3 16473.5 16555.0 16583.7 866.0 872.1 895.6 902.8 917.1 877.3 926.2 927.6 929.3 930.7 964.6 975.6 976.2 979.0 980.7 971.0 971.0 971.6 971.7 971.7 707.1 713.4 713.9 714.0 714.0 14647.8 14707.9 14924.4 14990.6 14993.2 16447.3 17013.9 17077.2 17080.9 17085.5 12267.4 12893.0 12906.4 12942.9 12947.4 3047.7 3053.8 3059.9 3062.2 3066.7 86029.0 87700.0 87769.1 88914.6 90060.0 12587.2 12665.0 12679.5 12844.2 12921.2 23794.3 24160.6 24272.8 24364.9 24380.0 6247.1 6292.2 6433.2 6496.6 6537.4 3075.3 3159.9 3160.0 3169.6 3173.8 3608.9 3698.3 3703.3 3704.8 3705.4 726.8 749.7 758.2 760.3 761.7 598.1 610.8 614.8 621.1 633.3 9744.4 9798.4 10089.6 10577.7 10874.5 575.7 583.1 587.2 589.5 593.0 4417.6 4421.4 4475.2 4561.4 4585.1 83955.0 84726.6 84969.0 85041.0 86470.0 70307.3 71121.6 71334.6 72179.6 72446.0 66543.3 67403.3 67418.7 67702.0 68085.0 8563.4 8900.4 8917.0 9128.0 9191.4 29512.0 29643.3 29793.7 29862.7 30098.0 37583.4 37622.8 37810.6 37968.2 38409.6 13039.8 13223.2 13275.7 13276.4 13440.1 14577.6 14805.1 14812.2 14871.9 14884.3 13118.0 13130.2 13327.7 13398.7 13500.1 13509.5 13605.1 13760.7 13785.2 13955.2 12461.6 12622.1 12631.7 12797.0 12823.7 9035.9 9101.5 9270.4 9305.1 9468.7 9796.6 9950.2 10019.4 10055.0 10430.8 12:27:50 INFO - PID 4359 | -------- Summary: end -------- 12:27:50 INFO - PID 4359 | 12:27:51 INFO - TEST-INFO | 4359: exit 0 12:27:51 INFO - TEST-OK | dromaeo_css | took 1147281ms 12:27:51 INFO - TEST-START | kraken 12:27:51 INFO - operating with platform_type : linux_ 12:27:51 INFO - Initialising browser for kraken test... 12:27:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41065/getInfo.html -profile /tmp/tmpfTROOa/profile 12:27:51 INFO - TEST-INFO | started process 4774 (/builds/slave/test/build/application/firefox/firefox http://localhost:41065/getInfo.html) 12:28:26 INFO - TEST-INFO | 4774: killed by SIGTERM 12:28:26 INFO - Browser initialized. 12:28:26 INFO - Running cycle 1/1 for kraken test... 12:28:26 INFO - TEST-INFO | started process 4981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfTROOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:38 INFO - PID 4981 | RSS: Main: 184438784 12:28:38 INFO - PID 4981 | 12:28:41 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41065/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:42 INFO - PID 4981 | RSS: Main: 187899904 12:28:42 INFO - PID 4981 | 12:28:44 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41065/tests/kraken/driver.html?testName=audio-dft) 12:28:45 INFO - PID 4981 | RSS: Main: 186855424 12:28:45 INFO - PID 4981 | 12:28:48 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41065/tests/kraken/driver.html?testName=audio-fft) 12:28:49 INFO - PID 4981 | RSS: Main: 181866496 12:28:49 INFO - PID 4981 | 12:28:51 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41065/tests/kraken/driver.html?testName=audio-oscillator) 12:28:51 INFO - PID 4981 | RSS: Main: 182538240 12:28:51 INFO - PID 4981 | 12:28:53 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:54 INFO - PID 4981 | RSS: Main: 182288384 12:28:54 INFO - PID 4981 | 12:28:57 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41065/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:58 INFO - PID 4981 | RSS: Main: 183738368 12:28:58 INFO - PID 4981 | 12:29:01 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41065/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:02 INFO - PID 4981 | RSS: Main: 182738944 12:29:02 INFO - PID 4981 | 12:29:05 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41065/tests/kraken/driver.html?testName=json-parse-financial) 12:29:05 INFO - PID 4981 | RSS: Main: 183676928 12:29:05 INFO - PID 4981 | 12:29:07 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:08 INFO - PID 4981 | RSS: Main: 183721984 12:29:08 INFO - PID 4981 | 12:29:09 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:10 INFO - PID 4981 | RSS: Main: 183640064 12:29:10 INFO - PID 4981 | 12:29:12 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:13 INFO - PID 4981 | RSS: Main: 183492608 12:29:13 INFO - PID 4981 | 12:29:16 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:16 INFO - PID 4981 | RSS: Main: 183603200 12:29:16 INFO - PID 4981 | 12:29:20 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:20 INFO - PID 4981 | RSS: Main: 183222272 12:29:20 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | Cycle 1(1): loaded http://localhost:41065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41065/tests/kraken/driver.html?testName=ai-astar) 12:29:22 INFO - PID 4981 | RSS: Main: 184799232 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | __start_tp_report 12:29:22 INFO - PID 4981 | _x_x_mozilla_page_load 12:29:22 INFO - PID 4981 | _x_x_mozilla_page_load_details 12:29:22 INFO - PID 4981 | |i|pagename|runs| 12:29:22 INFO - PID 4981 | |0;ai-astar;103;115;112;109;110;111;110;112;112;109 12:29:22 INFO - PID 4981 | |1;audio-beat-detection;149;122;125;184;123;123;124;122;151;123 12:29:22 INFO - PID 4981 | |2;audio-dft;164;165;162;165;166;173;169;168;162;163 12:29:22 INFO - PID 4981 | |3;audio-fft;74;74;75;101;75;76;74;74;93;83 12:29:22 INFO - PID 4981 | |4;audio-oscillator;83;84;100;85;84;83;96;83;83;109 12:29:22 INFO - PID 4981 | |5;imaging-gaussian-blur;114;115;115;115;114;113;114;116;115;117 12:29:22 INFO - PID 4981 | |6;imaging-darkroom;151;150;150;151;150;151;151;151;150;150 12:29:22 INFO - PID 4981 | |7;imaging-desaturate;94;95;94;95;94;94;94;95;94;94 12:29:22 INFO - PID 4981 | |8;json-parse-financial;55;54;55;56;57;56;56;59;56;58 12:29:22 INFO - PID 4981 | |9;json-stringify-tinderbox;56;56;57;57;57;56;58;57;57;56 12:29:22 INFO - PID 4981 | |10;stanford-crypto-aes;96;87;92;88;87;88;88;99;115;86 12:29:22 INFO - PID 4981 | |11;stanford-crypto-ccm;135;139;133;129;130;133;134;137;136;151 12:29:22 INFO - PID 4981 | |12;stanford-crypto-pbkdf2;192;198;196;204;198;195;199;196;202;198 12:29:22 INFO - PID 4981 | |13;stanford-crypto-sha256-iterative;76;72;73;72;71;76;72;71;75;73 12:29:22 INFO - PID 4981 | __end_tp_report 12:29:22 INFO - PID 4981 | __start_cc_report 12:29:22 INFO - PID 4981 | _x_x_mozilla_cycle_collect,1048 12:29:22 INFO - PID 4981 | __end_cc_report 12:29:22 INFO - PID 4981 | __startTimestamp1496258962831__endTimestamp 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | ------- Summary: start ------- 12:29:22 INFO - PID 4981 | Number of tests: 14 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.13 (2.8%) stddev-sans-first:1.90 12:29:22 INFO - PID 4981 | Values: 103.0 115.0 112.0 109.0 110.0 111.0 110.0 112.0 112.0 109.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:124.50 stddev:20.66 (16.6%) stddev-sans-first:21.25 12:29:22 INFO - PID 4981 | Values: 149.0 122.0 125.0 184.0 123.0 123.0 124.0 122.0 151.0 123.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:3.47 (2.1%) stddev-sans-first:3.62 12:29:22 INFO - PID 4981 | Values: 164.0 165.0 162.0 165.0 166.0 173.0 169.0 168.0 162.0 163.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:9.60 (12.8%) stddev-sans-first:9.94 12:29:22 INFO - PID 4981 | Values: 74.0 74.0 75.0 101.0 75.0 76.0 74.0 74.0 93.0 83.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.50 stddev:9.31 (11.1%) stddev-sans-first:9.62 12:29:22 INFO - PID 4981 | Values: 83.0 84.0 100.0 85.0 84.0 83.0 96.0 83.0 83.0 109.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.14 (1.0%) stddev-sans-first:1.17 12:29:22 INFO - PID 4981 | Values: 114.0 115.0 115.0 115.0 114.0 113.0 114.0 116.0 115.0 117.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 12:29:22 INFO - PID 4981 | Values: 151.0 150.0 150.0 151.0 150.0 151.0 151.0 151.0 150.0 150.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:29:22 INFO - PID 4981 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.48 (2.6%) stddev-sans-first:1.50 12:29:22 INFO - PID 4981 | Values: 55.0 54.0 55.0 56.0 57.0 56.0 56.0 59.0 56.0 58.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 12:29:22 INFO - PID 4981 | Values: 56.0 56.0 57.0 57.0 57.0 56.0 58.0 57.0 57.0 56.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:8.97 (10.2%) stddev-sans-first:9.43 12:29:22 INFO - PID 4981 | Values: 96.0 87.0 92.0 88.0 87.0 88.0 88.0 99.0 115.0 86.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:135.50 stddev:6.17 (4.6%) stddev-sans-first:6.53 12:29:22 INFO - PID 4981 | Values: 135.0 139.0 133.0 129.0 130.0 133.0 134.0 137.0 136.0 151.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:198.00 stddev:3.43 (1.7%) stddev-sans-first:2.92 12:29:22 INFO - PID 4981 | Values: 192.0 198.0 196.0 204.0 198.0 195.0 199.0 196.0 202.0 198.0 12:29:22 INFO - PID 4981 | 12:29:22 INFO - PID 4981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.91 (2.6%) stddev-sans-first:1.72 12:29:22 INFO - PID 4981 | Values: 76.0 72.0 73.0 72.0 71.0 76.0 72.0 71.0 75.0 73.0 12:29:22 INFO - PID 4981 | -------- Summary: end -------- 12:29:22 INFO - PID 4981 | 12:29:23 INFO - TEST-INFO | 4981: exit 0 12:29:24 INFO - TEST-OK | kraken | took 92495ms 12:29:24 INFO - SUITE-END | took 1239s 12:29:24 INFO - Completed test suite (00:20:40) 12:29:24 INFO - javascript benchmark 12:29:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6894.377605632997, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2751.972480275197, 2765.5022096022735, 2784.7076057014015, 2789.958150627741, 2800.915972520825, 5299.019681358946, 5311.62818602697, 5328.733563321833, 5339.305890234265, 5350.143976963686, 5294.100002999489, 5305.336832895888, 5345.1714984177415, 5404.054290499157, 5411.783528658859, 4483.125790470859, 4672.906541869161, 4740.525947405266, 4763.26169443735, 4788.760561971905, 4793.945332026949, 4835.05716385305, 4847.854564363075, 4867.318575399447, 4869.561739443449, 4665.370175026362, 4708.835190768306, 4739.502352252998, 4743.881402964954, 4764.404449443819, 4805.3753012108555, 4808.615310775164, 4820.542048505386, 4850.490698476679, 4872.074305881871, 4748.5251474852585, 4754.66717329787, 4776.8566942991765, 4801.927971080437, 4823.397075365579, 5299.231611416323, 5385.5960802939935, 5406.729663516848, 5408.756605952742, 5485.451454854522, 5711.0, 5798.971005144989, 5816.447437493432, 5829.825105246807, 5837.970810145965, 5824.30108386992, 5831.88336233273, 5836.766529338822, 5837.09525023622, 5851.531877449794, 5379.757910894019, 5398.703071331114, 5405.324334458192, 5406.08096623575, 5412.0, 5876.294844618673, 5886.735096920649, 5966.373530779292, 5975.671338076448, 5994.220751302303, 5693.146028095736, 5699.116636921284, 5709.200711900337, 5727.4845263926445, 5754.251947246915, 5595.104783234663, 5787.768489260467, 5794.420557944256, 5795.246617939725, 5803.767849285981, 5585.0, 5685.431456854281, 5773.5958482906635, 5780.393058728857, 5790.276215473066, 5646.774129034792, 5699.5155411790465, 5709.800156994568, 5811.389804070512, 5820.126980952807, 4814.20565606671, 4818.7108773473, 4826.251930950708, 4834.8791280218275, 4865.537773911473, 4092.856750013735, 4134.855280065183, 4137.710360274752, 4140.91718165635, 4208.0, 4764.094821983812, 4809.78355973982, 4823.03539292143, 4871.464138944713, 4872.9512704873205, 5772.855678607984, 5832.9708351457975, 5834.591578589543, 5838.5037271831525, 5863.237779088691, 4859.538343857328, 4872.610191184696, 4872.634552408584, 4873.926891096637, 4913.361263035854, 5119.846404607868, 5125.205593133071, 5136.43499215086, 5138.3577052868395, 5140.023395554907, 5220.686758794484, 5296.073187192149, 5301.443348448357, 5320.388155362183, 5409.215663728816, 5630.493255607015, 5704.885902282014, 5716.456936591017, 5831.591788574929, 5876.265466816648, 5237.659552129099, 5238.004779091961, 5329.333833270841, 5353.116735738559, 5365.892682146413, 5657.60396772222, 5690.5163061140265, 5705.343885453226, 5706.971465142814, 5708.828735137952, 5656.660600363992, 5810.68041257718, 5814.331351894586, 5821.446962538552, 5823.301203855564, 5570.3315602128005, 5583.246261754611, 5595.720213989365, 5628.4090170533145, 5656.660600363992, 5590.664560126405, 5606.411326810626, 5608.327000759935, 5616.606837521498, 5662.462066103713, 5492.423295554069, 5501.724913754216, 5512.118061110203, 5532.612717109763, 5542.418046105262, 5483.75323110469, 5567.359753628384, 5606.327240730975, 5638.097904335286, 5638.323401191883, 5494.423085576117, 5496.1755736639825, 5522.723863806874, 5530.170474428707, 5546.36216835053], "value": 5226.056508449855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.3386383731212, 764.6826566974706, 786.5202226641748, 1106.9557217711297, 1113.0817075912373, 33389.83305083477, 34472.82763586182, 34479.4828077579, 34494.482582761244, 34583.504144461185, 35919.82040089796, 36406.0, 36579.4513082304, 36579.81710091446, 36680.81659591705, 6637.535372523926, 6891.035255064307, 6938.09804725385, 7035.542689725177, 7046.4010559102535, 6884.655767211644, 6977.33715297046, 6990.720371185172, 6991.825204369906, 7005.754798582051, 6966.442684585247, 6998.895016574756, 7026.0, 7028.718851245944, 7039.612821294827, 6937.514373993822, 6954.339337762955, 6955.8956615650295, 6968.989496522976, 6969.128858892638, 6826.283240259801, 6873.793786186422, 6888.070110535064, 6890.379865812101, 6892.414144797698, 33688.32623347544, 33943.4908476373, 33995.83002084974, 33997.47011384494, 34004.31991360184, 3018.894338698135, 3051.465993451159, 3052.664206937235, 3053.618297712786, 3054.144839444959, 25945.091921782834, 25977.74022259791, 25980.74019259802, 26005.73994260071, 26007.739922600722, 3036.149878034154, 3055.7013269360655, 3074.6925307469296, 3088.90733278002, 3126.9687303126907, 125861.37069314686, 128580.0, 142700.99999999895, 150931.0, 151345.0, 41149.0, 41397.793011035355, 41423.7928810354, 41457.378139327935, 41548.584514155074, 43315.0, 43324.783376082916, 43407.13185736268, 43425.565744342784, 43486.565134348886, 13013.934930325477, 13141.802872956914, 13150.868491315156, 13166.275854827885, 13174.802377964339, 10642.0, 10660.573577056832, 10667.359958402521, 10672.146228301717, 10673.946630266953, 13200.537981170804, 13206.669833254246, 13227.73544529104, 13232.73534529304, 13346.933265333806, 5246.921296180561, 5398.784048638089, 5400.351957765093, 5524.0, 5546.084895992116, 864.5547543015352, 890.9064548222473, 900.3292547052488, 923.3121324613072, 939.1547607153616, 21332.253371131937, 21779.67330490044, 22022.128119109733, 22109.11563537473, 22159.667604985938, 996.277698668474, 999.3154689038032, 1011.0, 1014.7666036811574, 1019.1184625299211, 10967.780644387067, 11728.296302221894, 11729.765404691858, 11767.705807354885, 11779.823302650468, 175470.0, 177138.0, 177475.0, 177494.0, 177684.0, 42096.0, 42395.7880210597, 42402.36396454056, 42419.363709544385, 42471.150576988286, 1189.8318046610132, 1231.7967535356745, 1235.740494496148, 1241.993790031044, 1246.1214843535286, 20109.59780804405, 20896.582068358242, 21431.785682142978, 21727.34817955464, 21751.564968700855, 31019.224519387197, 31138.221544460663, 31143.22141946379, 31166.844165779024, 31188.0, 160987.0, 162095.0, 162208.18895905445, 162854.0, 162934.0, 29158.0, 30033.0, 30162.69837301599, 30632.234194145323, 30772.538411924288, 37501.43747843839, 37800.243995120494, 37932.43101353427, 38105.0, 38167.80916095402, 27061.323466912698, 27926.581101283904, 28012.85993570019, 28645.856770716848, 29576.408471830873, 27619.58570621402, 28310.15069547917, 28614.0, 28816.855915720287, 29567.852160739058, 31655.0, 31673.20816979594, 31768.682313176574, 31775.205619859687, 31785.04644860658, 27253.31866703269, 27411.31471713223, 27686.86156569204, 27913.720862791113, 29718.702812971595, 20396.592068158257, 22970.885145574164, 23336.299911002698, 23497.0, 23557.764422356242], "value": 14873.271827033133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.6894656641101, 430.14589280050745, 432.0, 432.6322625768099, 443.815816436179, 13382.598522044329, 13997.370118344674, 18151.820131691446, 18768.343107991222, 18919.337823176174, 18383.54041148972, 19174.616507669838, 19250.326238581652, 19269.903650481727, 19314.32399866005, 5395.59533035022, 5562.360328562207, 5568.1091025435935, 5575.832725018236, 5601.80393686221, 5496.1755736639425, 5497.065498865182, 5524.309461317335, 5533.142362933751, 5557.694326812024, 5464.371597266326, 5482.2873026506495, 5498.560115190775, 5499.587530935176, 5569.860753481175, 5264.710440925747, 5440.91838622421, 5456.645318054314, 5471.480209380143, 5485.040117979338, 4938.777755000998, 4946.5795407390415, 4947.50524947506, 4950.653454258203, 4954.331165292675, 22268.9978950946, 22532.0, 22607.434814129778, 22675.773242267533, 22709.0, 1665.6835201311833, 1700.6938751024811, 1701.3789966662202, 1701.574606348413, 1710.2816816936916, 14335.283235838166, 14444.133351998913, 14548.636284092876, 14687.412503499847, 15269.236538173047, 2095.3609149209483, 2099.8320134389364, 2106.9367918962457, 2133.0934352899953, 2136.9252076177413, 109922.45038774755, 111888.0, 111909.0, 112106.43946780213, 112726.0, 10677.359358438363, 10771.730706732395, 10792.46037698112, 10980.121590272758, 11051.889481105247, 15593.532194034196, 15609.921950390402, 15750.9212453937, 15757.842421575866, 15765.0, 7343.88984165238, 7449.627518624047, 7449.925500745032, 7636.350910172698, 8010.118886922434, 6735.663216839139, 6778.423833974168, 6803.149606299213, 6808.8297792554595, 6900.689468973908, 6921.238663746984, 7045.753398631024, 7055.173545336546, 7124.643767811589, 7171.247019062923, 2051.200031987526, 2061.196133507933, 2104.5475222827167, 2153.1710291537556, 2220.822334213259, 816.3754727633366, 841.3773807382615, 844.1178967978477, 873.9038705742363, 892.4689809563299, 17419.77734119192, 17811.910940445214, 17832.55418614519, 18023.639527209645, 18242.817571824377, 871.333429926107, 875.7153924974409, 886.0474989386436, 886.1802832380023, 889.4174315823146, 9247.0, 9260.305477089245, 9802.509874506246, 9834.311598188058, 9882.110610044987, 347393.0, 382398.0, 383988.0, 386567.0, 390191.1471327932, 88367.0, 90319.54840225757, 90512.0, 90642.54678726564, 91301.0, 1039.428314427062, 1057.0856209378985, 1075.8386242063752, 1083.6423980086552, 1086.4676308608725, 14850.331735071732, 15263.618409539851, 15476.613084672974, 15676.137812420426, 16004.679906401574, 41258.0, 42085.0, 42273.15453690848, 42460.363094554225, 42682.146357072066, 55528.167077494676, 55583.0, 56213.15680264881, 56321.71839140778, 56434.71782641225, 9473.336866419284, 9536.57085431171, 9577.138057574852, 9594.280428967715, 9649.565769540528, 12077.758444830879, 12559.434825432694, 15002.849971500145, 15234.542963711106, 15274.0, 12285.631431057083, 12945.158564693265, 13118.097875807764, 13133.671658208621, 13215.339233038501, 11680.94159529231, 11805.82291265649, 12210.938945305572, 12252.019838413084, 12593.496260149492, 13334.666633334244, 13487.0, 13545.932270338586, 13579.45682172702, 13610.659733506742, 9068.319876009195, 9137.269018478639, 9152.0, 9160.862587061067, 9229.169374756304, 12039.157258992136, 12395.0, 12575.87424125747, 12689.619311420673, 12693.936530317289], "value": 9247.890575443313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.8575656677765, 1351.6012776231012, 1353.1272329347578, 1359.5921223632913, 1366.801813737008, 10390.948045259773, 10882.782344353109, 10887.510062047197, 10900.12798976082, 11215.551377944872, 10837.241393102486, 11053.336799792018, 11069.667909962694, 11110.277831940919, 11141.331520108799, 2189.1681161158735, 2218.5895609312247, 2221.922232721855, 2223.0552015393473, 2235.2065016919005, 2039.0620314655275, 2075.844311676623, 2084.5726626041624, 2086.499240182353, 2094.0576740466777, 2018.3944816555047, 2021.282444732121, 2034.1863254698164, 2050.538628808521, 2055.9177632894666, 2037.4498885300886, 2039.3372154049846, 2040.0, 2047.7747447780732, 2049.6822992436196, 1848.0851978270707, 1915.9042047897549, 2040.0, 2056.506438454775, 2084.6247675418417, 10879.184061195441, 10947.50736216872, 10954.835677464844, 10961.780764384748, 10987.945060274647, 5528.281323427928, 5747.712614369307, 5749.913751293692, 5751.1085781703905, 5756.136579513065, 3115.1589070950945, 3219.388316219911, 3286.819224942627, 3306.6197387300285, 3314.287428202948, 1037.6057098302672, 1062.4900047976937, 1083.063150374928, 1085.1698450685153, 1088.2382332367295, 15866.206689665585, 15920.681586368324, 16054.839451605569, 16072.116033618146, 16104.0, 4647.209974304376, 4783.856484305476, 4827.61379089679, 4899.559039686445, 5033.974830125826, 12067.698307542381, 12073.094517911017, 12080.516779328904, 12081.939590301992, 12119.939400302943, 5580.386157522669, 5671.0, 5672.858178545569, 5672.914906276409, 5702.258706368146, 5131.97434012835, 5189.351331083614, 5190.143626301618, 5206.687598744087, 5328.547073498796, 3889.416587511839, 3977.9204415911518, 3998.8800335989968, 4053.6083710610883, 4080.714349995472, 1134.4157758754247, 1140.9657710268705, 1155.9537618495335, 1156.2311063142915, 1158.09089864456, 662.1458318768734, 683.6445048574714, 684.3088480634495, 702.7154002628944, 703.3458883238535, 5133.563647089964, 5285.68285902847, 5320.17537281722, 5422.5119739223655, 5496.31296087989, 504.43755212938044, 516.8216466456486, 517.5549027836058, 519.3819354967577, 519.4571672602065, 3222.6132864056462, 3245.9350812983607, 3257.3485302939507, 3270.689284517967, 3341.4820702791108, 13471.259080750457, 13729.519466818614, 13966.790498142536, 14084.197924979926, 14222.431102755774, 13803.447862085604, 13805.723885522233, 13818.309084545732, 13836.584902452943, 13879.791803122962, 7300.342969132804, 7481.625918704043, 7517.0, 7531.736389226351, 7532.887006694904, 5471.644343117685, 5651.491365777099, 5740.942590574041, 5831.533477321719, 6015.909761353671, 12480.188787728768, 12634.747305054032, 12762.29807360604, 12806.935965320487, 12845.807312890502, 12921.806172907225, 12938.61184164439, 12977.675558110745, 13059.281739504038, 13091.803622945474, 8494.745157645033, 8579.313654907468, 8586.91413085886, 8588.484690918565, 8598.011228708778, 9936.304458687822, 9992.350497217658, 10063.094321511098, 10083.14293285079, 10179.338343007681, 8253.917460825314, 8263.876041859497, 8317.708880189164, 8325.209105135002, 8423.957880210559, 8540.188682075193, 8547.444416112932, 8564.443311185003, 8567.700130495403, 8602.956985215034, 7585.089789225328, 7639.809004774703, 7661.387089032975, 7666.348360389429, 7666.884996725165, 5005.099082165099, 5082.847514574569, 5092.159793634157, 5092.8472145835685, 5171.095058364846, 5030.220315851049, 5066.44269130388, 5125.4362020177, 5170.948290517197, 5214.426413094632], "value": 4714.096913210723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.2401387190937, 378.2680513206945, 379.7930128080196, 386.3104358719684, 388.469738806529, 5574.944250557498, 5588.441155884409, 5619.775208991646, 5620.747066382012, 5645.209670646108, 5386.380566234874, 5433.945660543393, 5454.4545545445435, 5467.808626698066, 5481.725913704318, 4206.284931561627, 4236.449261595996, 4259.7231179973205, 4261.78691065447, 4277.786110694468, 4255.085156691311, 4260.659147268227, 4270.786460676969, 4274.337477690963, 4291.806868690916, 4221.219074471217, 4231.370922194962, 4237.2203674456805, 4240.342746874239, 4245.10852720929, 4213.705040647156, 4224.936920732475, 4231.196072746184, 4239.59723826236, 4253.680973926967, 3743.082944678571, 3754.3242216401036, 3769.038895081764, 3775.263823554408, 3776.603456637041, 5499.450054994509, 5500.28496295483, 5503.944960550383, 5508.0, 5545.639533430314, 5050.116229659795, 5052.747362631853, 5060.84817455477, 5067.569256613156, 5070.340855688773, 5938.8218353449465, 5953.166556682068, 5958.970205148947, 5963.373845746178, 5979.910301345483, 4238.512571054337, 4248.745075295461, 4250.747104034866, 4269.359596060584, 4280.379344994958, 6001.459868611846, 6198.3801619838105, 6278.874422511524, 6344.809655710336, 6347.619142851444, 4200.4038465382955, 4245.724027938174, 4282.935755963663, 4288.978555107205, 4312.310030395184, 4382.627476664456, 4398.868033958986, 4404.317330813665, 4406.1187762447635, 4422.137683151755, 4821.807127714852, 4997.9500204997485, 5006.173981293119, 5013.24801279811, 5019.222020586815, 5873.823785286449, 5890.970545147246, 5899.46904778572, 5901.144334071536, 5909.704514774244, 1500.3473489032306, 1514.1142431677592, 1518.0132913606244, 1523.0633160606149, 1526.5115163147686, 1002.0830939690102, 1019.8215312320315, 1042.2183362478142, 1042.7914417116608, 1044.9634262800766, 5125.436202017775, 5134.409542902539, 5139.58883289336, 5144.485551444825, 5148.176291793295, 6114.908276375858, 6138.232720909887, 6140.894638965029, 6145.231846019247, 6204.627722336674, 5089.923651145235, 5091.1854103343285, 5093.0, 5104.1578139606545, 5110.361204849394, 3243.68630704565, 3243.951340729891, 3261.59230096238, 3263.6246831614194, 3263.7715359924578, 5671.461211184931, 5674.517665998354, 5701.287339082614, 5716.1997320375185, 5722.341930677942, 6310.873782524323, 6353.459955903708, 6358.427741503287, 6365.458935990493, 6379.234491861006, 5682.232898558725, 5706.144078388192, 5713.74288157034, 5717.828465146053, 5739.770409183586, 6113.694315284307, 6145.0, 6150.692465376803, 6156.199694039746, 6181.474574661204, 6033.758649653964, 6034.396560344106, 6051.909221361595, 6085.391460854056, 6090.573659843769, 5334.399680096033, 5422.15956526739, 5590.329160500603, 5668.858278543069, 5691.430856914441, 4233.767142807175, 4241.809118589609, 4293.359583855969, 4314.180305741899, 4320.546342634104, 6119.204503414528, 6128.785492507741, 6155.692215389302, 6156.260464093435, 6169.81490555284, 5748.913766293425, 5953.285605727167, 5960.731767070405, 5967.283925928917, 5975.880482390415, 5951.166836642787, 5953.970230148821, 5970.731317090655, 5978.850528736816, 5984.13230081627, 5905.793297234576, 5909.804039132092, 5930.28836539618, 5931.7627294907725, 5933.258342707161, 6020.819375418744, 6035.668038257938, 6043.40984589262, 6058.818235452944, 6061.272647282354, 5858.443447872445, 5874.5887787856145, 5874.706264686663, 5885.205497257986, 5896.410358964069], "value": 4459.948731392012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.4513582516853, 751.0574229342175, 762.1349768013304, 766.0692258905428, 775.3022279948048, 14314.498992535264, 14564.635884102903, 14575.708485830277, 15752.212389380515, 16687.415940442086, 16289.266982985764, 16471.258793354296, 16473.505794826146, 16555.0, 16583.66832663346, 865.9523726195057, 872.1278721278721, 895.6014573514789, 902.7562558109306, 917.0554329041065, 877.3376101043704, 926.2080920812709, 927.5825878354734, 929.3494553812325, 930.7393929699662, 964.609333220047, 975.6000039983608, 976.199516396555, 979.0111986893218, 980.6959842448828, 971.00957023836, 971.0192705367559, 971.6259240192542, 971.7182017214999, 971.7182017214999, 707.1302298173224, 713.3936154268882, 713.9428845692332, 713.9857202855966, 714.0253553898942, 14647.780283295759, 14707.926460367737, 14924.403023879031, 14990.62523436912, 14993.17537535435, 16447.342106315733, 17013.91493042539, 17077.231524581424, 17080.914595427068, 17085.48743537696, 12267.447964841604, 12893.0, 12906.419211135522, 12942.935285323512, 12947.41736621845, 3047.740942019931, 3053.755699544053, 3059.908202753921, 3062.2344413896526, 3066.6626671066388, 86029.0, 87700.0, 87769.12230877737, 88914.55542722245, 90060.04069369324, 12587.244765313928, 12665.0, 12679.492820287269, 12844.165129266754, 12921.160124591872, 23794.286171414886, 24160.637590436156, 24272.757272427403, 24364.87817560901, 24380.0, 6247.125402443661, 6292.244930608356, 6433.163688720437, 6496.610203387811, 6537.411632952962, 3075.261937135116, 3159.936801263962, 3160.0361889623427, 3169.6037995250595, 3173.809571425722, 3608.9458658120147, 3698.2603479303707, 3703.2778608171147, 3704.833282502294, 3705.4071348584635, 726.785598248518, 749.6589051981335, 758.211460081509, 760.3347071312602, 761.7317166917131, 598.064029793372, 610.8350745298744, 614.7540983606503, 621.0745988477137, 633.3065293503606, 9744.415335079917, 9798.363106398205, 10089.611352429814, 10577.682669519927, 10874.510647020903, 575.6689903305617, 583.1340459417761, 587.2424572301768, 589.4635881347953, 593.0274350065895, 4417.558244175557, 4421.42521472213, 4475.239209334421, 4561.384213131251, 4585.128825523207, 83955.0, 84726.57636711777, 84969.0, 85041.0, 86470.0, 70307.29692703008, 71121.64439177874, 71334.64332678303, 72179.63910180416, 72446.0, 66543.34196606191, 67403.3259667397, 67418.66290668515, 67702.0, 68085.0, 8563.443376180529, 8900.42147260426, 8917.0, 9128.0, 9191.402558833923, 29512.0, 29643.258918526346, 29793.70206297996, 29862.701372985994, 30098.0, 37583.43624845684, 37622.81188594149, 37810.62189378181, 37968.24063518769, 38409.615903841725, 13039.804402933774, 13223.206607603575, 13275.734485310433, 13276.402561884544, 13440.126391784503, 14577.635559111108, 14805.111693298437, 14812.185329806964, 14871.851281487046, 14884.255787210812, 13117.964756961122, 13130.212187268795, 13327.66680832987, 13398.665033374244, 13500.122492037986, 13509.527166549124, 13605.115667481581, 13760.729479636148, 13785.172889626654, 13955.232462214675, 12461.626151215478, 12622.053345999271, 12631.747365052832, 12797.0, 12823.679408014874, 9035.864462032943, 9101.499417531835, 9270.351075424926, 9305.069493050642, 9468.715938521855, 9796.559154837907, 9950.154236889946, 10019.398836069859, 10055.0, 10430.843537346795], "value": 7105.371679309738, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 112.0, 109.0, 110.0, 111.0, 110.0, 112.0, 112.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 125.0, 184.0, 123.0, 123.0, 124.0, 122.0, 151.0, 123.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 165.0, 166.0, 173.0, 169.0, 168.0, 162.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 101.0, 75.0, 76.0, 74.0, 74.0, 93.0, 83.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 100.0, 85.0, 84.0, 83.0, 96.0, 83.0, 83.0, 109.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 114.0, 113.0, 114.0, 116.0, 115.0, 117.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 56.0, 57.0, 56.0, 56.0, 59.0, 56.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 87.0, 92.0, 88.0, 87.0, 88.0, 88.0, 99.0, 115.0, 86.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 133.0, 129.0, 130.0, 133.0, 134.0, 137.0, 136.0, 151.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 198.0, 196.0, 204.0, 198.0, 195.0, 199.0, 196.0, 202.0, 198.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 73.0, 72.0, 71.0, 76.0, 72.0, 71.0, 75.0, 73.0], "value": 73.1, "unit": "score"}]}]} 12:29:24 INFO - Return code: 0 12:29:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:29:24 INFO - # TBPL SUCCESS # 12:29:24 INFO - Running post-action listener: _resource_record_post_action 12:29:24 INFO - [mozharness: 2017-05-31 19:29:24.659123Z] Finished run-tests step (success) 12:29:24 INFO - Running post-run listener: _resource_record_post_run 12:29:24 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 430080; Write bytes: 412037120; Read time: 236; Write time: 278532 12:29:24 INFO - TinderboxPrint: CPU usage
12.6% 12:29:24 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 236 12:29:24 INFO - TinderboxPrint: I/O write bytes / time
412,037,120 / 278,532 12:29:24 INFO - TinderboxPrint: CPU idle
8,757.5 (87.3%) 12:29:24 INFO - TinderboxPrint: CPU user
1,216.2 (12.1%) 12:29:24 INFO - TinderboxPrint: Swap in / out
0 / 0 12:29:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102522880; Read time: 0; Write time: 95584 12:29:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:29:24 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 430080; Write bytes: 309514240; Read time: 236; Write time: 182948 12:29:25 INFO - Running post-run listener: _upload_blobber_files 12:29:25 INFO - Blob upload gear active. 12:29:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:29:25 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 12:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:29:25 INFO - (blobuploader) - INFO - Open directory for files ... 12:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:29 INFO - (blobuploader) - INFO - Done attempting. 12:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:30 INFO - (blobuploader) - INFO - Done attempting. 12:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:31 INFO - (blobuploader) - INFO - Done attempting. 12:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:32 INFO - (blobuploader) - INFO - Done attempting. 12:29:32 INFO - (blobuploader) - INFO - Iteration through files over. 12:29:32 INFO - Return code: 0 12:29:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:29:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:29:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c85622150aec04264bd6821a6942796e307aaad7efb2279a7c724a99a11226ad77f821cc9f614600a862dce5acb4cdc142ee4859d79f434a7a7adb80ba1a76b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4def65a8da670d4a87e3f3c397a274407af1ef1d7fbdcfd86f707ee671d5d80a083e62e96cdf28ff4d72aac547b2f39b1104d168c6cd582f68df7f046bca7eda", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5095405ad2771f222c762f97c9ad45c1b79da13aa1d65941017c26a46c78eabb66c10964b96f8bda55a221ce5f012d31f2bb635a67ece39d3d0bbcdd6672e8b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5867c0495ffcf54a8eaed6bd9aba065c83f244b415e88d91a90409814948de85f125d35c2afbd80540a19975c8f5d1f0860540d0337b6c8966ff65c377d2bab"} 12:29:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:29:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:29:32 INFO - Contents: 12:29:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c85622150aec04264bd6821a6942796e307aaad7efb2279a7c724a99a11226ad77f821cc9f614600a862dce5acb4cdc142ee4859d79f434a7a7adb80ba1a76b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4def65a8da670d4a87e3f3c397a274407af1ef1d7fbdcfd86f707ee671d5d80a083e62e96cdf28ff4d72aac547b2f39b1104d168c6cd582f68df7f046bca7eda", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5095405ad2771f222c762f97c9ad45c1b79da13aa1d65941017c26a46c78eabb66c10964b96f8bda55a221ce5f012d31f2bb635a67ece39d3d0bbcdd6672e8b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5867c0495ffcf54a8eaed6bd9aba065c83f244b415e88d91a90409814948de85f125d35c2afbd80540a19975c8f5d1f0860540d0337b6c8966ff65c377d2bab"} 12:29:32 INFO - Running post-run listener: copy_logs_to_upload_dir 12:29:32 INFO - Copying logs to upload dir... 12:29:32 INFO - mkdir: /builds/slave/test/build/upload/logs 12:29:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.501075 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-31 12:29:32.089579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 12:29:32.092810) ========= 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=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c85622150aec04264bd6821a6942796e307aaad7efb2279a7c724a99a11226ad77f821cc9f614600a862dce5acb4cdc142ee4859d79f434a7a7adb80ba1a76b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4def65a8da670d4a87e3f3c397a274407af1ef1d7fbdcfd86f707ee671d5d80a083e62e96cdf28ff4d72aac547b2f39b1104d168c6cd582f68df7f046bca7eda", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5095405ad2771f222c762f97c9ad45c1b79da13aa1d65941017c26a46c78eabb66c10964b96f8bda55a221ce5f012d31f2bb635a67ece39d3d0bbcdd6672e8b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5867c0495ffcf54a8eaed6bd9aba065c83f244b415e88d91a90409814948de85f125d35c2afbd80540a19975c8f5d1f0860540d0337b6c8966ff65c377d2bab"} build_url:https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/DmOUqfT5QfqiXzH8KK_TFg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c85622150aec04264bd6821a6942796e307aaad7efb2279a7c724a99a11226ad77f821cc9f614600a862dce5acb4cdc142ee4859d79f434a7a7adb80ba1a76b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4def65a8da670d4a87e3f3c397a274407af1ef1d7fbdcfd86f707ee671d5d80a083e62e96cdf28ff4d72aac547b2f39b1104d168c6cd582f68df7f046bca7eda", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5095405ad2771f222c762f97c9ad45c1b79da13aa1d65941017c26a46c78eabb66c10964b96f8bda55a221ce5f012d31f2bb635a67ece39d3d0bbcdd6672e8b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5867c0495ffcf54a8eaed6bd9aba065c83f244b415e88d91a90409814948de85f125d35c2afbd80540a19975c8f5d1f0860540d0337b6c8966ff65c377d2bab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 12:29:32.119870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:29:32.120189) ========= 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=232498196343f89f466a4a9a000001c8-1496257353.305364-495468115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 12:29:32.200216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 12:29:32.203541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 12:29:32.203864) ========= ========= Total master_lag: 0.28 =========