builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1497268911.99 results: success (0) revision: f9605772a0c9098ed1bcaa98089b2c944ed69e9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:51.992942) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:51.993341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:51.997068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:52.019629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:52.019891) ========= 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=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-12 05:01:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.6M=0s 2017-06-12 05:01:53 (87.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125112 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:52.198556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:52.199059) ========= 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=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023313 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:52.239393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-12 05:01:52.239689) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9605772a0c9098ed1bcaa98089b2c944ed69e9b --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 f9605772a0c9098ed1bcaa98089b2c944ed69e9b --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=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-12 05:01:53,360 truncating revision to first 12 chars 2017-06-12 05:01:53,360 Setting DEBUG logging. 2017-06-12 05:01:53,360 attempt 1/10 2017-06-12 05:01:53,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9605772a0c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-12 05:01:54,294 unpacking tar archive at: mozilla-central-f9605772a0c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.200098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-12 05:01:53.451622) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:53.454946) ========= script_repo_revision: f9605772a0c9098ed1bcaa98089b2c944ed69e9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:53.455300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:53.455555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:53.465121) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-12 05:01:53.465383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:54 INFO - MultiFileLogger online at 20170612 05:01:54 in /builds/slave/test 05:01:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:01:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:54 INFO - {'append_to_log': False, 05:01:54 INFO - 'base_work_dir': '/builds/slave/test', 05:01:54 INFO - 'blob_upload_branch': 'Firefox', 05:01:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:54 INFO - 'branch': 'Firefox', 05:01:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:54 INFO - 'config_files': ('talos/linux_config.py',), 05:01:54 INFO - 'default_actions': ('clobber', 05:01:54 INFO - 'read-buildbot-config', 05:01:54 INFO - 'download-and-extract', 05:01:54 INFO - 'populate-webroot', 05:01:54 INFO - 'create-virtualenv', 05:01:54 INFO - 'install', 05:01:54 INFO - 'setup-mitmproxy', 05:01:54 INFO - 'run-tests'), 05:01:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:54 INFO - 'download_minidump_stackwalk': True, 05:01:54 INFO - 'download_symbols': 'ondemand', 05:01:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:54 INFO - 'gecko_profile': False, 05:01:54 INFO - 'gecko_profile_interval': 0, 05:01:54 INFO - 'installer_path': 'installer.exe', 05:01:54 INFO - 'log_level': 'info', 05:01:54 INFO - 'log_name': 'talos', 05:01:54 INFO - 'log_to_console': True, 05:01:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:54 INFO - 'opt_config_files': (), 05:01:54 INFO - 'pip_index': False, 05:01:54 INFO - 'suite': 'dromaeojs-e10s', 05:01:54 INFO - 'system_bits': '32', 05:01:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:54 INFO - 'title': 'talos-linux64-ix-054', 05:01:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:54 INFO - 'use_talos_json': True, 05:01:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:54 INFO - 'work_dir': 'build'} 05:01:54 INFO - [mozharness: 2017-06-12 12:01:54.693219Z] Running clobber step. 05:01:54 INFO - Running pre-action listener: _resource_record_pre_action 05:01:54 INFO - Running main action method: clobber 05:01:54 INFO - rmtree: /builds/slave/test/build 05:01:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:56 INFO - Running post-action listener: _resource_record_post_action 05:01:56 INFO - [mozharness: 2017-06-12 12:01:56.242069Z] Finished clobber step (success) 05:01:56 INFO - [mozharness: 2017-06-12 12:01:56.242168Z] Running read-buildbot-config step. 05:01:56 INFO - Running pre-action listener: _resource_record_pre_action 05:01:56 INFO - Running main action method: read_buildbot_config 05:01:56 INFO - Using buildbot properties: 05:01:56 INFO - { 05:01:56 INFO - "project": "", 05:01:56 INFO - "product": "firefox", 05:01:56 INFO - "who": "cbook@mozilla.com", 05:01:56 INFO - "installer_path": "public/build/target.tar.bz2", 05:01:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:01:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:01:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:01:56 INFO - "stage_platform": "linux64-stylosequential", 05:01:56 INFO - "basedir": "/builds/slave/test", 05:01:56 INFO - "buildnumber": 54, 05:01:56 INFO - "platform": "ubuntu64_hw_styloseq", 05:01:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:01:56 INFO - "slavebuilddir": "test", 05:01:56 INFO - "taskId": "S0fiRmXET3-Dit2-lzCglQ", 05:01:56 INFO - "branch": "mozilla-central", 05:01:56 INFO - "script_repo_revision": "production", 05:01:56 INFO - "revision": "f9605772a0c9098ed1bcaa98089b2c944ed69e9b", 05:01:56 INFO - "slavename": "talos-linux64-ix-054", 05:01:56 INFO - "repo_path": "mozilla-central" 05:01:56 INFO - } 05:01:56 INFO - Finding installer, test and symbols from parent task. 05:01:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0fiRmXET3-Dit2-lzCglQ'}, attempt #1 05:01:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0fiRmXET3-Dit2-lzCglQ'}, attempt #1 05:01:57 INFO - Task dependencies: QfHtqPEXTuOQ4r-A0GCs0w 05:01:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w'}, attempt #1 05:01:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:01:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/test_packages.json 05:01:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip 05:01:57 INFO - Running post-action listener: _resource_record_post_action 05:01:57 INFO - [mozharness: 2017-06-12 12:01:57.607911Z] Finished read-buildbot-config step (success) 05:01:57 INFO - [mozharness: 2017-06-12 12:01:57.608131Z] Running download-and-extract step. 05:01:57 INFO - Running pre-action listener: _resource_record_pre_action 05:01:57 INFO - Running main action method: download_and_extract 05:01:57 INFO - mkdir: /builds/slave/test/build/tests 05:01: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')]} 05:01:57 INFO - trying https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json 05:01:57 INFO - Downloading https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:01:58 INFO - Downloaded 989 bytes. 05:01:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:01:58 INFO - Using the following test package requirements: 05:01:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:01:58 INFO - u'common': [u'target.common.tests.zip'], 05:01:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:01:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:01:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:01:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:01:58 INFO - u'mozbase': [u'target.common.tests.zip'], 05:01:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:01:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:01:58 INFO - u'web-platform': [u'target.common.tests.zip', 05:01:58 INFO - u'target.web-platform.tests.tar.gz'], 05:01:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:01:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:01:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip 05:01:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:01:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip into memory 05:01:59 INFO - Content-Length response header: 67876989 05:01:59 INFO - Bytes received: 67876989 05:02:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:02:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip 05:02:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:02:10 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip into memory 05:02:11 INFO - Content-Length response header: 67876989 05:02:11 INFO - Bytes received: 67876989 05:02:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip 05:02:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:02:23 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip into memory 05:02:24 INFO - Content-Length response header: 14450010 05:02:24 INFO - Bytes received: 14450010 05:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:24 INFO - trying https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:02:25 INFO - Downloaded 61471682 bytes. 05:02:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:25 INFO - mkdir: /builds/slave/test/properties 05:02:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:25 INFO - Contents: 05:02:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - Running post-action listener: set_extra_try_arguments 05:02:25 INFO - [mozharness: 2017-06-12 12:02:25.886109Z] Finished download-and-extract step (success) 05:02:25 INFO - [mozharness: 2017-06-12 12:02:25.886205Z] Running populate-webroot step. 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: populate_webroot 05:02:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:25 INFO - '--tppagecycles', 05:02:25 INFO - '7'], 05:02:25 INFO - 'tests': ['tsvgm']}}, 05:02:25 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['damp', 'tps']}, 05:02:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'tests': ['damp', 'tps']}, 05:02:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['dromaeo_dom']}, 05:02:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:02:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:02:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:02:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:02:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:02:25 INFO - 'bloom_basic_ref']}, 05:02:25 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:02:25 INFO - 'talos_options': ['--mitmproxy', 05:02:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:02:25 INFO - '--firstNonBlankPaint'], 05:02:25 INFO - 'tests': ['quantum_pageload_google', 05:02:25 INFO - 'quantum_pageload_youtube', 05:02:25 INFO - 'quantum_pageload_amazon', 05:02:25 INFO - 'quantum_pageload_facebook']}, 05:02:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tsvgx', 05:02:25 INFO - 'tsvgr_opacity', 05:02:25 INFO - 'tart', 05:02:25 INFO - 'tscrollx', 05:02:25 INFO - 'cart', 05:02:25 INFO - 'tsvg_static']}, 05:02:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:25 INFO - 'tsvgr_opacity', 05:02:25 INFO - 'tart', 05:02:25 INFO - 'tscrollx', 05:02:25 INFO - 'cart', 05:02:25 INFO - 'tsvg_static']}, 05:02:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tp5o']}, 05:02:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:02:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s', 05:02:25 INFO - '--xperf_path', 05:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:25 INFO - 'tests': ['tp5n']}, 05:02:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--xperf_path', 05:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:25 INFO - 'tests': ['tp5n']}}, 05:02:25 INFO - 'talos.zip': {'path': '', 05:02:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - [mozharness: 2017-06-12 12:02:25.901166Z] Finished populate-webroot step (success) 05:02:25 INFO - [mozharness: 2017-06-12 12:02:25.901255Z] Running create-virtualenv step. 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: create_virtualenv 05:02:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:25 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 05:02:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:26 INFO - Using real prefix '/usr' 05:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:28 INFO - Installing pip.................done. 05:02:28 INFO - Return code: 0 05:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:28 INFO - Reading from file tmpfile_stdout 05:02:28 INFO - Output received: 05:02:28 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) 05:02:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:28 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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 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 05:02:28 INFO - Cleaning up... 05:02:28 INFO - Return code: 0 05:02:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:28 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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:29 INFO - Downloading/unpacking psutil>=3.1.1 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:30 INFO - Installing collected packages: psutil 05:02:30 INFO - Running setup.py install for psutil 05:02:30 INFO - building 'psutil._psutil_linux' extension 05:02:30 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 05:02:30 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 05:02:30 INFO - building 'psutil._psutil_posix' extension 05:02:30 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 05:02:30 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 05:02:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:30 INFO - Successfully installed psutil 05:02:30 INFO - Cleaning up... 05:02:30 INFO - Return code: 0 05:02:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:30 INFO - Using env: {'DISPLAY': ':0', 05:02:30 INFO - 'HOME': '/home/cltbld', 05:02:30 INFO - 'LANG': 'en_US.UTF-8', 05:02:30 INFO - 'LANGUAGE': 'en_US:en', 05:02:30 INFO - 'LOGNAME': 'cltbld', 05:02:30 INFO - 'MAIL': '/var/mail/cltbld', 05:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:30 INFO - 'MOZ_NO_REMOTE': '1', 05:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:30 INFO - 'NO_EM_RESTART': '1', 05:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:30 INFO - 'PWD': '/builds/slave/test', 05:02:30 INFO - 'SHELL': '/bin/bash', 05:02:30 INFO - 'SHLVL': '1', 05:02:30 INFO - 'TERM': 'linux', 05:02:30 INFO - 'TMOUT': '86400', 05:02:30 INFO - 'USER': 'cltbld', 05:02:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:30 INFO - '_': '/tools/buildbot/bin/python'} 05:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:31 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 05:02:31 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 05:02:31 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 05:02:31 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 05:02:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:32 INFO - Installing collected packages: mozsystemmonitor 05:02:32 INFO - Running setup.py install for mozsystemmonitor 05:02:32 INFO - Successfully installed mozsystemmonitor 05:02:32 INFO - Cleaning up... 05:02:32 INFO - Return code: 0 05:02:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:32 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')]} 05:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:32 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')]} 05:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:32 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:32 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 05:02:32 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 05:02:32 INFO - Using env: {'DISPLAY': ':0', 05:02:32 INFO - 'HOME': '/home/cltbld', 05:02:32 INFO - 'LANG': 'en_US.UTF-8', 05:02:32 INFO - 'LANGUAGE': 'en_US:en', 05:02:32 INFO - 'LOGNAME': 'cltbld', 05:02:32 INFO - 'MAIL': '/var/mail/cltbld', 05:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:32 INFO - 'MOZ_NO_REMOTE': '1', 05:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:32 INFO - 'NO_EM_RESTART': '1', 05:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:32 INFO - 'PWD': '/builds/slave/test', 05:02:32 INFO - 'SHELL': '/bin/bash', 05:02:32 INFO - 'SHLVL': '1', 05:02:32 INFO - 'TERM': 'linux', 05:02:32 INFO - 'TMOUT': '86400', 05:02:32 INFO - 'USER': 'cltbld', 05:02:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:32 INFO - '_': '/tools/buildbot/bin/python'} 05:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:32 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:32 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 05:02:32 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 05:02:32 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 05:02:32 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 05:02:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:33 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 05:02:33 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 05:02:33 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 05:02:33 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 05:02:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:33 INFO - warning: no files found matching '*.txt' 05:02:33 INFO - no previously-included directories found matching 'build' 05:02:33 INFO - no previously-included directories found matching 'dist' 05:02:33 INFO - no previously-included directories found matching '.git*' 05:02:33 INFO - Installing collected packages: jsonschema, functools32 05:02:33 INFO - Running setup.py install for functools32 05:02:33 INFO - warning: no files found matching '*.txt' 05:02:33 INFO - no previously-included directories found matching 'build' 05:02:33 INFO - no previously-included directories found matching 'dist' 05:02:33 INFO - no previously-included directories found matching '.git*' 05:02:33 INFO - Successfully installed jsonschema functools32 05:02:33 INFO - Cleaning up... 05:02:33 INFO - Return code: 0 05:02:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:33 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')]} 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:33 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')]} 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:34 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:34 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 05:02:34 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 05:02:34 INFO - Using env: {'DISPLAY': ':0', 05:02:34 INFO - 'HOME': '/home/cltbld', 05:02:34 INFO - 'LANG': 'en_US.UTF-8', 05:02:34 INFO - 'LANGUAGE': 'en_US:en', 05:02:34 INFO - 'LOGNAME': 'cltbld', 05:02:34 INFO - 'MAIL': '/var/mail/cltbld', 05:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:34 INFO - 'MOZ_NO_REMOTE': '1', 05:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:34 INFO - 'NO_EM_RESTART': '1', 05:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:34 INFO - 'PWD': '/builds/slave/test', 05:02:34 INFO - 'SHELL': '/bin/bash', 05:02:34 INFO - 'SHLVL': '1', 05:02:34 INFO - 'TERM': 'linux', 05:02:34 INFO - 'TMOUT': '86400', 05:02:34 INFO - 'USER': 'cltbld', 05:02:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:34 INFO - '_': '/tools/buildbot/bin/python'} 05:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:34 INFO - Cleaning up... 05:02:34 INFO - Return code: 0 05:02:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:34 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:34 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 05:02:34 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 05:02:34 INFO - Using env: {'DISPLAY': ':0', 05:02:34 INFO - 'HOME': '/home/cltbld', 05:02:34 INFO - 'LANG': 'en_US.UTF-8', 05:02:34 INFO - 'LANGUAGE': 'en_US:en', 05:02:34 INFO - 'LOGNAME': 'cltbld', 05:02:34 INFO - 'MAIL': '/var/mail/cltbld', 05:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:34 INFO - 'MOZ_NO_REMOTE': '1', 05:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:34 INFO - 'NO_EM_RESTART': '1', 05:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:34 INFO - 'PWD': '/builds/slave/test', 05:02:34 INFO - 'SHELL': '/bin/bash', 05:02:34 INFO - 'SHLVL': '1', 05:02:34 INFO - 'TERM': 'linux', 05:02:34 INFO - 'TMOUT': '86400', 05:02:34 INFO - 'USER': 'cltbld', 05:02:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:34 INFO - '_': '/tools/buildbot/bin/python'} 05:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:34 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 05:02:34 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 05:02:34 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 05:02:34 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 05:02:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:35 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 05:02:35 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 05:02:35 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 05:02:35 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 05:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:35 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 05:02:35 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 05:02:35 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 05:02:35 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 05:02:36 INFO - Downloading docopt-0.6.1.tar.gz 05:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:36 INFO - Running setup.py install for blobuploader 05:02:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:36 INFO - Running setup.py install for requests 05:02:36 INFO - Running setup.py install for docopt 05:02:36 INFO - Successfully installed blobuploader requests docopt 05:02:36 INFO - Cleaning up... 05:02:36 INFO - Return code: 0 05:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02: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')]} 05:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:36 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:36 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 05:02:36 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 05:02:36 INFO - Using env: {'DISPLAY': ':0', 05:02:36 INFO - 'HOME': '/home/cltbld', 05:02:36 INFO - 'LANG': 'en_US.UTF-8', 05:02:36 INFO - 'LANGUAGE': 'en_US:en', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MAIL': '/var/mail/cltbld', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SHLVL': '1', 05:02:36 INFO - 'TERM': 'linux', 05:02:36 INFO - 'TMOUT': '86400', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - '_': '/tools/buildbot/bin/python'} 05:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:36 INFO - Running setup.py (path:/tmp/pip-9Q51gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:37 INFO - Running setup.py (path:/tmp/pip-HAjZtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:37 INFO - Running setup.py (path:/tmp/pip-5OiCgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:37 INFO - Running setup.py (path:/tmp/pip-vV0daj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:37 INFO - Running setup.py (path:/tmp/pip-LY4820-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:37 INFO - Running setup.py (path:/tmp/pip-yYEuCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:37 INFO - Running setup.py (path:/tmp/pip-1zpWMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:37 INFO - Running setup.py (path:/tmp/pip-0N6HKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:37 INFO - Running setup.py (path:/tmp/pip-7IOFPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:37 INFO - Running setup.py (path:/tmp/pip-Y8rt2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:37 INFO - Running setup.py (path:/tmp/pip-kWCJGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:37 INFO - Running setup.py (path:/tmp/pip-IPByUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:37 INFO - Running setup.py (path:/tmp/pip-RduIqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:37 INFO - Running setup.py (path:/tmp/pip-G4UzAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:37 INFO - Running setup.py (path:/tmp/pip-tjp1k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:38 INFO - Running setup.py (path:/tmp/pip-c6vEBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:38 INFO - Running setup.py (path:/tmp/pip-1lfZg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:38 INFO - Running setup.py install for manifestparser 05:02:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Running setup.py install for mozcrash 05:02:38 INFO - Running setup.py install for mozdebug 05:02:38 INFO - Running setup.py install for mozdevice 05:02:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Running setup.py install for mozfile 05:02:38 INFO - Running setup.py install for mozhttpd 05:02:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Running setup.py install for mozinfo 05:02:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Running setup.py install for mozInstall 05:02:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:38 INFO - Running setup.py install for mozleak 05:02:39 INFO - Running setup.py install for mozlog 05:02:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Running setup.py install for moznetwork 05:02:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Running setup.py install for mozprocess 05:02:39 INFO - Running setup.py install for mozprofile 05:02:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Running setup.py install for mozrunner 05:02:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Running setup.py install for mozscreenshot 05:02:39 INFO - Running setup.py install for moztest 05:02:39 INFO - Running setup.py install for mozversion 05:02:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:39 INFO - Cleaning up... 05:02:39 INFO - Return code: 0 05:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:39 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:39 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 05:02:39 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 05:02:39 INFO - Using env: {'DISPLAY': ':0', 05:02:39 INFO - 'HOME': '/home/cltbld', 05:02:39 INFO - 'LANG': 'en_US.UTF-8', 05:02:39 INFO - 'LANGUAGE': 'en_US:en', 05:02:39 INFO - 'LOGNAME': 'cltbld', 05:02:39 INFO - 'MAIL': '/var/mail/cltbld', 05:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:39 INFO - 'MOZ_NO_REMOTE': '1', 05:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:39 INFO - 'NO_EM_RESTART': '1', 05:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:39 INFO - 'PWD': '/builds/slave/test', 05:02:39 INFO - 'SHELL': '/bin/bash', 05:02:39 INFO - 'SHLVL': '1', 05:02:39 INFO - 'TERM': 'linux', 05:02:39 INFO - 'TMOUT': '86400', 05:02:39 INFO - 'USER': 'cltbld', 05:02:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:39 INFO - '_': '/tools/buildbot/bin/python'} 05:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:40 INFO - Running setup.py (path:/tmp/pip-w9LXcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:40 INFO - Running setup.py (path:/tmp/pip-dZWIBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:40 INFO - Running setup.py (path:/tmp/pip-ejk1TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:40 INFO - Running setup.py (path:/tmp/pip-Ku1ABC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:40 INFO - Running setup.py (path:/tmp/pip-_wk2j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:40 INFO - Running setup.py (path:/tmp/pip-OP3D_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:40 INFO - Running setup.py (path:/tmp/pip-jXLGBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:40 INFO - Running setup.py (path:/tmp/pip-Qrzg1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:40 INFO - Running setup.py (path:/tmp/pip-Cxrek1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:40 INFO - Running setup.py (path:/tmp/pip-15BeI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:40 INFO - Running setup.py (path:/tmp/pip-Ct8m_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:40 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)) 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:40 INFO - Running setup.py (path:/tmp/pip-uX4BSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:41 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)) 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:41 INFO - Running setup.py (path:/tmp/pip-QydymX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:41 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)) 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:41 INFO - Running setup.py (path:/tmp/pip-ymahPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:41 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)) 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:41 INFO - Running setup.py (path:/tmp/pip-DVK1nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:41 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)) 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:41 INFO - Running setup.py (path:/tmp/pip-Ip6QQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:41 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)) 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:41 INFO - Running setup.py (path:/tmp/pip-O4n0lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:41 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)) 05:02:41 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)) 05:02:41 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)) 05:02:41 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)) 05:02:41 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)) 05:02:41 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)) 05:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02: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 05:02: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 05:02: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 05:02: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 05:02:42 INFO - Downloading blessings-1.6.tar.gz 05:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:42 INFO - Installing collected packages: blessings 05:02:42 INFO - Running setup.py install for blessings 05:02:42 INFO - Successfully installed blessings 05:02:42 INFO - Cleaning up... 05:02:42 INFO - Return code: 0 05:02:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:42 INFO - Reading from file tmpfile_stdout 05:02:42 INFO - Current package versions: 05:02:42 INFO - argparse == 1.2.1 05:02:42 INFO - blessings == 1.6 05:02:42 INFO - blobuploader == 1.2.4 05:02:42 INFO - docopt == 0.6.1 05:02:42 INFO - functools32 == 3.2.3-2 05:02:42 INFO - jsonschema == 2.5.1 05:02:42 INFO - manifestparser == 1.1 05:02:42 INFO - mozInstall == 1.13 05:02:42 INFO - mozcrash == 1.0 05:02:42 INFO - mozdebug == 0.1 05:02:42 INFO - mozdevice == 0.51 05:02:42 INFO - mozfile == 1.2 05:02:42 INFO - mozhttpd == 0.7 05:02:42 INFO - mozinfo == 0.10 05:02:42 INFO - mozleak == 0.1 05:02:42 INFO - mozlog == 3.4 05:02:42 INFO - moznetwork == 0.27 05:02:42 INFO - mozprocess == 0.25 05:02:42 INFO - mozprofile == 0.28 05:02:42 INFO - mozrunner == 6.13 05:02:42 INFO - mozscreenshot == 0.1 05:02:42 INFO - mozsystemmonitor == 0.3 05:02:42 INFO - moztest == 0.8 05:02:42 INFO - mozversion == 1.4 05:02:42 INFO - psutil == 3.1.1 05:02:42 INFO - requests == 1.2.3 05:02:42 INFO - wsgiref == 0.1.2 05:02:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:42 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 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:42 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 05:02:42 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 05:02:42 INFO - Using env: {'DISPLAY': ':0', 05:02:42 INFO - 'HOME': '/home/cltbld', 05:02:42 INFO - 'LANG': 'en_US.UTF-8', 05:02:42 INFO - 'LANGUAGE': 'en_US:en', 05:02:42 INFO - 'LOGNAME': 'cltbld', 05:02:42 INFO - 'MAIL': '/var/mail/cltbld', 05:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:42 INFO - 'MOZ_NO_REMOTE': '1', 05:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:42 INFO - 'NO_EM_RESTART': '1', 05:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:42 INFO - 'PWD': '/builds/slave/test', 05:02:42 INFO - 'SHELL': '/bin/bash', 05:02:42 INFO - 'SHLVL': '1', 05:02:42 INFO - 'TERM': 'linux', 05:02:42 INFO - 'TMOUT': '86400', 05:02:42 INFO - 'USER': 'cltbld', 05:02:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:42 INFO - '_': '/tools/buildbot/bin/python'} 05:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 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)) 05:02:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:02:43 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 05:02:43 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 05:02:43 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 05:02:43 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 05:02:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:02:44 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)) 05:02:44 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)) 05:02:44 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)) 05:02:44 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)) 05:02:44 INFO - Installing collected packages: marionette-driver 05:02:44 INFO - Running setup.py install for marionette-driver 05:02:44 INFO - Successfully installed marionette-driver 05:02:44 INFO - Cleaning up... 05:02:44 INFO - Return code: 0 05:02:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25dd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, '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': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', '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 05:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:02:44 INFO - Using env: {'DISPLAY': ':0', 05:02:44 INFO - 'HOME': '/home/cltbld', 05:02:44 INFO - 'LANG': 'en_US.UTF-8', 05:02:44 INFO - 'LANGUAGE': 'en_US:en', 05:02:44 INFO - 'LOGNAME': 'cltbld', 05:02:44 INFO - 'MAIL': '/var/mail/cltbld', 05:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:44 INFO - 'MOZ_NO_REMOTE': '1', 05:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:44 INFO - 'NO_EM_RESTART': '1', 05:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:44 INFO - 'PWD': '/builds/slave/test', 05:02:44 INFO - 'SHELL': '/bin/bash', 05:02:44 INFO - 'SHLVL': '1', 05:02:44 INFO - 'TERM': 'linux', 05:02:44 INFO - 'TMOUT': '86400', 05:02:44 INFO - 'USER': 'cltbld', 05:02:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:44 INFO - '_': '/tools/buildbot/bin/python'} 05:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:44 INFO - Cleaning up... 05:02:44 INFO - Return code: 0 05:02:44 INFO - Running post-action listener: _resource_record_post_action 05:02:44 INFO - Running post-action listener: _start_resource_monitoring 05:02:44 INFO - Starting resource monitoring. 05:02:44 INFO - [mozharness: 2017-06-12 12:02:44.760205Z] Finished create-virtualenv step (success) 05:02:44 INFO - [mozharness: 2017-06-12 12:02:44.760768Z] Running install step. 05:02:44 INFO - Running pre-action listener: _resource_record_pre_action 05:02:44 INFO - Running main action method: install 05:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:44 INFO - Reading from file tmpfile_stdout 05:02:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:45 INFO - Reading from file tmpfile_stdout 05:02:45 INFO - Output received: 05:02:45 INFO - Usage: mozinstall [options] installer 05:02:45 INFO - Options: 05:02:45 INFO - -h, --help show this help message and exit 05:02:45 INFO - -d DEST, --destination=DEST 05:02:45 INFO - Directory to install application into. [default: 05:02:45 INFO - "/builds/slave/test"] 05:02:45 INFO - --app=APP Application being installed. [default: firefox] 05:02:45 INFO - mkdir: /builds/slave/test/build/application 05:02:45 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'] 05:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:03:02 INFO - Reading from file tmpfile_stdout 05:03:02 INFO - Output received: 05:03:02 INFO - /builds/slave/test/build/application/firefox/firefox 05:03:02 INFO - Running post-action listener: _resource_record_post_action 05:03:02 INFO - [mozharness: 2017-06-12 12:03:02.935947Z] Finished install step (success) 05:03:02 INFO - [mozharness: 2017-06-12 12:03:02.936184Z] Running setup-mitmproxy step. 05:03:02 INFO - Running pre-action listener: _resource_record_pre_action 05:03:02 INFO - Running main action method: setup_mitmproxy 05:03:02 INFO - Skipping: mitmproxy is not required 05:03:02 INFO - Running post-action listener: _resource_record_post_action 05:03:02 INFO - [mozharness: 2017-06-12 12:03:02.936723Z] Finished setup-mitmproxy step (success) 05:03:02 INFO - [mozharness: 2017-06-12 12:03:02.936916Z] Running run-tests step. 05:03:02 INFO - Running pre-action listener: _resource_record_pre_action 05:03:02 INFO - Running main action method: run_tests 05:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:03:02 INFO - Python 2.7.3 05:03:02 INFO - Return code: 0 05:03:02 INFO - grabbing minidump binary from tooltool 05:03:02 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')]} 05:03:02 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 0x2959140>, '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 0x2959a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:03:02 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 05:03:02 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 05:03:02 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 05:03:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:03 INFO - Return code: 0 05:03:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:03:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:03:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:03:03 INFO - ENV: RUST_BACKTRACE is now 1 05:03:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:03:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:03:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:03:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 05:03:03 INFO - Using env: {'DISPLAY': ':0', 05:03:03 INFO - 'HOME': '/home/cltbld', 05:03:03 INFO - 'LANG': 'en_US.UTF-8', 05:03:03 INFO - 'LANGUAGE': 'en_US:en', 05:03:03 INFO - 'LOGNAME': 'cltbld', 05:03:03 INFO - 'MAIL': '/var/mail/cltbld', 05:03:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:03:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:03 INFO - 'MOZ_NO_REMOTE': '1', 05:03:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:03 INFO - 'NO_EM_RESTART': '1', 05:03:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:03 INFO - 'PWD': '/builds/slave/test', 05:03:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:03:03 INFO - 'RUST_BACKTRACE': '1', 05:03:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:03:03 INFO - 'SHELL': '/bin/bash', 05:03:03 INFO - 'SHLVL': '1', 05:03:03 INFO - 'TERM': 'linux', 05:03:03 INFO - 'TMOUT': '86400', 05:03:03 INFO - 'USER': 'cltbld', 05:03:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189', 05:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:03 INFO - '_': '/tools/buildbot/bin/python'} 05:03:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:03:03 INFO - mozversion application_buildid: 20170612111647 05:03:03 INFO - mozversion application_changeset: f9605772a0c9098ed1bcaa98089b2c944ed69e9b 05:03:03 INFO - mozversion application_display_name: Nightly 05:03:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:03 INFO - mozversion application_name: Firefox 05:03:03 INFO - mozversion application_remotingname: firefox 05:03:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:03:03 INFO - mozversion application_vendor: Mozilla 05:03:03 INFO - mozversion application_version: 55.0a1 05:03:03 INFO - mozversion platform_buildid: 20170612111647 05:03:03 INFO - mozversion platform_changeset: f9605772a0c9098ed1bcaa98089b2c944ed69e9b 05:03:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:03:03 INFO - mozversion platform_version: 55.0a1 05:03:03 INFO - using testdate: 1497268983 05:03:03 INFO - actual date: 1497268983 05:03:03 INFO - starting webserver on 'localhost:58342' 05:03:03 INFO - SUITE-START | Running 2 tests 05:03:03 INFO - TEST-START | dromaeo_css 05:03:03 INFO - operating with platform_type : linux_ 05:03:03 INFO - Initialising browser for dromaeo_css test... 05:03:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58342/getInfo.html -profile /tmp/tmpFnwz93/profile 05:03:03 INFO - TEST-INFO | started process 7278 (/builds/slave/test/build/application/firefox/firefox http://localhost:58342/getInfo.html) 05:03:38 INFO - TEST-INFO | 7278: killed by SIGTERM 05:03:38 INFO - Browser initialized. 05:03:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:38 INFO - TEST-INFO | started process 7510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnwz93/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:50 INFO - PID 7510 | RSS: Main: 188260352 05:03:50 INFO - PID 7510 | 05:06:51 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58342/tests/dromaeo/cssquery-ext.html) 05:06:53 INFO - PID 7510 | RSS: Main: 188399616 05:06:53 INFO - PID 7510 | 05:09:55 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-ext.html (next: http://localhost:58342/tests/dromaeo/cssquery-jquery.html) 05:09:55 INFO - PID 7510 | RSS: Main: 187047936 05:09:55 INFO - PID 7510 | 05:12:57 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58342/tests/dromaeo/cssquery-mootools.html) 05:12:58 INFO - PID 7510 | RSS: Main: 190652416 05:12:58 INFO - PID 7510 | 05:16:00 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58342/tests/dromaeo/cssquery-prototype.html) 05:16:00 INFO - PID 7510 | RSS: Main: 188329984 05:16:00 INFO - PID 7510 | 05:19:03 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58342/tests/dromaeo/cssquery-yui.html) 05:19:04 INFO - PID 7510 | RSS: Main: 191918080 05:19:04 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-yui.html (next: http://localhost:58342/tests/dromaeo/cssquery-dojo.html) 05:22:06 INFO - PID 7510 | RSS: Main: 188067840 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | __start_tp_report 05:22:06 INFO - PID 7510 | _x_x_mozilla_page_load 05:22:06 INFO - PID 7510 | _x_x_mozilla_page_load_details 05:22:06 INFO - PID 7510 | |i|pagename|runs| 05:22:06 INFO - PID 7510 | |0;dojo.html;3019.0489995651383;3076.569280300758;3078.9692103078964;3089.2431354318187;3104.4567200739866;5770.798022069233;5816.563757718167;5849.181114643942;5886.264216972879;5923.9407605923925;5832.883342333151;5858.297004359472;5858.41415858414;5876.4123587641325;5937.198478205441;5402.405735369116;5402.864928376783;5459.481349271813;5467.398586155519;5472.2338872557875;5501.0648189807625;5588.189712491686;5594.440555944414;5602.943970560283;5642.210090587321;5587.720613969305;5587.944120558804;5590.301212348457;5591.552675785927;5615.859603509904;5526.253955715967;5540.36285827131;5587.938291724579;5607.074832652607;5621.044422448153;5362.812301569426;5364.517193452569;5364.892702145974;5479.1781232815;5502.779888804443;5857.092150716603;5874.206982057411;5893.941060589382;5918.201042859202;5928.318243401977;6294.590851594632;6315.305316415191;6319.4312511873695;6328.11406403104;6342.841428964267;6332.778352757678;6371.904421433682;6388.488920886318;6388.872222555569;6427.550071494998;5810.244668193108;5922.7927022554;5933.169356290123;5933.910991335133;5952.017917043682;6474.352564743582;6558.114654521674;6571.868562628721;6575.178102737158;6581.670916454158;6219.253689557282;6283.151774510383;6287.685615719287;6295.307516173218;6304.022876454157;6401.423871851555;6403.423691867662;6415.454686351619;6420;6423.132877061536;6137.5703700741415;6185.783497577563;6193.071039344044;6198.504119670415;6392.808215753442;6243.843903902439;6287.371262873676;6315.55791094619;6330.3669633036325;6331.461825744863;5174.404943431478;5221.164613661796;5226.451222621646;5251.501107394792;5271.499207575274;4433.069055498317;4435;4465.642748580106;4487.820487180542;4513.774311284488;5436.184572314184;5530.391656917735;5536.557075434036;5540.806071787468;5556.638818476786;6274.749010039639;6308.495320374451;6313.905291420632;6318.178636777189;6344.080108384258;5480.314960629921;5488.615796894259;5515.806946756844;5554.166874968787;5569.415211402826;5612.494875461228;5663.093904975184;5732.828015159552;5735.627184233012;5746.540276777848;6191.380861913953;6216.53375996793;6217.378262173746;6221.47117495018;6225.408586184396;6478.740850365933;6481.060246264171;6483.837904052436;6492.188476440445;6496.350364963466;6028.457438830526;6114.784027539347;6208.875822483616;6210.223722034746;6217.409346112112;6160.876782464236;6221.09794079865;6251.6561589113035;6253.062040693932;6268.811935641938;6418.101465794699;6422.678866056772;6460.483161346987;6471.417572418505;6477.77327793525;6262.405071518198;6264.154339164154;6266;6279.591826531261;6281.309056003744;6263.279722831932;6274.968625156845;6281.748730050746;6284.780032699016;6292.874142517216;5938.673372964528;5955.880882382241;5961.433663801932;6083.513318934386;6109.48069414087;6228.875422491616;6284.905726414199;6291.559590828598;6295.276043255084;6316.210473690789;6096.9390306096375;6115.480184184216;6124.502994489286;6126.264848218242;6138.75626760427 05:22:06 INFO - PID 7510 | |1;ext.html;731.7731503233995;761.8971438855752;782.7769085810544;801.6472751989124;805.5649949027522;36129.63870361295;36838.44742328867;36978.445323320106;37097.44353834691;37102.814485927534;32923.83538082312;33402.331953360976;33494.330113397715;33561.66438335622;33580.66419335806;6445.097686323918;6565.967170164166;6589.17635295588;6605.603663780189;6608.372204640552;6503.837404064889;6567.573107748005;6591.868162636744;6600.339966003386;6610.3720146586;6558.770443034495;6564.901526477107;6577.671116444182;6592.011198320266;6594.8681026379445;6516.902246466307;6546.116274302955;6563.081168636395;6585.901211481808;6590.934090659104;5874.236349274567;5967.16459695643;5969.8806023879715;6947.861042779166;7188.2811718828225;35164.47253291203;35763.4635480468;35795.64204357949;35889.82055089734;35951.4607280891;3383.441732114198;3428.8285585720864;3429;3430.9656903430896;3431.3995050865997;26163.869180654165;26283.211503654922;26287.21138365852;26325.078622248322;26413.075542355924;3607.8917632470807;3653.5798383186007;3668.0829792551863;3679.7240206984584;3682.760620559655;148220;149290.25354873264;149700;173278;174328;42555.36166957498;43378.34932476015;43452.13095738067;43672.3449148263;43705;44773.776131119135;44905.77547112243;44939.32591011137;44944.3258351125;45040.54959450429;13765.931170344084;13801.309934503235;13861.237631930138;13881.097728647606;13884.791728124086;11240.606578769704;11281.492332845042;11303.717407064725;11310.151738619472;11371.431428428545;13386.933065334611;13392.129511581716;13393.464261429433;13463.730725385438;13736.587902362946;5407.782809048272;5490.6431081979545;5526.668399896019;5605.383407825136;5605.579581531401;973.4986481961795;974.8976357482504;990.1286867556648;1009.8283291840405;1011.3123076308034;20914.686279705817;21180.78819211819;21366.78633213648;21569.352919412442;21574;1027.712240572641;1065.3394895165047;1079.983800242997;1087.7226307291749;1091.0541537847841;11306.491207895664;11311.83032254517;11315.773684526428;11402.771944561227;11774.764504709858;200868;201505;202316;202389;202505;45837.77081114573;46155.5384446158;46187;46211;46273;1353.499205294028;1405.5221224783622;1412.9222892740793;1435.167602790379;1439.3379045639124;19654;21366.252181173586;22142.335729928127;22144;22399.77600223977;34515.4822677655;34528.136796580286;34585.65414345825;34596;34611.65388346185;176170;176446;176564;176693;176993;29512;30456.086317409627;30631;31143.377132457677;31183.84408078036;35114.297714046086;36922.63077369192;37513.81243093767;37733;38058.809705951295;27499.725002750518;27835.44329113447;28112.43775124527;28273.57589636198;28347.574786378635;27743.30641733973;27879.581806273327;28549.714502855535;28921.421571568873;29373.412531748818;32205;32378;32446.513302300955;32469;32470.675293246764;26039.479210416066;27116.1865144046;27313.31716707098;28235.57646635261;28842.57108750205;20939.790602093784;22588.661170082134;22715.432114197276;22854.54290914139;23047.88476057609 05:22:06 INFO - PID 7510 | |2;jquery.html;467.5651643971108;472.7495773678618;486.370150654902;490.2376804069671;504.3292421079966;19644.508887277807;20340.1863925443;20421.387358379234;20426.795732042694;20472.18111275551;18258.543536411562;18303.816961830413;19122.13950372233;21909.452263693416;23973.28080157598;5973.641581505112;6074.8785024299705;6089.299730530979;6092.66490343031;6093.847653808646;6064.818055458321;6084.148219249309;6108.572399932006;6125.418085281891;6141;6090.695465226743;6091.634501929876;6096.69516524172;6105.633661980273;6116.204893363856;5531.585131115163;5689.345725241609;6020.819375418744;6048.637081775108;6103.786367477139;5502.752376143083;5524.58565607581;5564.137558678412;5571.749271282802;5596.104623260258;26083.478330433285;26353;26571.73428265712;26602.068927587636;26710.86644566784;1921.4331772127257;1935.8935258560773;1951.7950615185343;1952.9023548822502;1955.1788248935482;16673.91663041677;17302.56743581408;17536.21087051086;17627.206775695126;17801.287948482044;2234.8659080455222;2282.9086836526517;2317.3743089365944;2329.615613423783;2346.7066616672914;86063.56968215182;90618.54690726504;106465;114408;118669.40665296618;12288.2012669178;13143.474261029452;13427.12723672958;13468.326583670778;13596.728065438636;19599.706004409945;19609.31367402134;19769.50576235577;19774.110165042606;19786;8403.201695838885;8998.415103018282;9058.320625952949;9128;9130.452172869649;8325.084240733515;8462.323014158852;8467.237948584658;8550.78623034429;8570.271526920156;8152.777083437413;8305.252527272574;8393.454425462325;8408.621612027473;8476;2261.7851304126084;2290.797331401028;2313.849599776009;2326.627739561662;2436.8294219404825;951.7430293820768;953.7806304549854;966.5843687214565;1001.2590682894751;1007.0483393193362;18664;18729;18851.90574047121;19290.903545482182;19381.224751010082;952.0527075559723;987.8715766950394;1004.7136566078779;1007.7833265847878;1015.0813513769903;10358.171346292429;12223.694407639703;13359.398827052806;13789.069530265771;13979.650508737363;429696;438055;451071;453860;454658;96486.51756741172;97679.51160244153;97798;97978;98317.50841245748;1078.7734575739182;1184.5972369394276;1217.993910030444;1245.4022069406735;1254.799232122856;18627.813721862607;20361.389158325273;20440.342755441696;20440.59118817645;21000.36998890036;48867.75566122289;49983;50232.49767502278;52834.471655282956;56075;66762.33237667561;68279.3172068273;68834.65582672255;68838;70322;16769.413070542472;16878.915605421895;17084;17258.395956141976;17504.737428938322;18198.818011820244;18243.90878045601;18247.908760456114;18319.08404579739;18417.171227294537;14734.189619571027;15047.097174169585;15265.542033739006;15347.616309591904;15386.076835389913;12830.358482076046;12937.676558086123;13275.535356262484;14194.290285485891;14517.782233266298;15747.685046299239;15924.363025478851;15987;16057.11685857289;16107.275172617496;15554.766678499605;16777.527731862112;16890.324387024873;16890.831091688924;16906.577335566708;15405.537833865003;15469.071855688695;15481.148536830133;15484.225788710744;15486.457973970857 05:22:06 INFO - PID 7510 | |3;mootools.html;1339.163023110556;1395.2256497643803;1399.7900314952756;1418.0640777087124;1421.9217943013134;11812.527498900045;12393.256404615719;12412.131150819447;12473.563425280117;12486.063545234098;12061.758764824699;12422.689432764186;12445.315507647076;12479.438425270862;12482.875171248284;2505.937351566212;2574;2578.1363243313417;2580.7677309042183;2582.367320006601;2396.676448679423;2500.712418071927;2509.987450062747;2513.648089267504;2518.282289547479;2408.6868707068056;2455.791257743094;2503.3366157968153;2571.7813985811135;2594.403287243935;2507.4985002999383;2532.518821423942;2533.5819589767666;2533.8353007054575;2546.096135871767;2367.3963139399343;2399.124319623325;2414.1912459326145;2417.492326611414;2419.8427102238297;11994.340311282876;12068;12092.153549251556;12096.576619818352;12108.394580271039;6779.864402711918;7030.121234845645;7041.507094503387;7042.577445353295;7082.504224704273;4125.360569111793;4157.376393540962;4197.328427451624;4291.592298731615;4418.690691651585;1397.7274431485864;1420.8366037905669;1430.5994321589972;1451.978220326696;1452.1504919622034;18306.725399119023;18464.353747618905;18502.352417665315;18569.90715046416;18727.53181170468;5884.117382392676;5887.881302552501;5897.410258974154;6042.093685947055;6075.301340345828;13553.119047261896;13655;13661.726765464635;13674.247916364695;13706.177629342272;6753.797386078426;6884.896726549106;6900.551464154814;6935.133108361455;6937.098177236927;6330.113784070234;6397.840053998594;6439.066335381343;6443.903341449882;6545.116409284781;4619.722816631013;4675.4389473262745;4717.740524271198;4789.233722604366;4815.735134567562;1386.050555369575;1393.6028231953844;1406.4796025470641;1416.419268100074;1417.964550886236;782.9569373684388;835.8955130608674;838.6184286149787;846.3356265331809;847.9491230526188;6122.357152499013;6172.475339596095;6241.157443745127;6402.839929001812;6460.224773027267;904.500636132314;970.9563069661741;978.706388083572;985.3004366899581;1007.43080159711;4043.5754245804355;4096.897577560525;4171.290880550253;4291.206126866539;4494.191045611756;15720.764188537181;16435.506934791738;16458.42395516151;16470.505884823473;16477.670446591;15974.961627494407;16175;16195.947263428076;16260.674786504203;16271.430499932445;8921.643134274556;9642.71071867845;9665.565049572786;9786.168175705003;9927.056929591678;6398.584092034003;6582.8354291143105;6692.196936367667;6971.930280697128;7118.394936430462;13785.51750688721;14198.787018194942;14297.499587514387;14529.128252304896;14788.926055370084;14557.199354035629;14723.116613002825;14799.92600036993;14831.92584037073;14914.77627835605;10186.388816671024;10388.532516036645;10403.687889363331;10415.739606509898;10455.581776728846;10273.126784223425;10715.035646791826;10880.183986200907;10918.672439826818;11000.779984400428;8796.956015219883;9147.181565863344;9207.769805754642;9370.906290937004;9688.660896868576;9324.533773311443;9588.185004274716;9670.661526846527;9721.076497732704;10002.899971000197;8296.751097467086;8390.035145958293;8399.076101628938;8422.494650321001;8424.410291279552;5997.271241585156;6052.061930400795;6170.413810687977;6247;6446.516511261768;5836.737346819318;5853.385394533683;5973.283206015306;6147.262328520606;6193.225846769154 05:22:06 INFO - PID 7510 | |4;prototype.html;427.26936937836297;441.51212909734744;458.2690608479475;459.35690033952454;463.68469440780257;6277.497800175986;6308.179936608234;6338.524610654208;6358.586691865025;6393.808185754429;5941.197938278331;6100.450959413652;6124.387561243873;6136.509079273658;6196.72114754836;4951.975240123803;4983.451820299764;4993.675411098267;4997.30037794709;4999.125153098212;4909.509049095098;4910.263460480921;4912.287718280847;4919.557239848413;4941.4811444798315;4866.440359358666;4871.464138944713;4873.43955445123;4878.731669758162;5071.391433028042;5070.771815268304;5097.343363406908;5106.846794596168;5111.821086262;5129.563987061104;4615.076984603059;4678.836240731558;4705.3647757552635;4707.6233901287815;4717.221658426355;6005.369436209223;6039.909401358939;6045.425684559959;6056.727447264883;6058.606190597597;5854.238948936653;5855.443732845373;5881.176635271066;5891.351951285355;5893.697600751476;6596;6614.272430032693;6623.940169572893;6628.801135965929;6633.104530888365;5059.797608095671;5080.110980578384;5099.949000509984;5104.923426148611;5114.667546609458;6899.896501552431;6943.548669336477;7003.579785212853;7004.089468369079;7040.542364746275;5233.869153271199;5262.210668399771;5265.815696450606;5273.472652734773;5277.551408130275;5303.36359636846;5325.201219817059;5334.973325133349;5344.759485823147;5378.408375078739;5895;5906.7637294508595;5907.675077870673;5907.822765317047;5911.556633252523;6252.780263006567;6669.833254168685;6681.421013453723;6681.899771503431;6733.993274001961;1834.5046837353839;1854.3046357615895;1881.5296175956012;1888.669482840525;1891.6405882882484;1265.3799638177227;1325.495562536528;1352.8985326100583;1387.341013018828;1391.930403479822;5657.821738630657;5705.576654007646;5755;5812.593118481665;5812.796552120655;6680.3987641112535;6849.897251541231;6870.931290687129;6881.759138430231;6887.965560172167;5693.259876216065;5774.364819869811;5782.624129431573;5787.305523337226;5788.247527821356;3468.3813720640755;3611.331903597843;3613.1328481164855;3633.1280492681567;3640.7815531068222;6524.086627872101;6532.706028228741;6550;6556.541042127101;6580.11168492257;6882.380585747307;6943.583384996917;6944.270851560615;6956.5478243914995;6963.651817409109;6462.256840463313;6464.806055818333;6484.221893372825;6514.413702766679;6515.185601799775;6727.327267273234;6728.082496488477;6759.628220447726;6761.154855643044;6764.526483146133;6681.394256239973;6700.865982680221;6701.056693558813;6737.730490780314;6741.325867413219;6487.286398496068;6504.869902601827;6522.478201743944;6526.771562995273;6560.212774467094;4806.375171227718;4854.737768180369;4868.90262194747;4878.219484882402;4883.096627123993;6747.089142965833;6777;6782.152230971129;6800.591964482147;6819.249882513019;6179.5056395489155;6557.262360454495;6571.572847765071;6573.3098024706715;6606.273309935807;6506.837329066811;6530.706118224786;6545.509086818603;6548.705308261235;6560.3111673273615;6505.51208659343;6512.967435162794;6519.511036672364;6539.182602174728;6539.673016349068;6649.933500664932;6653.800385988428;6660.933390666225;6666.366740148695;6676.232233293234;6138.416850399205;6277.18396608438;6288.779892703734;6301.8109456716375;6440.488209598167 05:22:06 INFO - PID 7510 | |5;yui.html;820.5394397971605;830.9210624990625;835.9373047021475;842.5323945210409;849.5921957460419;17201.7419738704;17560.297588096462;17565.297388104478;17568.912155439237;17584.73622895656;17307.82692173078;18064.909675451636;18779.53051173718;18931.62136757264;18953;989.9802003959934;1010.7271036820055;1013.4020927652683;1014.6651604970342;1014.9188064954823;1023.2785885950387;1026.3277553202627;1028.0901402259017;1028.1363654530194;1029.5367084811865;1074.2533938912459;1074.5003573338397;1074.8871368506311;1075.7525769073118;1076.4025965589135;937.9531023448834;1033.3696445168441;1037.3412882819464;1045.4772613693153;1068.9518971646294;752.4732687119039;754.3814072460584;754.9094108706936;754.969801207951;757.6552668535858;16911.750054795102;16968.066756328397;17149.57126071858;17167.742483862752;17174.48476545693;18387.172577233923;18909.338173163873;18990.90504547482;19042.238310467565;19188.616227675368;14196.50312239077;14789.40842366304;14858.702825943528;14915.776263356058;14999.475018374305;3467.3412051710093;3500.0549851540195;3520.331137083946;3537.451694987281;3538.292341531704;79395.60302198453;81505;84447.57776211141;87244.56377718071;87994.56002720009;14953.177575233249;15151.469698560497;15168.772468412983;15185;15364.539063827879;24756;25476.490470190492;25815.225543233733;25828.096016639327;25905.481890362087;7889.723859664884;7893.407994400443;7899.210078992055;7906.841863162705;7911.960440197762;3720.8883733488037;3785.507883975121;3793.734438589272;3810.142717888453;3817.6373244541724;4209.452771139732;4266.8293268269545;4303.612674859278;4329.588689074533;4367.344898265222;799.7840583042662;829.1873963515789;833.0919297965247;835.9122292159358;841.1840514700731;587.8181773724217;664.1697877652933;668.2448832818884;677.1569396101885;680.2279412866433;10231.28381013322;10693.572257109785;10723.249372544004;10757.731056723644;11107.500162492708;666.4468491152332;669.9430548403441;688.6591137387026;704.3731079339392;711.2567367101392;4985.302057711923;4990.426100998359;5103.260027296022;5193.143131383279;5246.580273578104;85623.5718821402;90187;91914.54042729878;96182.51908740411;97108;76498;78943;82347.58826205951;82388.58805705933;82709.17290827136;70805.58388832194;71869.6406517964;72261.6386918062;72621.27378726145;74582.62708686422;9465.290103242147;9590.040995900354;9911.207103431852;10160.136388406772;11139.498722557666;33316;34096.65903340935;34575;34810.65189348176;35190.94427167189;57891.71054144702;60437.395626044934;65688;66592.66703666645;67556.66221668861;17701.114944252477;18365.540861478035;18439.170237339084;18522.351717689817;18538.536536586693;18875;18904.905475472533;18908.621827563646;19123.8087619122;19148.61702765909;15872.334539974292;16273.186340683154;16560.585985350463;16600.584985375463;16659.75010374821;16650.58373540671;17401.56496087608;17621.030843303743;17847.196876140344;17848.55378615545;15705.293261803017;16076.437324694047;16101.275442605345;16128.67742645164;16253.268602913135;10975.012248897638;11062.115030797357;11138.053265472525;11438.542458301576;11927.94036029849;11059.22585419013;11063.50214240345;11108.333499990027;11492.82760758606;11562.190646654653 05:22:06 INFO - PID 7510 | __end_tp_report 05:22:06 INFO - PID 7510 | __start_cc_report 05:22:06 INFO - PID 7510 | _x_x_mozilla_cycle_collect,392 05:22:06 INFO - PID 7510 | __end_cc_report 05:22:06 INFO - PID 7510 | __startTimestamp1497270126260__endTimestamp 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | ------- Summary: start ------- 05:22:06 INFO - PID 7510 | Number of tests: 6 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#0] dojo.html Cycles:165 Average:5876.69 Median:6114.78 stddev:669.09 (10.9%) stddev-sans-first:632.47 05:22:06 INFO - PID 7510 | Values: 3019.0 3076.6 3079.0 3089.2 3104.5 5770.8 5816.6 5849.2 5886.3 5923.9 5832.9 5858.3 5858.4 5876.4 5937.2 5402.4 5402.9 5459.5 5467.4 5472.2 5501.1 5588.2 5594.4 5602.9 5642.2 5587.7 5587.9 5590.3 5591.6 5615.9 5526.3 5540.4 5587.9 5607.1 5621.0 5362.8 5364.5 5364.9 5479.2 5502.8 5857.1 5874.2 5893.9 5918.2 5928.3 6294.6 6315.3 6319.4 6328.1 6342.8 6332.8 6371.9 6388.5 6388.9 6427.6 5810.2 5922.8 5933.2 5933.9 5952.0 6474.4 6558.1 6571.9 6575.2 6581.7 6219.3 6283.2 6287.7 6295.3 6304.0 6401.4 6403.4 6415.5 6420.0 6423.1 6137.6 6185.8 6193.1 6198.5 6392.8 6243.8 6287.4 6315.6 6330.4 6331.5 5174.4 5221.2 5226.5 5251.5 5271.5 4433.1 4435.0 4465.6 4487.8 4513.8 5436.2 5530.4 5536.6 5540.8 5556.6 6274.7 6308.5 6313.9 6318.2 6344.1 5480.3 5488.6 5515.8 5554.2 5569.4 5612.5 5663.1 5732.8 5735.6 5746.5 6191.4 6216.5 6217.4 6221.5 6225.4 6478.7 6481.1 6483.8 6492.2 6496.4 6028.5 6114.8 6208.9 6210.2 6217.4 6160.9 6221.1 6251.7 6253.1 6268.8 6418.1 6422.7 6460.5 6471.4 6477.8 6262.4 6264.2 6266.0 6279.6 6281.3 6263.3 6275.0 6281.7 6284.8 6292.9 5938.7 5955.9 5961.4 6083.5 6109.5 6228.9 6284.9 6291.6 6295.3 6316.2 6096.9 6115.5 6124.5 6126.3 6138.8 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#1] ext.html Cycles:180 Average:32988.04 Median:32469.84 stddev:46645.27 (143.7%) stddev-sans-first:46713.24 05:22:06 INFO - PID 7510 | Values: 731.8 761.9 782.8 801.6 805.6 36129.6 36838.4 36978.4 37097.4 37102.8 32923.8 33402.3 33494.3 33561.7 33580.7 6445.1 6566.0 6589.2 6605.6 6608.4 6503.8 6567.6 6591.9 6600.3 6610.4 6558.8 6564.9 6577.7 6592.0 6594.9 6516.9 6546.1 6563.1 6585.9 6590.9 5874.2 5967.2 5969.9 6947.9 7188.3 35164.5 35763.5 35795.6 35889.8 35951.5 3383.4 3428.8 3429.0 3431.0 3431.4 26163.9 26283.2 26287.2 26325.1 26413.1 3607.9 3653.6 3668.1 3679.7 3682.8 148220.0 149290.3 149700.0 173278.0 174328.0 42555.4 43378.3 43452.1 43672.3 43705.0 44773.8 44905.8 44939.3 44944.3 45040.5 13765.9 13801.3 13861.2 13881.1 13884.8 11240.6 11281.5 11303.7 11310.2 11371.4 13386.9 13392.1 13393.5 13463.7 13736.6 5407.8 5490.6 5526.7 5605.4 5605.6 973.5 974.9 990.1 1009.8 1011.3 20914.7 21180.8 21366.8 21569.4 21574.0 1027.7 1065.3 1080.0 1087.7 1091.1 11306.5 11311.8 11315.8 11402.8 11774.8 200868.0 201505.0 202316.0 202389.0 202505.0 45837.8 46155.5 46187.0 46211.0 46273.0 1353.5 1405.5 1412.9 1435.2 1439.3 19654.0 21366.3 22142.3 22144.0 22399.8 34515.5 34528.1 34585.7 34596.0 34611.7 176170.0 176446.0 176564.0 176693.0 176993.0 29512.0 30456.1 30631.0 31143.4 31183.8 35114.3 36922.6 37513.8 37733.0 38058.8 27499.7 27835.4 28112.4 28273.6 28347.6 27743.3 27879.6 28549.7 28921.4 29373.4 32205.0 32378.0 32446.5 32469.0 32470.7 26039.5 27116.2 27313.3 28235.6 28842.6 20939.8 22588.7 22715.4 22854.5 23047.9 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#2] jquery.html Cycles:180 Average:30933.44 Median:21454.91 stddev:74253.06 (346.1%) stddev-sans-first:74426.13 05:22:06 INFO - PID 7510 | Values: 467.6 472.7 486.4 490.2 504.3 19644.5 20340.2 20421.4 20426.8 20472.2 18258.5 18303.8 19122.1 21909.5 23973.3 5973.6 6074.9 6089.3 6092.7 6093.8 6064.8 6084.1 6108.6 6125.4 6141.0 6090.7 6091.6 6096.7 6105.6 6116.2 5531.6 5689.3 6020.8 6048.6 6103.8 5502.8 5524.6 5564.1 5571.7 5596.1 26083.5 26353.0 26571.7 26602.1 26710.9 1921.4 1935.9 1951.8 1952.9 1955.2 16673.9 17302.6 17536.2 17627.2 17801.3 2234.9 2282.9 2317.4 2329.6 2346.7 86063.6 90618.5 106465.0 114408.0 118669.4 12288.2 13143.5 13427.1 13468.3 13596.7 19599.7 19609.3 19769.5 19774.1 19786.0 8403.2 8998.4 9058.3 9128.0 9130.5 8325.1 8462.3 8467.2 8550.8 8570.3 8152.8 8305.3 8393.5 8408.6 8476.0 2261.8 2290.8 2313.8 2326.6 2436.8 951.7 953.8 966.6 1001.3 1007.0 18664.0 18729.0 18851.9 19290.9 19381.2 952.1 987.9 1004.7 1007.8 1015.1 10358.2 12223.7 13359.4 13789.1 13979.7 429696.0 438055.0 451071.0 453860.0 454658.0 96486.5 97679.5 97798.0 97978.0 98317.5 1078.8 1184.6 1218.0 1245.4 1254.8 18627.8 20361.4 20440.3 20440.6 21000.4 48867.8 49983.0 50232.5 52834.5 56075.0 66762.3 68279.3 68834.7 68838.0 70322.0 16769.4 16878.9 17084.0 17258.4 17504.7 18198.8 18243.9 18247.9 18319.1 18417.2 14734.2 15047.1 15265.5 15347.6 15386.1 12830.4 12937.7 13275.5 14194.3 14517.8 15747.7 15924.4 15987.0 16057.1 16107.3 15554.8 16777.5 16890.3 16890.8 16906.6 15405.5 15469.1 15481.1 15484.2 15486.5 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#3] mootools.html Cycles:180 Average:7547.11 Median:2558.94 stddev:4942.54 (193.1%) stddev-sans-first:4934.39 05:22:06 INFO - PID 7510 | Values: 1339.2 1395.2 1399.8 1418.1 1421.9 11812.5 12393.3 12412.1 12473.6 12486.1 12061.8 12422.7 12445.3 12479.4 12482.9 2505.9 2574.0 2578.1 2580.8 2582.4 2396.7 2500.7 2510.0 2513.6 2518.3 2408.7 2455.8 2503.3 2571.8 2594.4 2507.5 2532.5 2533.6 2533.8 2546.1 2367.4 2399.1 2414.2 2417.5 2419.8 11994.3 12068.0 12092.2 12096.6 12108.4 6779.9 7030.1 7041.5 7042.6 7082.5 4125.4 4157.4 4197.3 4291.6 4418.7 1397.7 1420.8 1430.6 1452.0 1452.2 18306.7 18464.4 18502.4 18569.9 18727.5 5884.1 5887.9 5897.4 6042.1 6075.3 13553.1 13655.0 13661.7 13674.2 13706.2 6753.8 6884.9 6900.6 6935.1 6937.1 6330.1 6397.8 6439.1 6443.9 6545.1 4619.7 4675.4 4717.7 4789.2 4815.7 1386.1 1393.6 1406.5 1416.4 1418.0 783.0 835.9 838.6 846.3 847.9 6122.4 6172.5 6241.2 6402.8 6460.2 904.5 971.0 978.7 985.3 1007.4 4043.6 4096.9 4171.3 4291.2 4494.2 15720.8 16435.5 16458.4 16470.5 16477.7 15975.0 16175.0 16195.9 16260.7 16271.4 8921.6 9642.7 9665.6 9786.2 9927.1 6398.6 6582.8 6692.2 6971.9 7118.4 13785.5 14198.8 14297.5 14529.1 14788.9 14557.2 14723.1 14799.9 14831.9 14914.8 10186.4 10388.5 10403.7 10415.7 10455.6 10273.1 10715.0 10880.2 10918.7 11000.8 8797.0 9147.2 9207.8 9370.9 9688.7 9324.5 9588.2 9670.7 9721.1 10002.9 8296.8 8390.0 8399.1 8422.5 8424.4 5997.3 6052.1 6170.4 6247.0 6446.5 5836.7 5853.4 5973.3 6147.3 6193.2 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#4] prototype.html Cycles:180 Average:5568.63 Median:6079.53 stddev:1542.12 (25.4%) stddev-sans-first:1497.38 05:22:06 INFO - PID 7510 | Values: 427.3 441.5 458.3 459.4 463.7 6277.5 6308.2 6338.5 6358.6 6393.8 5941.2 6100.5 6124.4 6136.5 6196.7 4952.0 4983.5 4993.7 4997.3 4999.1 4909.5 4910.3 4912.3 4919.6 4941.5 4866.4 4871.5 4873.4 4878.7 5071.4 5070.8 5097.3 5106.8 5111.8 5129.6 4615.1 4678.8 4705.4 4707.6 4717.2 6005.4 6039.9 6045.4 6056.7 6058.6 5854.2 5855.4 5881.2 5891.4 5893.7 6596.0 6614.3 6623.9 6628.8 6633.1 5059.8 5080.1 5099.9 5104.9 5114.7 6899.9 6943.5 7003.6 7004.1 7040.5 5233.9 5262.2 5265.8 5273.5 5277.6 5303.4 5325.2 5335.0 5344.8 5378.4 5895.0 5906.8 5907.7 5907.8 5911.6 6252.8 6669.8 6681.4 6681.9 6734.0 1834.5 1854.3 1881.5 1888.7 1891.6 1265.4 1325.5 1352.9 1387.3 1391.9 5657.8 5705.6 5755.0 5812.6 5812.8 6680.4 6849.9 6870.9 6881.8 6888.0 5693.3 5774.4 5782.6 5787.3 5788.2 3468.4 3611.3 3613.1 3633.1 3640.8 6524.1 6532.7 6550.0 6556.5 6580.1 6882.4 6943.6 6944.3 6956.5 6963.7 6462.3 6464.8 6484.2 6514.4 6515.2 6727.3 6728.1 6759.6 6761.2 6764.5 6681.4 6700.9 6701.1 6737.7 6741.3 6487.3 6504.9 6522.5 6526.8 6560.2 4806.4 4854.7 4868.9 4878.2 4883.1 6747.1 6777.0 6782.2 6800.6 6819.2 6179.5 6557.3 6571.6 6573.3 6606.3 6506.8 6530.7 6545.5 6548.7 6560.3 6505.5 6513.0 6519.5 6539.2 6539.7 6649.9 6653.8 6660.9 6666.4 6676.2 6138.4 6277.2 6288.8 6301.8 6440.5 05:22:06 INFO - PID 7510 | 05:22:06 INFO - PID 7510 | [#5] yui.html Cycles:180 Average:19937.61 Median:25116.25 stddev:25249.35 (100.5%) stddev-sans-first:25279.37 05:22:06 INFO - PID 7510 | Values: 820.5 830.9 835.9 842.5 849.6 17201.7 17560.3 17565.3 17568.9 17584.7 17307.8 18064.9 18779.5 18931.6 18953.0 990.0 1010.7 1013.4 1014.7 1014.9 1023.3 1026.3 1028.1 1028.1 1029.5 1074.3 1074.5 1074.9 1075.8 1076.4 938.0 1033.4 1037.3 1045.5 1069.0 752.5 754.4 754.9 755.0 757.7 16911.8 16968.1 17149.6 17167.7 17174.5 18387.2 18909.3 18990.9 19042.2 19188.6 14196.5 14789.4 14858.7 14915.8 14999.5 3467.3 3500.1 3520.3 3537.5 3538.3 79395.6 81505.0 84447.6 87244.6 87994.6 14953.2 15151.5 15168.8 15185.0 15364.5 24756.0 25476.5 25815.2 25828.1 25905.5 7889.7 7893.4 7899.2 7906.8 7912.0 3720.9 3785.5 3793.7 3810.1 3817.6 4209.5 4266.8 4303.6 4329.6 4367.3 799.8 829.2 833.1 835.9 841.2 587.8 664.2 668.2 677.2 680.2 10231.3 10693.6 10723.2 10757.7 11107.5 666.4 669.9 688.7 704.4 711.3 4985.3 4990.4 5103.3 5193.1 5246.6 85623.6 90187.0 91914.5 96182.5 97108.0 76498.0 78943.0 82347.6 82388.6 82709.2 70805.6 71869.6 72261.6 72621.3 74582.6 9465.3 9590.0 9911.2 10160.1 11139.5 33316.0 34096.7 34575.0 34810.7 35190.9 57891.7 60437.4 65688.0 66592.7 67556.7 17701.1 18365.5 18439.2 18522.4 18538.5 18875.0 18904.9 18908.6 19123.8 19148.6 15872.3 16273.2 16560.6 16600.6 16659.8 16650.6 17401.6 17621.0 17847.2 17848.6 15705.3 16076.4 16101.3 16128.7 16253.3 10975.0 11062.1 11138.1 11438.5 11927.9 11059.2 11063.5 11108.3 11492.8 11562.2 05:22:06 INFO - PID 7510 | -------- Summary: end -------- 05:22:06 INFO - PID 7510 | 05:22:07 INFO - TEST-INFO | 7510: exit 0 05:22:07 INFO - TEST-OK | dromaeo_css | took 1143980ms 05:22:07 INFO - TEST-START | kraken 05:22:07 INFO - operating with platform_type : linux_ 05:22:07 INFO - Initialising browser for kraken test... 05:22:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58342/getInfo.html -profile /tmp/tmpzwPMa4/profile 05:22:07 INFO - TEST-INFO | started process 7946 (/builds/slave/test/build/application/firefox/firefox http://localhost:58342/getInfo.html) 05:22:42 INFO - TEST-INFO | 7946: killed by SIGTERM 05:22:42 INFO - Browser initialized. 05:22:42 INFO - Running cycle 1/1 for kraken test... 05:22:42 INFO - TEST-INFO | started process 8178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzwPMa4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:54 INFO - PID 8178 | RSS: Main: 188465152 05:22:54 INFO - PID 8178 | 05:22:56 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:57 INFO - PID 8178 | RSS: Main: 191090688 05:22:57 INFO - PID 8178 | 05:23:00 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-dft) 05:23:00 INFO - PID 8178 | RSS: Main: 191987712 05:23:00 INFO - PID 8178 | 05:23:03 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-fft) 05:23:04 INFO - PID 8178 | RSS: Main: 187711488 05:23:04 INFO - PID 8178 | 05:23:06 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-oscillator) 05:23:07 INFO - PID 8178 | RSS: Main: 188329984 05:23:07 INFO - PID 8178 | 05:23:09 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:09 INFO - PID 8178 | RSS: Main: 188809216 05:23:09 INFO - PID 8178 | 05:23:13 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:13 INFO - PID 8178 | RSS: Main: 189952000 05:23:13 INFO - PID 8178 | 05:23:17 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:17 INFO - PID 8178 | RSS: Main: 190992384 05:23:17 INFO - PID 8178 | 05:23:20 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58342/tests/kraken/driver.html?testName=json-parse-financial) 05:23:21 INFO - PID 8178 | RSS: Main: 190545920 05:23:21 INFO - PID 8178 | 05:23:22 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:23 INFO - PID 8178 | RSS: Main: 189988864 05:23:23 INFO - PID 8178 | 05:23:25 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:26 INFO - PID 8178 | RSS: Main: 189566976 05:23:26 INFO - PID 8178 | 05:23:28 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:28 INFO - PID 8178 | RSS: Main: 190050304 05:23:28 INFO - PID 8178 | 05:23:31 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:32 INFO - PID 8178 | RSS: Main: 189636608 05:23:32 INFO - PID 8178 | 05:23:35 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:36 INFO - PID 8178 | RSS: Main: 189628416 05:23:36 INFO - PID 8178 | 05:23:37 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58342/tests/kraken/driver.html?testName=ai-astar) 05:23:38 INFO - PID 8178 | RSS: Main: 191270912 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | __start_tp_report 05:23:38 INFO - PID 8178 | _x_x_mozilla_page_load 05:23:38 INFO - PID 8178 | _x_x_mozilla_page_load_details 05:23:38 INFO - PID 8178 | |i|pagename|runs| 05:23:38 INFO - PID 8178 | |0;ai-astar;101;109;111;109;114;113;111;111;110;114 05:23:38 INFO - PID 8178 | |1;audio-beat-detection;154;122;155;174;125;157;146;126;175;127 05:23:38 INFO - PID 8178 | |2;audio-dft;163;165;163;165;172;180;177;171;163;163 05:23:38 INFO - PID 8178 | |3;audio-fft;75;74;80;153;74;74;75;78;93;77 05:23:38 INFO - PID 8178 | |4;audio-oscillator;84;83;137;83;82;82;139;84;83;131 05:23:38 INFO - PID 8178 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;115;120 05:23:38 INFO - PID 8178 | |6;imaging-darkroom;151;151;150;151;150;150;150;149;153;151 05:23:38 INFO - PID 8178 | |7;imaging-desaturate;95;100;94;95;94;95;95;94;94;94 05:23:38 INFO - PID 8178 | |8;json-parse-financial;58;53;59;57;54;54;58;53;53;56 05:23:38 INFO - PID 8178 | |9;json-stringify-tinderbox;57;57;56;58;57;57;56;56;57;57 05:23:38 INFO - PID 8178 | |10;stanford-crypto-aes;80;88;89;79;86;78;80;78;79;78 05:23:38 INFO - PID 8178 | |11;stanford-crypto-ccm;139;147;130;132;129;129;128;134;128;162 05:23:38 INFO - PID 8178 | |12;stanford-crypto-pbkdf2;189;193;206;188;191;189;189;189;199;181 05:23:38 INFO - PID 8178 | |13;stanford-crypto-sha256-iterative;72;72;73;71;79;75;74;70;73;69 05:23:38 INFO - PID 8178 | __end_tp_report 05:23:38 INFO - PID 8178 | __start_cc_report 05:23:38 INFO - PID 8178 | _x_x_mozilla_cycle_collect,974 05:23:38 INFO - PID 8178 | __end_cc_report 05:23:38 INFO - PID 8178 | __startTimestamp1497270218113__endTimestamp 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | ------- Summary: start ------- 05:23:38 INFO - PID 8178 | Number of tests: 14 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.74 (3.4%) stddev-sans-first:1.94 05:23:38 INFO - PID 8178 | Values: 101.0 109.0 111.0 109.0 114.0 113.0 111.0 111.0 110.0 114.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:154.50 stddev:20.19 (13.1%) stddev-sans-first:21.21 05:23:38 INFO - PID 8178 | Values: 154.0 122.0 155.0 174.0 125.0 157.0 146.0 126.0 175.0 127.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#2] audio-dft Cycles:10 Average:168.20 Median:168.00 stddev:6.39 (3.8%) stddev-sans-first:6.50 05:23:38 INFO - PID 8178 | Values: 163.0 165.0 163.0 165.0 172.0 180.0 177.0 171.0 163.0 163.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#3] audio-fft Cycles:10 Average:85.30 Median:76.00 stddev:24.47 (32.2%) stddev-sans-first:25.67 05:23:38 INFO - PID 8178 | Values: 75.0 74.0 80.0 153.0 74.0 74.0 75.0 78.0 93.0 77.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:83.00 stddev:25.52 (30.8%) stddev-sans-first:26.51 05:23:38 INFO - PID 8178 | Values: 84.0 83.0 137.0 83.0 82.0 82.0 139.0 84.0 83.0 131.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 05:23:38 INFO - PID 8178 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 120.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:23:38 INFO - PID 8178 | Values: 151.0 151.0 150.0 151.0 150.0 150.0 150.0 149.0 153.0 151.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.83 (1.9%) stddev-sans-first:1.94 05:23:38 INFO - PID 8178 | Values: 95.0 100.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:2.37 (4.2%) stddev-sans-first:2.33 05:23:38 INFO - PID 8178 | Values: 58.0 53.0 59.0 57.0 54.0 54.0 58.0 53.0 53.0 56.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 05:23:38 INFO - PID 8178 | Values: 57.0 57.0 56.0 58.0 57.0 57.0 56.0 56.0 57.0 57.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.00 stddev:4.38 (5.5%) stddev-sans-first:4.61 05:23:38 INFO - PID 8178 | Values: 80.0 88.0 89.0 79.0 86.0 78.0 80.0 78.0 79.0 78.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:133.00 stddev:10.99 (8.3%) stddev-sans-first:11.60 05:23:38 INFO - PID 8178 | Values: 139.0 147.0 130.0 132.0 129.0 129.0 128.0 134.0 128.0 162.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:190.00 stddev:6.80 (3.6%) stddev-sans-first:7.16 05:23:38 INFO - PID 8178 | Values: 189.0 193.0 206.0 188.0 191.0 189.0 189.0 189.0 199.0 181.0 05:23:38 INFO - PID 8178 | 05:23:38 INFO - PID 8178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.82 (3.9%) stddev-sans-first:2.98 05:23:38 INFO - PID 8178 | Values: 72.0 72.0 73.0 71.0 79.0 75.0 74.0 70.0 73.0 69.0 05:23:38 INFO - PID 8178 | -------- Summary: end -------- 05:23:38 INFO - PID 8178 | 05:23:39 INFO - TEST-INFO | 8178: exit 0 05:23:39 INFO - TEST-OK | kraken | took 92209ms 05:23:39 INFO - SUITE-END | took 1236s 05:23:39 INFO - Completed test suite (00:20:36) 05:23:39 INFO - javascript benchmark 05:23:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7829.225974434904, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.0489995651383, 3076.569280300758, 3078.9692103078964, 3089.2431354318187, 3104.4567200739866, 5770.798022069233, 5816.563757718167, 5849.181114643942, 5886.264216972879, 5923.9407605923925, 5832.883342333151, 5858.297004359472, 5858.41415858414, 5876.4123587641325, 5937.198478205441, 5402.405735369116, 5402.864928376783, 5459.481349271813, 5467.398586155519, 5472.2338872557875, 5501.0648189807625, 5588.189712491686, 5594.440555944414, 5602.943970560283, 5642.210090587321, 5587.720613969305, 5587.944120558804, 5590.301212348457, 5591.552675785927, 5615.859603509904, 5526.253955715967, 5540.36285827131, 5587.938291724579, 5607.074832652607, 5621.044422448153, 5362.812301569426, 5364.517193452569, 5364.892702145974, 5479.1781232815, 5502.779888804443, 5857.092150716603, 5874.206982057411, 5893.941060589382, 5918.201042859202, 5928.318243401977, 6294.590851594632, 6315.305316415191, 6319.4312511873695, 6328.11406403104, 6342.841428964267, 6332.778352757678, 6371.904421433682, 6388.488920886318, 6388.872222555569, 6427.550071494998, 5810.244668193108, 5922.7927022554, 5933.169356290123, 5933.910991335133, 5952.017917043682, 6474.352564743582, 6558.114654521674, 6571.868562628721, 6575.178102737158, 6581.670916454158, 6219.253689557282, 6283.151774510383, 6287.685615719287, 6295.307516173218, 6304.022876454157, 6401.423871851555, 6403.423691867662, 6415.454686351619, 6420.0, 6423.132877061536, 6137.5703700741415, 6185.783497577563, 6193.071039344044, 6198.504119670415, 6392.808215753442, 6243.843903902439, 6287.371262873676, 6315.55791094619, 6330.3669633036325, 6331.461825744863, 5174.404943431478, 5221.164613661796, 5226.451222621646, 5251.501107394792, 5271.499207575274, 4433.069055498317, 4435.0, 4465.642748580106, 4487.820487180542, 4513.774311284488, 5436.184572314184, 5530.391656917735, 5536.557075434036, 5540.806071787468, 5556.638818476786, 6274.749010039639, 6308.495320374451, 6313.905291420632, 6318.178636777189, 6344.080108384258, 5480.314960629921, 5488.615796894259, 5515.806946756844, 5554.166874968787, 5569.415211402826, 5612.494875461228, 5663.093904975184, 5732.828015159552, 5735.627184233012, 5746.540276777848, 6191.380861913953, 6216.53375996793, 6217.378262173746, 6221.47117495018, 6225.408586184396, 6478.740850365933, 6481.060246264171, 6483.837904052436, 6492.188476440445, 6496.350364963466, 6028.457438830526, 6114.784027539347, 6208.875822483616, 6210.223722034746, 6217.409346112112, 6160.876782464236, 6221.09794079865, 6251.6561589113035, 6253.062040693932, 6268.811935641938, 6418.101465794699, 6422.678866056772, 6460.483161346987, 6471.417572418505, 6477.77327793525, 6262.405071518198, 6264.154339164154, 6266.0, 6279.591826531261, 6281.309056003744, 6263.279722831932, 6274.968625156845, 6281.748730050746, 6284.780032699016, 6292.874142517216, 5938.673372964528, 5955.880882382241, 5961.433663801932, 6083.513318934386, 6109.48069414087, 6228.875422491616, 6284.905726414199, 6291.559590828598, 6295.276043255084, 6316.210473690789, 6096.9390306096375, 6115.480184184216, 6124.502994489286, 6126.264848218242, 6138.75626760427], "value": 5828.219433977777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7731503233995, 761.8971438855752, 782.7769085810544, 801.6472751989124, 805.5649949027522, 36129.63870361295, 36838.44742328867, 36978.445323320106, 37097.44353834691, 37102.814485927534, 32923.83538082312, 33402.331953360976, 33494.330113397715, 33561.66438335622, 33580.66419335806, 6445.097686323918, 6565.967170164166, 6589.17635295588, 6605.603663780189, 6608.372204640552, 6503.837404064889, 6567.573107748005, 6591.868162636744, 6600.339966003386, 6610.3720146586, 6558.770443034495, 6564.901526477107, 6577.671116444182, 6592.011198320266, 6594.8681026379445, 6516.902246466307, 6546.116274302955, 6563.081168636395, 6585.901211481808, 6590.934090659104, 5874.236349274567, 5967.16459695643, 5969.8806023879715, 6947.861042779166, 7188.2811718828225, 35164.47253291203, 35763.4635480468, 35795.64204357949, 35889.82055089734, 35951.4607280891, 3383.441732114198, 3428.8285585720864, 3429.0, 3430.9656903430896, 3431.3995050865997, 26163.869180654165, 26283.211503654922, 26287.21138365852, 26325.078622248322, 26413.075542355924, 3607.8917632470807, 3653.5798383186007, 3668.0829792551863, 3679.7240206984584, 3682.760620559655, 148220.0, 149290.25354873264, 149700.0, 173278.0, 174328.0, 42555.36166957498, 43378.34932476015, 43452.13095738067, 43672.3449148263, 43705.0, 44773.776131119135, 44905.77547112243, 44939.32591011137, 44944.3258351125, 45040.54959450429, 13765.931170344084, 13801.309934503235, 13861.237631930138, 13881.097728647606, 13884.791728124086, 11240.606578769704, 11281.492332845042, 11303.717407064725, 11310.151738619472, 11371.431428428545, 13386.933065334611, 13392.129511581716, 13393.464261429433, 13463.730725385438, 13736.587902362946, 5407.782809048272, 5490.6431081979545, 5526.668399896019, 5605.383407825136, 5605.579581531401, 973.4986481961795, 974.8976357482504, 990.1286867556648, 1009.8283291840405, 1011.3123076308034, 20914.686279705817, 21180.78819211819, 21366.78633213648, 21569.352919412442, 21574.0, 1027.712240572641, 1065.3394895165047, 1079.983800242997, 1087.7226307291749, 1091.0541537847841, 11306.491207895664, 11311.83032254517, 11315.773684526428, 11402.771944561227, 11774.764504709858, 200868.0, 201505.0, 202316.0, 202389.0, 202505.0, 45837.77081114573, 46155.5384446158, 46187.0, 46211.0, 46273.0, 1353.499205294028, 1405.5221224783622, 1412.9222892740793, 1435.167602790379, 1439.3379045639124, 19654.0, 21366.252181173586, 22142.335729928127, 22144.0, 22399.77600223977, 34515.4822677655, 34528.136796580286, 34585.65414345825, 34596.0, 34611.65388346185, 176170.0, 176446.0, 176564.0, 176693.0, 176993.0, 29512.0, 30456.086317409627, 30631.0, 31143.377132457677, 31183.84408078036, 35114.297714046086, 36922.63077369192, 37513.81243093767, 37733.0, 38058.809705951295, 27499.725002750518, 27835.44329113447, 28112.43775124527, 28273.57589636198, 28347.574786378635, 27743.30641733973, 27879.581806273327, 28549.714502855535, 28921.421571568873, 29373.412531748818, 32205.0, 32378.0, 32446.513302300955, 32469.0, 32470.675293246764, 26039.479210416066, 27116.1865144046, 27313.31716707098, 28235.57646635261, 28842.57108750205, 20939.790602093784, 22588.661170082134, 22715.432114197276, 22854.54290914139, 23047.88476057609], "value": 15243.87315558807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.5651643971108, 472.7495773678618, 486.370150654902, 490.2376804069671, 504.3292421079966, 19644.508887277807, 20340.1863925443, 20421.387358379234, 20426.795732042694, 20472.18111275551, 18258.543536411562, 18303.816961830413, 19122.13950372233, 21909.452263693416, 23973.28080157598, 5973.641581505112, 6074.8785024299705, 6089.299730530979, 6092.66490343031, 6093.847653808646, 6064.818055458321, 6084.148219249309, 6108.572399932006, 6125.418085281891, 6141.0, 6090.695465226743, 6091.634501929876, 6096.69516524172, 6105.633661980273, 6116.204893363856, 5531.585131115163, 5689.345725241609, 6020.819375418744, 6048.637081775108, 6103.786367477139, 5502.752376143083, 5524.58565607581, 5564.137558678412, 5571.749271282802, 5596.104623260258, 26083.478330433285, 26353.0, 26571.73428265712, 26602.068927587636, 26710.86644566784, 1921.4331772127257, 1935.8935258560773, 1951.7950615185343, 1952.9023548822502, 1955.1788248935482, 16673.91663041677, 17302.56743581408, 17536.21087051086, 17627.206775695126, 17801.287948482044, 2234.8659080455222, 2282.9086836526517, 2317.3743089365944, 2329.615613423783, 2346.7066616672914, 86063.56968215182, 90618.54690726504, 106465.0, 114408.0, 118669.40665296618, 12288.2012669178, 13143.474261029452, 13427.12723672958, 13468.326583670778, 13596.728065438636, 19599.706004409945, 19609.31367402134, 19769.50576235577, 19774.110165042606, 19786.0, 8403.201695838885, 8998.415103018282, 9058.320625952949, 9128.0, 9130.452172869649, 8325.084240733515, 8462.323014158852, 8467.237948584658, 8550.78623034429, 8570.271526920156, 8152.777083437413, 8305.252527272574, 8393.454425462325, 8408.621612027473, 8476.0, 2261.7851304126084, 2290.797331401028, 2313.849599776009, 2326.627739561662, 2436.8294219404825, 951.7430293820768, 953.7806304549854, 966.5843687214565, 1001.2590682894751, 1007.0483393193362, 18664.0, 18729.0, 18851.90574047121, 19290.903545482182, 19381.224751010082, 952.0527075559723, 987.8715766950394, 1004.7136566078779, 1007.7833265847878, 1015.0813513769903, 10358.171346292429, 12223.694407639703, 13359.398827052806, 13789.069530265771, 13979.650508737363, 429696.0, 438055.0, 451071.0, 453860.0, 454658.0, 96486.51756741172, 97679.51160244153, 97798.0, 97978.0, 98317.50841245748, 1078.7734575739182, 1184.5972369394276, 1217.993910030444, 1245.4022069406735, 1254.799232122856, 18627.813721862607, 20361.389158325273, 20440.342755441696, 20440.59118817645, 21000.36998890036, 48867.75566122289, 49983.0, 50232.49767502278, 52834.471655282956, 56075.0, 66762.33237667561, 68279.3172068273, 68834.65582672255, 68838.0, 70322.0, 16769.413070542472, 16878.915605421895, 17084.0, 17258.395956141976, 17504.737428938322, 18198.818011820244, 18243.90878045601, 18247.908760456114, 18319.08404579739, 18417.171227294537, 14734.189619571027, 15047.097174169585, 15265.542033739006, 15347.616309591904, 15386.076835389913, 12830.358482076046, 12937.676558086123, 13275.535356262484, 14194.290285485891, 14517.782233266298, 15747.685046299239, 15924.363025478851, 15987.0, 16057.11685857289, 16107.275172617496, 15554.766678499605, 16777.527731862112, 16890.324387024873, 16890.831091688924, 16906.577335566708, 15405.537833865003, 15469.071855688695, 15481.148536830133, 15484.225788710744, 15486.457973970857], "value": 10964.894604637393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.163023110556, 1395.2256497643803, 1399.7900314952756, 1418.0640777087124, 1421.9217943013134, 11812.527498900045, 12393.256404615719, 12412.131150819447, 12473.563425280117, 12486.063545234098, 12061.758764824699, 12422.689432764186, 12445.315507647076, 12479.438425270862, 12482.875171248284, 2505.937351566212, 2574.0, 2578.1363243313417, 2580.7677309042183, 2582.367320006601, 2396.676448679423, 2500.712418071927, 2509.987450062747, 2513.648089267504, 2518.282289547479, 2408.6868707068056, 2455.791257743094, 2503.3366157968153, 2571.7813985811135, 2594.403287243935, 2507.4985002999383, 2532.518821423942, 2533.5819589767666, 2533.8353007054575, 2546.096135871767, 2367.3963139399343, 2399.124319623325, 2414.1912459326145, 2417.492326611414, 2419.8427102238297, 11994.340311282876, 12068.0, 12092.153549251556, 12096.576619818352, 12108.394580271039, 6779.864402711918, 7030.121234845645, 7041.507094503387, 7042.577445353295, 7082.504224704273, 4125.360569111793, 4157.376393540962, 4197.328427451624, 4291.592298731615, 4418.690691651585, 1397.7274431485864, 1420.8366037905669, 1430.5994321589972, 1451.978220326696, 1452.1504919622034, 18306.725399119023, 18464.353747618905, 18502.352417665315, 18569.90715046416, 18727.53181170468, 5884.117382392676, 5887.881302552501, 5897.410258974154, 6042.093685947055, 6075.301340345828, 13553.119047261896, 13655.0, 13661.726765464635, 13674.247916364695, 13706.177629342272, 6753.797386078426, 6884.896726549106, 6900.551464154814, 6935.133108361455, 6937.098177236927, 6330.113784070234, 6397.840053998594, 6439.066335381343, 6443.903341449882, 6545.116409284781, 4619.722816631013, 4675.4389473262745, 4717.740524271198, 4789.233722604366, 4815.735134567562, 1386.050555369575, 1393.6028231953844, 1406.4796025470641, 1416.419268100074, 1417.964550886236, 782.9569373684388, 835.8955130608674, 838.6184286149787, 846.3356265331809, 847.9491230526188, 6122.357152499013, 6172.475339596095, 6241.157443745127, 6402.839929001812, 6460.224773027267, 904.500636132314, 970.9563069661741, 978.706388083572, 985.3004366899581, 1007.43080159711, 4043.5754245804355, 4096.897577560525, 4171.290880550253, 4291.206126866539, 4494.191045611756, 15720.764188537181, 16435.506934791738, 16458.42395516151, 16470.505884823473, 16477.670446591, 15974.961627494407, 16175.0, 16195.947263428076, 16260.674786504203, 16271.430499932445, 8921.643134274556, 9642.71071867845, 9665.565049572786, 9786.168175705003, 9927.056929591678, 6398.584092034003, 6582.8354291143105, 6692.196936367667, 6971.930280697128, 7118.394936430462, 13785.51750688721, 14198.787018194942, 14297.499587514387, 14529.128252304896, 14788.926055370084, 14557.199354035629, 14723.116613002825, 14799.92600036993, 14831.92584037073, 14914.77627835605, 10186.388816671024, 10388.532516036645, 10403.687889363331, 10415.739606509898, 10455.581776728846, 10273.126784223425, 10715.035646791826, 10880.183986200907, 10918.672439826818, 11000.779984400428, 8796.956015219883, 9147.181565863344, 9207.769805754642, 9370.906290937004, 9688.660896868576, 9324.533773311443, 9588.185004274716, 9670.661526846527, 9721.076497732704, 10002.899971000197, 8296.751097467086, 8390.035145958293, 8399.076101628938, 8422.494650321001, 8424.410291279552, 5997.271241585156, 6052.061930400795, 6170.413810687977, 6247.0, 6446.516511261768, 5836.737346819318, 5853.385394533683, 5973.283206015306, 6147.262328520606, 6193.225846769154], "value": 5641.335401076872, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.26936937836297, 441.51212909734744, 458.2690608479475, 459.35690033952454, 463.68469440780257, 6277.497800175986, 6308.179936608234, 6338.524610654208, 6358.586691865025, 6393.808185754429, 5941.197938278331, 6100.450959413652, 6124.387561243873, 6136.509079273658, 6196.72114754836, 4951.975240123803, 4983.451820299764, 4993.675411098267, 4997.30037794709, 4999.125153098212, 4909.509049095098, 4910.263460480921, 4912.287718280847, 4919.557239848413, 4941.4811444798315, 4866.440359358666, 4871.464138944713, 4873.43955445123, 4878.731669758162, 5071.391433028042, 5070.771815268304, 5097.343363406908, 5106.846794596168, 5111.821086262, 5129.563987061104, 4615.076984603059, 4678.836240731558, 4705.3647757552635, 4707.6233901287815, 4717.221658426355, 6005.369436209223, 6039.909401358939, 6045.425684559959, 6056.727447264883, 6058.606190597597, 5854.238948936653, 5855.443732845373, 5881.176635271066, 5891.351951285355, 5893.697600751476, 6596.0, 6614.272430032693, 6623.940169572893, 6628.801135965929, 6633.104530888365, 5059.797608095671, 5080.110980578384, 5099.949000509984, 5104.923426148611, 5114.667546609458, 6899.896501552431, 6943.548669336477, 7003.579785212853, 7004.089468369079, 7040.542364746275, 5233.869153271199, 5262.210668399771, 5265.815696450606, 5273.472652734773, 5277.551408130275, 5303.36359636846, 5325.201219817059, 5334.973325133349, 5344.759485823147, 5378.408375078739, 5895.0, 5906.7637294508595, 5907.675077870673, 5907.822765317047, 5911.556633252523, 6252.780263006567, 6669.833254168685, 6681.421013453723, 6681.899771503431, 6733.993274001961, 1834.5046837353839, 1854.3046357615895, 1881.5296175956012, 1888.669482840525, 1891.6405882882484, 1265.3799638177227, 1325.495562536528, 1352.8985326100583, 1387.341013018828, 1391.930403479822, 5657.821738630657, 5705.576654007646, 5755.0, 5812.593118481665, 5812.796552120655, 6680.3987641112535, 6849.897251541231, 6870.931290687129, 6881.759138430231, 6887.965560172167, 5693.259876216065, 5774.364819869811, 5782.624129431573, 5787.305523337226, 5788.247527821356, 3468.3813720640755, 3611.331903597843, 3613.1328481164855, 3633.1280492681567, 3640.7815531068222, 6524.086627872101, 6532.706028228741, 6550.0, 6556.541042127101, 6580.11168492257, 6882.380585747307, 6943.583384996917, 6944.270851560615, 6956.5478243914995, 6963.651817409109, 6462.256840463313, 6464.806055818333, 6484.221893372825, 6514.413702766679, 6515.185601799775, 6727.327267273234, 6728.082496488477, 6759.628220447726, 6761.154855643044, 6764.526483146133, 6681.394256239973, 6700.865982680221, 6701.056693558813, 6737.730490780314, 6741.325867413219, 6487.286398496068, 6504.869902601827, 6522.478201743944, 6526.771562995273, 6560.212774467094, 4806.375171227718, 4854.737768180369, 4868.90262194747, 4878.219484882402, 4883.096627123993, 6747.089142965833, 6777.0, 6782.152230971129, 6800.591964482147, 6819.249882513019, 6179.5056395489155, 6557.262360454495, 6571.572847765071, 6573.3098024706715, 6606.273309935807, 6506.837329066811, 6530.706118224786, 6545.509086818603, 6548.705308261235, 6560.3111673273615, 6505.51208659343, 6512.967435162794, 6519.511036672364, 6539.182602174728, 6539.673016349068, 6649.933500664932, 6653.800385988428, 6660.933390666225, 6666.366740148695, 6676.232233293234, 6138.416850399205, 6277.18396608438, 6288.779892703734, 6301.8109456716375, 6440.488209598167], "value": 5107.523888301095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.5394397971605, 830.9210624990625, 835.9373047021475, 842.5323945210409, 849.5921957460419, 17201.7419738704, 17560.297588096462, 17565.297388104478, 17568.912155439237, 17584.73622895656, 17307.82692173078, 18064.909675451636, 18779.53051173718, 18931.62136757264, 18953.0, 989.9802003959934, 1010.7271036820055, 1013.4020927652683, 1014.6651604970342, 1014.9188064954823, 1023.2785885950387, 1026.3277553202627, 1028.0901402259017, 1028.1363654530194, 1029.5367084811865, 1074.2533938912459, 1074.5003573338397, 1074.8871368506311, 1075.7525769073118, 1076.4025965589135, 937.9531023448834, 1033.3696445168441, 1037.3412882819464, 1045.4772613693153, 1068.9518971646294, 752.4732687119039, 754.3814072460584, 754.9094108706936, 754.969801207951, 757.6552668535858, 16911.750054795102, 16968.066756328397, 17149.57126071858, 17167.742483862752, 17174.48476545693, 18387.172577233923, 18909.338173163873, 18990.90504547482, 19042.238310467565, 19188.616227675368, 14196.50312239077, 14789.40842366304, 14858.702825943528, 14915.776263356058, 14999.475018374305, 3467.3412051710093, 3500.0549851540195, 3520.331137083946, 3537.451694987281, 3538.292341531704, 79395.60302198453, 81505.0, 84447.57776211141, 87244.56377718071, 87994.56002720009, 14953.177575233249, 15151.469698560497, 15168.772468412983, 15185.0, 15364.539063827879, 24756.0, 25476.490470190492, 25815.225543233733, 25828.096016639327, 25905.481890362087, 7889.723859664884, 7893.407994400443, 7899.210078992055, 7906.841863162705, 7911.960440197762, 3720.8883733488037, 3785.507883975121, 3793.734438589272, 3810.142717888453, 3817.6373244541724, 4209.452771139732, 4266.8293268269545, 4303.612674859278, 4329.588689074533, 4367.344898265222, 799.7840583042662, 829.1873963515789, 833.0919297965247, 835.9122292159358, 841.1840514700731, 587.8181773724217, 664.1697877652933, 668.2448832818884, 677.1569396101885, 680.2279412866433, 10231.28381013322, 10693.572257109785, 10723.249372544004, 10757.731056723644, 11107.500162492708, 666.4468491152332, 669.9430548403441, 688.6591137387026, 704.3731079339392, 711.2567367101392, 4985.302057711923, 4990.426100998359, 5103.260027296022, 5193.143131383279, 5246.580273578104, 85623.5718821402, 90187.0, 91914.54042729878, 96182.51908740411, 97108.0, 76498.0, 78943.0, 82347.58826205951, 82388.58805705933, 82709.17290827136, 70805.58388832194, 71869.6406517964, 72261.6386918062, 72621.27378726145, 74582.62708686422, 9465.290103242147, 9590.040995900354, 9911.207103431852, 10160.136388406772, 11139.498722557666, 33316.0, 34096.65903340935, 34575.0, 34810.65189348176, 35190.94427167189, 57891.71054144702, 60437.395626044934, 65688.0, 66592.66703666645, 67556.66221668861, 17701.114944252477, 18365.540861478035, 18439.170237339084, 18522.351717689817, 18538.536536586693, 18875.0, 18904.905475472533, 18908.621827563646, 19123.8087619122, 19148.61702765909, 15872.334539974292, 16273.186340683154, 16560.585985350463, 16600.584985375463, 16659.75010374821, 16650.58373540671, 17401.56496087608, 17621.030843303743, 17847.196876140344, 17848.55378615545, 15705.293261803017, 16076.437324694047, 16101.275442605345, 16128.67742645164, 16253.268602913135, 10975.012248897638, 11062.115030797357, 11138.053265472525, 11438.542458301576, 11927.94036029849, 11059.22585419013, 11063.50214240345, 11108.333499990027, 11492.82760758606, 11562.190646654653], "value": 8204.653232713106, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 111.0, 109.0, 114.0, 113.0, 111.0, 111.0, 110.0, 114.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 155.0, 174.0, 125.0, 157.0, 146.0, 126.0, 175.0, 127.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 165.0, 172.0, 180.0, 177.0, 171.0, 163.0, 163.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 153.0, 74.0, 74.0, 75.0, 78.0, 93.0, 77.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 137.0, 83.0, 82.0, 82.0, 139.0, 84.0, 83.0, 131.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 120.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 150.0, 150.0, 150.0, 149.0, 153.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 59.0, 57.0, 54.0, 54.0, 58.0, 53.0, 53.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 89.0, 79.0, 86.0, 78.0, 80.0, 78.0, 79.0, 78.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 130.0, 132.0, 129.0, 129.0, 128.0, 134.0, 128.0, 162.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 193.0, 206.0, 188.0, 191.0, 189.0, 189.0, 189.0, 199.0, 181.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 71.0, 79.0, 75.0, 74.0, 70.0, 73.0, 69.0], "value": 72.8, "unit": "score"}]}]} 05:23:39 INFO - Return code: 0 05:23:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:39 INFO - # TBPL SUCCESS # 05:23:39 INFO - Running post-action listener: _resource_record_post_action 05:23:39 INFO - [mozharness: 2017-06-12 12:23:39.987026Z] Finished run-tests step (success) 05:23:39 INFO - Running post-run listener: _resource_record_post_run 05:23:40 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 20480; Write bytes: 436289536; Read time: 192; Write time: 285652 05:23:40 INFO - TinderboxPrint: CPU usage
12.7% 05:23:40 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 192 05:23:40 INFO - TinderboxPrint: I/O write bytes / time
436,289,536 / 285,652 05:23:40 INFO - TinderboxPrint: CPU idle
8,746.4 (87.3%) 05:23:40 INFO - TinderboxPrint: CPU user
1,213.2 (12.1%) 05:23:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:23:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105222144; Read time: 28; Write time: 96412 05:23:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:23:40 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 12288; Write bytes: 330452992; Read time: 156; Write time: 189240 05:23:40 INFO - Running post-run listener: _upload_blobber_files 05:23:40 INFO - Blob upload gear active. 05:23:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:40 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 05:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:23:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:47 INFO - (blobuploader) - INFO - Done attempting. 05:23:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:48 INFO - (blobuploader) - INFO - Done attempting. 05:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:49 INFO - (blobuploader) - INFO - Done attempting. 05:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:50 INFO - (blobuploader) - INFO - Done attempting. 05:23:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:50 INFO - Return code: 0 05:23:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:23:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e40e8da4a5465290afb3b3bfce83c72f702dc2aa2142ad8def3be21ab7b1a469a5aba5ba5fd8c71ec078fbff3284f7627d1450f337a96a2bb59238013559bcdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be136d73cc234e7ceb83dfb64e6b619b1244b1e167f1e0ebe046cb0dd5c446e34a4f9ec2d16bb8d8efa05c41990bf6c0826c6287d72a38a15a81966206f1a1f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8a80e086bf65ba98c7facda8e3ca13eda35697b21807cf3d004fb9d1b4d2eeb950bf0d7b463e9967f3a41ea6d3b3a14d0267627fc3de87bd617fe2c4990219", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c3ba812514196d8ac48a8a3b00e508d6a248e4350c4ba6cdd44105e348d3c5176a0eba7d1a07c865d5ff68d364374222e6599aa29fb1f6dc7f31e1f16fb6d88"} 05:23:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:23:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:23:50 INFO - Contents: 05:23:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e40e8da4a5465290afb3b3bfce83c72f702dc2aa2142ad8def3be21ab7b1a469a5aba5ba5fd8c71ec078fbff3284f7627d1450f337a96a2bb59238013559bcdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be136d73cc234e7ceb83dfb64e6b619b1244b1e167f1e0ebe046cb0dd5c446e34a4f9ec2d16bb8d8efa05c41990bf6c0826c6287d72a38a15a81966206f1a1f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8a80e086bf65ba98c7facda8e3ca13eda35697b21807cf3d004fb9d1b4d2eeb950bf0d7b463e9967f3a41ea6d3b3a14d0267627fc3de87bd617fe2c4990219", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c3ba812514196d8ac48a8a3b00e508d6a248e4350c4ba6cdd44105e348d3c5176a0eba7d1a07c865d5ff68d364374222e6599aa29fb1f6dc7f31e1f16fb6d88"} 05:23:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:50 INFO - Copying logs to upload dir... 05:23:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:23:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.891055 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-12 05:23:49.363358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:49.367100) ========= 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=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e40e8da4a5465290afb3b3bfce83c72f702dc2aa2142ad8def3be21ab7b1a469a5aba5ba5fd8c71ec078fbff3284f7627d1450f337a96a2bb59238013559bcdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be136d73cc234e7ceb83dfb64e6b619b1244b1e167f1e0ebe046cb0dd5c446e34a4f9ec2d16bb8d8efa05c41990bf6c0826c6287d72a38a15a81966206f1a1f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8a80e086bf65ba98c7facda8e3ca13eda35697b21807cf3d004fb9d1b4d2eeb950bf0d7b463e9967f3a41ea6d3b3a14d0267627fc3de87bd617fe2c4990219", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c3ba812514196d8ac48a8a3b00e508d6a248e4350c4ba6cdd44105e348d3c5176a0eba7d1a07c865d5ff68d364374222e6599aa29fb1f6dc7f31e1f16fb6d88"} build_url:https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e40e8da4a5465290afb3b3bfce83c72f702dc2aa2142ad8def3be21ab7b1a469a5aba5ba5fd8c71ec078fbff3284f7627d1450f337a96a2bb59238013559bcdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be136d73cc234e7ceb83dfb64e6b619b1244b1e167f1e0ebe046cb0dd5c446e34a4f9ec2d16bb8d8efa05c41990bf6c0826c6287d72a38a15a81966206f1a1f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8a80e086bf65ba98c7facda8e3ca13eda35697b21807cf3d004fb9d1b4d2eeb950bf0d7b463e9967f3a41ea6d3b3a14d0267627fc3de87bd617fe2c4990219", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c3ba812514196d8ac48a8a3b00e508d6a248e4350c4ba6cdd44105e348d3c5176a0eba7d1a07c865d5ff68d364374222e6599aa29fb1f6dc7f31e1f16fb6d88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:49.391262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:49.391583) ========= 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=cbe409c6de289db6ac707de3000001d4-1497268556.337934-444794189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:49.473647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 05:23:49.473969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 05:23:49.474279) ========= ========= Total master_lag: 0.18 =========