builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1496418065.14 results: success (0) revision: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.137019) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.137542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.137820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.191054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.191433) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 08:41:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.6M=0.001s 2017-06-02 08:41:05 (21.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.197026 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.440230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.440603) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016786 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:05.490736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:41:05.491081) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 95d2d23ff510bea680e9707c1ec166b0cc08dc6b --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 95d2d23ff510bea680e9707c1ec166b0cc08dc6b --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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 08:41:05,529 truncating revision to first 12 chars 2017-06-02 08:41:05,529 Setting DEBUG logging. 2017-06-02 08:41:05,529 attempt 1/10 2017-06-02 08:41:05,529 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/95d2d23ff510?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 08:41:06,505 unpacking tar archive at: mozilla-central-95d2d23ff510/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:41:06.834692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:06.838117) ========= script_repo_revision: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:06.838709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:06.838980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:41:06.848902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-02 08:41:06.849305) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:07 INFO - MultiFileLogger online at 20170602 08:41:07 in /builds/slave/test 08:41:07 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 08:41:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:07 INFO - {'append_to_log': False, 08:41:07 INFO - 'base_work_dir': '/builds/slave/test', 08:41:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:41:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:07 INFO - 'branch': 'Firefox-Non-PGO', 08:41:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:07 INFO - 'config_files': ('talos/linux_config.py',), 08:41:07 INFO - 'default_actions': ('clobber', 08:41:07 INFO - 'read-buildbot-config', 08:41:07 INFO - 'download-and-extract', 08:41:07 INFO - 'populate-webroot', 08:41:07 INFO - 'create-virtualenv', 08:41:07 INFO - 'install', 08:41:07 INFO - 'setup-mitmproxy', 08:41:07 INFO - 'run-tests'), 08:41:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:07 INFO - 'download_minidump_stackwalk': True, 08:41:07 INFO - 'download_symbols': 'ondemand', 08:41:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:07 INFO - 'gecko_profile': False, 08:41:07 INFO - 'gecko_profile_interval': 0, 08:41:07 INFO - 'installer_path': 'installer.exe', 08:41:07 INFO - 'log_level': 'info', 08:41:07 INFO - 'log_name': 'talos', 08:41:07 INFO - 'log_to_console': True, 08:41:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:07 INFO - 'opt_config_files': (), 08:41:07 INFO - 'pip_index': False, 08:41:07 INFO - 'suite': 'dromaeojs-e10s', 08:41:07 INFO - 'system_bits': '32', 08:41:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:07 INFO - 'title': 'talos-linux64-ix-034', 08:41:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:07 INFO - 'use_talos_json': True, 08:41:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:07 INFO - 'work_dir': 'build'} 08:41:07 INFO - [mozharness: 2017-06-02 15:41:07.096268Z] Running clobber step. 08:41:07 INFO - Running pre-action listener: _resource_record_pre_action 08:41:07 INFO - Running main action method: clobber 08:41:07 INFO - rmtree: /builds/slave/test/build 08:41:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:08 INFO - Running post-action listener: _resource_record_post_action 08:41:08 INFO - [mozharness: 2017-06-02 15:41:08.073149Z] Finished clobber step (success) 08:41:08 INFO - [mozharness: 2017-06-02 15:41:08.073250Z] Running read-buildbot-config step. 08:41:08 INFO - Running pre-action listener: _resource_record_pre_action 08:41:08 INFO - Running main action method: read_buildbot_config 08:41:08 INFO - Using buildbot properties: 08:41:08 INFO - { 08:41:08 INFO - "project": "", 08:41:08 INFO - "product": "firefox", 08:41:08 INFO - "who": "ryanvm@gmail.com", 08:41:08 INFO - "installer_path": "public/build/target.tar.bz2", 08:41:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:41:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:41:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:41:08 INFO - "stage_platform": "linux64", 08:41:08 INFO - "basedir": "/builds/slave/test", 08:41:08 INFO - "buildnumber": 650, 08:41:08 INFO - "platform": "ubuntu64_hw", 08:41:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:41:08 INFO - "slavebuilddir": "test", 08:41:08 INFO - "taskId": "VHUCgTzlSUWrkvj4j6wV7g", 08:41:08 INFO - "branch": "mozilla-central", 08:41:08 INFO - "script_repo_revision": "production", 08:41:08 INFO - "revision": "95d2d23ff510bea680e9707c1ec166b0cc08dc6b", 08:41:08 INFO - "slavename": "talos-linux64-ix-034", 08:41:08 INFO - "repo_path": "mozilla-central" 08:41:08 INFO - } 08:41:08 INFO - Finding installer, test and symbols from parent task. 08:41:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHUCgTzlSUWrkvj4j6wV7g'}, attempt #1 08:41:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHUCgTzlSUWrkvj4j6wV7g'}, attempt #1 08:41:09 INFO - Task dependencies: IR6ZZSWGSGCRwSsBlYq1KQ 08:41:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ'}, attempt #1 08:41:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 08:41:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/test_packages.json 08:41:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.crashreporter-symbols.zip 08:41:09 INFO - Running post-action listener: _resource_record_post_action 08:41:09 INFO - [mozharness: 2017-06-02 15:41:09.446842Z] Finished read-buildbot-config step (success) 08:41:09 INFO - [mozharness: 2017-06-02 15:41:09.447061Z] Running download-and-extract step. 08:41:09 INFO - Running pre-action listener: _resource_record_pre_action 08:41:09 INFO - Running main action method: download_and_extract 08:41:09 INFO - mkdir: /builds/slave/test/build/tests 08:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:09 INFO - trying https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.test_packages.json 08:41:09 INFO - Downloading https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:41:10 INFO - Downloaded 989 bytes. 08:41:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:41:10 INFO - Using the following test package requirements: 08:41:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:41:10 INFO - u'common': [u'target.common.tests.zip'], 08:41:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:41:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:41:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:41:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:41:10 INFO - u'mozbase': [u'target.common.tests.zip'], 08:41:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:41:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:41:10 INFO - u'web-platform': [u'target.common.tests.zip', 08:41:10 INFO - u'target.web-platform.tests.tar.gz'], 08:41:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:41:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:41:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip 08:41:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:41:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip into memory 08:41:11 INFO - Content-Length response header: 65107252 08:41:11 INFO - Bytes received: 65107252 08:41:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:41:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip 08:41:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:41:22 INFO - Fetch https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.common.tests.zip into memory 08:41:23 INFO - Content-Length response header: 65107252 08:41:23 INFO - Bytes received: 65107252 08:41:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.talos.tests.zip 08:41:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:41:35 INFO - Fetch https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.talos.tests.zip into memory 08:41:36 INFO - Content-Length response header: 14447425 08:41:36 INFO - Bytes received: 14447425 08:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:36 INFO - trying https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 08:41:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:41:37 INFO - Downloaded 58582957 bytes. 08:41:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 08:41:37 INFO - mkdir: /builds/slave/test/properties 08:41:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:37 INFO - Contents: 08:41:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 08:41:37 INFO - Running post-action listener: _resource_record_post_action 08:41:37 INFO - Running post-action listener: set_extra_try_arguments 08:41:37 INFO - [mozharness: 2017-06-02 15:41:37.755713Z] Finished download-and-extract step (success) 08:41:37 INFO - [mozharness: 2017-06-02 15:41:37.755810Z] Running populate-webroot step. 08:41:37 INFO - Running pre-action listener: _resource_record_pre_action 08:41:37 INFO - Running main action method: populate_webroot 08:41:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:37 INFO - '--tppagecycles', 08:41:37 INFO - '7'], 08:41:37 INFO - 'tests': ['tsvgm']}}, 08:41:37 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['damp', 'tps']}, 08:41:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'tests': ['damp', 'tps']}, 08:41:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['dromaeo_dom']}, 08:41:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:41:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:41:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:41:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['a11yr', 08:41:37 INFO - 'ts_paint', 08:41:37 INFO - 'tpaint', 08:41:37 INFO - 'sessionrestore', 08:41:37 INFO - 'sessionrestore_no_auto_restore', 08:41:37 INFO - 'tabpaint']}, 08:41:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:41:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:41:37 INFO - 'bloom_basic_ref']}, 08:41:37 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:41:37 INFO - 'talos_options': ['--mitmproxy', 08:41:37 INFO - 'mitmproxy-recording-1.mp', 08:41:37 INFO - '--firstNonBlankPaint'], 08:41:37 INFO - 'tests': ['Quantum_1']}, 08:41:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['tsvgx', 08:41:37 INFO - 'tsvgr_opacity', 08:41:37 INFO - 'tart', 08:41:37 INFO - 'tscrollx', 08:41:37 INFO - 'cart', 08:41:37 INFO - 'tsvg_static']}, 08:41:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:37 INFO - 'tsvgr_opacity', 08:41:37 INFO - 'tart', 08:41:37 INFO - 'tscrollx', 08:41:37 INFO - 'cart', 08:41:37 INFO - 'tsvg_static']}, 08:41:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'talos_options': ['--disable-e10s'], 08:41:37 INFO - 'tests': ['tp5o']}, 08:41:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:41:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'talos_options': ['--disable-e10s', 08:41:37 INFO - '--xperf_path', 08:41:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:37 INFO - 'tests': ['tp5n']}, 08:41:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:41:37 INFO - 'talos_options': ['--xperf_path', 08:41:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:37 INFO - 'tests': ['tp5n']}}, 08:41:37 INFO - 'talos.zip': {'path': '', 08:41:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:37 INFO - Running post-action listener: _resource_record_post_action 08:41:37 INFO - [mozharness: 2017-06-02 15:41:37.770120Z] Finished populate-webroot step (success) 08:41:37 INFO - [mozharness: 2017-06-02 15:41:37.770214Z] Running create-virtualenv step. 08:41:37 INFO - Running pre-action listener: _resource_record_pre_action 08:41:37 INFO - Running main action method: create_virtualenv 08:41:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:37 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 08:41:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:41:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:37 INFO - Using real prefix '/usr' 08:41:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:40 INFO - Installing pip.................done. 08:41:40 INFO - Return code: 0 08:41:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:41:40 INFO - Reading from file tmpfile_stdout 08:41:40 INFO - Output received: 08:41:40 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) 08:41:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:40 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:40 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 08:41:40 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 08:41:40 INFO - Using env: {'DISPLAY': ':0', 08:41:40 INFO - 'HOME': '/home/cltbld', 08:41:40 INFO - 'LANG': 'en_US.UTF-8', 08:41:40 INFO - 'LANGUAGE': 'en_US:en', 08:41:40 INFO - 'LOGNAME': 'cltbld', 08:41:40 INFO - 'MAIL': '/var/mail/cltbld', 08:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:40 INFO - 'MOZ_NO_REMOTE': '1', 08:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:40 INFO - 'NO_EM_RESTART': '1', 08:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:40 INFO - 'PWD': '/builds/slave/test', 08:41:40 INFO - 'SHELL': '/bin/bash', 08:41:40 INFO - 'SHLVL': '1', 08:41:40 INFO - 'TERM': 'linux', 08:41:40 INFO - 'TMOUT': '86400', 08:41:40 INFO - 'USER': 'cltbld', 08:41:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:40 INFO - '_': '/tools/buildbot/bin/python'} 08:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:40 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 08:41:40 INFO - Cleaning up... 08:41:40 INFO - Return code: 0 08:41:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:41 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:41 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 08:41:41 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 08:41:41 INFO - Using env: {'DISPLAY': ':0', 08:41:41 INFO - 'HOME': '/home/cltbld', 08:41:41 INFO - 'LANG': 'en_US.UTF-8', 08:41:41 INFO - 'LANGUAGE': 'en_US:en', 08:41:41 INFO - 'LOGNAME': 'cltbld', 08:41:41 INFO - 'MAIL': '/var/mail/cltbld', 08:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:41 INFO - 'MOZ_NO_REMOTE': '1', 08:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:41 INFO - 'NO_EM_RESTART': '1', 08:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:41 INFO - 'PWD': '/builds/slave/test', 08:41:41 INFO - 'SHELL': '/bin/bash', 08:41:41 INFO - 'SHLVL': '1', 08:41:41 INFO - 'TERM': 'linux', 08:41:41 INFO - 'TMOUT': '86400', 08:41:41 INFO - 'USER': 'cltbld', 08:41:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:41 INFO - '_': '/tools/buildbot/bin/python'} 08:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:41 INFO - Downloading/unpacking psutil>=3.1.1 08:41:41 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 08:41:41 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 08:41:41 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 08:41:41 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 08:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:42 INFO - Installing collected packages: psutil 08:41:42 INFO - Running setup.py install for psutil 08:41:42 INFO - building 'psutil._psutil_linux' extension 08:41:42 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 08:41:43 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 08:41:43 INFO - building 'psutil._psutil_posix' extension 08:41:43 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 08:41:43 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 08:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:43 INFO - Successfully installed psutil 08:41:43 INFO - Cleaning up... 08:41:43 INFO - Return code: 0 08:41:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41: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')]} 08:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:43 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:43 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 08:41:43 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 08:41:43 INFO - Using env: {'DISPLAY': ':0', 08:41:43 INFO - 'HOME': '/home/cltbld', 08:41:43 INFO - 'LANG': 'en_US.UTF-8', 08:41:43 INFO - 'LANGUAGE': 'en_US:en', 08:41:43 INFO - 'LOGNAME': 'cltbld', 08:41:43 INFO - 'MAIL': '/var/mail/cltbld', 08:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:43 INFO - 'MOZ_NO_REMOTE': '1', 08:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:43 INFO - 'NO_EM_RESTART': '1', 08:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:43 INFO - 'PWD': '/builds/slave/test', 08:41:43 INFO - 'SHELL': '/bin/bash', 08:41:43 INFO - 'SHLVL': '1', 08:41:43 INFO - 'TERM': 'linux', 08:41:43 INFO - 'TMOUT': '86400', 08:41:43 INFO - 'USER': 'cltbld', 08:41:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:43 INFO - '_': '/tools/buildbot/bin/python'} 08:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:45 INFO - Installing collected packages: mozsystemmonitor 08:41:45 INFO - Running setup.py install for mozsystemmonitor 08:41:45 INFO - Successfully installed mozsystemmonitor 08:41:45 INFO - Cleaning up... 08:41:45 INFO - Return code: 0 08:41:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:45 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')]} 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:45 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')]} 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:45 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:45 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 08:41:45 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 08:41:45 INFO - Using env: {'DISPLAY': ':0', 08:41:45 INFO - 'HOME': '/home/cltbld', 08:41:45 INFO - 'LANG': 'en_US.UTF-8', 08:41:45 INFO - 'LANGUAGE': 'en_US:en', 08:41:45 INFO - 'LOGNAME': 'cltbld', 08:41:45 INFO - 'MAIL': '/var/mail/cltbld', 08:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:45 INFO - 'MOZ_NO_REMOTE': '1', 08:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:45 INFO - 'NO_EM_RESTART': '1', 08:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:45 INFO - 'PWD': '/builds/slave/test', 08:41:45 INFO - 'SHELL': '/bin/bash', 08:41:45 INFO - 'SHLVL': '1', 08:41:45 INFO - 'TERM': 'linux', 08:41:45 INFO - 'TMOUT': '86400', 08:41:45 INFO - 'USER': 'cltbld', 08:41:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:45 INFO - '_': '/tools/buildbot/bin/python'} 08:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:45 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 08:41:45 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 08:41:45 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 08:41:45 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 08:41:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:46 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 08:41:46 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 08:41:46 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 08:41:46 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 08:41:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:46 INFO - warning: no files found matching '*.txt' 08:41:46 INFO - no previously-included directories found matching 'build' 08:41:46 INFO - no previously-included directories found matching 'dist' 08:41:46 INFO - no previously-included directories found matching '.git*' 08:41:46 INFO - Installing collected packages: jsonschema, functools32 08:41:46 INFO - Running setup.py install for functools32 08:41:47 INFO - warning: no files found matching '*.txt' 08:41:47 INFO - no previously-included directories found matching 'build' 08:41:47 INFO - no previously-included directories found matching 'dist' 08:41:47 INFO - no previously-included directories found matching '.git*' 08:41:47 INFO - Successfully installed jsonschema functools32 08:41:47 INFO - Cleaning up... 08:41:47 INFO - Return code: 0 08:41:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:47 INFO - Using env: {'DISPLAY': ':0', 08:41:47 INFO - 'HOME': '/home/cltbld', 08:41:47 INFO - 'LANG': 'en_US.UTF-8', 08:41:47 INFO - 'LANGUAGE': 'en_US:en', 08:41:47 INFO - 'LOGNAME': 'cltbld', 08:41:47 INFO - 'MAIL': '/var/mail/cltbld', 08:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:47 INFO - 'MOZ_NO_REMOTE': '1', 08:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:47 INFO - 'NO_EM_RESTART': '1', 08:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:47 INFO - 'PWD': '/builds/slave/test', 08:41:47 INFO - 'SHELL': '/bin/bash', 08:41:47 INFO - 'SHLVL': '1', 08:41:47 INFO - 'TERM': 'linux', 08:41:47 INFO - 'TMOUT': '86400', 08:41:47 INFO - 'USER': 'cltbld', 08:41:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:47 INFO - '_': '/tools/buildbot/bin/python'} 08:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:47 INFO - Cleaning up... 08:41:47 INFO - Return code: 0 08:41:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:47 INFO - Using env: {'DISPLAY': ':0', 08:41:47 INFO - 'HOME': '/home/cltbld', 08:41:47 INFO - 'LANG': 'en_US.UTF-8', 08:41:47 INFO - 'LANGUAGE': 'en_US:en', 08:41:47 INFO - 'LOGNAME': 'cltbld', 08:41:47 INFO - 'MAIL': '/var/mail/cltbld', 08:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:47 INFO - 'MOZ_NO_REMOTE': '1', 08:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:47 INFO - 'NO_EM_RESTART': '1', 08:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:47 INFO - 'PWD': '/builds/slave/test', 08:41:47 INFO - 'SHELL': '/bin/bash', 08:41:47 INFO - 'SHLVL': '1', 08:41:47 INFO - 'TERM': 'linux', 08:41:47 INFO - 'TMOUT': '86400', 08:41:47 INFO - 'USER': 'cltbld', 08:41:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:47 INFO - '_': '/tools/buildbot/bin/python'} 08:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:49 INFO - Downloading docopt-0.6.1.tar.gz 08:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:49 INFO - Running setup.py install for blobuploader 08:41:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:49 INFO - Running setup.py install for requests 08:41:49 INFO - Running setup.py install for docopt 08:41:49 INFO - Successfully installed blobuploader requests docopt 08:41:49 INFO - Cleaning up... 08:41:49 INFO - Return code: 0 08:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:49 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:49 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 08:41:49 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 08:41:49 INFO - Using env: {'DISPLAY': ':0', 08:41:49 INFO - 'HOME': '/home/cltbld', 08:41:49 INFO - 'LANG': 'en_US.UTF-8', 08:41:49 INFO - 'LANGUAGE': 'en_US:en', 08:41:49 INFO - 'LOGNAME': 'cltbld', 08:41:49 INFO - 'MAIL': '/var/mail/cltbld', 08:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:49 INFO - 'MOZ_NO_REMOTE': '1', 08:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:49 INFO - 'NO_EM_RESTART': '1', 08:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:49 INFO - 'PWD': '/builds/slave/test', 08:41:49 INFO - 'SHELL': '/bin/bash', 08:41:49 INFO - 'SHLVL': '1', 08:41:49 INFO - 'TERM': 'linux', 08:41:49 INFO - 'TMOUT': '86400', 08:41:49 INFO - 'USER': 'cltbld', 08:41:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:49 INFO - '_': '/tools/buildbot/bin/python'} 08:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:49 INFO - Running setup.py (path:/tmp/pip-pCYkH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:50 INFO - Running setup.py (path:/tmp/pip-m6CFnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:50 INFO - Running setup.py (path:/tmp/pip-VYBnms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:50 INFO - Running setup.py (path:/tmp/pip-s91Noq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:50 INFO - Running setup.py (path:/tmp/pip-e1fPj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:50 INFO - Running setup.py (path:/tmp/pip-d0dBkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:50 INFO - Running setup.py (path:/tmp/pip-ZN5gZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:50 INFO - Running setup.py (path:/tmp/pip-XAyLom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:50 INFO - Running setup.py (path:/tmp/pip-_XxtEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:50 INFO - Running setup.py (path:/tmp/pip-HltNIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:50 INFO - Running setup.py (path:/tmp/pip-kalOYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:50 INFO - Running setup.py (path:/tmp/pip-EyY9mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:50 INFO - Running setup.py (path:/tmp/pip-Fe80AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:50 INFO - Running setup.py (path:/tmp/pip-_mQJ45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:51 INFO - Running setup.py (path:/tmp/pip-PQt8T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:51 INFO - Running setup.py (path:/tmp/pip-G5yqzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:51 INFO - Running setup.py (path:/tmp/pip-gRHouG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:51 INFO - Running setup.py install for manifestparser 08:41:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Running setup.py install for mozcrash 08:41:51 INFO - Running setup.py install for mozdebug 08:41:51 INFO - Running setup.py install for mozdevice 08:41:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Running setup.py install for mozfile 08:41:51 INFO - Running setup.py install for mozhttpd 08:41:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Running setup.py install for mozinfo 08:41:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Running setup.py install for mozInstall 08:41:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Running setup.py install for mozleak 08:41:52 INFO - Running setup.py install for mozlog 08:41:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Running setup.py install for moznetwork 08:41:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Running setup.py install for mozprocess 08:41:52 INFO - Running setup.py install for mozprofile 08:41:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Running setup.py install for mozrunner 08:41:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Running setup.py install for mozscreenshot 08:41:52 INFO - Running setup.py install for moztest 08:41:52 INFO - Running setup.py install for mozversion 08:41:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:52 INFO - Cleaning up... 08:41:52 INFO - Return code: 0 08:41:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:52 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')]} 08:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:52 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')]} 08:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:52 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:52 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 08:41:52 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 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:53 INFO - Running setup.py (path:/tmp/pip-3yNnr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:53 INFO - Running setup.py (path:/tmp/pip-y3O_dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:53 INFO - Running setup.py (path:/tmp/pip-AaIKQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:53 INFO - Running setup.py (path:/tmp/pip-XuCgDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:53 INFO - Running setup.py (path:/tmp/pip-OEwczQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:53 INFO - Running setup.py (path:/tmp/pip-gCBviY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:53 INFO - Running setup.py (path:/tmp/pip-XyfE_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:53 INFO - Running setup.py (path:/tmp/pip-rhy_gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:53 INFO - Running setup.py (path:/tmp/pip-eQT79A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:53 INFO - Running setup.py (path:/tmp/pip-7_5qYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:53 INFO - Running setup.py (path:/tmp/pip-QxELfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:53 INFO - Running setup.py (path:/tmp/pip-rZevkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:54 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)) 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:54 INFO - Running setup.py (path:/tmp/pip-XYPSaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:54 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)) 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:54 INFO - Running setup.py (path:/tmp/pip-1_4SpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:54 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)) 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:54 INFO - Running setup.py (path:/tmp/pip-HMjIKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:54 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)) 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:54 INFO - Running setup.py (path:/tmp/pip-Aj_lQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:54 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)) 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:54 INFO - Running setup.py (path:/tmp/pip-83XscE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:54 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)) 08:41:54 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)) 08:41:54 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)) 08:41:54 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)) 08:41:54 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)) 08:41:54 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)) 08:41:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:54 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 08:41:54 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 08:41:54 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 08:41:54 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 08:41:55 INFO - Downloading blessings-1.6.tar.gz 08:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:55 INFO - Installing collected packages: blessings 08:41:55 INFO - Running setup.py install for blessings 08:41:55 INFO - Successfully installed blessings 08:41:55 INFO - Cleaning up... 08:41:55 INFO - Return code: 0 08:41:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:55 INFO - Reading from file tmpfile_stdout 08:41:55 INFO - Current package versions: 08:41:55 INFO - argparse == 1.2.1 08:41:55 INFO - blessings == 1.6 08:41:55 INFO - blobuploader == 1.2.4 08:41:55 INFO - docopt == 0.6.1 08:41:55 INFO - functools32 == 3.2.3-2 08:41:55 INFO - jsonschema == 2.5.1 08:41:55 INFO - manifestparser == 1.1 08:41:55 INFO - mozInstall == 1.12 08:41:55 INFO - mozcrash == 1.0 08:41:55 INFO - mozdebug == 0.1 08:41:55 INFO - mozdevice == 0.51 08:41:55 INFO - mozfile == 1.2 08:41:55 INFO - mozhttpd == 0.7 08:41:55 INFO - mozinfo == 0.9 08:41:55 INFO - mozleak == 0.1 08:41:55 INFO - mozlog == 3.4 08:41:55 INFO - moznetwork == 0.27 08:41:55 INFO - mozprocess == 0.25 08:41:55 INFO - mozprofile == 0.28 08:41:55 INFO - mozrunner == 6.13 08:41:55 INFO - mozscreenshot == 0.1 08:41:55 INFO - mozsystemmonitor == 0.3 08:41:55 INFO - moztest == 0.8 08:41:55 INFO - mozversion == 1.4 08:41:55 INFO - psutil == 3.1.1 08:41:55 INFO - requests == 1.2.3 08:41:55 INFO - wsgiref == 0.1.2 08:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:55 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')]} 08:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:55 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')]} 08:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:55 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:55 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 08:41:55 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 08:41:55 INFO - Using env: {'DISPLAY': ':0', 08:41:55 INFO - 'HOME': '/home/cltbld', 08:41:55 INFO - 'LANG': 'en_US.UTF-8', 08:41:55 INFO - 'LANGUAGE': 'en_US:en', 08:41:55 INFO - 'LOGNAME': 'cltbld', 08:41:55 INFO - 'MAIL': '/var/mail/cltbld', 08:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:55 INFO - 'MOZ_NO_REMOTE': '1', 08:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:55 INFO - 'NO_EM_RESTART': '1', 08:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:55 INFO - 'PWD': '/builds/slave/test', 08:41:55 INFO - 'SHELL': '/bin/bash', 08:41:55 INFO - 'SHLVL': '1', 08:41:55 INFO - 'TERM': 'linux', 08:41:55 INFO - 'TMOUT': '86400', 08:41:55 INFO - 'USER': 'cltbld', 08:41:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:55 INFO - '_': '/tools/buildbot/bin/python'} 08:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 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)) 08:41:56 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:57 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 INFO - Installing collected packages: marionette-driver 08:41:57 INFO - Running setup.py install for marionette-driver 08:41:57 INFO - Successfully installed marionette-driver 08:41:57 INFO - Cleaning up... 08:41:57 INFO - Return code: 0 08:41:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:57 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')]} 08:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:57 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')]} 08:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:57 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 0x9e73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', '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 08:41:57 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 08:41:57 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 08:41:57 INFO - Using env: {'DISPLAY': ':0', 08:41:57 INFO - 'HOME': '/home/cltbld', 08:41:57 INFO - 'LANG': 'en_US.UTF-8', 08:41:57 INFO - 'LANGUAGE': 'en_US:en', 08:41:57 INFO - 'LOGNAME': 'cltbld', 08:41:57 INFO - 'MAIL': '/var/mail/cltbld', 08:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:57 INFO - 'MOZ_NO_REMOTE': '1', 08:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:57 INFO - 'NO_EM_RESTART': '1', 08:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:57 INFO - 'PWD': '/builds/slave/test', 08:41:57 INFO - 'SHELL': '/bin/bash', 08:41:57 INFO - 'SHLVL': '1', 08:41:57 INFO - 'TERM': 'linux', 08:41:57 INFO - 'TMOUT': '86400', 08:41:57 INFO - 'USER': 'cltbld', 08:41:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:57 INFO - '_': '/tools/buildbot/bin/python'} 08:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:57 INFO - Cleaning up... 08:41:57 INFO - Return code: 0 08:41:57 INFO - Running post-action listener: _resource_record_post_action 08:41:57 INFO - Running post-action listener: _start_resource_monitoring 08:41:57 INFO - Starting resource monitoring. 08:41:57 INFO - [mozharness: 2017-06-02 15:41:57.788972Z] Finished create-virtualenv step (success) 08:41:57 INFO - [mozharness: 2017-06-02 15:41:57.789477Z] Running install step. 08:41:57 INFO - Running pre-action listener: _resource_record_pre_action 08:41:57 INFO - Running main action method: install 08:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:58 INFO - Reading from file tmpfile_stdout 08:41:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:58 INFO - Reading from file tmpfile_stdout 08:41:58 INFO - Output received: 08:41:58 INFO - Usage: mozinstall [options] installer 08:41:58 INFO - Options: 08:41:58 INFO - -h, --help show this help message and exit 08:41:58 INFO - -d DEST, --destination=DEST 08:41:58 INFO - Directory to install application into. [default: 08:41:58 INFO - "/builds/slave/test"] 08:41:58 INFO - --app=APP Application being installed. [default: firefox] 08:41:58 INFO - mkdir: /builds/slave/test/build/application 08:41:58 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'] 08:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:42:15 INFO - Reading from file tmpfile_stdout 08:42:15 INFO - Output received: 08:42:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:15 INFO - Running post-action listener: _resource_record_post_action 08:42:15 INFO - [mozharness: 2017-06-02 15:42:15.041166Z] Finished install step (success) 08:42:15 INFO - [mozharness: 2017-06-02 15:42:15.041514Z] Running setup-mitmproxy step. 08:42:15 INFO - Running pre-action listener: _resource_record_pre_action 08:42:15 INFO - Running main action method: setup_mitmproxy 08:42:15 INFO - Skipping: mitmproxy is not required 08:42:15 INFO - Running post-action listener: _resource_record_post_action 08:42:15 INFO - [mozharness: 2017-06-02 15:42:15.042646Z] Finished setup-mitmproxy step (success) 08:42:15 INFO - [mozharness: 2017-06-02 15:42:15.042868Z] Running run-tests step. 08:42:15 INFO - Running pre-action listener: _resource_record_pre_action 08:42:15 INFO - Running main action method: run_tests 08:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:15 INFO - Python 2.7.3 08:42:15 INFO - Return code: 0 08:42:15 INFO - grabbing minidump binary from tooltool 08:42: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')]} 08:42:15 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 0xd62840>, '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 0xd63740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd63bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:15 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 08:42:15 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 08:42:15 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 08:42:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:15 INFO - Return code: 0 08:42:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:15 INFO - ENV: RUST_BACKTRACE is now 1 08:42:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:15 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/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:42:15 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/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 08:42:15 INFO - Using env: {'DISPLAY': ':0', 08:42:15 INFO - 'HOME': '/home/cltbld', 08:42:15 INFO - 'LANG': 'en_US.UTF-8', 08:42:15 INFO - 'LANGUAGE': 'en_US:en', 08:42:15 INFO - 'LOGNAME': 'cltbld', 08:42:15 INFO - 'MAIL': '/var/mail/cltbld', 08:42:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:15 INFO - 'MOZ_NO_REMOTE': '1', 08:42:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:15 INFO - 'NO_EM_RESTART': '1', 08:42:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:15 INFO - 'PWD': '/builds/slave/test', 08:42:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:15 INFO - 'RUST_BACKTRACE': '1', 08:42:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:42:15 INFO - 'SHELL': '/bin/bash', 08:42:15 INFO - 'SHLVL': '1', 08:42:15 INFO - 'TERM': 'linux', 08:42:15 INFO - 'TMOUT': '86400', 08:42:15 INFO - 'USER': 'cltbld', 08:42:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845', 08:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:15 INFO - '_': '/tools/buildbot/bin/python'} 08:42:15 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/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:42:15 INFO - mozversion application_buildid: 20170602151012 08:42:15 INFO - mozversion application_changeset: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b 08:42:15 INFO - mozversion application_display_name: Nightly 08:42:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:15 INFO - mozversion application_name: Firefox 08:42:15 INFO - mozversion application_remotingname: firefox 08:42:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:42:15 INFO - mozversion application_vendor: Mozilla 08:42:15 INFO - mozversion application_version: 55.0a1 08:42:15 INFO - mozversion platform_buildid: 20170602151012 08:42:15 INFO - mozversion platform_changeset: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b 08:42:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:42:15 INFO - mozversion platform_version: 55.0a1 08:42:15 INFO - using testdate: 1496418135 08:42:15 INFO - actual date: 1496418135 08:42:15 INFO - starting webserver on 'localhost:51347' 08:42:15 INFO - SUITE-START | Running 2 tests 08:42:15 INFO - TEST-START | dromaeo_css 08:42:15 INFO - operating with platform_type : linux_ 08:42:15 INFO - Initialising browser for dromaeo_css test... 08:42:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51347/getInfo.html -profile /tmp/tmpKm6HNU/profile 08:42:15 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox http://localhost:51347/getInfo.html) 08:42:53 INFO - TEST-INFO | 3322: killed by SIGTERM 08:42:53 INFO - Browser initialized. 08:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:53 INFO - TEST-INFO | started process 3530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKm6HNU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:05 INFO - PID 3530 | RSS: Main: 188276736 08:43:05 INFO - PID 3530 | 08:46:06 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51347/tests/dromaeo/cssquery-ext.html) 08:46:08 INFO - PID 3530 | RSS: Main: 183259136 08:46:08 INFO - PID 3530 | 08:49:10 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-ext.html (next: http://localhost:51347/tests/dromaeo/cssquery-jquery.html) 08:49:10 INFO - PID 3530 | RSS: Main: 188997632 08:49:10 INFO - PID 3530 | 08:52:12 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51347/tests/dromaeo/cssquery-mootools.html) 08:52:13 INFO - PID 3530 | RSS: Main: 187777024 08:52:13 INFO - PID 3530 | 08:55:14 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51347/tests/dromaeo/cssquery-prototype.html) 08:55:15 INFO - PID 3530 | RSS: Main: 190009344 08:55:15 INFO - PID 3530 | 08:58:18 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51347/tests/dromaeo/cssquery-yui.html) 08:58:18 INFO - PID 3530 | RSS: Main: 190763008 08:58:18 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:51347/tests/dromaeo/cssquery-yui.html (next: http://localhost:51347/tests/dromaeo/cssquery-dojo.html) 09:01:20 INFO - PID 3530 | RSS: Main: 188198912 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | __start_tp_report 09:01:20 INFO - PID 3530 | _x_x_mozilla_page_load 09:01:20 INFO - PID 3530 | _x_x_mozilla_page_load_details 09:01:20 INFO - PID 3530 | |i|pagename|runs| 09:01:20 INFO - PID 3530 | |0;dojo.html;3121.9375612487747;3153.80907179811;3173.9047828565153;3179.6661350558193;3191.441497737895;5890.64656120633;5976.551758618105;6011.54913381497;6024.186734790802;6045.183900173475;5919.911201331973;5968.910466342997;5976.5517586180995;6035.668038257894;6129.570930034888;5428;5513.751881165347;5537.252470916435;5558.416366281543;5597.160425936101;5598.972005139989;5610.382857885629;5611.8597035074245;5627.549796016329;5661.094224923992;5436.836894893159;5499.50504454601;5517.117261238182;5555.388907220223;5591.608587398884;5560.026995275851;5565.2486914266465;5567.248421463091;5569.331680198362;5593.468620481048;5518.751656175482;5525.668459892419;5527.309086364205;5530.2810634617645;5533.612647114704;6004.909926351108;6018.398160183947;6027.578069535134;6032.97439435297;6035.969820150871;6148.569600127993;6277.4664153547;6341.714622841983;6451.58064725796;6461.6446095464735;6495.447886929616;6539.182602174728;6541.313162117956;6547.836304092388;6561.704723287464;6035.7283922223605;6040.788572399989;6050.031994880798;6050.273967123973;6067.059605761114;6473.190851143607;6535.738570457129;6574.145361103026;6661.367170118831;6663.733450662016;6136.610985192662;6206.751729930843;6261.060840873905;6375.968120159462;6404.231492220963;6473.126127972758;6490.935090649127;6510.153680021662;6510.837229069217;6519.706613202417;6392.328805475451;6437.871242575216;6482.708278127496;6485.059666348353;6496.35036496356;6287.528435367366;6381.425671689571;6391.776287829996;6504.121943537656;6518.315576864456;5343.599230057761;5344.225087362311;5354.625176237704;5390.487903649226;5400.945990540123;4536.251518499476;4539.7049191802425;4556.088782243564;4581.106684196549;4585.1746685596245;5554.6944918029085;5630.493255607015;5690.2887139107615;5699.487046165865;5709;6361.872762544724;6480.351964803482;6509.544331896816;6514.902276465857;6520.608763474112;5658.151277308437;5665.3768085510565;5691.800786972436;5698.601097923106;5705.74324155414;5691.203231547586;5747.051736463521;5764.164196191613;5797.188393624896;5797.246357973437;6145.385461453819;6198.256209254918;6199.907001395073;6243.250809902841;6283.277423096402;6480.189976252968;6520.771772987922;6525.477961762953;6545.901811472927;6566.8358291043105;6353.523485738496;6356.3325850785;6361.681915904279;6369.713362898773;6370.745170193326;6159.6612186330185;6243.531735119975;6263.74945002213;6367.649779262185;6403.6798160090875;6543.411093001652;6575.80272591823;6582.605043697394;6584.473242140713;6588.472922166119;6107.037103281039;6161.137440758387;6335.303116657072;6355.110284560073;6355.650439225887;6165.290991536031;6326.051092336186;6348.587341822767;6360.93639063622;6371.776987805404;6144.53915956314;6150.384961503813;6157.507399407947;6270.404311590391;6281.12064311006;6413.454856337264;6414.935850641434;6418.4544313731985;6431.678416079271;6454.709538070704;6216.378362163748;6220.284667263322;6233.376662333912;6248.718807653576;6251.624902505682 09:01:20 INFO - PID 3530 | |1;ext.html;693.9340762627548;724.7608289264541;737.8192342875994;988.7231575158958;999.9250056245775;36310;37392;37753.39315619769;37761.62238377616;37762.43356349657;39327.80336098323;39347.40978885312;39633.80183099088;39692.40461393074;39754.403683944765;7266.781996540086;7374.778756637309;7502.287282708134;7503;7532.623368831564;7420.628968551551;7543.660535275926;7547.584882831442;7550.471466997313;7556;7505.1369092554505;7542.69829206831;7563.205863384348;7571.394288456938;7585.544867307979;7480.62596870157;7492.026036615205;7495;7517.135529414105;7523.924760752378;7377.963110184468;7386.630668466555;7400.740974065882;7420.85158296831;7423.591702456362;34197.487037694205;34453.48319775205;34462.31075378504;34519.13702157441;34563.30873382543;3457.3949558827358;3469.9479507807405;3494.5981212160673;3494.877679281238;3520.9471857921894;27317;27473;27609.447811043665;27657.723422765717;27725.445491090064;3566.1619519412916;3566.1797786509246;3572.678458938682;3580.3555360035184;3591.299696559172;160539.19730401272;160662;161002.1949890243;168009;174877.12561437237;43093.78453107777;43358.349624755654;43466;43758.34362484565;43790.56209437929;43996;44889;44903;45498;45880.3117953231;13500.257485838372;13640.317984100953;13703.657408564866;13760;13796.379162937692;10913.072388846878;10956.34261944286;10999.945000274947;11029.393383363831;11037.172212083966;13900.16599004063;13931.721365572632;13958.441662333596;13962.511312104027;13984;5835.708214589338;5918.822435326947;5926.288845338587;5960.642361458326;5966.284045914431;977.5112443778111;1017.0693815159194;1028.6091285311534;1029.7322696098918;1035.6582327831798;23331.76668233296;24506.264812055666;24595.039356028185;24633.71006981444;24731.129306656734;1097.412884106999;1102.614085070219;1110.2505808579176;1117.3910218930703;1128.8306753986967;12299.863103386731;13001.544945926848;13157.342132893316;13164;13220.074594778273;197038;197708;198653;198950;199070;48203.07187712522;48571.5142848574;48594;48642.67645206101;48762.268565971535;1388.4168649167375;1412.865777751112;1427.4290283886528;1437.9137251764928;1443.7256921184942;22119;22645.2074177403;23663.64504532468;23812.404689882893;23855.761442386047;35599.660050992556;35826;35977.82011089928;36024.27951441009;36034.63965360418;161335;161407;161792;162451;162998;33007.66992330046;33287.66849326;33384.49923251202;33387.499187512694;33401.33197336088;39765.80117099396;40490.79754601208;42183.36724949067;42533.57466425296;42727.78636106799;30266.24334391658;30816;31131.844340778152;31648.208794780316;33047;30239.546406803474;30553.23616909595;30555.388892221585;32130.67869321277;32162.839185804856;33358.66641333556;33835;34296;34496.65503345035;34544.82727586346;29678.851605741835;30170;30890.382192356476;30898.69101308958;30961.845190773904;22756;24032.51934961326;24384.756152438247;24403.755962440857;24496.75503245016 09:01:20 INFO - PID 3530 | |2;jquery.html;418.94972603287613;419.1039159131191;427.7861069465266;439.42435409613427;440.7641911577307;10854.077403420699;11312.37781921996;20355.1857925683;21059.68410473844;21202.78797212029;21583.136674533038;22382.21662241822;22478.213262535814;22561.09755609778;22594.54810903781;5822.243108395903;6025.758969641209;6040.546958978072;6046.7883624073165;6065.4844338231305;5896.410358964112;5903.586748927555;6004.42957918997;6011.669358185298;6572.047053177286;6532.3467653234775;6587.934120658804;6589.17635295588;6592.868142637144;6595.604263744167;6548.443382312509;6587.2095348558005;6591.0442985766795;6598.703058362361;6604.966975165094;6444.581102228387;6464.6767661617205;6466.838329041764;6473.320301368336;6486.935130648728;26183.607245891326;26448.73551264482;26590;26733.732662673512;27665;1950.5318723506257;1999.6300684373437;2001.2095222387075;2002.3092033248652;2003.8998050097437;17577.472675819747;17895.73156402655;17899.10504474771;17940.641187176185;17975.75303087114;2238.2501861876126;2302.5164715409783;2325.1513197682893;2338.380329212743;2364.47981444082;116264.41867790607;118902;119113;119434;119634.40182799117;18630;19222.711659325123;19869.503262418555;20444.79555204429;20578.691319630216;37696.62303376986;37806;37815.81092094577;37920.24159516794;38160;9573.852295409182;9694.224462043161;9718.902810971942;9797.902020979698;9885.110340069285;7718.652660630285;7728.4590078693955;7741.458097933203;7884.921150788418;7893.921060789318;7225.783226503213;7674.270944260286;7683.385329173652;7759.573223472763;10347.482625868677;2148.495103650641;2152.096119629728;2156.094440335032;2165.8483906126735;2304.9654255186188;920.1580553793204;934.6775362499926;975.673149494913;998.8501724741346;1018.9949050254701;18757.90621046886;18791.15439805212;19404.12681429339;19679.21283148658;19935;988.545269176187;994.3735446668697;1006.959721611142;1008.4151192308443;1016.1750334071294;10307;10524.842127367943;10666.093382062612;10675.306105103298;10826.079783218358;440850;449812;462756;467106;468891;101323;103534.48232758787;104906.47546762218;105357;106019.46990264999;1125.9662210133708;1154.088270266497;1165.3648761425043;1172.6364826903687;1174.5360582569838;16455.475615524792;16785.91607041957;17315.653686926442;17328.220230089424;17408.564785880455;44534.331985019606;46209;46842.76578617085;47387.76306118447;47452.52547474481;61667.383326166164;61918.0712289307;62315;62370;62442.375576245475;9385.906140938503;9732.805343893224;9866.654667086617;9893.406395616286;10004.799904001733;15547;16343;16385.59036024109;16523.091229982467;16550.917245414177;13616.18302901829;13928.373223204777;13991.16053036821;14104.506342278382;14250.358733857209;13003.349832508526;13086.411111499814;13123.212607243597;13258.53595124166;13385.263810490516;14284.714375706237;14378.137311761328;14382.496612618508;14513;14609.707805843611;9198.49408282551;9241.445513269226;9252.583633736633;9289.117533834275;9292.814143717223;13597.456101755819;13810.861891380957;14019.649508762363;14081.08472949255;14149.787753183504 09:01:20 INFO - PID 3530 | |3;mootools.html;1335.9265240411776;1352.9458821647136;1381.2610253514372;1390.3465371275504;1412.795144704018;10717.303375280611;11154.163437742181;11256.831147532794;11274.830877536844;11498.770024599504;11335.489902954367;11507.42462876855;11510.194286399956;11513.4818933148;11569.305841649486;2352.8117750579954;2404.146527982567;2411.0837881605053;2418.9153379631716;2424.0425032112307;2339.040993192791;2371.9525609487887;2377.8929948152377;2381.773731495505;2382.0828980842416;2302.2517681753498;2343;2350.330155905567;2351.9176828810996;2358.0685629176464;2188.6388745856916;2214.4685275533916;2221.0893533651206;2226.198568515333;2226.666000099982;2100.6113868934294;2206.2829580386438;2241.2491815241915;2259.5029093599383;2280.304507125326;10928.180386471047;11098.056665183469;11132;11138.276012059272;11139.610113645984;6049.606775559574;6257.217847769029;6266.216722909637;6322.620642761449;6330.905036424458;3631.1829838286176;3706.8331925063435;3779.8677046303524;3784.735068545203;3813.80930953454;1159.3913195572309;1182.3142577305143;1187.6971372300095;1194.068626471345;1210.1347536511437;15907.12510811905;15922.681546369124;16072.678546429006;16099.678006439923;16851.325946962228;5212.40057393397;5248.606354523426;5304.840854774363;5384.219288203189;5387;12108.757824843453;12232.633021009384;12232.877671223352;12235.510579576718;12264.938675306745;5933.110033495011;6086.056661217518;6094.146819445281;6094.421030002142;6095.634261944298;5624.887502250014;5676.914846277309;5687.687177205211;5740.397258287903;5785.1322301654245;4099.364598487239;4211.389348544505;4243.215005224043;4274.786260686953;4293.763842988666;1225.8957988571071;1252.1860790486076;1256.9937150314372;1271.0467149637773;1275.253976423784;827.3381294964125;847.737201467547;860.655737704923;871.2289623683087;887.8179973105498;6000.639961602318;6113.816585502442;6119.418655227835;6186.938130618726;6330.588511746814;609.2780055633999;612.5252928980076;624.2664868779166;629.5435809038502;633.8130251575705;3885.514310711161;4017.678585713136;4249.787510624456;4516.119356725473;4522.796474158671;14350.784738228935;14762.483313084205;14805.555833325017;14817.185054822088;14945.775813362809;13651.863481365257;14319.284035798377;14441.638959025899;14574.344154513072;14708.33812478441;7238.819029524304;8639.524826134622;8703.825923481494;8733.781655458537;8893.510856902803;6055.6063855849225;6883.242843287134;7111.43108551325;7118.537295075804;7331.193568707331;11929.642110736691;12114.333711645591;12118.272903625812;12257.387130643254;12272.631821045383;12258.816117758062;12278.938605307274;12446.813297800722;12515.56195533152;12529.937350313554;8728.345374097094;8776.078511756174;8782.560871956504;8793.736187914374;8838.734837954871;10215.284930054824;10389.220808439548;10579.682609521727;10592;10675.252732308974;8463.788405289917;8550.57247137653;8572.3999320047;8578.571071446278;8613.138686131337;8852.291816654524;8923.955380223317;8932.910670893209;9004.774880628036;9106.590203440728;7462.141853686896;7613.276738709814;7623.161452240138;7642.5032372895585;7694.07671079474;5885.529157667462;5943.197668314722;5956.5532585055425;5987.790427335022;6062.575619706578;6098.390160984043;6166.691665416622;6184.690765461799;6210.441060304594;6335.873282534231 09:01:20 INFO - PID 3530 | |4;prototype.html;380.7563159577871;392.7231301932138;397.21153510282085;400.0977795072112;403.9697022723296;6080.665563394012;6308.71610777515;6315.97888675624;6324.3991820776955;6372;5999.070144127667;6068.241469816273;6105.664188469633;6124.599793216089;6132.417420345071;4719.292106184065;4748.643851711118;4757.405324334458;4762.690425122356;4789.3294938708605;4740.194166991602;4764.547368000034;4767.213409787381;4779.187538118511;4789.568938795508;4741.988837088456;4743.810247590092;4754.263089221176;4754.809807607691;4766.189747742875;4757.429108507002;4759.762011899391;4761.8095276188915;4765.833195838129;4766.499517550659;4142.834286628531;4153.937690934638;4158.979205103955;4161;4168.687348448879;5964.343922168558;5991.370906054889;6018.368071352533;6020.819375418744;6039.158056792677;5453.454654534555;5456.727163641802;5457.727113644341;5467.125259958388;5475.397706252309;6406.743730250784;6414.4227019568;6417.1657684500715;6440.935590644081;6456.128422662928;4513.368128462018;4534.13851368239;4541.477730061019;4543.454785425737;4543.5002149763495;6490.6105633661655;6587.440067594261;6732.4950628703045;6871.587704737732;6969.7909062728195;4569.657275704336;4593.540645935446;4600.401947746772;4605.217113090783;4624.398828152386;4622.4684161321875;4631.397918270671;4663.650226233046;4685.742284174335;4689.320048593003;5251.0548101341365;5340;5348.866278343073;5370.3287089113865;5391.3799913009725;6466.385693359123;6540.836479087966;6547.377999090078;6552.770653027121;6557.606543607399;1603.7353836616828;1617.7411614141681;1618.8543031127256;1619.5222409389257;1622.691688579166;1041.354360296621;1055.1611468882256;1079.875814281352;1091.8908109189017;1094.0864378244096;5806.506446951972;5846.941530584725;5847.795327163529;5875.50058245054;5878.323992740804;6683.498737594603;6731.798046058626;6746.865062698718;6756.5608235465525;6777.762778302736;5796.362400135981;5804.796832110856;5817.825465236049;5844.912326315109;5864.618799778001;3549.9290014199573;3565.4651802229873;3575.73182011345;3609.4585812127866;3609.7112231021456;6548.9017664735065;6577.934220657732;6590.670466476657;6596.373344532261;6630.801075967729;6925.342092501204;6947.853604155359;6952.339527744856;6957.686904089328;6991.720331186797;6548.446106018657;6568.704408301638;6595.208574971034;6596.30738772422;6637.601743895285;6749.527533072835;6754.493412994143;6764.627945463047;6772;6775.525713200029;6658.167729033871;6709.865802683821;6713.482444083469;6738.393544580815;6743.460523158037;6187.690615469119;6512.413882750575;6547.574407663486;6566.080748695282;6621.834454138685;4600.504835928404;4612.570103267998;4621.191291524037;4633.4903160652975;4634.791434385528;6750.72997080131;6761.343470849673;6771.932280677327;6789.592624442549;6793.286704895915;6410.358964103552;6595.175603049619;6599.60402375859;6608.372204640552;6618.205815302194;6590.5716128451495;6593.340665933369;6619.238787539494;6636.170478690164;6643.667816609247;6452;6536.411722944958;6537.901931471127;6583.374579414948;6584.773461003978;6602.273749887412;6633.270340262471;6637.668116594247;6650.600963942179;6662.600243985376;6442.162518872704;6443.967780161257;6448.742050317935;6455.515231496688;6487.805365839033 09:01:20 INFO - PID 3530 | |5;yui.html;798.6685525506915;838.9328853691705;843.7679638099522;844.5692696724668;857.2627540315327;12441.813372799415;12889.484420623186;17236.913815430922;17685.55786105348;17701.911490442562;17525.7371139433;18277.451676449728;18304.908475457603;18379;18442.723359149622;901.8557030875062;949.9620015199419;951.8762560867112;958.3435346787438;958.9520523973808;945.2674177512414;969.5685419988108;972.9902700973006;974.6345120579782;975.2490582251662;1011.524583445783;1013.8327176015986;1015.1624909449697;1017.064300843226;1026.558579810681;1005.1606908231672;1012.9240306976969;1013.0477351289765;1015.5937624950005;1029.4595337447824;741.4068745003975;741.8850078237882;743.2938708227206;746.4774657739604;759.4531937005403;17744.645107097916;17848.55378615532;17941.461756147335;17997.640047198984;18109.366172184044;18028.459146225636;18206;18376.264949402008;18426.631467370713;18500.814991850042;14384.424623015067;14923.776143357858;15033.548993530212;15034.774478382833;15036.346001939888;3461.4115600348;3470.583529976394;3478.9130271743156;3482.5995010573856;3512.367773800715;96118.03881961231;96175.9999999993;96392.51803740936;98170;98729;13243.536476223286;13349.46602135923;13576.456941722417;13591.728165436636;13616.387262573207;25163.62254566183;26001.349966250997;26337.576115104916;26373.604395934075;26412.603810942852;7939.64271607779;7983.12185659577;8032.15662355456;8066.15305392937;8362.414630975894;3823.904402389907;3892.922141557153;3920.0199950012498;3925.823337949799;3937.9803100984886;4120.1553681495225;4142.1922725068325;4180.686448516373;4185.769782661922;4186.539480657125;862.7756783236404;873.1922971251566;914.401067300919;920.1948295241664;920.5949382271913;689.5621280486827;698.6471831724947;698.6576577477;715.1239731329081;718.1346477494607;10861.565537378574;11520.193586448868;12146.757064858653;12570.308633025272;12638.747225055447;685.715428097344;696.7282759723611;698.8532408194336;705.4497491956282;706.5372181221309;5316.0962636351915;5367.2485851980755;5418.349798024262;5527.115661494222;5607.607467477237;90109;94190.52904735433;94340;94793;95070.52464737633;80830;81016.18983810204;82616.58691706623;83106.58446707728;87137.20745358939;62257.68871155706;63700.681496592224;65630.34369656243;66890;69104.3089569108;10512.632057877938;11723.296602203895;11802.114841387101;11943.402829858645;11992.280463172237;28642.71357286484;29182.56226156652;29324;29397.265068372606;29872.10383688493;35376.46935295921;35453.290934181685;35639.465408019416;36304.81847590745;36684.81657591695;16651.50045498637;16753.91623041877;16907.91546042262;17000.404985825437;17263.3957811476;17967.191476383854;18072.548186295448;18691.532711682317;19530.511737206114;19689.409317720492;16417.83582164163;17428.651426971643;17802.37691680785;18038.729419058986;18073.45779626613;17453.912730436266;18200.81799182044;18252;18273.3604323848;18604.44186674402;17271.136443178042;17662.381816636356;17843.821561784214;18033.909830451288;18193.727094093334;11033.503492343025;11218.943905280421;11278.492467838803;11534.826977595176;11735.941320293345;13590.778328272398;14070.718585628434;14188.858111418755;14203.502877399242;14205.644858878612 09:01:20 INFO - PID 3530 | __end_tp_report 09:01:20 INFO - PID 3530 | __start_cc_report 09:01:20 INFO - PID 3530 | _x_x_mozilla_cycle_collect,365 09:01:20 INFO - PID 3530 | __end_cc_report 09:01:20 INFO - PID 3530 | __startTimestamp1496419280754__endTimestamp 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | ------- Summary: start ------- 09:01:20 INFO - PID 3530 | Number of tests: 6 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#0] dojo.html Cycles:165 Average:5970.24 Median:6159.66 stddev:673.13 (10.9%) stddev-sans-first:637.03 09:01:20 INFO - PID 3530 | Values: 3121.9 3153.8 3173.9 3179.7 3191.4 5890.6 5976.6 6011.5 6024.2 6045.2 5919.9 5968.9 5976.6 6035.7 6129.6 5428.0 5513.8 5537.3 5558.4 5597.2 5599.0 5610.4 5611.9 5627.5 5661.1 5436.8 5499.5 5517.1 5555.4 5591.6 5560.0 5565.2 5567.2 5569.3 5593.5 5518.8 5525.7 5527.3 5530.3 5533.6 6004.9 6018.4 6027.6 6033.0 6036.0 6148.6 6277.5 6341.7 6451.6 6461.6 6495.4 6539.2 6541.3 6547.8 6561.7 6035.7 6040.8 6050.0 6050.3 6067.1 6473.2 6535.7 6574.1 6661.4 6663.7 6136.6 6206.8 6261.1 6376.0 6404.2 6473.1 6490.9 6510.2 6510.8 6519.7 6392.3 6437.9 6482.7 6485.1 6496.4 6287.5 6381.4 6391.8 6504.1 6518.3 5343.6 5344.2 5354.6 5390.5 5400.9 4536.3 4539.7 4556.1 4581.1 4585.2 5554.7 5630.5 5690.3 5699.5 5709.0 6361.9 6480.4 6509.5 6514.9 6520.6 5658.2 5665.4 5691.8 5698.6 5705.7 5691.2 5747.1 5764.2 5797.2 5797.2 6145.4 6198.3 6199.9 6243.3 6283.3 6480.2 6520.8 6525.5 6545.9 6566.8 6353.5 6356.3 6361.7 6369.7 6370.7 6159.7 6243.5 6263.7 6367.6 6403.7 6543.4 6575.8 6582.6 6584.5 6588.5 6107.0 6161.1 6335.3 6355.1 6355.7 6165.3 6326.1 6348.6 6360.9 6371.8 6144.5 6150.4 6157.5 6270.4 6281.1 6413.5 6414.9 6418.5 6431.7 6454.7 6216.4 6220.3 6233.4 6248.7 6251.6 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#1] ext.html Cycles:180 Average:33809.54 Median:34016.24 stddev:45390.71 (133.4%) stddev-sans-first:45449.92 09:01:20 INFO - PID 3530 | Values: 693.9 724.8 737.8 988.7 999.9 36310.0 37392.0 37753.4 37761.6 37762.4 39327.8 39347.4 39633.8 39692.4 39754.4 7266.8 7374.8 7502.3 7503.0 7532.6 7420.6 7543.7 7547.6 7550.5 7556.0 7505.1 7542.7 7563.2 7571.4 7585.5 7480.6 7492.0 7495.0 7517.1 7523.9 7378.0 7386.6 7400.7 7420.9 7423.6 34197.5 34453.5 34462.3 34519.1 34563.3 3457.4 3469.9 3494.6 3494.9 3520.9 27317.0 27473.0 27609.4 27657.7 27725.4 3566.2 3566.2 3572.7 3580.4 3591.3 160539.2 160662.0 161002.2 168009.0 174877.1 43093.8 43358.3 43466.0 43758.3 43790.6 43996.0 44889.0 44903.0 45498.0 45880.3 13500.3 13640.3 13703.7 13760.0 13796.4 10913.1 10956.3 10999.9 11029.4 11037.2 13900.2 13931.7 13958.4 13962.5 13984.0 5835.7 5918.8 5926.3 5960.6 5966.3 977.5 1017.1 1028.6 1029.7 1035.7 23331.8 24506.3 24595.0 24633.7 24731.1 1097.4 1102.6 1110.3 1117.4 1128.8 12299.9 13001.5 13157.3 13164.0 13220.1 197038.0 197708.0 198653.0 198950.0 199070.0 48203.1 48571.5 48594.0 48642.7 48762.3 1388.4 1412.9 1427.4 1437.9 1443.7 22119.0 22645.2 23663.6 23812.4 23855.8 35599.7 35826.0 35977.8 36024.3 36034.6 161335.0 161407.0 161792.0 162451.0 162998.0 33007.7 33287.7 33384.5 33387.5 33401.3 39765.8 40490.8 42183.4 42533.6 42727.8 30266.2 30816.0 31131.8 31648.2 33047.0 30239.5 30553.2 30555.4 32130.7 32162.8 33358.7 33835.0 34296.0 34496.7 34544.8 29678.9 30170.0 30890.4 30898.7 30961.8 22756.0 24032.5 24384.8 24403.8 24496.8 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#2] jquery.html Cycles:180 Average:31558.66 Median:12448.53 stddev:76771.07 (616.7%) stddev-sans-first:76950.83 09:01:20 INFO - PID 3530 | Values: 418.9 419.1 427.8 439.4 440.8 10854.1 11312.4 20355.2 21059.7 21202.8 21583.1 22382.2 22478.2 22561.1 22594.5 5822.2 6025.8 6040.5 6046.8 6065.5 5896.4 5903.6 6004.4 6011.7 6572.0 6532.3 6587.9 6589.2 6592.9 6595.6 6548.4 6587.2 6591.0 6598.7 6605.0 6444.6 6464.7 6466.8 6473.3 6486.9 26183.6 26448.7 26590.0 26733.7 27665.0 1950.5 1999.6 2001.2 2002.3 2003.9 17577.5 17895.7 17899.1 17940.6 17975.8 2238.3 2302.5 2325.2 2338.4 2364.5 116264.4 118902.0 119113.0 119434.0 119634.4 18630.0 19222.7 19869.5 20444.8 20578.7 37696.6 37806.0 37815.8 37920.2 38160.0 9573.9 9694.2 9718.9 9797.9 9885.1 7718.7 7728.5 7741.5 7884.9 7893.9 7225.8 7674.3 7683.4 7759.6 10347.5 2148.5 2152.1 2156.1 2165.8 2305.0 920.2 934.7 975.7 998.9 1019.0 18757.9 18791.2 19404.1 19679.2 19935.0 988.5 994.4 1007.0 1008.4 1016.2 10307.0 10524.8 10666.1 10675.3 10826.1 440850.0 449812.0 462756.0 467106.0 468891.0 101323.0 103534.5 104906.5 105357.0 106019.5 1126.0 1154.1 1165.4 1172.6 1174.5 16455.5 16785.9 17315.7 17328.2 17408.6 44534.3 46209.0 46842.8 47387.8 47452.5 61667.4 61918.1 62315.0 62370.0 62442.4 9385.9 9732.8 9866.7 9893.4 10004.8 15547.0 16343.0 16385.6 16523.1 16550.9 13616.2 13928.4 13991.2 14104.5 14250.4 13003.3 13086.4 13123.2 13258.5 13385.3 14284.7 14378.1 14382.5 14513.0 14609.7 9198.5 9241.4 9252.6 9289.1 9292.8 13597.5 13810.9 14019.6 14081.1 14149.8 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#3] mootools.html Cycles:180 Average:6838.55 Median:3669.01 stddev:4359.83 (118.8%) stddev-sans-first:4352.45 09:01:20 INFO - PID 3530 | Values: 1335.9 1352.9 1381.3 1390.3 1412.8 10717.3 11154.2 11256.8 11274.8 11498.8 11335.5 11507.4 11510.2 11513.5 11569.3 2352.8 2404.1 2411.1 2418.9 2424.0 2339.0 2372.0 2377.9 2381.8 2382.1 2302.3 2343.0 2350.3 2351.9 2358.1 2188.6 2214.5 2221.1 2226.2 2226.7 2100.6 2206.3 2241.2 2259.5 2280.3 10928.2 11098.1 11132.0 11138.3 11139.6 6049.6 6257.2 6266.2 6322.6 6330.9 3631.2 3706.8 3779.9 3784.7 3813.8 1159.4 1182.3 1187.7 1194.1 1210.1 15907.1 15922.7 16072.7 16099.7 16851.3 5212.4 5248.6 5304.8 5384.2 5387.0 12108.8 12232.6 12232.9 12235.5 12264.9 5933.1 6086.1 6094.1 6094.4 6095.6 5624.9 5676.9 5687.7 5740.4 5785.1 4099.4 4211.4 4243.2 4274.8 4293.8 1225.9 1252.2 1257.0 1271.0 1275.3 827.3 847.7 860.7 871.2 887.8 6000.6 6113.8 6119.4 6186.9 6330.6 609.3 612.5 624.3 629.5 633.8 3885.5 4017.7 4249.8 4516.1 4522.8 14350.8 14762.5 14805.6 14817.2 14945.8 13651.9 14319.3 14441.6 14574.3 14708.3 7238.8 8639.5 8703.8 8733.8 8893.5 6055.6 6883.2 7111.4 7118.5 7331.2 11929.6 12114.3 12118.3 12257.4 12272.6 12258.8 12278.9 12446.8 12515.6 12529.9 8728.3 8776.1 8782.6 8793.7 8838.7 10215.3 10389.2 10579.7 10592.0 10675.3 8463.8 8550.6 8572.4 8578.6 8613.1 8852.3 8924.0 8932.9 9004.8 9106.6 7462.1 7613.3 7623.2 7642.5 7694.1 5885.5 5943.2 5956.6 5987.8 6062.6 6098.4 6166.7 6184.7 6210.4 6335.9 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#4] prototype.html Cycles:180 Average:5423.34 Median:6053.70 stddev:1618.58 (26.7%) stddev-sans-first:1578.25 09:01:20 INFO - PID 3530 | Values: 380.8 392.7 397.2 400.1 404.0 6080.7 6308.7 6316.0 6324.4 6372.0 5999.1 6068.2 6105.7 6124.6 6132.4 4719.3 4748.6 4757.4 4762.7 4789.3 4740.2 4764.5 4767.2 4779.2 4789.6 4742.0 4743.8 4754.3 4754.8 4766.2 4757.4 4759.8 4761.8 4765.8 4766.5 4142.8 4153.9 4159.0 4161.0 4168.7 5964.3 5991.4 6018.4 6020.8 6039.2 5453.5 5456.7 5457.7 5467.1 5475.4 6406.7 6414.4 6417.2 6440.9 6456.1 4513.4 4534.1 4541.5 4543.5 4543.5 6490.6 6587.4 6732.5 6871.6 6969.8 4569.7 4593.5 4600.4 4605.2 4624.4 4622.5 4631.4 4663.7 4685.7 4689.3 5251.1 5340.0 5348.9 5370.3 5391.4 6466.4 6540.8 6547.4 6552.8 6557.6 1603.7 1617.7 1618.9 1619.5 1622.7 1041.4 1055.2 1079.9 1091.9 1094.1 5806.5 5846.9 5847.8 5875.5 5878.3 6683.5 6731.8 6746.9 6756.6 6777.8 5796.4 5804.8 5817.8 5844.9 5864.6 3549.9 3565.5 3575.7 3609.5 3609.7 6548.9 6577.9 6590.7 6596.4 6630.8 6925.3 6947.9 6952.3 6957.7 6991.7 6548.4 6568.7 6595.2 6596.3 6637.6 6749.5 6754.5 6764.6 6772.0 6775.5 6658.2 6709.9 6713.5 6738.4 6743.5 6187.7 6512.4 6547.6 6566.1 6621.8 4600.5 4612.6 4621.2 4633.5 4634.8 6750.7 6761.3 6771.9 6789.6 6793.3 6410.4 6595.2 6599.6 6608.4 6618.2 6590.6 6593.3 6619.2 6636.2 6643.7 6452.0 6536.4 6537.9 6583.4 6584.8 6602.3 6633.3 6637.7 6650.6 6662.6 6442.2 6444.0 6448.7 6455.5 6487.8 09:01:20 INFO - PID 3530 | 09:01:20 INFO - PID 3530 | [#5] yui.html Cycles:180 Average:19442.96 Median:28912.64 stddev:25125.76 (86.9%) stddev-sans-first:25157.23 09:01:20 INFO - PID 3530 | Values: 798.7 838.9 843.8 844.6 857.3 12441.8 12889.5 17236.9 17685.6 17701.9 17525.7 18277.5 18304.9 18379.0 18442.7 901.9 950.0 951.9 958.3 959.0 945.3 969.6 973.0 974.6 975.2 1011.5 1013.8 1015.2 1017.1 1026.6 1005.2 1012.9 1013.0 1015.6 1029.5 741.4 741.9 743.3 746.5 759.5 17744.6 17848.6 17941.5 17997.6 18109.4 18028.5 18206.0 18376.3 18426.6 18500.8 14384.4 14923.8 15033.5 15034.8 15036.3 3461.4 3470.6 3478.9 3482.6 3512.4 96118.0 96176.0 96392.5 98170.0 98729.0 13243.5 13349.5 13576.5 13591.7 13616.4 25163.6 26001.3 26337.6 26373.6 26412.6 7939.6 7983.1 8032.2 8066.2 8362.4 3823.9 3892.9 3920.0 3925.8 3938.0 4120.2 4142.2 4180.7 4185.8 4186.5 862.8 873.2 914.4 920.2 920.6 689.6 698.6 698.7 715.1 718.1 10861.6 11520.2 12146.8 12570.3 12638.7 685.7 696.7 698.9 705.4 706.5 5316.1 5367.2 5418.3 5527.1 5607.6 90109.0 94190.5 94340.0 94793.0 95070.5 80830.0 81016.2 82616.6 83106.6 87137.2 62257.7 63700.7 65630.3 66890.0 69104.3 10512.6 11723.3 11802.1 11943.4 11992.3 28642.7 29182.6 29324.0 29397.3 29872.1 35376.5 35453.3 35639.5 36304.8 36684.8 16651.5 16753.9 16907.9 17000.4 17263.4 17967.2 18072.5 18691.5 19530.5 19689.4 16417.8 17428.7 17802.4 18038.7 18073.5 17453.9 18200.8 18252.0 18273.4 18604.4 17271.1 17662.4 17843.8 18033.9 18193.7 11033.5 11218.9 11278.5 11534.8 11735.9 13590.8 14070.7 14188.9 14203.5 14205.6 09:01:20 INFO - PID 3530 | -------- Summary: end -------- 09:01:20 INFO - PID 3530 | 09:01:21 INFO - TEST-INFO | 3530: exit 0 09:01:21 INFO - TEST-OK | dromaeo_css | took 1146244ms 09:01:21 INFO - TEST-START | kraken 09:01:21 INFO - operating with platform_type : linux_ 09:01:21 INFO - Initialising browser for kraken test... 09:01:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51347/getInfo.html -profile /tmp/tmpC4bF0k/profile 09:01:21 INFO - TEST-INFO | started process 3934 (/builds/slave/test/build/application/firefox/firefox http://localhost:51347/getInfo.html) 09:01:56 INFO - TEST-INFO | 3934: killed by SIGTERM 09:01:56 INFO - Browser initialized. 09:01:56 INFO - Running cycle 1/1 for kraken test... 09:01:56 INFO - TEST-INFO | started process 4143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC4bF0k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:08 INFO - PID 4143 | RSS: Main: 187781120 09:02:08 INFO - PID 4143 | 09:02:10 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51347/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:11 INFO - PID 4143 | RSS: Main: 192028672 09:02:11 INFO - PID 4143 | 09:02:14 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51347/tests/kraken/driver.html?testName=audio-dft) 09:02:14 INFO - PID 4143 | RSS: Main: 191172608 09:02:14 INFO - PID 4143 | 09:02:17 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51347/tests/kraken/driver.html?testName=audio-fft) 09:02:18 INFO - PID 4143 | RSS: Main: 186503168 09:02:18 INFO - PID 4143 | 09:02:20 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51347/tests/kraken/driver.html?testName=audio-oscillator) 09:02:21 INFO - PID 4143 | RSS: Main: 187080704 09:02:21 INFO - PID 4143 | 09:02:23 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:23 INFO - PID 4143 | RSS: Main: 187052032 09:02:23 INFO - PID 4143 | 09:02:27 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51347/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:27 INFO - PID 4143 | RSS: Main: 188280832 09:02:27 INFO - PID 4143 | 09:02:31 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51347/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:31 INFO - PID 4143 | RSS: Main: 187400192 09:02:31 INFO - PID 4143 | 09:02:34 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51347/tests/kraken/driver.html?testName=json-parse-financial) 09:02:35 INFO - PID 4143 | RSS: Main: 188215296 09:02:35 INFO - PID 4143 | 09:02:36 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:37 INFO - PID 4143 | RSS: Main: 188334080 09:02:37 INFO - PID 4143 | 09:02:39 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:39 INFO - PID 4143 | RSS: Main: 188301312 09:02:39 INFO - PID 4143 | 09:02:42 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:42 INFO - PID 4143 | RSS: Main: 188456960 09:02:42 INFO - PID 4143 | 09:02:45 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:46 INFO - PID 4143 | RSS: Main: 188338176 09:02:46 INFO - PID 4143 | 09:02:49 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:50 INFO - PID 4143 | RSS: Main: 188338176 09:02:50 INFO - PID 4143 | 09:02:51 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:51347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51347/tests/kraken/driver.html?testName=ai-astar) 09:02:52 INFO - PID 4143 | RSS: Main: 189739008 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | __start_tp_report 09:02:52 INFO - PID 4143 | _x_x_mozilla_page_load 09:02:52 INFO - PID 4143 | _x_x_mozilla_page_load_details 09:02:52 INFO - PID 4143 | |i|pagename|runs| 09:02:52 INFO - PID 4143 | |0;ai-astar;101;111;111;111;109;111;110;111;110;111 09:02:52 INFO - PID 4143 | |1;audio-beat-detection;156;124;130;166;123;123;125;125;143;129 09:02:52 INFO - PID 4143 | |2;audio-dft;166;165;166;162;165;166;165;169;171;163 09:02:52 INFO - PID 4143 | |3;audio-fft;73;73;74;119;77;75;74;74;95;75 09:02:52 INFO - PID 4143 | |4;audio-oscillator;82;83;110;84;84;81;99;82;83;103 09:02:52 INFO - PID 4143 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;114;122 09:02:52 INFO - PID 4143 | |6;imaging-darkroom;150;150;150;150;151;151;150;149;152;150 09:02:52 INFO - PID 4143 | |7;imaging-desaturate;94;95;95;95;94;93;94;94;94;94 09:02:52 INFO - PID 4143 | |8;json-parse-financial;54;57;56;57;58;55;59;56;55;55 09:02:52 INFO - PID 4143 | |9;json-stringify-tinderbox;60;56;56;56;56;57;56;56;56;55 09:02:52 INFO - PID 4143 | |10;stanford-crypto-aes;88;87;85;88;87;87;101;89;121;101 09:02:52 INFO - PID 4143 | |11;stanford-crypto-ccm;131;133;139;137;129;128;137;133;128;144 09:02:52 INFO - PID 4143 | |12;stanford-crypto-pbkdf2;194;196;193;189;182;202;196;195;196;194 09:02:52 INFO - PID 4143 | |13;stanford-crypto-sha256-iterative;70;71;71;69;76;71;74;78;74;71 09:02:52 INFO - PID 4143 | __end_tp_report 09:02:52 INFO - PID 4143 | __start_cc_report 09:02:52 INFO - PID 4143 | _x_x_mozilla_cycle_collect,990 09:02:52 INFO - PID 4143 | __end_cc_report 09:02:52 INFO - PID 4143 | __startTimestamp1496419372008__endTimestamp 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | ------- Summary: start ------- 09:02:52 INFO - PID 4143 | Number of tests: 14 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.10 (2.8%) stddev-sans-first:0.73 09:02:52 INFO - PID 4143 | Values: 101.0 111.0 111.0 111.0 109.0 111.0 110.0 111.0 110.0 111.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:129.50 stddev:15.39 (11.9%) stddev-sans-first:14.20 09:02:52 INFO - PID 4143 | Values: 156.0 124.0 130.0 166.0 123.0 123.0 125.0 125.0 143.0 129.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:2.62 (1.6%) stddev-sans-first:2.77 09:02:52 INFO - PID 4143 | Values: 166.0 165.0 166.0 162.0 165.0 166.0 165.0 169.0 171.0 163.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.50 stddev:14.92 (20.0%) stddev-sans-first:15.55 09:02:52 INFO - PID 4143 | Values: 73.0 73.0 74.0 119.0 77.0 75.0 74.0 74.0 95.0 75.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:10.65 (12.8%) stddev-sans-first:10.98 09:02:52 INFO - PID 4143 | Values: 82.0 83.0 110.0 84.0 84.0 81.0 99.0 82.0 83.0 103.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.51 (2.2%) stddev-sans-first:2.65 09:02:52 INFO - PID 4143 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 122.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:02:52 INFO - PID 4143 | Values: 150.0 150.0 150.0 150.0 151.0 151.0 150.0 149.0 152.0 150.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:02:52 INFO - PID 4143 | Values: 94.0 95.0 95.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.42 09:02:52 INFO - PID 4143 | Values: 54.0 57.0 56.0 57.0 58.0 55.0 59.0 56.0 55.0 55.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:0.50 09:02:52 INFO - PID 4143 | Values: 60.0 56.0 56.0 56.0 56.0 57.0 56.0 56.0 56.0 55.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:87.00 stddev:11.30 (13.0%) stddev-sans-first:11.81 09:02:52 INFO - PID 4143 | Values: 88.0 87.0 85.0 88.0 87.0 87.0 101.0 89.0 121.0 101.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:135.00 stddev:5.28 (3.9%) stddev-sans-first:5.49 09:02:52 INFO - PID 4143 | Values: 131.0 133.0 139.0 137.0 129.0 128.0 137.0 133.0 128.0 144.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:195.50 stddev:5.23 (2.7%) stddev-sans-first:5.55 09:02:52 INFO - PID 4143 | Values: 194.0 196.0 193.0 189.0 182.0 202.0 196.0 195.0 196.0 194.0 09:02:52 INFO - PID 4143 | 09:02:52 INFO - PID 4143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:2.88 (4.0%) stddev-sans-first:2.91 09:02:52 INFO - PID 4143 | Values: 70.0 71.0 71.0 69.0 76.0 71.0 74.0 78.0 74.0 71.0 09:02:52 INFO - PID 4143 | -------- Summary: end -------- 09:02:52 INFO - PID 4143 | 09:02:53 INFO - TEST-INFO | 4143: exit 0 09:02:53 INFO - TEST-OK | kraken | took 91545ms 09:02:53 INFO - SUITE-END | took 1237s 09:02:53 INFO - Completed test suite (00:20:38) 09:02:53 INFO - javascript benchmark 09:02:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7713.876788912464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.9375612487747, 3153.80907179811, 3173.9047828565153, 3179.6661350558193, 3191.441497737895, 5890.64656120633, 5976.551758618105, 6011.54913381497, 6024.186734790802, 6045.183900173475, 5919.911201331973, 5968.910466342997, 5976.5517586180995, 6035.668038257894, 6129.570930034888, 5428.0, 5513.751881165347, 5537.252470916435, 5558.416366281543, 5597.160425936101, 5598.972005139989, 5610.382857885629, 5611.8597035074245, 5627.549796016329, 5661.094224923992, 5436.836894893159, 5499.50504454601, 5517.117261238182, 5555.388907220223, 5591.608587398884, 5560.026995275851, 5565.2486914266465, 5567.248421463091, 5569.331680198362, 5593.468620481048, 5518.751656175482, 5525.668459892419, 5527.309086364205, 5530.2810634617645, 5533.612647114704, 6004.909926351108, 6018.398160183947, 6027.578069535134, 6032.97439435297, 6035.969820150871, 6148.569600127993, 6277.4664153547, 6341.714622841983, 6451.58064725796, 6461.6446095464735, 6495.447886929616, 6539.182602174728, 6541.313162117956, 6547.836304092388, 6561.704723287464, 6035.7283922223605, 6040.788572399989, 6050.031994880798, 6050.273967123973, 6067.059605761114, 6473.190851143607, 6535.738570457129, 6574.145361103026, 6661.367170118831, 6663.733450662016, 6136.610985192662, 6206.751729930843, 6261.060840873905, 6375.968120159462, 6404.231492220963, 6473.126127972758, 6490.935090649127, 6510.153680021662, 6510.837229069217, 6519.706613202417, 6392.328805475451, 6437.871242575216, 6482.708278127496, 6485.059666348353, 6496.35036496356, 6287.528435367366, 6381.425671689571, 6391.776287829996, 6504.121943537656, 6518.315576864456, 5343.599230057761, 5344.225087362311, 5354.625176237704, 5390.487903649226, 5400.945990540123, 4536.251518499476, 4539.7049191802425, 4556.088782243564, 4581.106684196549, 4585.1746685596245, 5554.6944918029085, 5630.493255607015, 5690.2887139107615, 5699.487046165865, 5709.0, 6361.872762544724, 6480.351964803482, 6509.544331896816, 6514.902276465857, 6520.608763474112, 5658.151277308437, 5665.3768085510565, 5691.800786972436, 5698.601097923106, 5705.74324155414, 5691.203231547586, 5747.051736463521, 5764.164196191613, 5797.188393624896, 5797.246357973437, 6145.385461453819, 6198.256209254918, 6199.907001395073, 6243.250809902841, 6283.277423096402, 6480.189976252968, 6520.771772987922, 6525.477961762953, 6545.901811472927, 6566.8358291043105, 6353.523485738496, 6356.3325850785, 6361.681915904279, 6369.713362898773, 6370.745170193326, 6159.6612186330185, 6243.531735119975, 6263.74945002213, 6367.649779262185, 6403.6798160090875, 6543.411093001652, 6575.80272591823, 6582.605043697394, 6584.473242140713, 6588.472922166119, 6107.037103281039, 6161.137440758387, 6335.303116657072, 6355.110284560073, 6355.650439225887, 6165.290991536031, 6326.051092336186, 6348.587341822767, 6360.93639063622, 6371.776987805404, 6144.53915956314, 6150.384961503813, 6157.507399407947, 6270.404311590391, 6281.12064311006, 6413.454856337264, 6414.935850641434, 6418.4544313731985, 6431.678416079271, 6454.709538070704, 6216.378362163748, 6220.284667263322, 6233.376662333912, 6248.718807653576, 6251.624902505682], "value": 5922.398784100968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9340762627548, 724.7608289264541, 737.8192342875994, 988.7231575158958, 999.9250056245775, 36310.0, 37392.0, 37753.39315619769, 37761.62238377616, 37762.43356349657, 39327.80336098323, 39347.40978885312, 39633.80183099088, 39692.40461393074, 39754.403683944765, 7266.781996540086, 7374.778756637309, 7502.287282708134, 7503.0, 7532.623368831564, 7420.628968551551, 7543.660535275926, 7547.584882831442, 7550.471466997313, 7556.0, 7505.1369092554505, 7542.69829206831, 7563.205863384348, 7571.394288456938, 7585.544867307979, 7480.62596870157, 7492.026036615205, 7495.0, 7517.135529414105, 7523.924760752378, 7377.963110184468, 7386.630668466555, 7400.740974065882, 7420.85158296831, 7423.591702456362, 34197.487037694205, 34453.48319775205, 34462.31075378504, 34519.13702157441, 34563.30873382543, 3457.3949558827358, 3469.9479507807405, 3494.5981212160673, 3494.877679281238, 3520.9471857921894, 27317.0, 27473.0, 27609.447811043665, 27657.723422765717, 27725.445491090064, 3566.1619519412916, 3566.1797786509246, 3572.678458938682, 3580.3555360035184, 3591.299696559172, 160539.19730401272, 160662.0, 161002.1949890243, 168009.0, 174877.12561437237, 43093.78453107777, 43358.349624755654, 43466.0, 43758.34362484565, 43790.56209437929, 43996.0, 44889.0, 44903.0, 45498.0, 45880.3117953231, 13500.257485838372, 13640.317984100953, 13703.657408564866, 13760.0, 13796.379162937692, 10913.072388846878, 10956.34261944286, 10999.945000274947, 11029.393383363831, 11037.172212083966, 13900.16599004063, 13931.721365572632, 13958.441662333596, 13962.511312104027, 13984.0, 5835.708214589338, 5918.822435326947, 5926.288845338587, 5960.642361458326, 5966.284045914431, 977.5112443778111, 1017.0693815159194, 1028.6091285311534, 1029.7322696098918, 1035.6582327831798, 23331.76668233296, 24506.264812055666, 24595.039356028185, 24633.71006981444, 24731.129306656734, 1097.412884106999, 1102.614085070219, 1110.2505808579176, 1117.3910218930703, 1128.8306753986967, 12299.863103386731, 13001.544945926848, 13157.342132893316, 13164.0, 13220.074594778273, 197038.0, 197708.0, 198653.0, 198950.0, 199070.0, 48203.07187712522, 48571.5142848574, 48594.0, 48642.67645206101, 48762.268565971535, 1388.4168649167375, 1412.865777751112, 1427.4290283886528, 1437.9137251764928, 1443.7256921184942, 22119.0, 22645.2074177403, 23663.64504532468, 23812.404689882893, 23855.761442386047, 35599.660050992556, 35826.0, 35977.82011089928, 36024.27951441009, 36034.63965360418, 161335.0, 161407.0, 161792.0, 162451.0, 162998.0, 33007.66992330046, 33287.66849326, 33384.49923251202, 33387.499187512694, 33401.33197336088, 39765.80117099396, 40490.79754601208, 42183.36724949067, 42533.57466425296, 42727.78636106799, 30266.24334391658, 30816.0, 31131.844340778152, 31648.208794780316, 33047.0, 30239.546406803474, 30553.23616909595, 30555.388892221585, 32130.67869321277, 32162.839185804856, 33358.66641333556, 33835.0, 34296.0, 34496.65503345035, 34544.82727586346, 29678.851605741835, 30170.0, 30890.382192356476, 30898.69101308958, 30961.845190773904, 22756.0, 24032.51934961326, 24384.756152438247, 24403.755962440857, 24496.75503245016], "value": 16141.024130051403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.94972603287613, 419.1039159131191, 427.7861069465266, 439.42435409613427, 440.7641911577307, 10854.077403420699, 11312.37781921996, 20355.1857925683, 21059.68410473844, 21202.78797212029, 21583.136674533038, 22382.21662241822, 22478.213262535814, 22561.09755609778, 22594.54810903781, 5822.243108395903, 6025.758969641209, 6040.546958978072, 6046.7883624073165, 6065.4844338231305, 5896.410358964112, 5903.586748927555, 6004.42957918997, 6011.669358185298, 6572.047053177286, 6532.3467653234775, 6587.934120658804, 6589.17635295588, 6592.868142637144, 6595.604263744167, 6548.443382312509, 6587.2095348558005, 6591.0442985766795, 6598.703058362361, 6604.966975165094, 6444.581102228387, 6464.6767661617205, 6466.838329041764, 6473.320301368336, 6486.935130648728, 26183.607245891326, 26448.73551264482, 26590.0, 26733.732662673512, 27665.0, 1950.5318723506257, 1999.6300684373437, 2001.2095222387075, 2002.3092033248652, 2003.8998050097437, 17577.472675819747, 17895.73156402655, 17899.10504474771, 17940.641187176185, 17975.75303087114, 2238.2501861876126, 2302.5164715409783, 2325.1513197682893, 2338.380329212743, 2364.47981444082, 116264.41867790607, 118902.0, 119113.0, 119434.0, 119634.40182799117, 18630.0, 19222.711659325123, 19869.503262418555, 20444.79555204429, 20578.691319630216, 37696.62303376986, 37806.0, 37815.81092094577, 37920.24159516794, 38160.0, 9573.852295409182, 9694.224462043161, 9718.902810971942, 9797.902020979698, 9885.110340069285, 7718.652660630285, 7728.4590078693955, 7741.458097933203, 7884.921150788418, 7893.921060789318, 7225.783226503213, 7674.270944260286, 7683.385329173652, 7759.573223472763, 10347.482625868677, 2148.495103650641, 2152.096119629728, 2156.094440335032, 2165.8483906126735, 2304.9654255186188, 920.1580553793204, 934.6775362499926, 975.673149494913, 998.8501724741346, 1018.9949050254701, 18757.90621046886, 18791.15439805212, 19404.12681429339, 19679.21283148658, 19935.0, 988.545269176187, 994.3735446668697, 1006.959721611142, 1008.4151192308443, 1016.1750334071294, 10307.0, 10524.842127367943, 10666.093382062612, 10675.306105103298, 10826.079783218358, 440850.0, 449812.0, 462756.0, 467106.0, 468891.0, 101323.0, 103534.48232758787, 104906.47546762218, 105357.0, 106019.46990264999, 1125.9662210133708, 1154.088270266497, 1165.3648761425043, 1172.6364826903687, 1174.5360582569838, 16455.475615524792, 16785.91607041957, 17315.653686926442, 17328.220230089424, 17408.564785880455, 44534.331985019606, 46209.0, 46842.76578617085, 47387.76306118447, 47452.52547474481, 61667.383326166164, 61918.0712289307, 62315.0, 62370.0, 62442.375576245475, 9385.906140938503, 9732.805343893224, 9866.654667086617, 9893.406395616286, 10004.799904001733, 15547.0, 16343.0, 16385.59036024109, 16523.091229982467, 16550.917245414177, 13616.18302901829, 13928.373223204777, 13991.16053036821, 14104.506342278382, 14250.358733857209, 13003.349832508526, 13086.411111499814, 13123.212607243597, 13258.53595124166, 13385.263810490516, 14284.714375706237, 14378.137311761328, 14382.496612618508, 14513.0, 14609.707805843611, 9198.49408282551, 9241.445513269226, 9252.583633736633, 9289.117533834275, 9292.814143717223, 13597.456101755819, 13810.861891380957, 14019.649508762363, 14081.08472949255, 14149.787753183504], "value": 10738.451807065316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.9265240411776, 1352.9458821647136, 1381.2610253514372, 1390.3465371275504, 1412.795144704018, 10717.303375280611, 11154.163437742181, 11256.831147532794, 11274.830877536844, 11498.770024599504, 11335.489902954367, 11507.42462876855, 11510.194286399956, 11513.4818933148, 11569.305841649486, 2352.8117750579954, 2404.146527982567, 2411.0837881605053, 2418.9153379631716, 2424.0425032112307, 2339.040993192791, 2371.9525609487887, 2377.8929948152377, 2381.773731495505, 2382.0828980842416, 2302.2517681753498, 2343.0, 2350.330155905567, 2351.9176828810996, 2358.0685629176464, 2188.6388745856916, 2214.4685275533916, 2221.0893533651206, 2226.198568515333, 2226.666000099982, 2100.6113868934294, 2206.2829580386438, 2241.2491815241915, 2259.5029093599383, 2280.304507125326, 10928.180386471047, 11098.056665183469, 11132.0, 11138.276012059272, 11139.610113645984, 6049.606775559574, 6257.217847769029, 6266.216722909637, 6322.620642761449, 6330.905036424458, 3631.1829838286176, 3706.8331925063435, 3779.8677046303524, 3784.735068545203, 3813.80930953454, 1159.3913195572309, 1182.3142577305143, 1187.6971372300095, 1194.068626471345, 1210.1347536511437, 15907.12510811905, 15922.681546369124, 16072.678546429006, 16099.678006439923, 16851.325946962228, 5212.40057393397, 5248.606354523426, 5304.840854774363, 5384.219288203189, 5387.0, 12108.757824843453, 12232.633021009384, 12232.877671223352, 12235.510579576718, 12264.938675306745, 5933.110033495011, 6086.056661217518, 6094.146819445281, 6094.421030002142, 6095.634261944298, 5624.887502250014, 5676.914846277309, 5687.687177205211, 5740.397258287903, 5785.1322301654245, 4099.364598487239, 4211.389348544505, 4243.215005224043, 4274.786260686953, 4293.763842988666, 1225.8957988571071, 1252.1860790486076, 1256.9937150314372, 1271.0467149637773, 1275.253976423784, 827.3381294964125, 847.737201467547, 860.655737704923, 871.2289623683087, 887.8179973105498, 6000.639961602318, 6113.816585502442, 6119.418655227835, 6186.938130618726, 6330.588511746814, 609.2780055633999, 612.5252928980076, 624.2664868779166, 629.5435809038502, 633.8130251575705, 3885.514310711161, 4017.678585713136, 4249.787510624456, 4516.119356725473, 4522.796474158671, 14350.784738228935, 14762.483313084205, 14805.555833325017, 14817.185054822088, 14945.775813362809, 13651.863481365257, 14319.284035798377, 14441.638959025899, 14574.344154513072, 14708.33812478441, 7238.819029524304, 8639.524826134622, 8703.825923481494, 8733.781655458537, 8893.510856902803, 6055.6063855849225, 6883.242843287134, 7111.43108551325, 7118.537295075804, 7331.193568707331, 11929.642110736691, 12114.333711645591, 12118.272903625812, 12257.387130643254, 12272.631821045383, 12258.816117758062, 12278.938605307274, 12446.813297800722, 12515.56195533152, 12529.937350313554, 8728.345374097094, 8776.078511756174, 8782.560871956504, 8793.736187914374, 8838.734837954871, 10215.284930054824, 10389.220808439548, 10579.682609521727, 10592.0, 10675.252732308974, 8463.788405289917, 8550.57247137653, 8572.3999320047, 8578.571071446278, 8613.138686131337, 8852.291816654524, 8923.955380223317, 8932.910670893209, 9004.774880628036, 9106.590203440728, 7462.141853686896, 7613.276738709814, 7623.161452240138, 7642.5032372895585, 7694.07671079474, 5885.529157667462, 5943.197668314722, 5956.5532585055425, 5987.790427335022, 6062.575619706578, 6098.390160984043, 6166.691665416622, 6184.690765461799, 6210.441060304594, 6335.873282534231], "value": 5124.350622647048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7563159577871, 392.7231301932138, 397.21153510282085, 400.0977795072112, 403.9697022723296, 6080.665563394012, 6308.71610777515, 6315.97888675624, 6324.3991820776955, 6372.0, 5999.070144127667, 6068.241469816273, 6105.664188469633, 6124.599793216089, 6132.417420345071, 4719.292106184065, 4748.643851711118, 4757.405324334458, 4762.690425122356, 4789.3294938708605, 4740.194166991602, 4764.547368000034, 4767.213409787381, 4779.187538118511, 4789.568938795508, 4741.988837088456, 4743.810247590092, 4754.263089221176, 4754.809807607691, 4766.189747742875, 4757.429108507002, 4759.762011899391, 4761.8095276188915, 4765.833195838129, 4766.499517550659, 4142.834286628531, 4153.937690934638, 4158.979205103955, 4161.0, 4168.687348448879, 5964.343922168558, 5991.370906054889, 6018.368071352533, 6020.819375418744, 6039.158056792677, 5453.454654534555, 5456.727163641802, 5457.727113644341, 5467.125259958388, 5475.397706252309, 6406.743730250784, 6414.4227019568, 6417.1657684500715, 6440.935590644081, 6456.128422662928, 4513.368128462018, 4534.13851368239, 4541.477730061019, 4543.454785425737, 4543.5002149763495, 6490.6105633661655, 6587.440067594261, 6732.4950628703045, 6871.587704737732, 6969.7909062728195, 4569.657275704336, 4593.540645935446, 4600.401947746772, 4605.217113090783, 4624.398828152386, 4622.4684161321875, 4631.397918270671, 4663.650226233046, 4685.742284174335, 4689.320048593003, 5251.0548101341365, 5340.0, 5348.866278343073, 5370.3287089113865, 5391.3799913009725, 6466.385693359123, 6540.836479087966, 6547.377999090078, 6552.770653027121, 6557.606543607399, 1603.7353836616828, 1617.7411614141681, 1618.8543031127256, 1619.5222409389257, 1622.691688579166, 1041.354360296621, 1055.1611468882256, 1079.875814281352, 1091.8908109189017, 1094.0864378244096, 5806.506446951972, 5846.941530584725, 5847.795327163529, 5875.50058245054, 5878.323992740804, 6683.498737594603, 6731.798046058626, 6746.865062698718, 6756.5608235465525, 6777.762778302736, 5796.362400135981, 5804.796832110856, 5817.825465236049, 5844.912326315109, 5864.618799778001, 3549.9290014199573, 3565.4651802229873, 3575.73182011345, 3609.4585812127866, 3609.7112231021456, 6548.9017664735065, 6577.934220657732, 6590.670466476657, 6596.373344532261, 6630.801075967729, 6925.342092501204, 6947.853604155359, 6952.339527744856, 6957.686904089328, 6991.720331186797, 6548.446106018657, 6568.704408301638, 6595.208574971034, 6596.30738772422, 6637.601743895285, 6749.527533072835, 6754.493412994143, 6764.627945463047, 6772.0, 6775.525713200029, 6658.167729033871, 6709.865802683821, 6713.482444083469, 6738.393544580815, 6743.460523158037, 6187.690615469119, 6512.413882750575, 6547.574407663486, 6566.080748695282, 6621.834454138685, 4600.504835928404, 4612.570103267998, 4621.191291524037, 4633.4903160652975, 4634.791434385528, 6750.72997080131, 6761.343470849673, 6771.932280677327, 6789.592624442549, 6793.286704895915, 6410.358964103552, 6595.175603049619, 6599.60402375859, 6608.372204640552, 6618.205815302194, 6590.5716128451495, 6593.340665933369, 6619.238787539494, 6636.170478690164, 6643.667816609247, 6452.0, 6536.411722944958, 6537.901931471127, 6583.374579414948, 6584.773461003978, 6602.273749887412, 6633.270340262471, 6637.668116594247, 6650.600963942179, 6662.600243985376, 6442.162518872704, 6443.967780161257, 6448.742050317935, 6455.515231496688, 6487.805365839033], "value": 4908.91054224921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.6685525506915, 838.9328853691705, 843.7679638099522, 844.5692696724668, 857.2627540315327, 12441.813372799415, 12889.484420623186, 17236.913815430922, 17685.55786105348, 17701.911490442562, 17525.7371139433, 18277.451676449728, 18304.908475457603, 18379.0, 18442.723359149622, 901.8557030875062, 949.9620015199419, 951.8762560867112, 958.3435346787438, 958.9520523973808, 945.2674177512414, 969.5685419988108, 972.9902700973006, 974.6345120579782, 975.2490582251662, 1011.524583445783, 1013.8327176015986, 1015.1624909449697, 1017.064300843226, 1026.558579810681, 1005.1606908231672, 1012.9240306976969, 1013.0477351289765, 1015.5937624950005, 1029.4595337447824, 741.4068745003975, 741.8850078237882, 743.2938708227206, 746.4774657739604, 759.4531937005403, 17744.645107097916, 17848.55378615532, 17941.461756147335, 17997.640047198984, 18109.366172184044, 18028.459146225636, 18206.0, 18376.264949402008, 18426.631467370713, 18500.814991850042, 14384.424623015067, 14923.776143357858, 15033.548993530212, 15034.774478382833, 15036.346001939888, 3461.4115600348, 3470.583529976394, 3478.9130271743156, 3482.5995010573856, 3512.367773800715, 96118.03881961231, 96175.9999999993, 96392.51803740936, 98170.0, 98729.0, 13243.536476223286, 13349.46602135923, 13576.456941722417, 13591.728165436636, 13616.387262573207, 25163.62254566183, 26001.349966250997, 26337.576115104916, 26373.604395934075, 26412.603810942852, 7939.64271607779, 7983.12185659577, 8032.15662355456, 8066.15305392937, 8362.414630975894, 3823.904402389907, 3892.922141557153, 3920.0199950012498, 3925.823337949799, 3937.9803100984886, 4120.1553681495225, 4142.1922725068325, 4180.686448516373, 4185.769782661922, 4186.539480657125, 862.7756783236404, 873.1922971251566, 914.401067300919, 920.1948295241664, 920.5949382271913, 689.5621280486827, 698.6471831724947, 698.6576577477, 715.1239731329081, 718.1346477494607, 10861.565537378574, 11520.193586448868, 12146.757064858653, 12570.308633025272, 12638.747225055447, 685.715428097344, 696.7282759723611, 698.8532408194336, 705.4497491956282, 706.5372181221309, 5316.0962636351915, 5367.2485851980755, 5418.349798024262, 5527.115661494222, 5607.607467477237, 90109.0, 94190.52904735433, 94340.0, 94793.0, 95070.52464737633, 80830.0, 81016.18983810204, 82616.58691706623, 83106.58446707728, 87137.20745358939, 62257.68871155706, 63700.681496592224, 65630.34369656243, 66890.0, 69104.3089569108, 10512.632057877938, 11723.296602203895, 11802.114841387101, 11943.402829858645, 11992.280463172237, 28642.71357286484, 29182.56226156652, 29324.0, 29397.265068372606, 29872.10383688493, 35376.46935295921, 35453.290934181685, 35639.465408019416, 36304.81847590745, 36684.81657591695, 16651.50045498637, 16753.91623041877, 16907.91546042262, 17000.404985825437, 17263.3957811476, 17967.191476383854, 18072.548186295448, 18691.532711682317, 19530.511737206114, 19689.409317720492, 16417.83582164163, 17428.651426971643, 17802.37691680785, 18038.729419058986, 18073.45779626613, 17453.912730436266, 18200.81799182044, 18252.0, 18273.3604323848, 18604.44186674402, 17271.136443178042, 17662.381816636356, 17843.821561784214, 18033.909830451288, 18193.727094093334, 11033.503492343025, 11218.943905280421, 11278.492467838803, 11534.826977595176, 11735.941320293345, 13590.778328272398, 14070.718585628434, 14188.858111418755, 14203.502877399242, 14205.644858878612], "value": 8158.5410106333175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 109.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 130.0, 166.0, 123.0, 123.0, 125.0, 125.0, 143.0, 129.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 162.0, 165.0, 166.0, 165.0, 169.0, 171.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 119.0, 77.0, 75.0, 74.0, 74.0, 95.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 110.0, 84.0, 84.0, 81.0, 99.0, 82.0, 83.0, 103.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 122.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 149.0, 152.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 57.0, 58.0, 55.0, 59.0, 56.0, 55.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 88.0, 87.0, 87.0, 101.0, 89.0, 121.0, 101.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 139.0, 137.0, 129.0, 128.0, 137.0, 133.0, 128.0, 144.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 193.0, 189.0, 182.0, 202.0, 196.0, 195.0, 196.0, 194.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 76.0, 71.0, 74.0, 78.0, 74.0, 71.0], "value": 72.5, "unit": "score"}]}]} 09:02:53 INFO - Return code: 0 09:02:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:53 INFO - # TBPL SUCCESS # 09:02:53 INFO - Running post-action listener: _resource_record_post_action 09:02:53 INFO - [mozharness: 2017-06-02 16:02:53.896733Z] Finished run-tests step (success) 09:02:53 INFO - Running post-run listener: _resource_record_post_run 09:02:53 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8589312; Write bytes: 436228096; Read time: 1940; Write time: 373996 09:02:53 INFO - TinderboxPrint: CPU usage
12.7% 09:02:53 INFO - TinderboxPrint: I/O read bytes / time
8,589,312 / 1,940 09:02:53 INFO - TinderboxPrint: I/O write bytes / time
436,228,096 / 373,996 09:02:53 INFO - TinderboxPrint: CPU idle
8,747.6 (87.3%) 09:02:53 INFO - TinderboxPrint: CPU user
1,211.4 (12.1%) 09:02:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113057792; Read time: 0; Write time: 109824 09:02:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:02:54 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 6221824; Write bytes: 323170304; Read time: 1364; Write time: 264172 09:02:54 INFO - Running post-run listener: _upload_blobber_files 09:02:54 INFO - Blob upload gear active. 09:02:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:55 INFO - (blobuploader) - INFO - Done attempting. 09:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:57 INFO - (blobuploader) - INFO - Done attempting. 09:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:57 INFO - (blobuploader) - INFO - Done attempting. 09:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:04 INFO - (blobuploader) - INFO - Done attempting. 09:03:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:04 INFO - Return code: 0 09:03:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0227488355d69280ae77cee3e9c672a13a33e9981c24a9b546771286d99072e14db4e7c10e9692367b4ccf5f02e47e3a8bd9bde79aa3dc2694005bf58e8c65", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24cd8b5b406a44b5b0d97f515b4a00e0a43e79345b4798789a08a1c8ef9d667458d5fb52392a5242f80c68a0e5b996541a10b60921a181c3c9b628262dd6c44f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c90c088d7bfc79a11014cdb64202093333e8b24cd87170d653bd9f8a31a07aa28f42ee3d77a648c7df8ad812ffad2f8ac85db1d60804965fb81a59736de236b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d6b66c1046e9181eded66078d54a025cbde2c26f091972028035707b7548a49a54d9123af51e463086e69985a9dd85b37a51fceeb6284c9c575ae2448e127a8"} 09:03:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:04 INFO - Contents: 09:03:04 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0227488355d69280ae77cee3e9c672a13a33e9981c24a9b546771286d99072e14db4e7c10e9692367b4ccf5f02e47e3a8bd9bde79aa3dc2694005bf58e8c65", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24cd8b5b406a44b5b0d97f515b4a00e0a43e79345b4798789a08a1c8ef9d667458d5fb52392a5242f80c68a0e5b996541a10b60921a181c3c9b628262dd6c44f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c90c088d7bfc79a11014cdb64202093333e8b24cd87170d653bd9f8a31a07aa28f42ee3d77a648c7df8ad812ffad2f8ac85db1d60804965fb81a59736de236b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d6b66c1046e9181eded66078d54a025cbde2c26f091972028035707b7548a49a54d9123af51e463086e69985a9dd85b37a51fceeb6284c9c575ae2448e127a8"} 09:03:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:04 INFO - Copying logs to upload dir... 09:03:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.640483 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-02 09:03:04.507950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:03:04.515525) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 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/3b0227488355d69280ae77cee3e9c672a13a33e9981c24a9b546771286d99072e14db4e7c10e9692367b4ccf5f02e47e3a8bd9bde79aa3dc2694005bf58e8c65", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24cd8b5b406a44b5b0d97f515b4a00e0a43e79345b4798789a08a1c8ef9d667458d5fb52392a5242f80c68a0e5b996541a10b60921a181c3c9b628262dd6c44f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c90c088d7bfc79a11014cdb64202093333e8b24cd87170d653bd9f8a31a07aa28f42ee3d77a648c7df8ad812ffad2f8ac85db1d60804965fb81a59736de236b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d6b66c1046e9181eded66078d54a025cbde2c26f091972028035707b7548a49a54d9123af51e463086e69985a9dd85b37a51fceeb6284c9c575ae2448e127a8"} build_url:https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/IR6ZZSWGSGCRwSsBlYq1KQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0227488355d69280ae77cee3e9c672a13a33e9981c24a9b546771286d99072e14db4e7c10e9692367b4ccf5f02e47e3a8bd9bde79aa3dc2694005bf58e8c65", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24cd8b5b406a44b5b0d97f515b4a00e0a43e79345b4798789a08a1c8ef9d667458d5fb52392a5242f80c68a0e5b996541a10b60921a181c3c9b628262dd6c44f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c90c088d7bfc79a11014cdb64202093333e8b24cd87170d653bd9f8a31a07aa28f42ee3d77a648c7df8ad812ffad2f8ac85db1d60804965fb81a59736de236b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d6b66c1046e9181eded66078d54a025cbde2c26f091972028035707b7548a49a54d9123af51e463086e69985a9dd85b37a51fceeb6284c9c575ae2448e127a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:03:04.543322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:03:04.543655) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496415282.337396-1961000845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:03:04.624895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:03:04.628252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:03:04.628577) ========= ========= Total master_lag: 0.21 =========