builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1496159666.8 results: success (0) revision: 268cfff98df1cc643df7f79dab467043fd1837f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.797232) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.797627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.797904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.815030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.815339) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 08:54:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.0M=0s 2017-05-30 08:54:27 (30.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.963151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:26.963463) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:27.013236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 08:54:27.013562) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 268cfff98df1cc643df7f79dab467043fd1837f1 --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 268cfff98df1cc643df7f79dab467043fd1837f1 --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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 08:54:28,041 truncating revision to first 12 chars 2017-05-30 08:54:28,041 Setting DEBUG logging. 2017-05-30 08:54:28,041 attempt 1/10 2017-05-30 08:54:28,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/268cfff98df1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 08:54:28,983 unpacking tar archive at: mozilla-central-268cfff98df1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 08:54:28.321658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:28.321939) ========= script_repo_revision: 268cfff98df1cc643df7f79dab467043fd1837f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:28.322297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:28.322557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 08:54:28.331929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-30 08:54:28.332210) ========= /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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:29 INFO - MultiFileLogger online at 20170530 08:54:29 in /builds/slave/test 08:54:29 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 08:54:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:29 INFO - {'append_to_log': False, 08:54:29 INFO - 'base_work_dir': '/builds/slave/test', 08:54:29 INFO - 'blob_upload_branch': 'Firefox', 08:54:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:29 INFO - 'branch': 'Firefox', 08:54:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:29 INFO - 'config_files': ('talos/linux_config.py',), 08:54:29 INFO - 'default_actions': ('clobber', 08:54:29 INFO - 'read-buildbot-config', 08:54:29 INFO - 'download-and-extract', 08:54:29 INFO - 'populate-webroot', 08:54:29 INFO - 'create-virtualenv', 08:54:29 INFO - 'install', 08:54:29 INFO - 'setup-mitmproxy', 08:54:29 INFO - 'run-tests'), 08:54:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:29 INFO - 'download_minidump_stackwalk': True, 08:54:29 INFO - 'download_symbols': 'ondemand', 08:54:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:29 INFO - 'gecko_profile': False, 08:54:29 INFO - 'gecko_profile_interval': 0, 08:54:29 INFO - 'installer_path': 'installer.exe', 08:54:29 INFO - 'log_level': 'info', 08:54:29 INFO - 'log_name': 'talos', 08:54:29 INFO - 'log_to_console': True, 08:54:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:29 INFO - 'opt_config_files': (), 08:54:29 INFO - 'pip_index': False, 08:54:29 INFO - 'suite': 'dromaeojs-e10s', 08:54:29 INFO - 'system_bits': '32', 08:54:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:29 INFO - 'title': 'talos-linux64-ix-088', 08:54:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:29 INFO - 'use_talos_json': True, 08:54:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:29 INFO - 'work_dir': 'build'} 08:54:29 INFO - [mozharness: 2017-05-30 15:54:29.461715Z] Running clobber step. 08:54:29 INFO - Running pre-action listener: _resource_record_pre_action 08:54:29 INFO - Running main action method: clobber 08:54:29 INFO - rmtree: /builds/slave/test/build 08:54:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:30 INFO - Running post-action listener: _resource_record_post_action 08:54:30 INFO - [mozharness: 2017-05-30 15:54:30.876067Z] Finished clobber step (success) 08:54:30 INFO - [mozharness: 2017-05-30 15:54:30.876168Z] Running read-buildbot-config step. 08:54:30 INFO - Running pre-action listener: _resource_record_pre_action 08:54:30 INFO - Running main action method: read_buildbot_config 08:54:30 INFO - Using buildbot properties: 08:54:30 INFO - { 08:54:30 INFO - "project": "", 08:54:30 INFO - "product": "firefox", 08:54:30 INFO - "who": "ffxbld@noreply.mozilla.org", 08:54:30 INFO - "installer_path": "public/build/target.tar.bz2", 08:54:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:54:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:54:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:54:30 INFO - "stage_platform": "linux64-stylosequential", 08:54:30 INFO - "basedir": "/builds/slave/test", 08:54:30 INFO - "buildnumber": 31, 08:54:30 INFO - "platform": "ubuntu64_hw_styloseq", 08:54:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:54:30 INFO - "slavebuilddir": "test", 08:54:30 INFO - "taskId": "Nrq51EQ8TN6x42hWM0e3Hw", 08:54:30 INFO - "branch": "mozilla-central", 08:54:30 INFO - "script_repo_revision": "production", 08:54:30 INFO - "revision": "268cfff98df1cc643df7f79dab467043fd1837f1", 08:54:30 INFO - "slavename": "talos-linux64-ix-088", 08:54:30 INFO - "repo_path": "mozilla-central" 08:54:30 INFO - } 08:54:30 INFO - Finding installer, test and symbols from parent task. 08:54:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nrq51EQ8TN6x42hWM0e3Hw'}, attempt #1 08:54:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nrq51EQ8TN6x42hWM0e3Hw'}, attempt #1 08:54:31 INFO - Task dependencies: JcwLLDK9SR6qndqjEoqVDQ 08:54:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ'}, attempt #1 08:54:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 08:54:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/test_packages.json 08:54:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.crashreporter-symbols.zip 08:54:32 INFO - Running post-action listener: _resource_record_post_action 08:54:32 INFO - [mozharness: 2017-05-30 15:54:32.225923Z] Finished read-buildbot-config step (success) 08:54:32 INFO - [mozharness: 2017-05-30 15:54:32.226145Z] Running download-and-extract step. 08:54:32 INFO - Running pre-action listener: _resource_record_pre_action 08:54:32 INFO - Running main action method: download_and_extract 08:54:32 INFO - mkdir: /builds/slave/test/build/tests 08:54: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')]} 08:54:32 INFO - trying https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.test_packages.json 08:54:32 INFO - Downloading https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:54:32 INFO - Downloaded 986 bytes. 08:54:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:54:32 INFO - Using the following test package requirements: 08:54:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:54:32 INFO - u'common': [u'target.common.tests.zip'], 08:54:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:54:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:54:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:54:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:54:32 INFO - u'mozbase': [u'target.common.tests.zip'], 08:54:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:54:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:54:32 INFO - u'web-platform': [u'target.common.tests.zip', 08:54:32 INFO - u'target.web-platform.tests.zip'], 08:54:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:54:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:54:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip 08:54:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:32 INFO - Fetch https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip into memory 08:54:35 INFO - Content-Length response header: 63528764 08:54:35 INFO - Bytes received: 63528764 08:54:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip 08:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.common.tests.zip into memory 08:54:48 INFO - Content-Length response header: 63528764 08:54:48 INFO - Bytes received: 63528764 08:55:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.talos.tests.zip 08:55:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:55:00 INFO - Fetch https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.talos.tests.zip into memory 08:55:01 INFO - Content-Length response header: 14447425 08:55:01 INFO - Bytes received: 14447425 08:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:01 INFO - trying https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 08:55:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:55:02 INFO - Downloaded 55880702 bytes. 08:55:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 08:55:02 INFO - mkdir: /builds/slave/test/properties 08:55:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:02 INFO - Contents: 08:55:02 INFO - build_url:https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 08:55:02 INFO - Running post-action listener: _resource_record_post_action 08:55:02 INFO - Running post-action listener: set_extra_try_arguments 08:55:02 INFO - [mozharness: 2017-05-30 15:55:02.852549Z] Finished download-and-extract step (success) 08:55:02 INFO - [mozharness: 2017-05-30 15:55:02.852702Z] Running populate-webroot step. 08:55:02 INFO - Running pre-action listener: _resource_record_pre_action 08:55:02 INFO - Running main action method: populate_webroot 08:55:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:02 INFO - '--tppagecycles', 08:55:02 INFO - '7'], 08:55:02 INFO - 'tests': ['tsvgm']}}, 08:55:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['damp', 'tps']}, 08:55:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'tests': ['damp', 'tps']}, 08:55:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['dromaeo_dom']}, 08:55:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:55:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:55:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:55:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['a11yr', 08:55:02 INFO - 'ts_paint', 08:55:02 INFO - 'tpaint', 08:55:02 INFO - 'sessionrestore', 08:55:02 INFO - 'sessionrestore_no_auto_restore', 08:55:02 INFO - 'tabpaint']}, 08:55:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:55:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:55:02 INFO - 'bloom_basic_ref']}, 08:55:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:55:02 INFO - 'talos_options': ['--mitmproxy', 08:55:02 INFO - 'mitmproxy-recording-1.mp', 08:55:02 INFO - '--firstNonBlankPaint'], 08:55:02 INFO - 'tests': ['Quantum_1']}, 08:55:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['tsvgx', 08:55:02 INFO - 'tsvgr_opacity', 08:55:02 INFO - 'tart', 08:55:02 INFO - 'tscrollx', 08:55:02 INFO - 'cart', 08:55:02 INFO - 'tsvg_static']}, 08:55:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:02 INFO - 'tsvgr_opacity', 08:55:02 INFO - 'tart', 08:55:02 INFO - 'tscrollx', 08:55:02 INFO - 'cart', 08:55:02 INFO - 'tsvg_static']}, 08:55:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'talos_options': ['--disable-e10s'], 08:55:02 INFO - 'tests': ['tp5o']}, 08:55:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:55:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'talos_options': ['--disable-e10s', 08:55:02 INFO - '--xperf_path', 08:55:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:02 INFO - 'tests': ['tp5n']}, 08:55:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:55:02 INFO - 'talos_options': ['--xperf_path', 08:55:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:02 INFO - 'tests': ['tp5n']}}, 08:55:02 INFO - 'talos.zip': {'path': '', 08:55:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:02 INFO - Running post-action listener: _resource_record_post_action 08:55:02 INFO - [mozharness: 2017-05-30 15:55:02.872662Z] Finished populate-webroot step (success) 08:55:02 INFO - [mozharness: 2017-05-30 15:55:02.872752Z] Running create-virtualenv step. 08:55:02 INFO - Running pre-action listener: _resource_record_pre_action 08:55:02 INFO - Running main action method: create_virtualenv 08:55:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:55:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:02 INFO - Using real prefix '/usr' 08:55:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:05 INFO - Installing pip.................done. 08:55:05 INFO - Return code: 0 08:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:55:05 INFO - Reading from file tmpfile_stdout 08:55:05 INFO - Output received: 08:55:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:55:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:05 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:55:05 INFO - Using env: {'DISPLAY': ':0', 08:55:05 INFO - 'HOME': '/home/cltbld', 08:55:05 INFO - 'LANG': 'en_US.UTF-8', 08:55:05 INFO - 'LANGUAGE': 'en_US:en', 08:55:05 INFO - 'LOGNAME': 'cltbld', 08:55:05 INFO - 'MAIL': '/var/mail/cltbld', 08:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:05 INFO - 'MOZ_NO_REMOTE': '1', 08:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:05 INFO - 'NO_EM_RESTART': '1', 08:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:05 INFO - 'PWD': '/builds/slave/test', 08:55:05 INFO - 'SHELL': '/bin/bash', 08:55:05 INFO - 'SHLVL': '1', 08:55:05 INFO - 'TERM': 'linux', 08:55:05 INFO - 'TMOUT': '86400', 08:55:05 INFO - 'USER': 'cltbld', 08:55:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:05 INFO - '_': '/tools/buildbot/bin/python'} 08:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:55:05 INFO - Cleaning up... 08:55:05 INFO - Return code: 0 08:55:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:05 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:55:05 INFO - Using env: {'DISPLAY': ':0', 08:55:05 INFO - 'HOME': '/home/cltbld', 08:55:05 INFO - 'LANG': 'en_US.UTF-8', 08:55:05 INFO - 'LANGUAGE': 'en_US:en', 08:55:05 INFO - 'LOGNAME': 'cltbld', 08:55:05 INFO - 'MAIL': '/var/mail/cltbld', 08:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:05 INFO - 'MOZ_NO_REMOTE': '1', 08:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:05 INFO - 'NO_EM_RESTART': '1', 08:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:05 INFO - 'PWD': '/builds/slave/test', 08:55:05 INFO - 'SHELL': '/bin/bash', 08:55:05 INFO - 'SHLVL': '1', 08:55:05 INFO - 'TERM': 'linux', 08:55:05 INFO - 'TMOUT': '86400', 08:55:05 INFO - 'USER': 'cltbld', 08:55:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:05 INFO - '_': '/tools/buildbot/bin/python'} 08:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:06 INFO - Downloading/unpacking psutil>=3.1.1 08:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:07 INFO - Installing collected packages: psutil 08:55:07 INFO - Running setup.py install for psutil 08:55:07 INFO - building 'psutil._psutil_linux' extension 08:55:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:55:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:55:07 INFO - building 'psutil._psutil_posix' extension 08:55:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:55:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:07 INFO - Successfully installed psutil 08:55:07 INFO - Cleaning up... 08:55:07 INFO - Return code: 0 08:55:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:08 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:55:08 INFO - Using env: {'DISPLAY': ':0', 08:55:08 INFO - 'HOME': '/home/cltbld', 08:55:08 INFO - 'LANG': 'en_US.UTF-8', 08:55:08 INFO - 'LANGUAGE': 'en_US:en', 08:55:08 INFO - 'LOGNAME': 'cltbld', 08:55:08 INFO - 'MAIL': '/var/mail/cltbld', 08:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:08 INFO - 'MOZ_NO_REMOTE': '1', 08:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:08 INFO - 'NO_EM_RESTART': '1', 08:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:08 INFO - 'PWD': '/builds/slave/test', 08:55:08 INFO - 'SHELL': '/bin/bash', 08:55:08 INFO - 'SHLVL': '1', 08:55:08 INFO - 'TERM': 'linux', 08:55:08 INFO - 'TMOUT': '86400', 08:55:08 INFO - 'USER': 'cltbld', 08:55:08 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:08 INFO - '_': '/tools/buildbot/bin/python'} 08:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:09 INFO - Installing collected packages: mozsystemmonitor 08:55:09 INFO - Running setup.py install for mozsystemmonitor 08:55:09 INFO - Successfully installed mozsystemmonitor 08:55:09 INFO - Cleaning up... 08:55:09 INFO - Return code: 0 08:55:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:09 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:55:09 INFO - Using env: {'DISPLAY': ':0', 08:55:09 INFO - 'HOME': '/home/cltbld', 08:55:09 INFO - 'LANG': 'en_US.UTF-8', 08:55:09 INFO - 'LANGUAGE': 'en_US:en', 08:55:09 INFO - 'LOGNAME': 'cltbld', 08:55:09 INFO - 'MAIL': '/var/mail/cltbld', 08:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:09 INFO - 'MOZ_NO_REMOTE': '1', 08:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:09 INFO - 'NO_EM_RESTART': '1', 08:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:09 INFO - 'PWD': '/builds/slave/test', 08:55:09 INFO - 'SHELL': '/bin/bash', 08:55:09 INFO - 'SHLVL': '1', 08:55:09 INFO - 'TERM': 'linux', 08:55:09 INFO - 'TMOUT': '86400', 08:55:09 INFO - 'USER': 'cltbld', 08:55:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:09 INFO - '_': '/tools/buildbot/bin/python'} 08:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:09 INFO - Downloading/unpacking jsonschema==2.5.1 08:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:10 INFO - warning: no files found matching '*.txt' 08:55:10 INFO - no previously-included directories found matching 'build' 08:55:10 INFO - no previously-included directories found matching 'dist' 08:55:10 INFO - no previously-included directories found matching '.git*' 08:55:10 INFO - Installing collected packages: jsonschema, functools32 08:55:11 INFO - Running setup.py install for functools32 08:55:11 INFO - warning: no files found matching '*.txt' 08:55:11 INFO - no previously-included directories found matching 'build' 08:55:11 INFO - no previously-included directories found matching 'dist' 08:55:11 INFO - no previously-included directories found matching '.git*' 08:55:11 INFO - Successfully installed jsonschema functools32 08:55:11 INFO - Cleaning up... 08:55:11 INFO - Return code: 0 08:55:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:11 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:55:11 INFO - Using env: {'DISPLAY': ':0', 08:55:11 INFO - 'HOME': '/home/cltbld', 08:55:11 INFO - 'LANG': 'en_US.UTF-8', 08:55:11 INFO - 'LANGUAGE': 'en_US:en', 08:55:11 INFO - 'LOGNAME': 'cltbld', 08:55:11 INFO - 'MAIL': '/var/mail/cltbld', 08:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:11 INFO - 'MOZ_NO_REMOTE': '1', 08:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:11 INFO - 'NO_EM_RESTART': '1', 08:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:11 INFO - 'PWD': '/builds/slave/test', 08:55:11 INFO - 'SHELL': '/bin/bash', 08:55:11 INFO - 'SHLVL': '1', 08:55:11 INFO - 'TERM': 'linux', 08:55:11 INFO - 'TMOUT': '86400', 08:55:11 INFO - 'USER': 'cltbld', 08:55:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:11 INFO - '_': '/tools/buildbot/bin/python'} 08:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:11 INFO - Cleaning up... 08:55:11 INFO - Return code: 0 08:55:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:11 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:55:11 INFO - Using env: {'DISPLAY': ':0', 08:55:11 INFO - 'HOME': '/home/cltbld', 08:55:11 INFO - 'LANG': 'en_US.UTF-8', 08:55:11 INFO - 'LANGUAGE': 'en_US:en', 08:55:11 INFO - 'LOGNAME': 'cltbld', 08:55:11 INFO - 'MAIL': '/var/mail/cltbld', 08:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:11 INFO - 'MOZ_NO_REMOTE': '1', 08:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:11 INFO - 'NO_EM_RESTART': '1', 08:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:11 INFO - 'PWD': '/builds/slave/test', 08:55:11 INFO - 'SHELL': '/bin/bash', 08:55:11 INFO - 'SHLVL': '1', 08:55:11 INFO - 'TERM': 'linux', 08:55:11 INFO - 'TMOUT': '86400', 08:55:11 INFO - 'USER': 'cltbld', 08:55:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:11 INFO - '_': '/tools/buildbot/bin/python'} 08:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:13 INFO - Downloading docopt-0.6.1.tar.gz 08:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:13 INFO - Running setup.py install for blobuploader 08:55:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:13 INFO - Running setup.py install for requests 08:55:13 INFO - Running setup.py install for docopt 08:55:13 INFO - Successfully installed blobuploader requests docopt 08:55:13 INFO - Cleaning up... 08:55:13 INFO - Return code: 0 08:55:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:13 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:13 INFO - Using env: {'DISPLAY': ':0', 08:55:13 INFO - 'HOME': '/home/cltbld', 08:55:13 INFO - 'LANG': 'en_US.UTF-8', 08:55:13 INFO - 'LANGUAGE': 'en_US:en', 08:55:13 INFO - 'LOGNAME': 'cltbld', 08:55:13 INFO - 'MAIL': '/var/mail/cltbld', 08:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:13 INFO - 'MOZ_NO_REMOTE': '1', 08:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:13 INFO - 'NO_EM_RESTART': '1', 08:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:13 INFO - 'PWD': '/builds/slave/test', 08:55:13 INFO - 'SHELL': '/bin/bash', 08:55:13 INFO - 'SHLVL': '1', 08:55:13 INFO - 'TERM': 'linux', 08:55:13 INFO - 'TMOUT': '86400', 08:55:13 INFO - 'USER': 'cltbld', 08:55:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:13 INFO - '_': '/tools/buildbot/bin/python'} 08:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:14 INFO - Running setup.py (path:/tmp/pip-7N7j8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:14 INFO - Running setup.py (path:/tmp/pip-Tjax6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:14 INFO - Running setup.py (path:/tmp/pip-H6b6Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:14 INFO - Running setup.py (path:/tmp/pip-4oBS8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:14 INFO - Running setup.py (path:/tmp/pip-CiftJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:14 INFO - Running setup.py (path:/tmp/pip-1n4o6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:14 INFO - Running setup.py (path:/tmp/pip-pJV_wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:14 INFO - Running setup.py (path:/tmp/pip-z2qVRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:14 INFO - Running setup.py (path:/tmp/pip-ZUKFo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:14 INFO - Running setup.py (path:/tmp/pip-3ltfvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:14 INFO - Running setup.py (path:/tmp/pip-uTdynC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:14 INFO - Running setup.py (path:/tmp/pip-P9Pf9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:14 INFO - Running setup.py (path:/tmp/pip-HF0eKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:15 INFO - Running setup.py (path:/tmp/pip-VfeelF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:15 INFO - Running setup.py (path:/tmp/pip-3zkjB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:15 INFO - Running setup.py (path:/tmp/pip-dR0bHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:15 INFO - Running setup.py (path:/tmp/pip-UBhUtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:15 INFO - Running setup.py install for manifestparser 08:55:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:15 INFO - Running setup.py install for mozcrash 08:55:15 INFO - Running setup.py install for mozdebug 08:55:15 INFO - Running setup.py install for mozdevice 08:55:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:15 INFO - Running setup.py install for mozfile 08:55:15 INFO - Running setup.py install for mozhttpd 08:55:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:15 INFO - Running setup.py install for mozinfo 08:55:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for mozInstall 08:55:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for mozleak 08:55:16 INFO - Running setup.py install for mozlog 08:55:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for moznetwork 08:55:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for mozprocess 08:55:16 INFO - Running setup.py install for mozprofile 08:55:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for mozrunner 08:55:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:16 INFO - Running setup.py install for mozscreenshot 08:55:16 INFO - Running setup.py install for moztest 08:55:16 INFO - Running setup.py install for mozversion 08:55:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:17 INFO - Cleaning up... 08:55:17 INFO - Return code: 0 08:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:17 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:17 INFO - Using env: {'DISPLAY': ':0', 08:55:17 INFO - 'HOME': '/home/cltbld', 08:55:17 INFO - 'LANG': 'en_US.UTF-8', 08:55:17 INFO - 'LANGUAGE': 'en_US:en', 08:55:17 INFO - 'LOGNAME': 'cltbld', 08:55:17 INFO - 'MAIL': '/var/mail/cltbld', 08:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:17 INFO - 'MOZ_NO_REMOTE': '1', 08:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:17 INFO - 'NO_EM_RESTART': '1', 08:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:17 INFO - 'PWD': '/builds/slave/test', 08:55:17 INFO - 'SHELL': '/bin/bash', 08:55:17 INFO - 'SHLVL': '1', 08:55:17 INFO - 'TERM': 'linux', 08:55:17 INFO - 'TMOUT': '86400', 08:55:17 INFO - 'USER': 'cltbld', 08:55:17 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:17 INFO - '_': '/tools/buildbot/bin/python'} 08:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:17 INFO - Running setup.py (path:/tmp/pip-42Pv_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:17 INFO - Running setup.py (path:/tmp/pip-cLQngs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:17 INFO - Running setup.py (path:/tmp/pip-AWuQp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:17 INFO - Running setup.py (path:/tmp/pip-Gfi7UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:17 INFO - Running setup.py (path:/tmp/pip-X3EDJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:17 INFO - Running setup.py (path:/tmp/pip-F8meVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:17 INFO - Running setup.py (path:/tmp/pip-5jEWYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:17 INFO - Running setup.py (path:/tmp/pip-ZGaGvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:17 INFO - Running setup.py (path:/tmp/pip-OdbAfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:17 INFO - Running setup.py (path:/tmp/pip-cB9hel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:18 INFO - Running setup.py (path:/tmp/pip-QJA4zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:18 INFO - Running setup.py (path:/tmp/pip-DNrbVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:18 INFO - Running setup.py (path:/tmp/pip-UtYDhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:18 INFO - Running setup.py (path:/tmp/pip-YsL4iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:18 INFO - Running setup.py (path:/tmp/pip-SraL48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:18 INFO - Running setup.py (path:/tmp/pip-KL_0Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:18 INFO - Running setup.py (path:/tmp/pip-Wh9Ne9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:19 INFO - Downloading blessings-1.6.tar.gz 08:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:19 INFO - Installing collected packages: blessings 08:55:19 INFO - Running setup.py install for blessings 08:55:19 INFO - Successfully installed blessings 08:55:19 INFO - Cleaning up... 08:55:19 INFO - Return code: 0 08:55:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:20 INFO - Reading from file tmpfile_stdout 08:55:20 INFO - Current package versions: 08:55:20 INFO - argparse == 1.2.1 08:55:20 INFO - blessings == 1.6 08:55:20 INFO - blobuploader == 1.2.4 08:55:20 INFO - docopt == 0.6.1 08:55:20 INFO - functools32 == 3.2.3-2 08:55:20 INFO - jsonschema == 2.5.1 08:55:20 INFO - manifestparser == 1.1 08:55:20 INFO - mozInstall == 1.12 08:55:20 INFO - mozcrash == 1.0 08:55:20 INFO - mozdebug == 0.1 08:55:20 INFO - mozdevice == 0.51 08:55:20 INFO - mozfile == 1.2 08:55:20 INFO - mozhttpd == 0.7 08:55:20 INFO - mozinfo == 0.9 08:55:20 INFO - mozleak == 0.1 08:55:20 INFO - mozlog == 3.4 08:55:20 INFO - moznetwork == 0.27 08:55:20 INFO - mozprocess == 0.25 08:55:20 INFO - mozprofile == 0.28 08:55:20 INFO - mozrunner == 6.13 08:55:20 INFO - mozscreenshot == 0.1 08:55:20 INFO - mozsystemmonitor == 0.3 08:55:20 INFO - moztest == 0.8 08:55:20 INFO - mozversion == 1.4 08:55:20 INFO - psutil == 3.1.1 08:55:20 INFO - requests == 1.2.3 08:55:20 INFO - wsgiref == 0.1.2 08:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:20 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:20 INFO - Using env: {'DISPLAY': ':0', 08:55:20 INFO - 'HOME': '/home/cltbld', 08:55:20 INFO - 'LANG': 'en_US.UTF-8', 08:55:20 INFO - 'LANGUAGE': 'en_US:en', 08:55:20 INFO - 'LOGNAME': 'cltbld', 08:55:20 INFO - 'MAIL': '/var/mail/cltbld', 08:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:20 INFO - 'MOZ_NO_REMOTE': '1', 08:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:20 INFO - 'NO_EM_RESTART': '1', 08:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:20 INFO - 'PWD': '/builds/slave/test', 08:55:20 INFO - 'SHELL': '/bin/bash', 08:55:20 INFO - 'SHLVL': '1', 08:55:20 INFO - 'TERM': 'linux', 08:55:20 INFO - 'TMOUT': '86400', 08:55:20 INFO - 'USER': 'cltbld', 08:55:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:20 INFO - '_': '/tools/buildbot/bin/python'} 08:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:55:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:55:21 INFO - Installing collected packages: marionette-driver 08:55:21 INFO - Running setup.py install for marionette-driver 08:55:21 INFO - Successfully installed marionette-driver 08:55:21 INFO - Cleaning up... 08:55:21 INFO - Return code: 0 08:55:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:21 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 0x9c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, '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': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:55:21 INFO - Using env: {'DISPLAY': ':0', 08:55:21 INFO - 'HOME': '/home/cltbld', 08:55:21 INFO - 'LANG': 'en_US.UTF-8', 08:55:21 INFO - 'LANGUAGE': 'en_US:en', 08:55:21 INFO - 'LOGNAME': 'cltbld', 08:55:21 INFO - 'MAIL': '/var/mail/cltbld', 08:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:21 INFO - 'MOZ_NO_REMOTE': '1', 08:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:21 INFO - 'NO_EM_RESTART': '1', 08:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:21 INFO - 'PWD': '/builds/slave/test', 08:55:21 INFO - 'SHELL': '/bin/bash', 08:55:21 INFO - 'SHLVL': '1', 08:55:21 INFO - 'TERM': 'linux', 08:55:21 INFO - 'TMOUT': '86400', 08:55:21 INFO - 'USER': 'cltbld', 08:55:21 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:21 INFO - '_': '/tools/buildbot/bin/python'} 08:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:55:21 INFO - Cleaning up... 08:55:21 INFO - Return code: 0 08:55:21 INFO - Running post-action listener: _resource_record_post_action 08:55:21 INFO - Running post-action listener: _start_resource_monitoring 08:55:21 INFO - Starting resource monitoring. 08:55:21 INFO - [mozharness: 2017-05-30 15:55:21.898803Z] Finished create-virtualenv step (success) 08:55:21 INFO - [mozharness: 2017-05-30 15:55:21.899333Z] Running install step. 08:55:21 INFO - Running pre-action listener: _resource_record_pre_action 08:55:21 INFO - Running main action method: install 08:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:22 INFO - Reading from file tmpfile_stdout 08:55:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:22 INFO - Reading from file tmpfile_stdout 08:55:22 INFO - Output received: 08:55:22 INFO - Usage: mozinstall [options] installer 08:55:22 INFO - Options: 08:55:22 INFO - -h, --help show this help message and exit 08:55:22 INFO - -d DEST, --destination=DEST 08:55:22 INFO - Directory to install application into. [default: 08:55:22 INFO - "/builds/slave/test"] 08:55:22 INFO - --app=APP Application being installed. [default: firefox] 08:55:22 INFO - mkdir: /builds/slave/test/build/application 08:55:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:55:38 INFO - Reading from file tmpfile_stdout 08:55:38 INFO - Output received: 08:55:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:38 INFO - Running post-action listener: _resource_record_post_action 08:55:38 INFO - [mozharness: 2017-05-30 15:55:38.284157Z] Finished install step (success) 08:55:38 INFO - [mozharness: 2017-05-30 15:55:38.284309Z] Running setup-mitmproxy step. 08:55:38 INFO - Running pre-action listener: _resource_record_pre_action 08:55:38 INFO - Running main action method: setup_mitmproxy 08:55:38 INFO - Skipping: mitmproxy is not required 08:55:38 INFO - Running post-action listener: _resource_record_post_action 08:55:38 INFO - [mozharness: 2017-05-30 15:55:38.284847Z] Finished setup-mitmproxy step (success) 08:55:38 INFO - [mozharness: 2017-05-30 15:55:38.285078Z] Running run-tests step. 08:55:38 INFO - Running pre-action listener: _resource_record_pre_action 08:55:38 INFO - Running main action method: run_tests 08:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:38 INFO - Python 2.7.3 08:55:38 INFO - Return code: 0 08:55:38 INFO - grabbing minidump binary from tooltool 08:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:38 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 0xd41e40>, '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 0xd42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd43440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:55:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:55:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:55:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:38 INFO - Return code: 0 08:55:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:38 INFO - ENV: RUST_BACKTRACE is now 1 08:55:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:38 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/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:55:38 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/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:55:38 INFO - Using env: {'DISPLAY': ':0', 08:55:38 INFO - 'HOME': '/home/cltbld', 08:55:38 INFO - 'LANG': 'en_US.UTF-8', 08:55:38 INFO - 'LANGUAGE': 'en_US:en', 08:55:38 INFO - 'LOGNAME': 'cltbld', 08:55:38 INFO - 'MAIL': '/var/mail/cltbld', 08:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:38 INFO - 'MOZ_NO_REMOTE': '1', 08:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:38 INFO - 'NO_EM_RESTART': '1', 08:55:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:38 INFO - 'PWD': '/builds/slave/test', 08:55:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:38 INFO - 'RUST_BACKTRACE': '1', 08:55:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:55:38 INFO - 'SHELL': '/bin/bash', 08:55:38 INFO - 'SHLVL': '1', 08:55:38 INFO - 'TERM': 'linux', 08:55:38 INFO - 'TMOUT': '86400', 08:55:38 INFO - 'USER': 'cltbld', 08:55:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780', 08:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:38 INFO - '_': '/tools/buildbot/bin/python'} 08:55:38 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/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:55:38 INFO - mozversion application_buildid: 20170530151654 08:55:38 INFO - mozversion application_changeset: 268cfff98df1cc643df7f79dab467043fd1837f1 08:55:38 INFO - mozversion application_display_name: Nightly 08:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:38 INFO - mozversion application_name: Firefox 08:55:38 INFO - mozversion application_remotingname: firefox 08:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:55:38 INFO - mozversion application_vendor: Mozilla 08:55:38 INFO - mozversion application_version: 55.0a1 08:55:38 INFO - mozversion platform_buildid: 20170530151654 08:55:38 INFO - mozversion platform_changeset: 268cfff98df1cc643df7f79dab467043fd1837f1 08:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:55:38 INFO - mozversion platform_version: 55.0a1 08:55:38 INFO - using testdate: 1496159738 08:55:38 INFO - actual date: 1496159738 08:55:38 INFO - starting webserver on 'localhost:43057' 08:55:38 INFO - SUITE-START | Running 2 tests 08:55:38 INFO - TEST-START | dromaeo_css 08:55:38 INFO - operating with platform_type : linux_ 08:55:38 INFO - Initialising browser for dromaeo_css test... 08:55:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43057/getInfo.html -profile /tmp/tmpMEFtaZ/profile 08:55:38 INFO - TEST-INFO | started process 12107 (/builds/slave/test/build/application/firefox/firefox http://localhost:43057/getInfo.html) 08:56:13 INFO - TEST-INFO | 12107: killed by SIGTERM 08:56:13 INFO - Browser initialized. 08:56:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:13 INFO - TEST-INFO | started process 12329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMEFtaZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:25 INFO - PID 12329 | RSS: Main: 186408960 08:56:25 INFO - PID 12329 | 08:59:30 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43057/tests/dromaeo/cssquery-ext.html) 08:59:32 INFO - PID 12329 | RSS: Main: 182308864 08:59:32 INFO - PID 12329 | 09:02:34 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-ext.html (next: http://localhost:43057/tests/dromaeo/cssquery-jquery.html) 09:02:34 INFO - PID 12329 | RSS: Main: 187670528 09:02:34 INFO - PID 12329 | 09:05:36 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43057/tests/dromaeo/cssquery-mootools.html) 09:05:37 INFO - PID 12329 | RSS: Main: 184414208 09:05:37 INFO - PID 12329 | 09:08:38 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43057/tests/dromaeo/cssquery-prototype.html) 09:08:39 INFO - PID 12329 | RSS: Main: 190234624 09:08:39 INFO - PID 12329 | 09:11:42 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43057/tests/dromaeo/cssquery-yui.html) 09:11:43 INFO - PID 12329 | RSS: Main: 187199488 09:11:43 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | Cycle 1(1): loaded http://localhost:43057/tests/dromaeo/cssquery-yui.html (next: http://localhost:43057/tests/dromaeo/cssquery-dojo.html) 09:14:45 INFO - PID 12329 | RSS: Main: 184946688 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | __start_tp_report 09:14:45 INFO - PID 12329 | _x_x_mozilla_page_load 09:14:45 INFO - PID 12329 | _x_x_mozilla_page_load_details 09:14:45 INFO - PID 12329 | |i|pagename|runs| 09:14:45 INFO - PID 12329 | |0;dojo.html;2722.3738540135755;2723.332783468051;2724.087430710712;2765.0737003103945;2767.2528417327317;5158.690478571289;5197.558207552363;5210.6613070150415;5223.582113430926;5259.3162888824445;5166.741662916858;5201.193814958678;5234.947650523493;5252.52727254547;5295.020421222077;4674.11191873543;4683.742394168319;4701.600363969067;4714.528547145293;4729.55069268419;4658.231391820363;4711.246200607903;4743.976280118594;4778.665493415462;4807.206810876201;4604.355390245369;4649.256119020974;4702.694324868872;4715.31627913954;4768.47546769855;4683.250679891235;4718.740469274188;4728.030753695484;4740.739259340735;4754.025424787945;4656.161890859644;4658.743769092698;4668.043051174501;4680.227762419197;4720.929186062212;5172.844814655528;5186.5850731941355;5227.398849132361;5230.34620672416;5244.501772331622;5543.833684989457;5579.2746942897165;5604.523615492647;5651.802186923438;5737.168110623936;5627.943720562824;5664.830055098354;5673.23411339468;5697.715114244271;5704.315482142128;5232.895342093137;5237.266782650432;5242.397124330712;5258.027264955919;5259.289995850588;5650;5777.595568310262;5786.42135786418;5799.804512178121;5849.093390524476;5507.366652834975;5525.861853453615;5583.106702927512;5590.5248053915875;5640.069388550925;5630.6058575900115;5663.858403539944;5664.433556644385;5665.830025099253;5670.5463562914865;5444.8366549003595;5531.751071201806;5622.437756224344;5622.746976386073;5632.155176723524;5554.638948468418;5569.693666848362;5632.070708333161;5639.407862174495;5666.575006874501;4622.214223581932;4629.027904140101;4643.883902902455;4648.767561621973;4680.765961701902;3994;4000.119973605802;4000.239954408653;4047;4076.0217547788316;4723.197056500403;4765.380500534909;4795.040991801654;4814.301926220748;4862.805487780449;5699.658020518782;5714.028615135437;5722.7424765885635;5736.254286942671;5750.453706897838;4809.062232864558;4817.9518204818205;4819.108464933998;4825.860458611638;4846.878828029327;4890.095332363453;4974.030064137459;4974.253861920741;4980.203167493256;4980.477049909779;5248.475152484873;5251.842444726664;5275.841724748264;5313.415524292402;5328.333958255218;5484.287042684426;5555.72221388937;5682.176084467812;5703.0589952659;5711.685857277889;5287.312649355559;5289;5326.733663316896;5361.973190134025;5380.273663055437;5459.235707001102;5519.199716041232;5576.1356989666665;5582.246396736388;5586.078297080936;5596.692181930033;5666.716664166693;5678.233438485751;5713.628614140068;5772.307323121252;5490.258815059916;5492.615516913777;5510.228568000563;5540.141278101901;5546.084895992116;5487.122060470306;5487.670739755627;5493.835184944458;5500.972495137498;5504.394516603091;5349.491798279158;5429.592780541396;5440.1023831069015;5449.700266485382;5469.261649677402;5428.402875683751;5474.562035037267;5534.059209934401;5569.805056822992;5606.551475881838;5366.382865970308;5378.1663842104535;5383.892322153613;5385.73071346439;5387.595930305321 09:14:45 INFO - PID 12329 | |1;ext.html;662.1524448705655;725.7568714480649;742.8365759532902;1214.8602910665277;1244.0731654917088;34278.828605856965;35452.64547354526;35504.822475887646;35520.46719299206;35584.99999999997;33699.32601347972;33893.15267118317;34006.829965850135;34026.14934626636;34045.829770851175;6515.934840651592;6662.733490660392;6744.460443164535;6882.552634078794;6927.376536111749;6880.655967201645;6896;6898;6962.7911162665205;6963.442924566048;6846.691898864538;6910.170779506467;6914.135733033371;6934.410575101122;6961.756338528153;6881.4838887083415;6897.655117244168;6930.688119034605;6934.583924964493;6954.200266969262;6793.796186114375;6809.455243580502;6842.076319696827;6843.863122737517;6857.451403887727;31649.20876978071;31916.36167276665;32048.359032819448;32095.518567221512;32112.197195070075;2954.4534261161753;2983.418233444479;2989.5515672649058;2992.745616622568;2993.117030476015;24282.514349713085;24508.26475205747;24555;24594;24676.876615616988;3015.321552650636;3033.924151896198;3064.8620812063286;3066.6166729158854;3127.6090488688915;126583.36708316492;128191;139551.30224348814;146734;146777;39904;40092.59907400947;40202.195956080715;40210;40226.1954760909;41657.1668566633;42077;42080.78959605182;42152.156956861305;42285;11501.539938402537;11726.70683232909;11751.590923860587;11753.236039657395;11777.470013849397;9251.306152038624;9319.347645664873;9327.580258888367;9330.58012389444;9343.626254949862;12960.611181664564;13035.217886926815;13042.087053906325;13042.9565634749;13171.868281317256;5281.419043905167;5346.8128615499045;5366.409694933554;5379;5380.354357477127;873.1007062725403;913.4108500017452;928.3640706116197;930.423137654645;946.9053094690476;20625.174993000113;20827.1669133236;22007.11971521121;22023;22139.667904981437;991.1575161112996;995.9800803983879;1003.844404117363;1004.1866088468364;1016.4104819204844;11456.99502587044;11585;11682.824757628643;11687.357195354338;11699.941500292443;175871;175891;177514;177660;178066;40695;40999;41054;41061.38407923884;41114.38328425076;1189.8064946508428;1233.0690328801877;1235.3576140407117;1246.2958428487875;1246.3145270101409;19609.509762256057;20020.899895500428;20507.69238461454;21292.893535532843;21443.571128577652;30352.241193969443;30365.240868978453;37238.25523489569;38073.80963095167;38074.23851523009;164264;165869;166170;166573;167846;29098.41803163967;29675.40649186961;29932.251693707833;30517.389652207276;30688;35472.68082737757;35946.64053359433;36125.63874361328;36560.81719591385;37086.62913370832;26877.193684189504;27722.861385693748;28085.43829123447;28133.296667583476;29142.854285728437;27028.864855676384;27603.86198068997;27686.307842304104;28088.29779255535;29258.85370573219;30868.382632347675;31287.061388158392;31364.686353136178;31384.686153138176;31421.371572568878;26142.477150456503;26629.334266643487;27189.72810271872;27625.171244862686;27704;20429.48926276855;22491.100355986233;22518.32445026652;22564.887175564018;22792.430189245402 09:14:45 INFO - PID 12329 | |2;jquery.html;418.94344263524437;421.55525920154264;426.92101961137195;435.8735966569695;441.2476727180156;12200.450979705913;13802.93098534506;17456.389026384062;18297.99361035144;18356.17397217125;18555.07224638766;18700.345487907925;18893;19356.806431935678;19379.515512112168;5520.282363292777;5739.368669446358;5746.454086861741;5749.022666146744;5755.597108202427;5146.845594632167;5339.70631615261;5350.063738845706;5352;5380.435054319299;5284.973575132138;5292.603054770889;5308.6814791112465;5309.495597918191;5309.681419114846;5236.083685355066;5417.377001644822;5447.536959358459;5462.562994960434;5485.588580856452;4932;4935.950640493585;4940.604751619861;4952.380952380952;4970.353853998993;21709.565808683896;22057.11771529137;22133.66799498009;22144.114235430563;22153.66769498459;1593.6334643032167;1618.174730887244;1619.651774868409;1621.3271492330668;1622.6835767025434;14510.564683059525;14533.563993080119;14891.32989015497;15072.171030593314;15115.924420377827;2047.140201115535;2089.791020897898;2119.2622049919073;2132.3176583493287;2138.786121387864;90473.54763226141;95124;96187.51906240424;97838.51080744622;97871;11244.26912250701;11447.109026027532;11532.2504037239;11594.304341739522;11654.650360489199;16230;16232.350705971865;16238.512844614681;16244.106574138299;16264.105474199032;7224.711011559479;7545.434092443089;7551.622418879034;7731.845363092707;7750.651220695082;6743.291954344723;6759.164969450013;6910.896336554955;6919.37725604688;6923.757668481579;7092.2340287288;7092.574445533284;7116;7177.318154775288;7284.162321333115;2028.9594208115755;2036.867603605761;2067.824234940047;2093.216022689819;2165.9133634654754;830.5390508267849;864.1833467373398;879.8064425826308;885.7254251182154;886.5301390263171;16951.898126621978;17647.205875735624;17872.91063544674;17892.552686182687;18042.09789510519;882.1575395497284;887.6493784955036;890.1276748786225;895.2256298301922;918.2149262380702;9560.187384072431;9654.179394751385;9837;9918.950405248072;9943.353682010646;351011;352120;372330;377953;381227;75788.24211757812;80114.5994270025;81503.59248203722;81701.59149204334;82784.99999999879;1077.9083777878811;1133;1134.659602119361;1140.4639819284923;1150.6663067710438;17861.196246169213;18408.81591184071;18814.623707525498;18927.810721893155;18963.43109706711;37594.8120259397;38114.237715244984;38987;39335.40996885106;39554;48473;49090.26364604605;49753.751231243616;49825.252621209984;50674.239886400996;7930.850026746205;8219.342452603896;8270.751877443687;8322.791930201793;8433.746987590383;11514.42427878586;11516.827247591125;12028.939855300667;12391.75216495647;12427.31649759272;10206.540705668114;10710.518026688662;10878.347299161758;10990.725231869268;11262.718432039264;9797.118259356692;9880.16018638395;9885.604575816888;9944.30389872702;10226.28416010872;10723.142148628247;11005.339679619248;11553.826692599785;11568.595099171489;11896;8564.785880353042;8648.481091134552;8731.345149113715;8732.78168045804;8763.561821909007;9978.850317245102;10047.397156170653;10070.532719483774;10209.489525523546;10560.577576896838 09:14:45 INFO - PID 12329 | |3;mootools.html;1268.930208838514;1304.2696090189495;1310.3841194638524;1314.38880920372;1328.249539010459;9934.45360505172;10475.476226188688;10483.370997740121;10485.161187105032;10803.081738052255;10563.524641391137;10733.087687546567;10766;10769.892301076987;10785.892141078586;2161.2219600943686;2200.625893598084;2210.823134149264;2212.6791615215784;2213.4908970936694;2123.660214365702;2154.795294447033;2157.147926569004;2158.4819643285578;2159.84881058326;1931.9710204346945;1947.5033866364129;1956.0415396455776;1962.6859702447612;1964.2732189090057;1944.6888497840348;1947.51312171957;1947.9318223862097;1948.65898467769;1951.4828570428847;1944.270898413095;1966.7344908437321;1974.2103158736477;2014.5870096630156;2104.3476522278143;10306.896931030744;10385.42880141592;10394.844077338847;10399.428031458267;10403.271770976035;5433.1035379162395;5657.2928383952;5681.034224181858;5688.658680479143;5700.572457065737;3182.5703530023616;3322.1030321812973;3387.745919056056;3391.5251864738957;3399.3201359727905;1069.3637285814928;1078.8759292681284;1080.9675709728642;1082.566973210722;1111.6442738323658;15135.091894486366;15346.769798453031;15362.769558456632;15364.769528457082;15367.308471118715;4704.129735998851;4791.6406269529925;4922.0648076866;4924.556789888856;4939.333190019373;10878.891211087788;10884.727881803019;10902.345859248471;10912.727181820359;10931.18016148792;5491.917621235684;5590.776368945278;5600.4399560044485;5604.299462567179;5618.297712785902;5125.897482050413;5167.379914410295;5171.3018742469285;5191.9480805192225;5277.261183434322;3628.510151129564;3717.386631205875;3757.229767897574;3758.473813666089;3812.4662547243406;1166.5275563396838;1178.80549709297;1179.6696924861053;1188.6552899659175;1188.7028242939266;687.52560733094;711.0898050495374;715.4169351978121;722.6134018300185;727.0403067950255;5200.531952124251;5366.409694933554;5391.676499410048;5392.541633961078;5405.378381486101;526.7129414469124;529.5736931769962;537.5162353881537;539.6303532080537;541.8618252345626;3457.3085382923514;3495.3358861816682;3512.5784905811465;3570.143165640228;3730.4705070921336;13320.200787952754;13575.660608484866;13763;13770.93114534441;13861.4455421782;13268.867311326763;13614.183149010893;13683.179009259477;13687.657808554666;13716.314184290746;7031.8945215821805;7147.749828755968;7192.676329565182;7212.7114915403845;7217.566945983258;5425.511703946664;5587.469190426903;5658.717064146694;5801.76792928295;5828.446297601721;11940;12026.037916966796;12077.698057548632;12106.697332566757;12215.26708397499;12303.876961230273;12584.811227831407;12588.685282868002;12607.180533265308;12700.36498175069;7661;7753.457257991887;7757.1079325878245;7763.961180194063;7774.533527988338;9629.085236902483;9724;9772.315937884565;9778.9022109778;9796.755081123029;8137.471064380797;8140.430169888051;8202.26179643835;8234.464759790833;8241.95879020601;8123.75628731139;8170.060443049126;8180.550069745983;8261.339092872677;8284.917150828414;7007.6846541904715;7150.141982962078;7156.928430715626;7164.355208031302;7172.820679482846;4795.640326975421;5100.336956195671;5113.284140220298;5138.3833939927445;5382.246485492113;5020.594233614594;5053.267276244997;5159.432462429205;5160.251763494197;5194.428612852507 09:14:45 INFO - PID 12329 | |4;prototype.html;372.1719174835989;373.630106194867;375.4143536083708;375.622499388115;376.9868054618089;5341.813036543722;5386.865328366793;5431.076716958117;5450.645708028976;5512.228288039678;5233.476652334764;5319.0957537218665;5322.600804939626;5327.348521958195;5331.386890507592;4074.837006519743;4152.56398078202;4246.745195288293;4260.1882757380135;4273.166732487166;4254.27677294859;4254.361845723135;4255.234057869582;4267.189234045537;4281.892952676177;4234.115818460787;4236.428082208909;4239.261902619926;4240.427542281784;4272;4112.876613701564;4192.559781222958;4250.744955302676;4255.936160957573;4258.765767882765;3823.330917089498;3865.1496670732395;3867.7292589518743;3884.514435695538;3886.24218277436;5291.735413229323;5300.840974770725;5303.840884773463;5304.283921670563;5311.229871668586;4950.183219768734;5022.221555658879;5039.622028347889;5052.72210028452;5062.139436295838;5738.368779434259;5755.740991655385;5755.740991655385;5758.136279558058;5764.221830052973;4313.331433627793;4327.394164816928;4328.61042506176;4331.220380331539;4334.393184954109;5913.526917846562;6019.608725432877;6021.157038014681;6059;6103.816885493487;4475.239209334356;4487.102579484116;4497.550244975541;4504.842330518416;4527.320901864747;4512.638988880882;4544.296143794437;4549.476810166807;4558.794854231567;4574.839880604163;4825.179719447632;4959.652824302264;5030.874228144253;5056.393232812013;5060.51925067118;5755.050416681201;5763.7982670606325;5769.365369809318;5774.595778295563;5817.534597232211;1542.460138951358;1542.7762974368654;1548.1562548411143;1550.4030948084842;1559.50095969291;1128.0242590159453;1143.6454699043322;1157.242006485753;1157.4039369724599;1157.7496303991668;5018.5985121190215;5024.145895197825;5025.447200807908;5027.1705168647495;5032.119379108642;5891.8510890375965;5975.282966044103;5981.162637230791;5991.580589358703;5999.950008748451;4950.603951683928;4954.653174277838;4967.130752118437;4979.4771548987555;4992.950070499249;3107.285324375406;3127.5308703694627;3138.6704396038544;3139.0896639974153;3144.088214417839;5468.425815289417;5530;5535.501804837584;5538.667679939216;5554.861128471821;5841.328247251536;6039.127870360115;6042.939570604326;6064.3935606439;6068.939310606926;5480.314645823598;5524.447555244444;5525.530329922001;5535.25274087993;5558.416366281563;5725.51333136688;5875.50058245054;5900.0264956281735;5900.616459930091;5949;5712.971435142797;5773.769049237983;5774.9133762994425;5777.91333129995;5812.070068788974;5495.0658388073325;5512.228288039758;5531.170324451365;5547.583931205095;5556.083246264321;3966.1076257841755;4010.3984402338715;4027.8187481562813;4032.395140728914;4035.596440355941;5884.9705751470965;5900.70496475166;5911.733971971185;5929.229200204119;5953.642781433128;5650.491455769001;5702.771889124555;5734.913976290442;5742.339630942328;5760.654360738369;5619.690916999441;5631.324241091095;5707.400722924033;5733.878464967988;5753.510951569164;5628.943710562842;5652.349979752381;5662.2639056922335;5662.915056274242;5665.224040220345;5630.18362337467;5682.0908654616715;5775.653460792366;5777.884442311214;5795.275590551181;5586.972065139648;5595.972020139873;5602.551795856403;5620.173443630918;5623.297087864017 09:14:45 INFO - PID 12329 | |5;yui.html;731.4441024821134;743.3161491427886;744.9292317229865;750.3471979377942;761.2881955371728;13678.247696376695;14476.782848257284;14619.488317908876;14629.707405851877;16871.662566748688;16517.174141292948;16677.66644667106;16869.325226990935;16882.493525194233;16934.83065169348;871.4466313890662;893.2987604730288;894.5214310343968;911.6080085563206;914.4878867834001;870.6212797433105;928.3223247029672;930.3719989007427;933.8739270198504;935.3966691483989;950.4629884115487;957.0286159548065;962.2975228083503;966.2849491376367;967.1102585621245;952.4333021852021;953.814006268771;957.7940742740344;958.5590628310986;959.4627008875052;699.2762490822025;704.6371118873784;704.6476761619191;705.4180301251488;708.1077841919167;13736.381862816197;13799.931000345034;14134.92932535341;14137.717245655133;14162.504312349121;14380;15040.623984400368;15458.61353466161;15598.922005390014;15738.291776870068;12841;12938.805917911239;13307.600771976857;13554.796678049837;13596.660083497893;2999.805012674191;3009.714077162666;3011.578379026916;3026.9545956810666;3030.9997700758695;79593.60203198947;81117.18882811155;81748.18251817525;82780.51658450197;82894.58552707259;12968.481260749653;13140.474381024653;13246.867531324757;13374.866251337362;13403.664908377368;23265.651015234784;23623.88188059083;23766.762332376456;23800.642990354812;23833.88083059608;6039.667818270037;6664.266930637626;6685.498587605949;6729.293424190488;6730;2999.115260998011;3086.135881953057;3100.0389879137538;3107.238726512019;3111.2688518198206;3566.8407767475674;3654.817259137086;3656.9817150914073;3665.651763082503;3667.468217108504;725.8584576007734;753.3634079203065;756.2248695087579;758.7003133762133;763.4884627299723;542.6509834931319;582.2314544800822;606.757297081171;614.2720875762236;638.125767698247;9936.652217172365;10561.207909406672;10660.946695266473;10726;11207.43962801873;578.4475825586554;584.6083124306725;584.7339460545442;586.1822757253607;586.9119632055141;4827.444843842933;5052.191649336162;5116.9744151279;5121.769520371592;5264.868378290574;72511.63744181351;72751;72849.63575182196;85790.14209857822;87791.56104219439;67088.6645566769;68073.3192668077;68605.65697171482;69067.30932690609;69988.30011699919;57751.71124144436;58064;59406.70296648489;59961.10058349128;60230.397696023356;10012.199024078202;10106.242031847787;10337.896621033693;10366.579028920287;11195;26839.463210735285;26869.328266793487;27975.580366294114;28131.43737125287;28700.282492937844;48058;48799.268010979154;49812.25281620851;50054.24918626296;50427;13063.412146453242;13159.473621055433;13211.801822972471;13217.603471895858;13291;15196.620084497976;15349.462768803038;15360.923195383952;15418;15577.688446230784;12479.188852724545;12490.562830300896;12505.624831254712;12577.993760498955;12620.621381358575;14979.925100374428;15120.54638360851;15157.621059473602;15272.465463708717;15295.31171097281;12929.806052909025;12960.805587916377;13095.345232738135;13115.344232788513;13202.537911173064;9958.800823983334;10369.481525923824;10414.375137491776;10451.68644940653;10711.571537138427;10761.139108871428;10773.89226107729;11009.339439633648;11156.497957591766;11275.887241127812 09:14:45 INFO - PID 12329 | __end_tp_report 09:14:45 INFO - PID 12329 | __start_cc_report 09:14:45 INFO - PID 12329 | _x_x_mozilla_cycle_collect,377 09:14:45 INFO - PID 12329 | __end_cc_report 09:14:45 INFO - PID 12329 | __startTimestamp1496160885391__endTimestamp 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | ------- Summary: start ------- 09:14:45 INFO - PID 12329 | Number of tests: 6 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#0] dojo.html Cycles:165 Average:5164.56 Median:5328.33 stddev:603.55 (11.3%) stddev-sans-first:574.19 09:14:45 INFO - PID 12329 | Values: 2722.4 2723.3 2724.1 2765.1 2767.3 5158.7 5197.6 5210.7 5223.6 5259.3 5166.7 5201.2 5234.9 5252.5 5295.0 4674.1 4683.7 4701.6 4714.5 4729.6 4658.2 4711.2 4744.0 4778.7 4807.2 4604.4 4649.3 4702.7 4715.3 4768.5 4683.3 4718.7 4728.0 4740.7 4754.0 4656.2 4658.7 4668.0 4680.2 4720.9 5172.8 5186.6 5227.4 5230.3 5244.5 5543.8 5579.3 5604.5 5651.8 5737.2 5627.9 5664.8 5673.2 5697.7 5704.3 5232.9 5237.3 5242.4 5258.0 5259.3 5650.0 5777.6 5786.4 5799.8 5849.1 5507.4 5525.9 5583.1 5590.5 5640.1 5630.6 5663.9 5664.4 5665.8 5670.5 5444.8 5531.8 5622.4 5622.7 5632.2 5554.6 5569.7 5632.1 5639.4 5666.6 4622.2 4629.0 4643.9 4648.8 4680.8 3994.0 4000.1 4000.2 4047.0 4076.0 4723.2 4765.4 4795.0 4814.3 4862.8 5699.7 5714.0 5722.7 5736.3 5750.5 4809.1 4818.0 4819.1 4825.9 4846.9 4890.1 4974.0 4974.3 4980.2 4980.5 5248.5 5251.8 5275.8 5313.4 5328.3 5484.3 5555.7 5682.2 5703.1 5711.7 5287.3 5289.0 5326.7 5362.0 5380.3 5459.2 5519.2 5576.1 5582.2 5586.1 5596.7 5666.7 5678.2 5713.6 5772.3 5490.3 5492.6 5510.2 5540.1 5546.1 5487.1 5487.7 5493.8 5501.0 5504.4 5349.5 5429.6 5440.1 5449.7 5469.3 5428.4 5474.6 5534.1 5569.8 5606.6 5366.4 5378.2 5383.9 5385.7 5387.6 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#1] ext.html Cycles:180 Average:30683.24 Median:30778.19 stddev:41625.44 (135.2%) stddev-sans-first:41681.17 09:14:45 INFO - PID 12329 | Values: 662.2 725.8 742.8 1214.9 1244.1 34278.8 35452.6 35504.8 35520.5 35585.0 33699.3 33893.2 34006.8 34026.1 34045.8 6515.9 6662.7 6744.5 6882.6 6927.4 6880.7 6896.0 6898.0 6962.8 6963.4 6846.7 6910.2 6914.1 6934.4 6961.8 6881.5 6897.7 6930.7 6934.6 6954.2 6793.8 6809.5 6842.1 6843.9 6857.5 31649.2 31916.4 32048.4 32095.5 32112.2 2954.5 2983.4 2989.6 2992.7 2993.1 24282.5 24508.3 24555.0 24594.0 24676.9 3015.3 3033.9 3064.9 3066.6 3127.6 126583.4 128191.0 139551.3 146734.0 146777.0 39904.0 40092.6 40202.2 40210.0 40226.2 41657.2 42077.0 42080.8 42152.2 42285.0 11501.5 11726.7 11751.6 11753.2 11777.5 9251.3 9319.3 9327.6 9330.6 9343.6 12960.6 13035.2 13042.1 13043.0 13171.9 5281.4 5346.8 5366.4 5379.0 5380.4 873.1 913.4 928.4 930.4 946.9 20625.2 20827.2 22007.1 22023.0 22139.7 991.2 996.0 1003.8 1004.2 1016.4 11457.0 11585.0 11682.8 11687.4 11699.9 175871.0 175891.0 177514.0 177660.0 178066.0 40695.0 40999.0 41054.0 41061.4 41114.4 1189.8 1233.1 1235.4 1246.3 1246.3 19609.5 20020.9 20507.7 21292.9 21443.6 30352.2 30365.2 37238.3 38073.8 38074.2 164264.0 165869.0 166170.0 166573.0 167846.0 29098.4 29675.4 29932.3 30517.4 30688.0 35472.7 35946.6 36125.6 36560.8 37086.6 26877.2 27722.9 28085.4 28133.3 29142.9 27028.9 27603.9 27686.3 28088.3 29258.9 30868.4 31287.1 31364.7 31384.7 31421.4 26142.5 26629.3 27189.7 27625.2 27704.0 20429.5 22491.1 22518.3 22564.9 22792.4 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#2] jquery.html Cycles:180 Average:25146.71 Median:420.25 stddev:61434.19 (14618.5%) stddev-sans-first:61578.47 09:14:45 INFO - PID 12329 | Values: 418.9 421.6 426.9 435.9 441.2 12200.5 13802.9 17456.4 18298.0 18356.2 18555.1 18700.3 18893.0 19356.8 19379.5 5520.3 5739.4 5746.5 5749.0 5755.6 5146.8 5339.7 5350.1 5352.0 5380.4 5285.0 5292.6 5308.7 5309.5 5309.7 5236.1 5417.4 5447.5 5462.6 5485.6 4932.0 4936.0 4940.6 4952.4 4970.4 21709.6 22057.1 22133.7 22144.1 22153.7 1593.6 1618.2 1619.7 1621.3 1622.7 14510.6 14533.6 14891.3 15072.2 15115.9 2047.1 2089.8 2119.3 2132.3 2138.8 90473.5 95124.0 96187.5 97838.5 97871.0 11244.3 11447.1 11532.3 11594.3 11654.7 16230.0 16232.4 16238.5 16244.1 16264.1 7224.7 7545.4 7551.6 7731.8 7750.7 6743.3 6759.2 6910.9 6919.4 6923.8 7092.2 7092.6 7116.0 7177.3 7284.2 2029.0 2036.9 2067.8 2093.2 2165.9 830.5 864.2 879.8 885.7 886.5 16951.9 17647.2 17872.9 17892.6 18042.1 882.2 887.6 890.1 895.2 918.2 9560.2 9654.2 9837.0 9919.0 9943.4 351011.0 352120.0 372330.0 377953.0 381227.0 75788.2 80114.6 81503.6 81701.6 82785.0 1077.9 1133.0 1134.7 1140.5 1150.7 17861.2 18408.8 18814.6 18927.8 18963.4 37594.8 38114.2 38987.0 39335.4 39554.0 48473.0 49090.3 49753.8 49825.3 50674.2 7930.9 8219.3 8270.8 8322.8 8433.7 11514.4 11516.8 12028.9 12391.8 12427.3 10206.5 10710.5 10878.3 10990.7 11262.7 9797.1 9880.2 9885.6 9944.3 10226.3 10723.1 11005.3 11553.8 11568.6 11896.0 8564.8 8648.5 8731.3 8732.8 8763.6 9978.9 10047.4 10070.5 10209.5 10560.6 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#3] mootools.html Cycles:180 Average:6277.57 Median:3503.96 stddev:4171.34 (119.0%) stddev-sans-first:4166.07 09:14:45 INFO - PID 12329 | Values: 1268.9 1304.3 1310.4 1314.4 1328.2 9934.5 10475.5 10483.4 10485.2 10803.1 10563.5 10733.1 10766.0 10769.9 10785.9 2161.2 2200.6 2210.8 2212.7 2213.5 2123.7 2154.8 2157.1 2158.5 2159.8 1932.0 1947.5 1956.0 1962.7 1964.3 1944.7 1947.5 1947.9 1948.7 1951.5 1944.3 1966.7 1974.2 2014.6 2104.3 10306.9 10385.4 10394.8 10399.4 10403.3 5433.1 5657.3 5681.0 5688.7 5700.6 3182.6 3322.1 3387.7 3391.5 3399.3 1069.4 1078.9 1081.0 1082.6 1111.6 15135.1 15346.8 15362.8 15364.8 15367.3 4704.1 4791.6 4922.1 4924.6 4939.3 10878.9 10884.7 10902.3 10912.7 10931.2 5491.9 5590.8 5600.4 5604.3 5618.3 5125.9 5167.4 5171.3 5191.9 5277.3 3628.5 3717.4 3757.2 3758.5 3812.5 1166.5 1178.8 1179.7 1188.7 1188.7 687.5 711.1 715.4 722.6 727.0 5200.5 5366.4 5391.7 5392.5 5405.4 526.7 529.6 537.5 539.6 541.9 3457.3 3495.3 3512.6 3570.1 3730.5 13320.2 13575.7 13763.0 13770.9 13861.4 13268.9 13614.2 13683.2 13687.7 13716.3 7031.9 7147.7 7192.7 7212.7 7217.6 5425.5 5587.5 5658.7 5801.8 5828.4 11940.0 12026.0 12077.7 12106.7 12215.3 12303.9 12584.8 12588.7 12607.2 12700.4 7661.0 7753.5 7757.1 7764.0 7774.5 9629.1 9724.0 9772.3 9778.9 9796.8 8137.5 8140.4 8202.3 8234.5 8242.0 8123.8 8170.1 8180.6 8261.3 8284.9 7007.7 7150.1 7156.9 7164.4 7172.8 4795.6 5100.3 5113.3 5138.4 5382.2 5020.6 5053.3 5159.4 5160.3 5194.4 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#4] prototype.html Cycles:180 Average:4791.33 Median:5315.16 stddev:1353.09 (25.5%) stddev-sans-first:1315.61 09:14:45 INFO - PID 12329 | Values: 372.2 373.6 375.4 375.6 377.0 5341.8 5386.9 5431.1 5450.6 5512.2 5233.5 5319.1 5322.6 5327.3 5331.4 4074.8 4152.6 4246.7 4260.2 4273.2 4254.3 4254.4 4255.2 4267.2 4281.9 4234.1 4236.4 4239.3 4240.4 4272.0 4112.9 4192.6 4250.7 4255.9 4258.8 3823.3 3865.1 3867.7 3884.5 3886.2 5291.7 5300.8 5303.8 5304.3 5311.2 4950.2 5022.2 5039.6 5052.7 5062.1 5738.4 5755.7 5755.7 5758.1 5764.2 4313.3 4327.4 4328.6 4331.2 4334.4 5913.5 6019.6 6021.2 6059.0 6103.8 4475.2 4487.1 4497.6 4504.8 4527.3 4512.6 4544.3 4549.5 4558.8 4574.8 4825.2 4959.7 5030.9 5056.4 5060.5 5755.1 5763.8 5769.4 5774.6 5817.5 1542.5 1542.8 1548.2 1550.4 1559.5 1128.0 1143.6 1157.2 1157.4 1157.7 5018.6 5024.1 5025.4 5027.2 5032.1 5891.9 5975.3 5981.2 5991.6 6000.0 4950.6 4954.7 4967.1 4979.5 4993.0 3107.3 3127.5 3138.7 3139.1 3144.1 5468.4 5530.0 5535.5 5538.7 5554.9 5841.3 6039.1 6042.9 6064.4 6068.9 5480.3 5524.4 5525.5 5535.3 5558.4 5725.5 5875.5 5900.0 5900.6 5949.0 5713.0 5773.8 5774.9 5777.9 5812.1 5495.1 5512.2 5531.2 5547.6 5556.1 3966.1 4010.4 4027.8 4032.4 4035.6 5885.0 5900.7 5911.7 5929.2 5953.6 5650.5 5702.8 5734.9 5742.3 5760.7 5619.7 5631.3 5707.4 5733.9 5753.5 5628.9 5652.3 5662.3 5662.9 5665.2 5630.2 5682.1 5775.7 5777.9 5795.3 5587.0 5596.0 5602.6 5620.2 5623.3 09:14:45 INFO - PID 12329 | 09:14:45 INFO - PID 12329 | [#5] yui.html Cycles:180 Average:17110.53 Median:3103.64 stddev:21844.24 (703.8%) stddev-sans-first:21870.90 09:14:45 INFO - PID 12329 | Values: 731.4 743.3 744.9 750.3 761.3 13678.2 14476.8 14619.5 14629.7 16871.7 16517.2 16677.7 16869.3 16882.5 16934.8 871.4 893.3 894.5 911.6 914.5 870.6 928.3 930.4 933.9 935.4 950.5 957.0 962.3 966.3 967.1 952.4 953.8 957.8 958.6 959.5 699.3 704.6 704.6 705.4 708.1 13736.4 13799.9 14134.9 14137.7 14162.5 14380.0 15040.6 15458.6 15598.9 15738.3 12841.0 12938.8 13307.6 13554.8 13596.7 2999.8 3009.7 3011.6 3027.0 3031.0 79593.6 81117.2 81748.2 82780.5 82894.6 12968.5 13140.5 13246.9 13374.9 13403.7 23265.7 23623.9 23766.8 23800.6 23833.9 6039.7 6664.3 6685.5 6729.3 6730.0 2999.1 3086.1 3100.0 3107.2 3111.3 3566.8 3654.8 3657.0 3665.7 3667.5 725.9 753.4 756.2 758.7 763.5 542.7 582.2 606.8 614.3 638.1 9936.7 10561.2 10660.9 10726.0 11207.4 578.4 584.6 584.7 586.2 586.9 4827.4 5052.2 5117.0 5121.8 5264.9 72511.6 72751.0 72849.6 85790.1 87791.6 67088.7 68073.3 68605.7 69067.3 69988.3 57751.7 58064.0 59406.7 59961.1 60230.4 10012.2 10106.2 10337.9 10366.6 11195.0 26839.5 26869.3 27975.6 28131.4 28700.3 48058.0 48799.3 49812.3 50054.2 50427.0 13063.4 13159.5 13211.8 13217.6 13291.0 15196.6 15349.5 15360.9 15418.0 15577.7 12479.2 12490.6 12505.6 12578.0 12620.6 14979.9 15120.5 15157.6 15272.5 15295.3 12929.8 12960.8 13095.3 13115.3 13202.5 9958.8 10369.5 10414.4 10451.7 10711.6 10761.1 10773.9 11009.3 11156.5 11275.9 09:14:45 INFO - PID 12329 | -------- Summary: end -------- 09:14:45 INFO - PID 12329 | 09:14:46 INFO - TEST-INFO | 12329: exit 0 09:14:46 INFO - TEST-OK | dromaeo_css | took 1147733ms 09:14:46 INFO - TEST-START | kraken 09:14:46 INFO - operating with platform_type : linux_ 09:14:46 INFO - Initialising browser for kraken test... 09:14:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43057/getInfo.html -profile /tmp/tmpSI4_Ro/profile 09:14:46 INFO - TEST-INFO | started process 12752 (/builds/slave/test/build/application/firefox/firefox http://localhost:43057/getInfo.html) 09:15:21 INFO - TEST-INFO | 12752: killed by SIGTERM 09:15:21 INFO - Browser initialized. 09:15:21 INFO - Running cycle 1/1 for kraken test... 09:15:21 INFO - TEST-INFO | started process 12973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSI4_Ro/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:33 INFO - PID 12973 | RSS: Main: 186445824 09:15:33 INFO - PID 12973 | 09:15:36 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43057/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:37 INFO - PID 12973 | RSS: Main: 189657088 09:15:37 INFO - PID 12973 | 09:15:39 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43057/tests/kraken/driver.html?testName=audio-dft) 09:15:40 INFO - PID 12973 | RSS: Main: 188641280 09:15:40 INFO - PID 12973 | 09:15:43 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43057/tests/kraken/driver.html?testName=audio-fft) 09:15:44 INFO - PID 12973 | RSS: Main: 185286656 09:15:44 INFO - PID 12973 | 09:15:46 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43057/tests/kraken/driver.html?testName=audio-oscillator) 09:15:46 INFO - PID 12973 | RSS: Main: 185753600 09:15:46 INFO - PID 12973 | 09:15:48 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:49 INFO - PID 12973 | RSS: Main: 185946112 09:15:49 INFO - PID 12973 | 09:15:52 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43057/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:53 INFO - PID 12973 | RSS: Main: 189997056 09:15:53 INFO - PID 12973 | 09:15:56 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43057/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:57 INFO - PID 12973 | RSS: Main: 185860096 09:15:57 INFO - PID 12973 | 09:16:00 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43057/tests/kraken/driver.html?testName=json-parse-financial) 09:16:01 INFO - PID 12973 | RSS: Main: 186650624 09:16:01 INFO - PID 12973 | 09:16:02 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:03 INFO - PID 12973 | RSS: Main: 186769408 09:16:03 INFO - PID 12973 | 09:16:05 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:05 INFO - PID 12973 | RSS: Main: 186662912 09:16:05 INFO - PID 12973 | 09:16:08 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:08 INFO - PID 12973 | RSS: Main: 186978304 09:16:08 INFO - PID 12973 | 09:16:11 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:12 INFO - PID 12973 | RSS: Main: 187088896 09:16:12 INFO - PID 12973 | 09:16:15 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:16 INFO - PID 12973 | RSS: Main: 186621952 09:16:16 INFO - PID 12973 | 09:16:17 INFO - PID 12973 | Cycle 1(1): loaded http://localhost:43057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43057/tests/kraken/driver.html?testName=ai-astar) 09:16:18 INFO - PID 12973 | RSS: Main: 188153856 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | __start_tp_report 09:16:18 INFO - PID 12973 | _x_x_mozilla_page_load 09:16:18 INFO - PID 12973 | _x_x_mozilla_page_load_details 09:16:18 INFO - PID 12973 | |i|pagename|runs| 09:16:18 INFO - PID 12973 | |0;ai-astar;104;111;112;113;110;111;110;110;111;110 09:16:18 INFO - PID 12973 | |1;audio-beat-detection;148;123;125;171;125;125;125;127;149;124 09:16:18 INFO - PID 12973 | |2;audio-dft;174;164;166;168;168;173;164;164;165;167 09:16:18 INFO - PID 12973 | |3;audio-fft;77;73;74;118;75;77;75;75;92;78 09:16:18 INFO - PID 12973 | |4;audio-oscillator;84;84;102;83;86;84;97;83;83;109 09:16:18 INFO - PID 12973 | |5;imaging-gaussian-blur;118;114;114;114;115;114;114;114;113;114 09:16:18 INFO - PID 12973 | |6;imaging-darkroom;150;154;156;150;149;153;150;150;151;152 09:16:18 INFO - PID 12973 | |7;imaging-desaturate;95;95;94;94;95;100;100;102;95;95 09:16:18 INFO - PID 12973 | |8;json-parse-financial;57;56;56;57;56;56;56;58;57;58 09:16:18 INFO - PID 12973 | |9;json-stringify-tinderbox;58;58;58;58;58;57;57;58;58;58 09:16:18 INFO - PID 12973 | |10;stanford-crypto-aes;88;86;87;93;86;87;87;89;113;88 09:16:18 INFO - PID 12973 | |11;stanford-crypto-ccm;135;142;134;135;133;135;135;139;134;133 09:16:18 INFO - PID 12973 | |12;stanford-crypto-pbkdf2;188;195;194;202;196;194;192;191;198;198 09:16:18 INFO - PID 12973 | |13;stanford-crypto-sha256-iterative;76;75;72;73;73;72;74;70;71;69 09:16:18 INFO - PID 12973 | __end_tp_report 09:16:18 INFO - PID 12973 | __start_cc_report 09:16:18 INFO - PID 12973 | _x_x_mozilla_cycle_collect,1029 09:16:18 INFO - PID 12973 | __end_cc_report 09:16:18 INFO - PID 12973 | __startTimestamp1496160978139__endTimestamp 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | ------- Summary: start ------- 09:16:18 INFO - PID 12973 | Number of tests: 14 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:1.05 09:16:18 INFO - PID 12973 | Values: 104.0 111.0 112.0 113.0 110.0 111.0 110.0 110.0 111.0 110.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:126.00 stddev:16.27 (12.9%) stddev-sans-first:16.48 09:16:18 INFO - PID 12973 | Values: 148.0 123.0 125.0 171.0 125.0 125.0 125.0 127.0 149.0 124.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#2] audio-dft Cycles:10 Average:167.30 Median:167.50 stddev:3.62 (2.2%) stddev-sans-first:2.92 09:16:18 INFO - PID 12973 | Values: 174.0 164.0 166.0 168.0 168.0 173.0 164.0 164.0 165.0 167.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:13.95 (18.3%) stddev-sans-first:14.70 09:16:18 INFO - PID 12973 | Values: 77.0 73.0 74.0 118.0 75.0 77.0 75.0 75.0 92.0 78.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:9.56 (11.4%) stddev-sans-first:9.93 09:16:18 INFO - PID 12973 | Values: 84.0 84.0 102.0 83.0 86.0 84.0 97.0 83.0 83.0 109.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 09:16:18 INFO - PID 12973 | Values: 118.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 113.0 114.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:2.22 (1.5%) stddev-sans-first:2.29 09:16:18 INFO - PID 12973 | Values: 150.0 154.0 156.0 150.0 149.0 153.0 150.0 150.0 151.0 152.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:95.00 stddev:2.95 (3.1%) stddev-sans-first:3.08 09:16:18 INFO - PID 12973 | Values: 95.0 95.0 94.0 94.0 95.0 100.0 100.0 102.0 95.0 95.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 09:16:18 INFO - PID 12973 | Values: 57.0 56.0 56.0 57.0 56.0 56.0 56.0 58.0 57.0 58.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 09:16:18 INFO - PID 12973 | Values: 58.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 58.0 58.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:87.50 stddev:8.19 (9.4%) stddev-sans-first:8.65 09:16:18 INFO - PID 12973 | Values: 88.0 86.0 87.0 93.0 86.0 87.0 87.0 89.0 113.0 88.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:135.00 stddev:2.84 (2.1%) stddev-sans-first:3.00 09:16:18 INFO - PID 12973 | Values: 135.0 142.0 134.0 135.0 133.0 135.0 135.0 139.0 134.0 133.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:195.50 stddev:3.99 (2.0%) stddev-sans-first:3.40 09:16:18 INFO - PID 12973 | Values: 188.0 195.0 194.0 202.0 196.0 194.0 192.0 191.0 198.0 198.0 09:16:18 INFO - PID 12973 | 09:16:18 INFO - PID 12973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:2.17 (3.0%) stddev-sans-first:1.90 09:16:18 INFO - PID 12973 | Values: 76.0 75.0 72.0 73.0 73.0 72.0 74.0 70.0 71.0 69.0 09:16:18 INFO - PID 12973 | -------- Summary: end -------- 09:16:18 INFO - PID 12973 | 09:16:19 INFO - TEST-INFO | 12973: exit 0 09:16:19 INFO - TEST-OK | kraken | took 93082ms 09:16:19 INFO - SUITE-END | took 1240s 09:16:19 INFO - Completed test suite (00:20:41) 09:16:19 INFO - javascript benchmark 09:16:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6773.04275708753, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.3738540135755, 2723.332783468051, 2724.087430710712, 2765.0737003103945, 2767.2528417327317, 5158.690478571289, 5197.558207552363, 5210.6613070150415, 5223.582113430926, 5259.3162888824445, 5166.741662916858, 5201.193814958678, 5234.947650523493, 5252.52727254547, 5295.020421222077, 4674.11191873543, 4683.742394168319, 4701.600363969067, 4714.528547145293, 4729.55069268419, 4658.231391820363, 4711.246200607903, 4743.976280118594, 4778.665493415462, 4807.206810876201, 4604.355390245369, 4649.256119020974, 4702.694324868872, 4715.31627913954, 4768.47546769855, 4683.250679891235, 4718.740469274188, 4728.030753695484, 4740.739259340735, 4754.025424787945, 4656.161890859644, 4658.743769092698, 4668.043051174501, 4680.227762419197, 4720.929186062212, 5172.844814655528, 5186.5850731941355, 5227.398849132361, 5230.34620672416, 5244.501772331622, 5543.833684989457, 5579.2746942897165, 5604.523615492647, 5651.802186923438, 5737.168110623936, 5627.943720562824, 5664.830055098354, 5673.23411339468, 5697.715114244271, 5704.315482142128, 5232.895342093137, 5237.266782650432, 5242.397124330712, 5258.027264955919, 5259.289995850588, 5650.0, 5777.595568310262, 5786.42135786418, 5799.804512178121, 5849.093390524476, 5507.366652834975, 5525.861853453615, 5583.106702927512, 5590.5248053915875, 5640.069388550925, 5630.6058575900115, 5663.858403539944, 5664.433556644385, 5665.830025099253, 5670.5463562914865, 5444.8366549003595, 5531.751071201806, 5622.437756224344, 5622.746976386073, 5632.155176723524, 5554.638948468418, 5569.693666848362, 5632.070708333161, 5639.407862174495, 5666.575006874501, 4622.214223581932, 4629.027904140101, 4643.883902902455, 4648.767561621973, 4680.765961701902, 3994.0, 4000.119973605802, 4000.239954408653, 4047.0, 4076.0217547788316, 4723.197056500403, 4765.380500534909, 4795.040991801654, 4814.301926220748, 4862.805487780449, 5699.658020518782, 5714.028615135437, 5722.7424765885635, 5736.254286942671, 5750.453706897838, 4809.062232864558, 4817.9518204818205, 4819.108464933998, 4825.860458611638, 4846.878828029327, 4890.095332363453, 4974.030064137459, 4974.253861920741, 4980.203167493256, 4980.477049909779, 5248.475152484873, 5251.842444726664, 5275.841724748264, 5313.415524292402, 5328.333958255218, 5484.287042684426, 5555.72221388937, 5682.176084467812, 5703.0589952659, 5711.685857277889, 5287.312649355559, 5289.0, 5326.733663316896, 5361.973190134025, 5380.273663055437, 5459.235707001102, 5519.199716041232, 5576.1356989666665, 5582.246396736388, 5586.078297080936, 5596.692181930033, 5666.716664166693, 5678.233438485751, 5713.628614140068, 5772.307323121252, 5490.258815059916, 5492.615516913777, 5510.228568000563, 5540.141278101901, 5546.084895992116, 5487.122060470306, 5487.670739755627, 5493.835184944458, 5500.972495137498, 5504.394516603091, 5349.491798279158, 5429.592780541396, 5440.1023831069015, 5449.700266485382, 5469.261649677402, 5428.402875683751, 5474.562035037267, 5534.059209934401, 5569.805056822992, 5606.551475881838, 5366.382865970308, 5378.1663842104535, 5383.892322153613, 5385.73071346439, 5387.595930305321], "value": 5120.937542473373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.1524448705655, 725.7568714480649, 742.8365759532902, 1214.8602910665277, 1244.0731654917088, 34278.828605856965, 35452.64547354526, 35504.822475887646, 35520.46719299206, 35584.99999999997, 33699.32601347972, 33893.15267118317, 34006.829965850135, 34026.14934626636, 34045.829770851175, 6515.934840651592, 6662.733490660392, 6744.460443164535, 6882.552634078794, 6927.376536111749, 6880.655967201645, 6896.0, 6898.0, 6962.7911162665205, 6963.442924566048, 6846.691898864538, 6910.170779506467, 6914.135733033371, 6934.410575101122, 6961.756338528153, 6881.4838887083415, 6897.655117244168, 6930.688119034605, 6934.583924964493, 6954.200266969262, 6793.796186114375, 6809.455243580502, 6842.076319696827, 6843.863122737517, 6857.451403887727, 31649.20876978071, 31916.36167276665, 32048.359032819448, 32095.518567221512, 32112.197195070075, 2954.4534261161753, 2983.418233444479, 2989.5515672649058, 2992.745616622568, 2993.117030476015, 24282.514349713085, 24508.26475205747, 24555.0, 24594.0, 24676.876615616988, 3015.321552650636, 3033.924151896198, 3064.8620812063286, 3066.6166729158854, 3127.6090488688915, 126583.36708316492, 128191.0, 139551.30224348814, 146734.0, 146777.0, 39904.0, 40092.59907400947, 40202.195956080715, 40210.0, 40226.1954760909, 41657.1668566633, 42077.0, 42080.78959605182, 42152.156956861305, 42285.0, 11501.539938402537, 11726.70683232909, 11751.590923860587, 11753.236039657395, 11777.470013849397, 9251.306152038624, 9319.347645664873, 9327.580258888367, 9330.58012389444, 9343.626254949862, 12960.611181664564, 13035.217886926815, 13042.087053906325, 13042.9565634749, 13171.868281317256, 5281.419043905167, 5346.8128615499045, 5366.409694933554, 5379.0, 5380.354357477127, 873.1007062725403, 913.4108500017452, 928.3640706116197, 930.423137654645, 946.9053094690476, 20625.174993000113, 20827.1669133236, 22007.11971521121, 22023.0, 22139.667904981437, 991.1575161112996, 995.9800803983879, 1003.844404117363, 1004.1866088468364, 1016.4104819204844, 11456.99502587044, 11585.0, 11682.824757628643, 11687.357195354338, 11699.941500292443, 175871.0, 175891.0, 177514.0, 177660.0, 178066.0, 40695.0, 40999.0, 41054.0, 41061.38407923884, 41114.38328425076, 1189.8064946508428, 1233.0690328801877, 1235.3576140407117, 1246.2958428487875, 1246.3145270101409, 19609.509762256057, 20020.899895500428, 20507.69238461454, 21292.893535532843, 21443.571128577652, 30352.241193969443, 30365.240868978453, 37238.25523489569, 38073.80963095167, 38074.23851523009, 164264.0, 165869.0, 166170.0, 166573.0, 167846.0, 29098.41803163967, 29675.40649186961, 29932.251693707833, 30517.389652207276, 30688.0, 35472.68082737757, 35946.64053359433, 36125.63874361328, 36560.81719591385, 37086.62913370832, 26877.193684189504, 27722.861385693748, 28085.43829123447, 28133.296667583476, 29142.854285728437, 27028.864855676384, 27603.86198068997, 27686.307842304104, 28088.29779255535, 29258.85370573219, 30868.382632347675, 31287.061388158392, 31364.686353136178, 31384.686153138176, 31421.371572568878, 26142.477150456503, 26629.334266643487, 27189.72810271872, 27625.171244862686, 27704.0, 20429.48926276855, 22491.100355986233, 22518.32445026652, 22564.887175564018, 22792.430189245402], "value": 14601.746231369998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.94344263524437, 421.55525920154264, 426.92101961137195, 435.8735966569695, 441.2476727180156, 12200.450979705913, 13802.93098534506, 17456.389026384062, 18297.99361035144, 18356.17397217125, 18555.07224638766, 18700.345487907925, 18893.0, 19356.806431935678, 19379.515512112168, 5520.282363292777, 5739.368669446358, 5746.454086861741, 5749.022666146744, 5755.597108202427, 5146.845594632167, 5339.70631615261, 5350.063738845706, 5352.0, 5380.435054319299, 5284.973575132138, 5292.603054770889, 5308.6814791112465, 5309.495597918191, 5309.681419114846, 5236.083685355066, 5417.377001644822, 5447.536959358459, 5462.562994960434, 5485.588580856452, 4932.0, 4935.950640493585, 4940.604751619861, 4952.380952380952, 4970.353853998993, 21709.565808683896, 22057.11771529137, 22133.66799498009, 22144.114235430563, 22153.66769498459, 1593.6334643032167, 1618.174730887244, 1619.651774868409, 1621.3271492330668, 1622.6835767025434, 14510.564683059525, 14533.563993080119, 14891.32989015497, 15072.171030593314, 15115.924420377827, 2047.140201115535, 2089.791020897898, 2119.2622049919073, 2132.3176583493287, 2138.786121387864, 90473.54763226141, 95124.0, 96187.51906240424, 97838.51080744622, 97871.0, 11244.26912250701, 11447.109026027532, 11532.2504037239, 11594.304341739522, 11654.650360489199, 16230.0, 16232.350705971865, 16238.512844614681, 16244.106574138299, 16264.105474199032, 7224.711011559479, 7545.434092443089, 7551.622418879034, 7731.845363092707, 7750.651220695082, 6743.291954344723, 6759.164969450013, 6910.896336554955, 6919.37725604688, 6923.757668481579, 7092.2340287288, 7092.574445533284, 7116.0, 7177.318154775288, 7284.162321333115, 2028.9594208115755, 2036.867603605761, 2067.824234940047, 2093.216022689819, 2165.9133634654754, 830.5390508267849, 864.1833467373398, 879.8064425826308, 885.7254251182154, 886.5301390263171, 16951.898126621978, 17647.205875735624, 17872.91063544674, 17892.552686182687, 18042.09789510519, 882.1575395497284, 887.6493784955036, 890.1276748786225, 895.2256298301922, 918.2149262380702, 9560.187384072431, 9654.179394751385, 9837.0, 9918.950405248072, 9943.353682010646, 351011.0, 352120.0, 372330.0, 377953.0, 381227.0, 75788.24211757812, 80114.5994270025, 81503.59248203722, 81701.59149204334, 82784.99999999879, 1077.9083777878811, 1133.0, 1134.659602119361, 1140.4639819284923, 1150.6663067710438, 17861.196246169213, 18408.81591184071, 18814.623707525498, 18927.810721893155, 18963.43109706711, 37594.8120259397, 38114.237715244984, 38987.0, 39335.40996885106, 39554.0, 48473.0, 49090.26364604605, 49753.751231243616, 49825.252621209984, 50674.239886400996, 7930.850026746205, 8219.342452603896, 8270.751877443687, 8322.791930201793, 8433.746987590383, 11514.42427878586, 11516.827247591125, 12028.939855300667, 12391.75216495647, 12427.31649759272, 10206.540705668114, 10710.518026688662, 10878.347299161758, 10990.725231869268, 11262.718432039264, 9797.118259356692, 9880.16018638395, 9885.604575816888, 9944.30389872702, 10226.28416010872, 10723.142148628247, 11005.339679619248, 11553.826692599785, 11568.595099171489, 11896.0, 8564.785880353042, 8648.481091134552, 8731.345149113715, 8732.78168045804, 8763.561821909007, 9978.850317245102, 10047.397156170653, 10070.532719483774, 10209.489525523546, 10560.577576896838], "value": 8892.261857728632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.930208838514, 1304.2696090189495, 1310.3841194638524, 1314.38880920372, 1328.249539010459, 9934.45360505172, 10475.476226188688, 10483.370997740121, 10485.161187105032, 10803.081738052255, 10563.524641391137, 10733.087687546567, 10766.0, 10769.892301076987, 10785.892141078586, 2161.2219600943686, 2200.625893598084, 2210.823134149264, 2212.6791615215784, 2213.4908970936694, 2123.660214365702, 2154.795294447033, 2157.147926569004, 2158.4819643285578, 2159.84881058326, 1931.9710204346945, 1947.5033866364129, 1956.0415396455776, 1962.6859702447612, 1964.2732189090057, 1944.6888497840348, 1947.51312171957, 1947.9318223862097, 1948.65898467769, 1951.4828570428847, 1944.270898413095, 1966.7344908437321, 1974.2103158736477, 2014.5870096630156, 2104.3476522278143, 10306.896931030744, 10385.42880141592, 10394.844077338847, 10399.428031458267, 10403.271770976035, 5433.1035379162395, 5657.2928383952, 5681.034224181858, 5688.658680479143, 5700.572457065737, 3182.5703530023616, 3322.1030321812973, 3387.745919056056, 3391.5251864738957, 3399.3201359727905, 1069.3637285814928, 1078.8759292681284, 1080.9675709728642, 1082.566973210722, 1111.6442738323658, 15135.091894486366, 15346.769798453031, 15362.769558456632, 15364.769528457082, 15367.308471118715, 4704.129735998851, 4791.6406269529925, 4922.0648076866, 4924.556789888856, 4939.333190019373, 10878.891211087788, 10884.727881803019, 10902.345859248471, 10912.727181820359, 10931.18016148792, 5491.917621235684, 5590.776368945278, 5600.4399560044485, 5604.299462567179, 5618.297712785902, 5125.897482050413, 5167.379914410295, 5171.3018742469285, 5191.9480805192225, 5277.261183434322, 3628.510151129564, 3717.386631205875, 3757.229767897574, 3758.473813666089, 3812.4662547243406, 1166.5275563396838, 1178.80549709297, 1179.6696924861053, 1188.6552899659175, 1188.7028242939266, 687.52560733094, 711.0898050495374, 715.4169351978121, 722.6134018300185, 727.0403067950255, 5200.531952124251, 5366.409694933554, 5391.676499410048, 5392.541633961078, 5405.378381486101, 526.7129414469124, 529.5736931769962, 537.5162353881537, 539.6303532080537, 541.8618252345626, 3457.3085382923514, 3495.3358861816682, 3512.5784905811465, 3570.143165640228, 3730.4705070921336, 13320.200787952754, 13575.660608484866, 13763.0, 13770.93114534441, 13861.4455421782, 13268.867311326763, 13614.183149010893, 13683.179009259477, 13687.657808554666, 13716.314184290746, 7031.8945215821805, 7147.749828755968, 7192.676329565182, 7212.7114915403845, 7217.566945983258, 5425.511703946664, 5587.469190426903, 5658.717064146694, 5801.76792928295, 5828.446297601721, 11940.0, 12026.037916966796, 12077.698057548632, 12106.697332566757, 12215.26708397499, 12303.876961230273, 12584.811227831407, 12588.685282868002, 12607.180533265308, 12700.36498175069, 7661.0, 7753.457257991887, 7757.1079325878245, 7763.961180194063, 7774.533527988338, 9629.085236902483, 9724.0, 9772.315937884565, 9778.9022109778, 9796.755081123029, 8137.471064380797, 8140.430169888051, 8202.26179643835, 8234.464759790833, 8241.95879020601, 8123.75628731139, 8170.060443049126, 8180.550069745983, 8261.339092872677, 8284.917150828414, 7007.6846541904715, 7150.141982962078, 7156.928430715626, 7164.355208031302, 7172.820679482846, 4795.640326975421, 5100.336956195671, 5113.284140220298, 5138.3833939927445, 5382.246485492113, 5020.594233614594, 5053.267276244997, 5159.432462429205, 5160.251763494197, 5194.428612852507], "value": 4628.496829413755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.1719174835989, 373.630106194867, 375.4143536083708, 375.622499388115, 376.9868054618089, 5341.813036543722, 5386.865328366793, 5431.076716958117, 5450.645708028976, 5512.228288039678, 5233.476652334764, 5319.0957537218665, 5322.600804939626, 5327.348521958195, 5331.386890507592, 4074.837006519743, 4152.56398078202, 4246.745195288293, 4260.1882757380135, 4273.166732487166, 4254.27677294859, 4254.361845723135, 4255.234057869582, 4267.189234045537, 4281.892952676177, 4234.115818460787, 4236.428082208909, 4239.261902619926, 4240.427542281784, 4272.0, 4112.876613701564, 4192.559781222958, 4250.744955302676, 4255.936160957573, 4258.765767882765, 3823.330917089498, 3865.1496670732395, 3867.7292589518743, 3884.514435695538, 3886.24218277436, 5291.735413229323, 5300.840974770725, 5303.840884773463, 5304.283921670563, 5311.229871668586, 4950.183219768734, 5022.221555658879, 5039.622028347889, 5052.72210028452, 5062.139436295838, 5738.368779434259, 5755.740991655385, 5755.740991655385, 5758.136279558058, 5764.221830052973, 4313.331433627793, 4327.394164816928, 4328.61042506176, 4331.220380331539, 4334.393184954109, 5913.526917846562, 6019.608725432877, 6021.157038014681, 6059.0, 6103.816885493487, 4475.239209334356, 4487.102579484116, 4497.550244975541, 4504.842330518416, 4527.320901864747, 4512.638988880882, 4544.296143794437, 4549.476810166807, 4558.794854231567, 4574.839880604163, 4825.179719447632, 4959.652824302264, 5030.874228144253, 5056.393232812013, 5060.51925067118, 5755.050416681201, 5763.7982670606325, 5769.365369809318, 5774.595778295563, 5817.534597232211, 1542.460138951358, 1542.7762974368654, 1548.1562548411143, 1550.4030948084842, 1559.50095969291, 1128.0242590159453, 1143.6454699043322, 1157.242006485753, 1157.4039369724599, 1157.7496303991668, 5018.5985121190215, 5024.145895197825, 5025.447200807908, 5027.1705168647495, 5032.119379108642, 5891.8510890375965, 5975.282966044103, 5981.162637230791, 5991.580589358703, 5999.950008748451, 4950.603951683928, 4954.653174277838, 4967.130752118437, 4979.4771548987555, 4992.950070499249, 3107.285324375406, 3127.5308703694627, 3138.6704396038544, 3139.0896639974153, 3144.088214417839, 5468.425815289417, 5530.0, 5535.501804837584, 5538.667679939216, 5554.861128471821, 5841.328247251536, 6039.127870360115, 6042.939570604326, 6064.3935606439, 6068.939310606926, 5480.314645823598, 5524.447555244444, 5525.530329922001, 5535.25274087993, 5558.416366281563, 5725.51333136688, 5875.50058245054, 5900.0264956281735, 5900.616459930091, 5949.0, 5712.971435142797, 5773.769049237983, 5774.9133762994425, 5777.91333129995, 5812.070068788974, 5495.0658388073325, 5512.228288039758, 5531.170324451365, 5547.583931205095, 5556.083246264321, 3966.1076257841755, 4010.3984402338715, 4027.8187481562813, 4032.395140728914, 4035.596440355941, 5884.9705751470965, 5900.70496475166, 5911.733971971185, 5929.229200204119, 5953.642781433128, 5650.491455769001, 5702.771889124555, 5734.913976290442, 5742.339630942328, 5760.654360738369, 5619.690916999441, 5631.324241091095, 5707.400722924033, 5733.878464967988, 5753.510951569164, 5628.943710562842, 5652.349979752381, 5662.2639056922335, 5662.915056274242, 5665.224040220345, 5630.18362337467, 5682.0908654616715, 5775.653460792366, 5777.884442311214, 5795.275590551181, 5586.972065139648, 5595.972020139873, 5602.551795856403, 5620.173443630918, 5623.297087864017], "value": 4382.356215422511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.4441024821134, 743.3161491427886, 744.9292317229865, 750.3471979377942, 761.2881955371728, 13678.247696376695, 14476.782848257284, 14619.488317908876, 14629.707405851877, 16871.662566748688, 16517.174141292948, 16677.66644667106, 16869.325226990935, 16882.493525194233, 16934.83065169348, 871.4466313890662, 893.2987604730288, 894.5214310343968, 911.6080085563206, 914.4878867834001, 870.6212797433105, 928.3223247029672, 930.3719989007427, 933.8739270198504, 935.3966691483989, 950.4629884115487, 957.0286159548065, 962.2975228083503, 966.2849491376367, 967.1102585621245, 952.4333021852021, 953.814006268771, 957.7940742740344, 958.5590628310986, 959.4627008875052, 699.2762490822025, 704.6371118873784, 704.6476761619191, 705.4180301251488, 708.1077841919167, 13736.381862816197, 13799.931000345034, 14134.92932535341, 14137.717245655133, 14162.504312349121, 14380.0, 15040.623984400368, 15458.61353466161, 15598.922005390014, 15738.291776870068, 12841.0, 12938.805917911239, 13307.600771976857, 13554.796678049837, 13596.660083497893, 2999.805012674191, 3009.714077162666, 3011.578379026916, 3026.9545956810666, 3030.9997700758695, 79593.60203198947, 81117.18882811155, 81748.18251817525, 82780.51658450197, 82894.58552707259, 12968.481260749653, 13140.474381024653, 13246.867531324757, 13374.866251337362, 13403.664908377368, 23265.651015234784, 23623.88188059083, 23766.762332376456, 23800.642990354812, 23833.88083059608, 6039.667818270037, 6664.266930637626, 6685.498587605949, 6729.293424190488, 6730.0, 2999.115260998011, 3086.135881953057, 3100.0389879137538, 3107.238726512019, 3111.2688518198206, 3566.8407767475674, 3654.817259137086, 3656.9817150914073, 3665.651763082503, 3667.468217108504, 725.8584576007734, 753.3634079203065, 756.2248695087579, 758.7003133762133, 763.4884627299723, 542.6509834931319, 582.2314544800822, 606.757297081171, 614.2720875762236, 638.125767698247, 9936.652217172365, 10561.207909406672, 10660.946695266473, 10726.0, 11207.43962801873, 578.4475825586554, 584.6083124306725, 584.7339460545442, 586.1822757253607, 586.9119632055141, 4827.444843842933, 5052.191649336162, 5116.9744151279, 5121.769520371592, 5264.868378290574, 72511.63744181351, 72751.0, 72849.63575182196, 85790.14209857822, 87791.56104219439, 67088.6645566769, 68073.3192668077, 68605.65697171482, 69067.30932690609, 69988.30011699919, 57751.71124144436, 58064.0, 59406.70296648489, 59961.10058349128, 60230.397696023356, 10012.199024078202, 10106.242031847787, 10337.896621033693, 10366.579028920287, 11195.0, 26839.463210735285, 26869.328266793487, 27975.580366294114, 28131.43737125287, 28700.282492937844, 48058.0, 48799.268010979154, 49812.25281620851, 50054.24918626296, 50427.0, 13063.412146453242, 13159.473621055433, 13211.801822972471, 13217.603471895858, 13291.0, 15196.620084497976, 15349.462768803038, 15360.923195383952, 15418.0, 15577.688446230784, 12479.188852724545, 12490.562830300896, 12505.624831254712, 12577.993760498955, 12620.621381358575, 14979.925100374428, 15120.54638360851, 15157.621059473602, 15272.465463708717, 15295.31171097281, 12929.806052909025, 12960.805587916377, 13095.345232738135, 13115.344232788513, 13202.537911173064, 9958.800823983334, 10369.481525923824, 10414.375137491776, 10451.68644940653, 10711.571537138427, 10761.139108871428, 10773.89226107729, 11009.339439633648, 11156.497957591766, 11275.887241127812], "value": 7157.419551044813, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 113.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 125.0, 171.0, 125.0, 125.0, 125.0, 127.0, 149.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 164.0, 166.0, 168.0, 168.0, 173.0, 164.0, 164.0, 165.0, 167.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 74.0, 118.0, 75.0, 77.0, 75.0, 75.0, 92.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 102.0, 83.0, 86.0, 84.0, 97.0, 83.0, 83.0, 109.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 156.0, 150.0, 149.0, 153.0, 150.0, 150.0, 151.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 100.0, 100.0, 102.0, 95.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 58.0, 57.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 93.0, 86.0, 87.0, 87.0, 89.0, 113.0, 88.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 134.0, 135.0, 133.0, 135.0, 135.0, 139.0, 134.0, 133.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 195.0, 194.0, 202.0, 196.0, 194.0, 192.0, 191.0, 198.0, 198.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 72.0, 73.0, 73.0, 72.0, 74.0, 70.0, 71.0, 69.0], "value": 72.5, "unit": "score"}]}]} 09:16:19 INFO - Return code: 0 09:16:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:19 INFO - # TBPL SUCCESS # 09:16:19 INFO - Running post-action listener: _resource_record_post_action 09:16:19 INFO - [mozharness: 2017-05-30 16:16:19.944628Z] Finished run-tests step (success) 09:16:19 INFO - Running post-run listener: _resource_record_post_run 09:16:20 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 411738112; Read time: 16; Write time: 212176 09:16:20 INFO - TinderboxPrint: CPU usage
12.7% 09:16:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:16:20 INFO - TinderboxPrint: I/O write bytes / time
411,738,112 / 212,176 09:16:20 INFO - TinderboxPrint: CPU idle
8,759.9 (87.3%) 09:16:20 INFO - TinderboxPrint: CPU user
1,222.4 (12.2%) 09:16:20 INFO - TinderboxPrint: Swap in / out
0 / 0 09:16:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 88997888; Read time: 0; Write time: 57528 09:16:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:16:20 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 311771136; Read time: 0; Write time: 149176 09:16:20 INFO - Running post-run listener: _upload_blobber_files 09:16:20 INFO - Blob upload gear active. 09:16:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:16:20 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'] 09:16:20 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 09:16:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:21 INFO - (blobuploader) - INFO - Done attempting. 09:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:27 INFO - (blobuploader) - INFO - Done attempting. 09:16:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:16:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:16:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:28 INFO - (blobuploader) - INFO - Done attempting. 09:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:29 INFO - (blobuploader) - INFO - Done attempting. 09:16:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:29 INFO - Return code: 0 09:16:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98e04215def04d21627ce33788b1a5d7127d2650ce944f529006714b747df4f0ff39dc97330ed8d114cefa38f831af8eb5b03e90cc5d4c91805c540fc2445433", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8efdba03586ebf3c343d95b38c669a97fc91d26012327f45c38ad81f58eb726c7fca2a907f6f10e134873dba0b44cfde810505b212b2788ab118168443c27da1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a349a895e906b08b1fdc05b96901edee5e9927eb3390d17b539c654d35f1734dd55e5bc708287710d9689ba184ddd4177d965539fcf2b6e765adeac421695ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58bc4f38c4da765368249ed7ac14e4afcff57ccc8342716d09092e6f64b03a5af2b2fe2f5b141ed17cd5444ca0a50c24f7d16c8eeeb8336b0a4ead5dcdaf2d09"} 09:16:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:29 INFO - Contents: 09:16:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98e04215def04d21627ce33788b1a5d7127d2650ce944f529006714b747df4f0ff39dc97330ed8d114cefa38f831af8eb5b03e90cc5d4c91805c540fc2445433", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8efdba03586ebf3c343d95b38c669a97fc91d26012327f45c38ad81f58eb726c7fca2a907f6f10e134873dba0b44cfde810505b212b2788ab118168443c27da1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a349a895e906b08b1fdc05b96901edee5e9927eb3390d17b539c654d35f1734dd55e5bc708287710d9689ba184ddd4177d965539fcf2b6e765adeac421695ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58bc4f38c4da765368249ed7ac14e4afcff57ccc8342716d09092e6f64b03a5af2b2fe2f5b141ed17cd5444ca0a50c24f7d16c8eeeb8336b0a4ead5dcdaf2d09"} 09:16:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:29 INFO - Copying logs to upload dir... 09:16:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.191653 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-30 09:16:28.533500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:16:28.537890) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 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/98e04215def04d21627ce33788b1a5d7127d2650ce944f529006714b747df4f0ff39dc97330ed8d114cefa38f831af8eb5b03e90cc5d4c91805c540fc2445433", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8efdba03586ebf3c343d95b38c669a97fc91d26012327f45c38ad81f58eb726c7fca2a907f6f10e134873dba0b44cfde810505b212b2788ab118168443c27da1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a349a895e906b08b1fdc05b96901edee5e9927eb3390d17b539c654d35f1734dd55e5bc708287710d9689ba184ddd4177d965539fcf2b6e765adeac421695ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58bc4f38c4da765368249ed7ac14e4afcff57ccc8342716d09092e6f64b03a5af2b2fe2f5b141ed17cd5444ca0a50c24f7d16c8eeeb8336b0a4ead5dcdaf2d09"} build_url:https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/JcwLLDK9SR6qndqjEoqVDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98e04215def04d21627ce33788b1a5d7127d2650ce944f529006714b747df4f0ff39dc97330ed8d114cefa38f831af8eb5b03e90cc5d4c91805c540fc2445433", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8efdba03586ebf3c343d95b38c669a97fc91d26012327f45c38ad81f58eb726c7fca2a907f6f10e134873dba0b44cfde810505b212b2788ab118168443c27da1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a349a895e906b08b1fdc05b96901edee5e9927eb3390d17b539c654d35f1734dd55e5bc708287710d9689ba184ddd4177d965539fcf2b6e765adeac421695ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58bc4f38c4da765368249ed7ac14e4afcff57ccc8342716d09092e6f64b03a5af2b2fe2f5b141ed17cd5444ca0a50c24f7d16c8eeeb8336b0a4ead5dcdaf2d09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:16:28.568511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:16:28.569109) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496159018.777227-1291636780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:16:28.654337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:16:28.654807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:16:28.655255) ========= ========= Total master_lag: 0.17 =========